builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1465290241.23 results: success (0) buildid: 20160606194329 builduid: 3d31ab4f42854c829e06ac6160cc676b revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:01.229847) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:01.230503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:01.230833) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:01.246012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:01.246395) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:04:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-06-07 02:04:01 (37.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102893 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:01.363831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:01.364203) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018564 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:01.413842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:01.414251) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:04:01,476 truncating revision to first 12 chars 2016-06-07 02:04:01,477 Setting DEBUG logging. 2016-06-07 02:04:01,477 attempt 1/10 2016-06-07 02:04:01,477 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/1f9f6bdee31c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 02:04:01,786 unpacking tar archive at: mozilla-beta-1f9f6bdee31c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645925 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:02.077350) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:02.077752) ========= script_repo_revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:02.078245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:02.078746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:04:02.089864) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-06-07 02:04:02.090418) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:04:02 INFO - MultiFileLogger online at 20160607 02:04:02 in /builds/slave/test 02:04:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 02:04:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:04:02 INFO - {'append_to_log': False, 02:04:02 INFO - 'base_work_dir': '/builds/slave/test', 02:04:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:04:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:04:02 INFO - 'branch': 'Mozilla-Beta', 02:04:02 INFO - 'buildbot_json_path': 'buildprops.json', 02:04:02 INFO - 'config_files': ('talos/linux_config.py',), 02:04:02 INFO - 'default_actions': ('clobber', 02:04:02 INFO - 'read-buildbot-config', 02:04:02 INFO - 'download-and-extract', 02:04:02 INFO - 'populate-webroot', 02:04:02 INFO - 'create-virtualenv', 02:04:02 INFO - 'install', 02:04:02 INFO - 'run-tests'), 02:04:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:04:02 INFO - 'download_minidump_stackwalk': True, 02:04:02 INFO - 'download_symbols': 'ondemand', 02:04:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:04:02 INFO - 'tooltool.py': '/tools/tooltool.py', 02:04:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:04:02 INFO - '/tools/misc-python/virtualenv.py')}, 02:04:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:04:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:04:02 INFO - 'installer_path': 'installer.exe', 02:04:02 INFO - 'log_level': 'info', 02:04:02 INFO - 'log_name': 'talos', 02:04:02 INFO - 'log_to_console': True, 02:04:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:04:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:04:02 INFO - 'opt_config_files': (), 02:04:02 INFO - 'pip_index': False, 02:04:02 INFO - 'sps_profile': False, 02:04:02 INFO - 'sps_profile_interval': 0, 02:04:02 INFO - 'suite': 'dromaeojs', 02:04:02 INFO - 'system_bits': '32', 02:04:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:04:02 INFO - 'title': 'talos-linux64-ix-030', 02:04:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:04:02 INFO - 'use_talos_json': True, 02:04:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:04:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:04:02 INFO - 'work_dir': 'build'} 02:04:02 INFO - ##### 02:04:02 INFO - ##### Running clobber step. 02:04:02 INFO - ##### 02:04:02 INFO - Running pre-action listener: _resource_record_pre_action 02:04:02 INFO - Running main action method: clobber 02:04:02 INFO - rmtree: /builds/slave/test/build 02:04:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:04:02 INFO - Running post-action listener: _resource_record_post_action 02:04:02 INFO - ##### 02:04:02 INFO - ##### Running read-buildbot-config step. 02:04:02 INFO - ##### 02:04:02 INFO - Running pre-action listener: _resource_record_pre_action 02:04:02 INFO - Running main action method: read_buildbot_config 02:04:02 INFO - Using buildbot properties: 02:04:02 INFO - { 02:04:02 INFO - "project": "", 02:04:02 INFO - "product": "firefox", 02:04:02 INFO - "script_repo_revision": "production", 02:04:02 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 02:04:02 INFO - "repository": "", 02:04:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 02:04:02 INFO - "buildid": "20160606194329", 02:04:02 INFO - "pgo_build": "True", 02:04:02 INFO - "basedir": "/builds/slave/test", 02:04:02 INFO - "buildnumber": 125, 02:04:02 INFO - "slavename": "talos-linux64-ix-030", 02:04:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:04:02 INFO - "platform": "ubuntu64_hw", 02:04:02 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 02:04:02 INFO - "branch": "mozilla-beta", 02:04:02 INFO - "repo_path": "releases/mozilla-beta", 02:04:02 INFO - "revision": "1f9f6bdee31c14fd5a39485e8ae326de2928ef7d", 02:04:02 INFO - "stage_platform": "linux64-pgo", 02:04:02 INFO - "builduid": "3d31ab4f42854c829e06ac6160cc676b", 02:04:02 INFO - "slavebuilddir": "test" 02:04:02 INFO - } 02:04:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 02:04:02 INFO - Running post-action listener: _resource_record_post_action 02:04:02 INFO - ##### 02:04:02 INFO - ##### Running download-and-extract step. 02:04:02 INFO - ##### 02:04:02 INFO - Running pre-action listener: _resource_record_pre_action 02:04:02 INFO - Running main action method: download_and_extract 02:04:02 INFO - mkdir: /builds/slave/test/build/tests 02:04:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:02 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:04:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:04:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:04:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:04:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:04:03 INFO - Downloaded 1327 bytes. 02:04:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:04:03 INFO - Using the following test package requirements: 02:04:03 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:04:03 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:04:03 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 02:04:03 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:04:03 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 02:04:03 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:04:03 INFO - u'jsshell-linux-x86_64.zip'], 02:04:03 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:04:03 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 02:04:03 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:04:03 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:04:03 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 02:04:03 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:04:03 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 02:04:03 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:04:03 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 02:04:03 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:04:03 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 02:04:03 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:03 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:04:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:04:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:04:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:04:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:04:04 INFO - Downloaded 24176679 bytes. 02:04:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:04:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:04:05 INFO - Return code: 0 02:04:05 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:04:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:05 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:04:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:04:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:04:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 02:04:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:04:07 INFO - Downloaded 24176679 bytes. 02:04:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:04:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:04:08 INFO - Return code: 0 02:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:08 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:04:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:04:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:04:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 02:04:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:04:10 INFO - Downloaded 10840145 bytes. 02:04:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:04:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:04:10 INFO - Return code: 0 02:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:10 INFO - https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:04:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:04:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:04:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:04:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:04:14 INFO - Downloaded 55996763 bytes. 02:04:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:04:14 INFO - mkdir: /builds/slave/test/properties 02:04:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:04:14 INFO - Writing to file /builds/slave/test/properties/build_url 02:04:14 INFO - Contents: 02:04:14 INFO - build_url:https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 02:04:15 INFO - Running post-action listener: _resource_record_post_action 02:04:15 INFO - Running post-action listener: set_extra_try_arguments 02:04:15 INFO - ##### 02:04:15 INFO - ##### Running populate-webroot step. 02:04:15 INFO - ##### 02:04:15 INFO - Running pre-action listener: _resource_record_pre_action 02:04:15 INFO - Running main action method: populate_webroot 02:04:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:04:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:04:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:04:15 INFO - '--tppagecycles', 02:04:15 INFO - '7'], 02:04:15 INFO - 'tests': ['tsvgm']}}, 02:04:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:04:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:04:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:04:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:04:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:04:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:04:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['damp', 'tps']}, 02:04:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'tests': ['damp', 'tps']}, 02:04:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['dromaeo_dom']}, 02:04:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:04:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'other-e10s': {'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['tsvgx', 02:04:15 INFO - 'tsvgr_opacity', 02:04:15 INFO - 'tart', 02:04:15 INFO - 'tscrollx', 02:04:15 INFO - 'cart']}, 02:04:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:04:15 INFO - 'tsvgr_opacity', 02:04:15 INFO - 'tart', 02:04:15 INFO - 'tscrollx', 02:04:15 INFO - 'cart']}, 02:04:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['tp5o']}, 02:04:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'tests': ['tp5o']}, 02:04:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'talos_options': ['--disable-e10s', 02:04:15 INFO - '--xperf_path', 02:04:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:04:15 INFO - 'tests': ['tp5n']}, 02:04:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'talos_options': ['--xperf_path', 02:04:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:04:15 INFO - 'tests': ['tp5n']}}, 02:04:15 INFO - 'talos.zip': {'path': '', 02:04:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:04:15 INFO - Running post-action listener: _resource_record_post_action 02:04:15 INFO - ##### 02:04:15 INFO - ##### Running create-virtualenv step. 02:04:15 INFO - ##### 02:04:15 INFO - Running pre-action listener: _resource_record_pre_action 02:04:15 INFO - Running main action method: create_virtualenv 02:04:15 INFO - Creating virtualenv /builds/slave/test/build/venv 02:04:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:04:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:04:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:04:15 INFO - Using real prefix '/usr' 02:04:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:04:16 INFO - Installing distribute.............................................................................................................................................................................................done. 02:04:18 INFO - Installing pip.................done. 02:04:18 INFO - Return code: 0 02:04:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ed46bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c887a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:04:18 INFO - Using env: {'DISPLAY': ':0', 02:04:18 INFO - 'HOME': '/home/cltbld', 02:04:18 INFO - 'LANG': 'en_US.UTF-8', 02:04:18 INFO - 'LANGUAGE': 'en_US:en', 02:04:18 INFO - 'LOGNAME': 'cltbld', 02:04:18 INFO - 'MAIL': '/var/mail/cltbld', 02:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:18 INFO - 'MOZ_NO_REMOTE': '1', 02:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:18 INFO - 'NO_EM_RESTART': '1', 02:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:18 INFO - 'PWD': '/builds/slave/test', 02:04:18 INFO - 'SHELL': '/bin/bash', 02:04:18 INFO - 'SHLVL': '1', 02:04:18 INFO - 'TERM': 'linux', 02:04:18 INFO - 'TMOUT': '86400', 02:04:18 INFO - 'USER': 'cltbld', 02:04:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 02:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:18 INFO - '_': '/tools/buildbot/bin/python'} 02:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:04:19 INFO - Cleaning up... 02:04:19 INFO - Return code: 0 02:04:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ed46bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c887a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:04:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:04:19 INFO - Using env: {'DISPLAY': ':0', 02:04:19 INFO - 'HOME': '/home/cltbld', 02:04:19 INFO - 'LANG': 'en_US.UTF-8', 02:04:19 INFO - 'LANGUAGE': 'en_US:en', 02:04:19 INFO - 'LOGNAME': 'cltbld', 02:04:19 INFO - 'MAIL': '/var/mail/cltbld', 02:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:19 INFO - 'MOZ_NO_REMOTE': '1', 02:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:19 INFO - 'NO_EM_RESTART': '1', 02:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:19 INFO - 'PWD': '/builds/slave/test', 02:04:19 INFO - 'SHELL': '/bin/bash', 02:04:19 INFO - 'SHLVL': '1', 02:04:19 INFO - 'TERM': 'linux', 02:04:19 INFO - 'TMOUT': '86400', 02:04:19 INFO - 'USER': 'cltbld', 02:04:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 02:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:19 INFO - '_': '/tools/buildbot/bin/python'} 02:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:19 INFO - Downloading/unpacking psutil>=0.7.1 02:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:04:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:04:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:04:21 INFO - Installing collected packages: psutil 02:04:21 INFO - Running setup.py install for psutil 02:04:21 INFO - building 'psutil._psutil_linux' extension 02:04:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:04:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:04:21 INFO - building 'psutil._psutil_posix' extension 02:04:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:04:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:04:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:04:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:04:21 INFO - Successfully installed psutil 02:04:21 INFO - Cleaning up... 02:04:21 INFO - Return code: 0 02:04:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ed46bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c887a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:04:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:04:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:04:21 INFO - Using env: {'DISPLAY': ':0', 02:04:21 INFO - 'HOME': '/home/cltbld', 02:04:21 INFO - 'LANG': 'en_US.UTF-8', 02:04:21 INFO - 'LANGUAGE': 'en_US:en', 02:04:21 INFO - 'LOGNAME': 'cltbld', 02:04:21 INFO - 'MAIL': '/var/mail/cltbld', 02:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:21 INFO - 'MOZ_NO_REMOTE': '1', 02:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:21 INFO - 'NO_EM_RESTART': '1', 02:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:21 INFO - 'PWD': '/builds/slave/test', 02:04:21 INFO - 'SHELL': '/bin/bash', 02:04:21 INFO - 'SHLVL': '1', 02:04:21 INFO - 'TERM': 'linux', 02:04:21 INFO - 'TMOUT': '86400', 02:04:21 INFO - 'USER': 'cltbld', 02:04:21 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 02:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:21 INFO - '_': '/tools/buildbot/bin/python'} 02:04:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:04:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:04:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:04:24 INFO - Installing collected packages: mozsystemmonitor 02:04:24 INFO - Running setup.py install for mozsystemmonitor 02:04:24 INFO - Successfully installed mozsystemmonitor 02:04:24 INFO - Cleaning up... 02:04:24 INFO - Return code: 0 02:04:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ed46bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c887a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:04:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:04:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:04:24 INFO - Using env: {'DISPLAY': ':0', 02:04:24 INFO - 'HOME': '/home/cltbld', 02:04:24 INFO - 'LANG': 'en_US.UTF-8', 02:04:24 INFO - 'LANGUAGE': 'en_US:en', 02:04:24 INFO - 'LOGNAME': 'cltbld', 02:04:24 INFO - 'MAIL': '/var/mail/cltbld', 02:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:24 INFO - 'MOZ_NO_REMOTE': '1', 02:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:24 INFO - 'NO_EM_RESTART': '1', 02:04:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:24 INFO - 'PWD': '/builds/slave/test', 02:04:24 INFO - 'SHELL': '/bin/bash', 02:04:24 INFO - 'SHLVL': '1', 02:04:24 INFO - 'TERM': 'linux', 02:04:24 INFO - 'TMOUT': '86400', 02:04:24 INFO - 'USER': 'cltbld', 02:04:24 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 02:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:24 INFO - '_': '/tools/buildbot/bin/python'} 02:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:24 INFO - Downloading/unpacking blobuploader==1.2.4 02:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:26 INFO - Downloading blobuploader-1.2.4.tar.gz 02:04:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:04:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:04:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:27 INFO - Downloading docopt-0.6.1.tar.gz 02:04:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:04:27 INFO - Installing collected packages: blobuploader, requests, docopt 02:04:27 INFO - Running setup.py install for blobuploader 02:04:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:04:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:04:27 INFO - Running setup.py install for requests 02:04:27 INFO - Running setup.py install for docopt 02:04:27 INFO - Successfully installed blobuploader requests docopt 02:04:27 INFO - Cleaning up... 02:04:27 INFO - Return code: 0 02:04:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ed46bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c887a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:04:27 INFO - Using env: {'DISPLAY': ':0', 02:04:27 INFO - 'HOME': '/home/cltbld', 02:04:27 INFO - 'LANG': 'en_US.UTF-8', 02:04:27 INFO - 'LANGUAGE': 'en_US:en', 02:04:27 INFO - 'LOGNAME': 'cltbld', 02:04:27 INFO - 'MAIL': '/var/mail/cltbld', 02:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:27 INFO - 'MOZ_NO_REMOTE': '1', 02:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:27 INFO - 'NO_EM_RESTART': '1', 02:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:27 INFO - 'PWD': '/builds/slave/test', 02:04:27 INFO - 'SHELL': '/bin/bash', 02:04:27 INFO - 'SHLVL': '1', 02:04:27 INFO - 'TERM': 'linux', 02:04:27 INFO - 'TMOUT': '86400', 02:04:27 INFO - 'USER': 'cltbld', 02:04:27 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 02:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:27 INFO - '_': '/tools/buildbot/bin/python'} 02:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:04:27 INFO - Running setup.py (path:/tmp/pip-IZQ62q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:04:28 INFO - Running setup.py (path:/tmp/pip-oEd59W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:04:28 INFO - Running setup.py (path:/tmp/pip-5_sd5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:04:28 INFO - Running setup.py (path:/tmp/pip-oqp4g9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:04:28 INFO - Running setup.py (path:/tmp/pip-7Ekdwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:04:28 INFO - Running setup.py (path:/tmp/pip-oxVbRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:04:28 INFO - Running setup.py (path:/tmp/pip-xCRsr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:04:28 INFO - Running setup.py (path:/tmp/pip-ZmF1Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:04:28 INFO - Running setup.py (path:/tmp/pip-efs6Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:04:28 INFO - Running setup.py (path:/tmp/pip-6H1na3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:04:28 INFO - Running setup.py (path:/tmp/pip-TXJFkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:04:28 INFO - Running setup.py (path:/tmp/pip-UxyXHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:04:28 INFO - Running setup.py (path:/tmp/pip-Qu2I9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:04:28 INFO - Running setup.py (path:/tmp/pip-6V2FUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:04:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:28 INFO - Running setup.py (path:/tmp/pip-HHlx6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:04:29 INFO - Running setup.py (path:/tmp/pip-4LfMfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:04:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:04:29 INFO - Running setup.py (path:/tmp/pip-FtbNg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:04:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:04:29 INFO - Running setup.py install for manifestparser 02:04:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:04:29 INFO - Running setup.py install for mozcrash 02:04:29 INFO - Running setup.py install for mozdebug 02:04:29 INFO - Running setup.py install for mozdevice 02:04:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:04:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:04:29 INFO - Running setup.py install for mozfile 02:04:29 INFO - Running setup.py install for mozhttpd 02:04:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:04:29 INFO - Running setup.py install for mozinfo 02:04:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:04:29 INFO - Running setup.py install for mozInstall 02:04:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:04:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:04:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:04:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:04:29 INFO - Running setup.py install for mozleak 02:04:30 INFO - Running setup.py install for mozlog 02:04:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:04:30 INFO - Running setup.py install for moznetwork 02:04:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:04:30 INFO - Running setup.py install for mozprocess 02:04:30 INFO - Running setup.py install for mozprofile 02:04:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:04:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:04:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:04:30 INFO - Running setup.py install for mozrunner 02:04:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:04:30 INFO - Running setup.py install for mozscreenshot 02:04:30 INFO - Running setup.py install for moztest 02:04:30 INFO - Running setup.py install for mozversion 02:04:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:04:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:04:30 INFO - Cleaning up... 02:04:30 INFO - Return code: 0 02:04:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ed46bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c887a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:04:30 INFO - Using env: {'DISPLAY': ':0', 02:04:30 INFO - 'HOME': '/home/cltbld', 02:04:30 INFO - 'LANG': 'en_US.UTF-8', 02:04:30 INFO - 'LANGUAGE': 'en_US:en', 02:04:30 INFO - 'LOGNAME': 'cltbld', 02:04:30 INFO - 'MAIL': '/var/mail/cltbld', 02:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:30 INFO - 'MOZ_NO_REMOTE': '1', 02:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:30 INFO - 'NO_EM_RESTART': '1', 02:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:30 INFO - 'PWD': '/builds/slave/test', 02:04:30 INFO - 'SHELL': '/bin/bash', 02:04:30 INFO - 'SHLVL': '1', 02:04:30 INFO - 'TERM': 'linux', 02:04:30 INFO - 'TMOUT': '86400', 02:04:30 INFO - 'USER': 'cltbld', 02:04:30 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 02:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:30 INFO - '_': '/tools/buildbot/bin/python'} 02:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:04:31 INFO - Running setup.py (path:/tmp/pip-cgnNik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:04:31 INFO - Running setup.py (path:/tmp/pip-jGN9nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:04:31 INFO - Running setup.py (path:/tmp/pip-ew86nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:04:31 INFO - Running setup.py (path:/tmp/pip-w6L8UD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:04:31 INFO - Running setup.py (path:/tmp/pip-JadYU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:04:31 INFO - Running setup.py (path:/tmp/pip-lLOKMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:04:31 INFO - Running setup.py (path:/tmp/pip-XfUOqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:04:31 INFO - Running setup.py (path:/tmp/pip-patOPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:04:31 INFO - Running setup.py (path:/tmp/pip-rgRMPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:04:31 INFO - Running setup.py (path:/tmp/pip-EeVjQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:04:31 INFO - Running setup.py (path:/tmp/pip-tix0Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:04:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:04:31 INFO - Running setup.py (path:/tmp/pip-4HZITs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:04:32 INFO - Running setup.py (path:/tmp/pip-sdNlYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:04:32 INFO - Running setup.py (path:/tmp/pip-YfI5vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:32 INFO - Running setup.py (path:/tmp/pip-Z7XHzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:04:32 INFO - Running setup.py (path:/tmp/pip-Fzypkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:04:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:04:32 INFO - Running setup.py (path:/tmp/pip-9uwbD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:04:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:34 INFO - Downloading blessings-1.6.tar.gz 02:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:04:34 INFO - Installing collected packages: blessings 02:04:34 INFO - Running setup.py install for blessings 02:04:34 INFO - Successfully installed blessings 02:04:34 INFO - Cleaning up... 02:04:34 INFO - Return code: 0 02:04:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:04:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:04:34 INFO - Reading from file tmpfile_stdout 02:04:34 INFO - Current package versions: 02:04:34 INFO - argparse == 1.2.1 02:04:34 INFO - blessings == 1.6 02:04:34 INFO - blobuploader == 1.2.4 02:04:34 INFO - docopt == 0.6.1 02:04:34 INFO - manifestparser == 1.1 02:04:34 INFO - mozInstall == 1.12 02:04:34 INFO - mozcrash == 0.17 02:04:34 INFO - mozdebug == 0.1 02:04:34 INFO - mozdevice == 0.48 02:04:34 INFO - mozfile == 1.2 02:04:34 INFO - mozhttpd == 0.7 02:04:34 INFO - mozinfo == 0.9 02:04:34 INFO - mozleak == 0.1 02:04:34 INFO - mozlog == 3.1 02:04:34 INFO - moznetwork == 0.27 02:04:34 INFO - mozprocess == 0.22 02:04:34 INFO - mozprofile == 0.28 02:04:34 INFO - mozrunner == 6.11 02:04:34 INFO - mozscreenshot == 0.1 02:04:34 INFO - mozsystemmonitor == 0.0 02:04:34 INFO - moztest == 0.7 02:04:34 INFO - mozversion == 1.4 02:04:34 INFO - psutil == 3.1.1 02:04:34 INFO - requests == 1.2.3 02:04:34 INFO - wsgiref == 0.1.2 02:04:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ed46bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c887a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:04:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:04:34 INFO - Using env: {'DISPLAY': ':0', 02:04:34 INFO - 'HOME': '/home/cltbld', 02:04:34 INFO - 'LANG': 'en_US.UTF-8', 02:04:34 INFO - 'LANGUAGE': 'en_US:en', 02:04:34 INFO - 'LOGNAME': 'cltbld', 02:04:34 INFO - 'MAIL': '/var/mail/cltbld', 02:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:34 INFO - 'MOZ_NO_REMOTE': '1', 02:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:34 INFO - 'NO_EM_RESTART': '1', 02:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:34 INFO - 'PWD': '/builds/slave/test', 02:04:34 INFO - 'SHELL': '/bin/bash', 02:04:34 INFO - 'SHLVL': '1', 02:04:34 INFO - 'TERM': 'linux', 02:04:34 INFO - 'TMOUT': '86400', 02:04:34 INFO - 'USER': 'cltbld', 02:04:34 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 02:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:34 INFO - '_': '/tools/buildbot/bin/python'} 02:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:04:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:04:34 INFO - Cleaning up... 02:04:34 INFO - Return code: 0 02:04:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ed46bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c887a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:04:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:04:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:04:34 INFO - Using env: {'DISPLAY': ':0', 02:04:34 INFO - 'HOME': '/home/cltbld', 02:04:34 INFO - 'LANG': 'en_US.UTF-8', 02:04:34 INFO - 'LANGUAGE': 'en_US:en', 02:04:34 INFO - 'LOGNAME': 'cltbld', 02:04:34 INFO - 'MAIL': '/var/mail/cltbld', 02:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:34 INFO - 'MOZ_NO_REMOTE': '1', 02:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:34 INFO - 'NO_EM_RESTART': '1', 02:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:34 INFO - 'PWD': '/builds/slave/test', 02:04:34 INFO - 'SHELL': '/bin/bash', 02:04:34 INFO - 'SHLVL': '1', 02:04:34 INFO - 'TERM': 'linux', 02:04:34 INFO - 'TMOUT': '86400', 02:04:34 INFO - 'USER': 'cltbld', 02:04:34 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 02:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:34 INFO - '_': '/tools/buildbot/bin/python'} 02:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:35 INFO - Downloading/unpacking jsonschema 02:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:04:37 INFO - Downloading/unpacking functools32 (from jsonschema) 02:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:04:37 INFO - warning: no files found matching '*.txt' 02:04:37 INFO - no previously-included directories found matching 'build' 02:04:37 INFO - no previously-included directories found matching 'dist' 02:04:37 INFO - no previously-included directories found matching '.git*' 02:04:37 INFO - Installing collected packages: jsonschema, functools32 02:04:37 INFO - Running setup.py install for functools32 02:04:37 INFO - warning: no files found matching '*.txt' 02:04:37 INFO - no previously-included directories found matching 'build' 02:04:37 INFO - no previously-included directories found matching 'dist' 02:04:37 INFO - no previously-included directories found matching '.git*' 02:04:37 INFO - Successfully installed jsonschema functools32 02:04:37 INFO - Cleaning up... 02:04:37 INFO - Return code: 0 02:04:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ed46bff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c887a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:04:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:04:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:04:37 INFO - Using env: {'DISPLAY': ':0', 02:04:37 INFO - 'HOME': '/home/cltbld', 02:04:37 INFO - 'LANG': 'en_US.UTF-8', 02:04:37 INFO - 'LANGUAGE': 'en_US:en', 02:04:37 INFO - 'LOGNAME': 'cltbld', 02:04:37 INFO - 'MAIL': '/var/mail/cltbld', 02:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:37 INFO - 'MOZ_NO_REMOTE': '1', 02:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:37 INFO - 'NO_EM_RESTART': '1', 02:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:37 INFO - 'PWD': '/builds/slave/test', 02:04:37 INFO - 'SHELL': '/bin/bash', 02:04:37 INFO - 'SHLVL': '1', 02:04:37 INFO - 'TERM': 'linux', 02:04:37 INFO - 'TMOUT': '86400', 02:04:37 INFO - 'USER': 'cltbld', 02:04:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 02:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:37 INFO - '_': '/tools/buildbot/bin/python'} 02:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:37 INFO - Downloading/unpacking flake8 02:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:04:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:04:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:04:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:04:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:04:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:04:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:04:40 INFO - no previously-included directories found matching 'docs/_build' 02:04:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:04:40 INFO - Running setup.py install for pep8 02:04:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:04:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:04:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:04:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:04:40 INFO - no previously-included directories found matching 'docs/_build' 02:04:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:04:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:04:40 INFO - Cleaning up... 02:04:40 INFO - Return code: 0 02:04:40 INFO - Running post-action listener: _resource_record_post_action 02:04:40 INFO - Running post-action listener: _start_resource_monitoring 02:04:40 INFO - Starting resource monitoring. 02:04:40 INFO - ##### 02:04:40 INFO - ##### Running install step. 02:04:40 INFO - ##### 02:04:40 INFO - Running pre-action listener: _resource_record_pre_action 02:04:40 INFO - Running main action method: install 02:04:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:04:40 INFO - Reading from file tmpfile_stdout 02:04:40 INFO - Detecting whether we're running mozinstall >=1.0... 02:04:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:04:40 INFO - Reading from file tmpfile_stdout 02:04:40 INFO - Output received: 02:04:40 INFO - Usage: mozinstall [options] installer 02:04:40 INFO - Options: 02:04:40 INFO - -h, --help show this help message and exit 02:04:40 INFO - -d DEST, --destination=DEST 02:04:40 INFO - Directory to install application into. [default: 02:04:40 INFO - "/builds/slave/test"] 02:04:40 INFO - --app=APP Application being installed. [default: firefox] 02:04:40 INFO - mkdir: /builds/slave/test/build/application 02:04:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:04:54 INFO - Reading from file tmpfile_stdout 02:04:54 INFO - Output received: 02:04:54 INFO - /builds/slave/test/build/application/firefox/firefox 02:04:54 INFO - Running post-action listener: _resource_record_post_action 02:04:54 INFO - ##### 02:04:54 INFO - ##### Running run-tests step. 02:04:54 INFO - ##### 02:04:54 INFO - Running pre-action listener: _resource_record_pre_action 02:04:54 INFO - Running main action method: run_tests 02:04:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:04:54 INFO - Python 2.7.3 02:04:54 INFO - Return code: 0 02:04:54 INFO - grabbing minidump binary from tooltool 02:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:04:54 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c87410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c88310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c887a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:04:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:04:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:04:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:04:54 INFO - Return code: 0 02:04:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:04:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:04:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:04:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:04:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:04:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:04:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:04:55 INFO - Return code: 0 02:04:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:04:55 INFO - Using env: {'DISPLAY': ':0', 02:04:55 INFO - 'HOME': '/home/cltbld', 02:04:55 INFO - 'LANG': 'en_US.UTF-8', 02:04:55 INFO - 'LANGUAGE': 'en_US:en', 02:04:55 INFO - 'LOGNAME': 'cltbld', 02:04:55 INFO - 'MAIL': '/var/mail/cltbld', 02:04:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:04:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:55 INFO - 'MOZ_NO_REMOTE': '1', 02:04:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:04:55 INFO - 'NO_EM_RESTART': '1', 02:04:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:55 INFO - 'PWD': '/builds/slave/test', 02:04:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:04:55 INFO - 'SHELL': '/bin/bash', 02:04:55 INFO - 'SHLVL': '1', 02:04:55 INFO - 'TERM': 'linux', 02:04:55 INFO - 'TMOUT': '86400', 02:04:55 INFO - 'USER': 'cltbld', 02:04:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104', 02:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:55 INFO - '_': '/tools/buildbot/bin/python'} 02:04:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:04:55 INFO - mozversion application_buildid: 20160606194329 02:04:55 INFO - mozversion application_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 02:04:55 INFO - mozversion application_display_name: Firefox 02:04:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:04:55 INFO - mozversion application_name: Firefox 02:04:55 INFO - mozversion application_remotingname: firefox 02:04:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:04:55 INFO - mozversion application_vendor: Mozilla 02:04:55 INFO - mozversion application_version: 48.0 02:04:55 INFO - mozversion platform_buildid: 20160606194329 02:04:55 INFO - mozversion platform_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 02:04:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:04:55 INFO - mozversion platform_version: 48.0 02:04:55 INFO - using testdate: 1465290295 02:04:55 INFO - actual date: 1465290295 02:04:55 INFO - starting webserver on 'localhost:50933' 02:04:55 INFO - SUITE-START | Running 2 tests 02:04:55 INFO - TEST-START | dromaeo_css 02:04:55 INFO - operating with platform_type : linux_ 02:04:55 INFO - Initialising browser for dromaeo_css test... 02:04:55 INFO - TEST-INFO | started process 9351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFBHrXS/profile http://localhost:50933/getInfo.html) 02:04:59 INFO - PROCESS | 9351 | __metrics Screen width/height:1600/1200 02:04:59 INFO - PROCESS | 9351 | colorDepth:24 02:04:59 INFO - PROCESS | 9351 | Browser inner width/height: 1024/697 02:04:59 INFO - PROCESS | 9351 | __metrics 02:05:00 ERROR - PROCESS | 9351 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:05:01 INFO - TEST-INFO | 9351: exit 0 02:05:01 INFO - Browser initialized. 02:05:01 INFO - Running cycle 1/1 for dromaeo_css test... 02:05:01 INFO - TEST-INFO | started process 9441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFBHrXS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:05:13 INFO - PROCESS | 9441 | RSS: Main: 140767232 02:05:13 INFO - PROCESS | 9441 | 02:06:04 INFO - PROCESS | 9441 | 1465290364613 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:08:11 INFO - PROCESS | 9441 | Cycle 1(1): loaded http://localhost:50933/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50933/tests/dromaeo/cssquery-ext.html) 02:08:12 INFO - PROCESS | 9441 | RSS: Main: 252637184 02:08:12 INFO - PROCESS | 9441 | 02:11:15 INFO - PROCESS | 9441 | Cycle 1(1): loaded http://localhost:50933/tests/dromaeo/cssquery-ext.html (next: http://localhost:50933/tests/dromaeo/cssquery-jquery.html) 02:11:15 INFO - PROCESS | 9441 | RSS: Main: 224980992 02:11:15 INFO - PROCESS | 9441 | 02:14:17 INFO - PROCESS | 9441 | Cycle 1(1): loaded http://localhost:50933/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50933/tests/dromaeo/cssquery-mootools.html) 02:14:18 INFO - PROCESS | 9441 | RSS: Main: 218820608 02:14:18 INFO - PROCESS | 9441 | 02:17:19 INFO - PROCESS | 9441 | Cycle 1(1): loaded http://localhost:50933/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50933/tests/dromaeo/cssquery-prototype.html) 02:17:20 INFO - PROCESS | 9441 | RSS: Main: 216162304 02:17:20 INFO - PROCESS | 9441 | 02:20:22 INFO - PROCESS | 9441 | Cycle 1(1): loaded http://localhost:50933/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50933/tests/dromaeo/cssquery-yui.html) 02:20:23 INFO - PROCESS | 9441 | RSS: Main: 210083840 02:20:23 INFO - PROCESS | 9441 | 02:23:25 INFO - PROCESS | 9441 | Cycle 1(1): loaded http://localhost:50933/tests/dromaeo/cssquery-yui.html (next: http://localhost:50933/tests/dromaeo/cssquery-dojo.html) 02:23:26 INFO - PROCESS | 9441 | RSS: Main: 255119360 02:23:26 INFO - PROCESS | 9441 | 02:23:26 INFO - PROCESS | 9441 | __start_tp_report 02:23:26 INFO - PROCESS | 9441 | _x_x_mozilla_page_load 02:23:26 INFO - PROCESS | 9441 | _x_x_mozilla_page_load_details 02:23:26 INFO - PROCESS | 9441 | |i|pagename|runs| 02:23:26 INFO - PROCESS | 9441 | |0;dojo.html;3324.4680851063827;3351.715104216141;3353.9161520961975;3382.0868365541287;3393.3043726036167;5604.635698679583;5625.32496100468;5630.2117703521435;5631.099024156136;5654.632448890824;5634.633748806335;5649.6327738696955;5660.9433905660935;5661.688607126606;5671.347795003576;5031.2453132030305;5151.76817043233;5185.55922746567;5253.658512196714;5284.44513326101;5034.748262586856;5081.796728130888;5089.083964886319;5136.332276804029;5182.585393168538;5143.331366922295;5181.948180518184;5190.169572868342;5192.1432963560965;5228.503292187255;5129.256257842592;5145.99653067652;5185.455527169631;5204.245384419257;5204.713740744258;4890.5109489051165;5119.923201151949;5173.17229243323;5179.766910489037;5192.58459323257;5503.147012213113;5544.279243698334;5548.833534993957;5554.666719996813;5563.610547261694;5695.658260504383;6031;6043.516518678495;6061.090836374535;6077.36187700294;5917.763289468459;5922.58541902067;5995.490383317423;6008.48927841134;6046.516278697693;5607;5631.380548139701;5634.323881134208;5637.46444087811;5665.263515742927;5945.554083443759;6122.938770612237;6127.938720612737;6127.969360153171;6172.629642221481;5975.19334889793;5980.790672326448;5987.341392446914;5989.520838332923;6026.758929642853;6087.239095113111;6099.207103076572;6108.267007959073;6111.236095488064;6111.786087487006;5853.560982926212;5962.3739507351975;6017.308009578867;6018.247719035121;6029.78895738647;6023.247094113236;6067.848303792352;6075.605085669417;6078.483328917003;6082.57421980466;4530.365748795171;4543.795529201194;4545.636349092131;4551.590356867898;4575.26795712691;3990.2418540477215;4032.3145065338963;4072.1855628874346;4075.9592404076175;4117.958820411817;5851.678157701367;5875.4124587541755;5879.941200588025;5889.764409423661;5897.292324921037;6106.480949119375;6141.263048434127;6143.047827586642;6154.19995400604;6157.692115394212;5544.972275138679;5823.272090988627;5864.882702345929;5884.735186916599;5920.2895652521975;5021.949780502221;5034.244863270539;5037.823676171316;5038.420581633086;5045.672031318026;6252.843678908063;6273.498120150377;6276.246850377984;6278.183836101278;6287.402696743802;5823.912641310299;5853.03424934898;5873.148393482836;5898.1152827076285;5926.199963005025;6262.843428914313;6319.8104056878365;6324;6325.367463253638;6327.430531252209;5626.099824028136;5968.104784282393;6012.428819262163;6013.518918486423;6019.903230155434;5963.2844058713235;5967.254093238345;5994.460498555151;6028.09578563219;6028.156058151774;5847.532197424281;5851.561132914963;5851.853703657443;5854.297484301911;5855.00464920956;5663.150527420919;5699.658020518782;5835.883282334415;5889.116632505158;5903.380145084704;5833.300003999378;5835.737391817293;5836.270466191726;5845.707714614337;5868.589198756217;5950.761969521171;5961.314448838266;5969;5969.074793407029;5977.6114552553945;5574.9163762542785;5648.4633959773755;5672.234248376416;5853.94146058534;5860.238169037998 02:23:26 INFO - PROCESS | 9441 | |1;ext.html;636.9299377068521;682.2154522299356;689.4725534965752;729.9707412548305;737.0823324960425;33479.497807532876;34084;40847.38728919069;41091.79454102725;41254.38118428218;43907.3413898791;44292.33561496572;44476;44481.33278000825;44617.330740038924;8173.836523269531;8695.782605434868;8906.910930890674;8913.242374398184;8919.821603567925;8232.629531671058;10612.416317102556;10815.080718138968;10855.185861060412;10856.837147442755;10565.260431769779;10669.253152279343;10672.573097076107;10674.9466252669;10678.946605266963;10415.323004004715;10422.062014418738;10477.371357718484;10479.161667066617;10496.422696751713;10420.478976051167;10487.737806554896;10543.367397956146;10550.261481696285;10552.15582753378;44335.334969975156;44800.77599612014;44811.55188448139;44878.775606122086;44883.10233795339;3766.6986641068647;3821.3503704370323;3917.2557214129224;4135.731177473454;4373.934390984138;33699;33893.322133557434;34018.82990585056;34096.31807363839;34240;4264.808083636244;4392.472903251598;4406.2949928011685;4413.16149931512;4442.311441726538;350677;357428;359432;359588;360350.19824900967;71211;72270;72575;72703.6364818183;72743;67053.66473167604;74199;75721;76074.3373981908;76139;17714.91142544305;17741.11294435299;17844.91077544604;17874.642507150045;17879.106044697714;12716.682082947815;13614.523491677744;13751.862481375258;14026.579202623938;14057;21659.67510487344;21670.45823854416;21787.455313617287;21803.236886708888;21923;8116.350691944748;8117.391195660349;8281.8343633127;8362.958185209034;8436.535990520457;1063.56393878511;1075.188232884183;1205.312971606176;1235.3761350517932;1270.8729127087402;34272;34320.31359372799;35010;35258.118547036014;35326.82336588352;1140.43548443521;1222.4010234984794;1248.656619429664;1252.4990003998473;1264.962051138449;15695.607609809846;16086.211461887828;16365.672686546202;16693.582660433345;17272.913635431993;444591;446044;447679;447908;448942;60820.39179608147;61424;61485.38514614886;61521;61680.69159654173;1414.6039109049277;1501.6546194375355;1516.9544913652608;1533.9079655220946;1545.706315800017;29935.55096673508;30416.391672166876;34662.65337346695;34974;35913.82043089768;55612.443875560726;56406;56641;56647;56655.43344566502;461110;466214;466492;467137;467843;40941;47203.76398117987;47616.52383476121;48066.27900581564;48232.758836206995;46656.30015549837;46657.53342466532;47338.52661473479;47433.762831185624;47849;39308.80345598254;39668.603313966494;39961.600383995785;40135.79932100321;40543;38457.42313865238;38972;40399;42580.5741942589;43899.561004390824;43923;44547.554524455634;44652.77673611741;44662.106757864014;44787;37117.443238350905;38169.618303816605;38933.80533097316;39521.80239098786;39624;29144.27139321534;29358.082443724692;30069.849650751607;30132.69867301299;30507.2373190672 02:23:26 INFO - PROCESS | 9441 | |2;jquery.html;406.24235800232566;411.530854825499;412.6719258189739;414.76565740356693;424.32955929631186;18176.909115454404;18395.908020459894;19288.614227715436;19305.227790888366;19307.517312067186;19424.125914333854;19686;19955.401337959847;20565.38303850883;20591.485212869648;5344.839654810362;5649.6327738696855;5696.25948626679;5919.704014799265;5934.703264836762;5658.632188907728;5679.971600141994;5690.317161940573;5715.799947001856;5720.141978703186;5687.800926967557;6014.278286605613;6020.759169633209;6021.367756385582;6032.306284777241;5683.431656834284;5838.2994040715175;5877.441643043904;5880.176775251447;5881.147233651118;5667.858303542444;5673;5730.799422020209;5742.856428589277;5743.253377060997;13768.793468097987;13984.16095034291;15339;23461;23574.882125589433;2353.423411264251;2452.914148004811;2466.5313590417763;2512.2337687005456;2549.9362515937064;9865.260105492116;9989.800203995952;10051.396916185053;10298.897011029943;10518.158547316272;1959.964146997314;1973.9309124180584;1990.3431867483841;2025.5442525431806;2103.7475502939747;59301.40698593002;60526.69736651333;82235.5888220561;83401.58299208464;84654.57672711597;9820.45987470696;10214.540345684461;10235.59057637701;10334.793304133875;10668.14654827612;12775.61673149807;13847.376868040761;13851.792223116661;14649.780253296209;15252.771208431883;8086.757397278091;8191.508509489449;8408.159184081544;8411.285040771481;8432.283255923316;8079.959600202079;8173.713920012771;8177.672893084329;8214.096449390563;8291;4667.929981050287;4746.28805679144;4759.286107083965;4860.854174374775;4890.975545122252;1968.193040853272;1982.3260091568936;1983.5338695406567;1997.500624843789;2005.8896760678304;1009.3136667066466;1046.5604446132643;1086.1310951239136;1137.5790957345835;1145.8510393648771;18875.811241887404;18883.105058981946;19165.32921347746;19190.904045479685;19782.802171978095;1047.9947600262103;1114.147677027075;1134.8014097532898;1149.5516748468103;1166.2710805746408;10669.78660426787;10698.144148468104;10893.891061089445;10981.725456863642;11069.391183484824;542078;554289;570749;587118;589963;89393;89542.55228723814;99581;101800.96398071997;107031.46484267684;1175.4651633506735;1179.0626451970704;1182.9763404731857;1191.4817054581285;1228.8402507673945;16565.668686626443;16636;16818.915905420396;16948;16961.74557381665;31259.374812504077;37940.810295948344;37977.050573735876;40107.59892401039;42036.36945445882;57653;59302.40697592969;59349.703251485196;59680;59946.700266500135;8272.958635206785;8374.036985746474;8497.150284971452;8591.140885911358;8766.517841518522;9540.475273860004;13390.464381424634;13678.110922790385;13699.589012329647;13734.313284335543;11756.882431175578;12127.454264558293;12157.635270941886;12220.511179553074;12241.938790305992;7082.220955694766;8629;10549.261551691616;12134.271943683407;12384.071194660257;6857.622830744357;9436.52817359143;12613.30626815534;12662.873371266169;13058.824705776526;8914.598843051948;9034.27725781949;9062.501562413867;9250.907490925274;9311.348205625542;11687.88312116868;11697.2981621103;11776.941115294369;11802.173847830569;11833.408329583313 02:23:26 INFO - PROCESS | 9441 | |3;mootools.html;1414.8231471066117;1559.812822461305;1568.85095915888;1778.1240790965535;1922.567422329976;8188.54962977036;8430.241278284953;8436.282915952152;8450;8454.070052294242;8237.423380363376;8369.079401265855;8422.789430264247;8423.831523369528;8428.704995325164;2331.9883400583017;2350.4946436516148;2355.0697474497565;2355.1639168095335;2356.045801450415;2381.3570336009266;2391.1391898916377;2437.573424650679;2438.8414753041084;2445.193086281523;2371.8221133414977;2396.892139853711;2413.191580820427;2414.6981627296586;2416.9758302416926;2359.6696462495265;2381.559411508868;2394.2817154853474;2394.8682822444757;2427.7693619106158;2317.73346065203;2403.471236328005;2404.759524047581;2412.5657381671294;2417.3473162246096;6926.58440493572;8174.836503269901;8644.870326945102;8672.913270867273;8694.826103477895;5152.304438900738;5214.374275086976;5246.632735708502;5254.8686282842855;5264.578833693334;3514;3527.9294414111832;3538.168530395355;3590.6588874056924;3597.190632107781;1079.1151255970108;1082.0099608857886;1127.9735440748962;1129.6328693174669;1133.4955944604653;11751;12269.693257668541;12277.324747138904;12288.139830211889;12300.384980750927;4597.149527337453;4605.171069207575;4669.626429885601;4703.95296047042;4716.3632909557455;10417.9479102604;10426.843597346045;10427.530761115768;10427.791444171075;10442.947785261176;5402.91895621566;5408.45915408456;5411.161270003156;5417.945820541823;5419.105847535191;4864.732439715779;4913.926291105637;4914.410270767531;4918.311436398907;4922.114019476457;3693.169036966715;3718.6095459976855;3730.8880733578035;3736.4208547675153;3745.250949810049;1152.251036826053;1160.6576060062303;1164.7088227943013;1171.812509998396;1171.9531218751154;937.3813283233034;942.9124744233824;1006.2453160129902;1011.0597144655394;1044.3107549017611;5980.342162362137;6003.8198854034445;6008.3390827009;6106.114613381035;6123.2652081750475;1061.3631820907394;1062.5909025025421;1075.1398880895254;1076.8815430302661;1080.5947769586405;4235.978820105941;4293.635041021485;4298.78506074695;4343.435353404037;4352.586504282088;10332.070113689804;10487.790244195226;10567.15462762977;10605.204609654307;10749.140068794477;10463.581456741797;10483.947580262202;10596.788064238672;10637.787244255072;10639.574417023387;8128.227818357246;8135.918640813635;8274.503529788231;8336.8332633347;8366.163383661707;5955.851103722442;5962.582619216787;6034.125051867367;6076;6098.969505152623;9103.453792772454;9420.670276540288;9526.237900968044;9694.272929530172;9745.561449734922;9055.411398259355;9243.537823108683;9345.859812102688;9438.764030899283;9450.243980481682;7403.8149046274275;7406.925930740624;7437.330640242404;7443.888341674771;7488.438367122597;7718;7895.289423951872;7921.643526041457;7927.801804954922;7954.522728636301;7523.8495230093995;7628.313451789366;7720.613969301625;7732.9226707732205;7805.375569954276;7506.361959233308;7518.624068796647;7636.694532218649;7671.808204794925;7705.22947705225;6856.314368563104;6994.405475534637;6999.965000174967;7053.647317634201;7113.110861142357;4482.372467854438;5280.841574752763;5334.51989320963;5387.757550910297;5412.675239485643;5221.164613661796;5247.4490178530705;5305.442928492453;5359.785608575613;5380.784768609368 02:23:26 INFO - PROCESS | 9441 | |4;prototype.html;340.18355945730247;340.88409940620187;341.693024182502;352.04068912214217;353.29693909120823;6158.076288556713;6272.65500397478;6275.717592708328;6289.528285378592;6337.968310158454;6281.057841323804;6310.211223597051;6311.116443697886;6312.905306420396;6313.463355614778;4824.17988941879;4824.927626085611;4826;4834.274858771178;4837.298591704192;4841.128596852565;4842.927356089662;4846.418429788413;4853.199222128344;4863.732494712789;4777.880552986186;4798.232282834747;4803.903921921559;4809.254565542329;4811.566958973692;4697.342372067913;4791.568758811689;4815.518448155174;4821.325014497973;4829.7585120744;4218.430511880888;4226.830926762926;4234.745915245096;4240.851570195059;4241.978790106061;6011.458968692795;6016.338202797689;6107.572469927107;6110.175126357929;6121.204243448323;5598.58010649203;5612.130119831392;5612.971935140339;5614.887702245932;5615.494605485485;6635.502337324671;6641.335866413368;6642.867142657168;6648.268690444047;6661.866762664768;4488.147252022138;4699.389079419653;4713.175194341011;4715.764211789431;4717.198076327033;6651.135352404156;6864.519483636147;6948.27043160471;7015.508914375996;7035.261297563733;4558.1795276849825;4573.268277075718;4575.95424045762;4620.722756634613;4642.001969576557;4720.291956206596;4734.7159170449195;4740.265258884879;4744.240921452551;4754.358161648202;5244.868878277997;5360.517553420133;5406.8918621627345;5421.620486565981;5510.366307874566;6615.470762339001;6630.403263706193;6697.3637504437;6698.39714425704;6706.832329191711;1630.0627139394896;1663.6173680053655;1664.583854036491;1666.6583350413136;1668.7747154134036;1072.5924148823397;1077.8113830079706;1080.702806728156;1092.4323595640283;1102.5611576892072;6573.769918052845;6577.3422657733845;6590.670466476753;6591.802245932629;6592.901106483407;6929.757458488929;6954.3393377629045;6958.721651133999;6963.1296087989;6970.093887794555;6573.80278591643;6577;6577.309382514863;6581.539292249497;6585.506087043395;3722.739408241397;3754.737168398186;3756.9624303756614;3757.0607348162957;3757.1546402059316;7030.507864449542;7287.417006639456;7297.854042919112;7322.304381083895;7327.377172940253;7097.89353159703;7173;7177.784666460015;7187.89218161728;7192.784216473514;7290.489665723455;7291.635418229067;7294.598797066213;7304.2695730427595;7326.9375940488335;6827.044213809972;7032.296770322927;7034.5427547209265;7034.964825175842;7037.683304251424;6601.702923368364;6917.619530925847;6926.238113807578;6929.861402771816;6936.687849046704;7054.365107140382;7267.527610705287;7274.96362518184;7299.05112335393;7307.634618269171;4615.815367385267;4696.929546056744;4705.952940470552;4706.058788242297;4706.4822869485015;6909.1018167637885;6976.790696279119;6989.650517474004;6995.79012629622;7000.754973576104;6625.768098116543;6747.190337159376;6749.392554670103;6757.121574195323;6827.522073455009;6765.729370825112;6783.559068660521;6793.150856142982;6793.456523478011;6798.218204906301;6641.767538136142;6664.133662623828;6673.065770791996;6680.231773346128;6686.966565167338;6812.318768123148;6824.146981627297;6834.897476537756;6858.142732158481;6917.827054323682;6515.185601799775;6640.634765087966;6647.5014373921185;6654.800355989328;6673.265940746611 02:23:26 INFO - PROCESS | 9441 | |5;yui.html;872.9781755456116;907.5779762410477;915.6108653822126;923.487464457226;927.4713413354388;14996;15212.543623691294;15219.923900380483;15237.923810380946;15245.466408675698;14247.28763561823;14414.927925360385;14416.423343066292;14423.5672929812;14427.78358324626;746.4625469661862;890.3011136258023;900.4507250577176;911.3848152497071;926.4719110107242;909.4134283387211;914.5701520285455;915.9084091590854;916.1571354353977;920.3097676742443;962.6390103711109;966.8646389505475;972.5866506734645;975.9707208783713;976.599594166392;811.5009269299397;947.9194268487153;964.1997142371849;979.8236317462854;981.7398389426808;706.0221593093551;707.9981825716604;710.1691021504852;710.2223065743003;710.8507213485175;14440.71118577633;14536.127832330094;14577.562673119823;14578.416863325454;14603.050801697962;14565.854341456661;15016.924915375354;15034.17312047837;15132.394704211929;15237.238138093162;11879.584214552535;12319.63041108768;12821.871781282254;12845.48618055286;13007.349632518337;4617.30740388941;4627.95372046282;4645.5354464553275;4658.580727734487;4706.576408123286;54780.452195477934;55054;55251.44748552544;55308.44691553113;55568.72215638896;11723.765524689628;11993.760124797629;12093.697657558632;12289.815652765215;12339.62981110568;21623.56752864934;21625.3780966425;21651.025703843367;22640.207592734503;22716.432089197573;8584.39909206362;8674.175953284428;8950.507722075348;9040.547972601475;9098.135677110664;4977.751112444364;5046;5173.508516690908;5185.196294574347;5402.567794576425;3711.5917249102577;3770.038640146745;3776.9433458498142;3786.8863934082024;3791.6208379161862;622.0884952327567;642.9421352078335;672.2034389248756;673.2695025896859;675.6554157379674;705.28413660135;754.9433792465477;768.1358471719316;781.6795114003231;804.5373910001772;9282.396644218104;9374.250059995184;9412.764680883032;9481.336306458481;9556;685.6468918506973;817.1664901800249;821.6425854753202;835.6573804740027;837.8701301298308;4379.868603941887;4481.775911204427;4490.348899409567;4686.531346865286;4815.374001379798;62361;63119.684401577695;63340.36659633345;63706.36293637097;63780.36219637744;56372.43627563754;59578.702106490055;59777.402225978054;59983.700081499315;60954.39045609576;49044.26433603499;52756.73621631867;53804.192937105974;54348.45651543513;54517;9544;9577.425354478475;9696.85454718194;9891.802163956536;9900.603975840886;38366;39209.607903920594;40076.799616001736;42124.368134477394;42170.57829421666;51054.23418648798;51253.7437312811;52472.737636311576;52681;54094.459055408945;12913.741725165257;13134.343282836011;13246.801297980346;13368.197908125543;13475;14211.573652790434;14273.286335682966;14399.856001439852;14784.408623654934;14947.313905543528;13585.252811095485;13738.519151829638;13748.793768093687;14125.929370353082;14415.351309191321;13124.868751312364;13392.866071339162;13472.595822125351;13822.792658110338;13873.653158671113;13345.66635834073;13404.865951340751;13435.529756458476;13936.303184840515;14020.088694234842;11336.206465547333;11393.316401015965;11659.883401166218;11741.647750567497;11809.645710628694;11568.826467603161;11706.76586468283;11764.294142351486;11869.762604747684;11917.463714132711 02:23:26 INFO - PROCESS | 9441 | __end_tp_report 02:23:26 INFO - PROCESS | 9441 | __start_cc_report 02:23:26 INFO - PROCESS | 9441 | _x_x_mozilla_cycle_collect,887 02:23:26 INFO - PROCESS | 9441 | __end_cc_report 02:23:26 INFO - PROCESS | 9441 | __startTimestamp1465291406182__endTimestamp 02:23:26 INFO - PROCESS | 9441 | 02:23:26 INFO - PROCESS | 9441 | ------- Summary: start ------- 02:23:26 INFO - PROCESS | 9441 | Number of tests: 6 02:23:26 INFO - PROCESS | 9441 | 02:23:26 INFO - PROCESS | 9441 | [#0] dojo.html Cycles:165 Average:5600.46 Median:5851.68 stddev:636.61 (10.9%) stddev-sans-first:613.01 02:23:26 INFO - PROCESS | 9441 | Values: 3324.5 3351.7 3353.9 3382.1 3393.3 5604.6 5625.3 5630.2 5631.1 5654.6 5634.6 5649.6 5660.9 5661.7 5671.3 5031.2 5151.8 5185.6 5253.7 5284.4 5034.7 5081.8 5089.1 5136.3 5182.6 5143.3 5181.9 5190.2 5192.1 5228.5 5129.3 5146.0 5185.5 5204.2 5204.7 4890.5 5119.9 5173.2 5179.8 5192.6 5503.1 5544.3 5548.8 5554.7 5563.6 5695.7 6031.0 6043.5 6061.1 6077.4 5917.8 5922.6 5995.5 6008.5 6046.5 5607.0 5631.4 5634.3 5637.5 5665.3 5945.6 6122.9 6127.9 6128.0 6172.6 5975.2 5980.8 5987.3 5989.5 6026.8 6087.2 6099.2 6108.3 6111.2 6111.8 5853.6 5962.4 6017.3 6018.2 6029.8 6023.2 6067.8 6075.6 6078.5 6082.6 4530.4 4543.8 4545.6 4551.6 4575.3 3990.2 4032.3 4072.2 4076.0 4118.0 5851.7 5875.4 5879.9 5889.8 5897.3 6106.5 6141.3 6143.0 6154.2 6157.7 5545.0 5823.3 5864.9 5884.7 5920.3 5021.9 5034.2 5037.8 5038.4 5045.7 6252.8 6273.5 6276.2 6278.2 6287.4 5823.9 5853.0 5873.1 5898.1 5926.2 6262.8 6319.8 6324.0 6325.4 6327.4 5626.1 5968.1 6012.4 6013.5 6019.9 5963.3 5967.3 5994.5 6028.1 6028.2 5847.5 5851.6 5851.9 5854.3 5855.0 5663.2 5699.7 5835.9 5889.1 5903.4 5833.3 5835.7 5836.3 5845.7 5868.6 5950.8 5961.3 5969.0 5969.1 5977.6 5574.9 5648.5 5672.2 5853.9 5860.2 02:23:26 INFO - PROCESS | 9441 | 02:23:26 INFO - PROCESS | 9441 | [#1] ext.html Cycles:180 Average:60899.18 Median:39572.90 stddev:112305.95 (283.8%) stddev-sans-first:112529.86 02:23:26 INFO - PROCESS | 9441 | Values: 636.9 682.2 689.5 730.0 737.1 33479.5 34084.0 40847.4 41091.8 41254.4 43907.3 44292.3 44476.0 44481.3 44617.3 8173.8 8695.8 8906.9 8913.2 8919.8 8232.6 10612.4 10815.1 10855.2 10856.8 10565.3 10669.3 10672.6 10674.9 10678.9 10415.3 10422.1 10477.4 10479.2 10496.4 10420.5 10487.7 10543.4 10550.3 10552.2 44335.3 44800.8 44811.6 44878.8 44883.1 3766.7 3821.4 3917.3 4135.7 4373.9 33699.0 33893.3 34018.8 34096.3 34240.0 4264.8 4392.5 4406.3 4413.2 4442.3 350677.0 357428.0 359432.0 359588.0 360350.2 71211.0 72270.0 72575.0 72703.6 72743.0 67053.7 74199.0 75721.0 76074.3 76139.0 17714.9 17741.1 17844.9 17874.6 17879.1 12716.7 13614.5 13751.9 14026.6 14057.0 21659.7 21670.5 21787.5 21803.2 21923.0 8116.4 8117.4 8281.8 8363.0 8436.5 1063.6 1075.2 1205.3 1235.4 1270.9 34272.0 34320.3 35010.0 35258.1 35326.8 1140.4 1222.4 1248.7 1252.5 1265.0 15695.6 16086.2 16365.7 16693.6 17272.9 444591.0 446044.0 447679.0 447908.0 448942.0 60820.4 61424.0 61485.4 61521.0 61680.7 1414.6 1501.7 1517.0 1533.9 1545.7 29935.6 30416.4 34662.7 34974.0 35913.8 55612.4 56406.0 56641.0 56647.0 56655.4 461110.0 466214.0 466492.0 467137.0 467843.0 40941.0 47203.8 47616.5 48066.3 48232.8 46656.3 46657.5 47338.5 47433.8 47849.0 39308.8 39668.6 39961.6 40135.8 40543.0 38457.4 38972.0 40399.0 42580.6 43899.6 43923.0 44547.6 44652.8 44662.1 44787.0 37117.4 38169.6 38933.8 39521.8 39624.0 29144.3 29358.1 30069.8 30132.7 30507.2 02:23:26 INFO - PROCESS | 9441 | 02:23:26 INFO - PROCESS | 9441 | [#2] jquery.html Cycles:180 Average:30874.31 Median:2459.72 stddev:93531.00 (3802.5%) stddev-sans-first:93765.40 02:23:26 INFO - PROCESS | 9441 | Values: 406.2 411.5 412.7 414.8 424.3 18176.9 18395.9 19288.6 19305.2 19307.5 19424.1 19686.0 19955.4 20565.4 20591.5 5344.8 5649.6 5696.3 5919.7 5934.7 5658.6 5680.0 5690.3 5715.8 5720.1 5687.8 6014.3 6020.8 6021.4 6032.3 5683.4 5838.3 5877.4 5880.2 5881.1 5667.9 5673.0 5730.8 5742.9 5743.3 13768.8 13984.2 15339.0 23461.0 23574.9 2353.4 2452.9 2466.5 2512.2 2549.9 9865.3 9989.8 10051.4 10298.9 10518.2 1960.0 1973.9 1990.3 2025.5 2103.7 59301.4 60526.7 82235.6 83401.6 84654.6 9820.5 10214.5 10235.6 10334.8 10668.1 12775.6 13847.4 13851.8 14649.8 15252.8 8086.8 8191.5 8408.2 8411.3 8432.3 8080.0 8173.7 8177.7 8214.1 8291.0 4667.9 4746.3 4759.3 4860.9 4891.0 1968.2 1982.3 1983.5 1997.5 2005.9 1009.3 1046.6 1086.1 1137.6 1145.9 18875.8 18883.1 19165.3 19190.9 19782.8 1048.0 1114.1 1134.8 1149.6 1166.3 10669.8 10698.1 10893.9 10981.7 11069.4 542078.0 554289.0 570749.0 587118.0 589963.0 89393.0 89542.6 99581.0 101801.0 107031.5 1175.5 1179.1 1183.0 1191.5 1228.8 16565.7 16636.0 16818.9 16948.0 16961.7 31259.4 37940.8 37977.1 40107.6 42036.4 57653.0 59302.4 59349.7 59680.0 59946.7 8273.0 8374.0 8497.2 8591.1 8766.5 9540.5 13390.5 13678.1 13699.6 13734.3 11756.9 12127.5 12157.6 12220.5 12241.9 7082.2 8629.0 10549.3 12134.3 12384.1 6857.6 9436.5 12613.3 12662.9 13058.8 8914.6 9034.3 9062.5 9250.9 9311.3 11687.9 11697.3 11776.9 11802.2 11833.4 02:23:26 INFO - PROCESS | 9441 | 02:23:26 INFO - PROCESS | 9441 | [#3] mootools.html Cycles:180 Average:5712.57 Median:4914.17 stddev:3142.89 (64.0%) stddev-sans-first:3135.10 02:23:26 INFO - PROCESS | 9441 | Values: 1414.8 1559.8 1568.9 1778.1 1922.6 8188.5 8430.2 8436.3 8450.0 8454.1 8237.4 8369.1 8422.8 8423.8 8428.7 2332.0 2350.5 2355.1 2355.2 2356.0 2381.4 2391.1 2437.6 2438.8 2445.2 2371.8 2396.9 2413.2 2414.7 2417.0 2359.7 2381.6 2394.3 2394.9 2427.8 2317.7 2403.5 2404.8 2412.6 2417.3 6926.6 8174.8 8644.9 8672.9 8694.8 5152.3 5214.4 5246.6 5254.9 5264.6 3514.0 3527.9 3538.2 3590.7 3597.2 1079.1 1082.0 1128.0 1129.6 1133.5 11751.0 12269.7 12277.3 12288.1 12300.4 4597.1 4605.2 4669.6 4704.0 4716.4 10417.9 10426.8 10427.5 10427.8 10442.9 5402.9 5408.5 5411.2 5417.9 5419.1 4864.7 4913.9 4914.4 4918.3 4922.1 3693.2 3718.6 3730.9 3736.4 3745.3 1152.3 1160.7 1164.7 1171.8 1172.0 937.4 942.9 1006.2 1011.1 1044.3 5980.3 6003.8 6008.3 6106.1 6123.3 1061.4 1062.6 1075.1 1076.9 1080.6 4236.0 4293.6 4298.8 4343.4 4352.6 10332.1 10487.8 10567.2 10605.2 10749.1 10463.6 10483.9 10596.8 10637.8 10639.6 8128.2 8135.9 8274.5 8336.8 8366.2 5955.9 5962.6 6034.1 6076.0 6099.0 9103.5 9420.7 9526.2 9694.3 9745.6 9055.4 9243.5 9345.9 9438.8 9450.2 7403.8 7406.9 7437.3 7443.9 7488.4 7718.0 7895.3 7921.6 7927.8 7954.5 7523.8 7628.3 7720.6 7732.9 7805.4 7506.4 7518.6 7636.7 7671.8 7705.2 6856.3 6994.4 7000.0 7053.6 7113.1 4482.4 5280.8 5334.5 5387.8 5412.7 5221.2 5247.4 5305.4 5359.8 5380.8 02:23:26 INFO - PROCESS | 9441 | 02:23:26 INFO - PROCESS | 9441 | [#4] prototype.html Cycles:180 Average:5624.33 Median:6544.48 stddev:1723.91 (26.3%) stddev-sans-first:1682.50 02:23:26 INFO - PROCESS | 9441 | Values: 340.2 340.9 341.7 352.0 353.3 6158.1 6272.7 6275.7 6289.5 6338.0 6281.1 6310.2 6311.1 6312.9 6313.5 4824.2 4824.9 4826.0 4834.3 4837.3 4841.1 4842.9 4846.4 4853.2 4863.7 4777.9 4798.2 4803.9 4809.3 4811.6 4697.3 4791.6 4815.5 4821.3 4829.8 4218.4 4226.8 4234.7 4240.9 4242.0 6011.5 6016.3 6107.6 6110.2 6121.2 5598.6 5612.1 5613.0 5614.9 5615.5 6635.5 6641.3 6642.9 6648.3 6661.9 4488.1 4699.4 4713.2 4715.8 4717.2 6651.1 6864.5 6948.3 7015.5 7035.3 4558.2 4573.3 4576.0 4620.7 4642.0 4720.3 4734.7 4740.3 4744.2 4754.4 5244.9 5360.5 5406.9 5421.6 5510.4 6615.5 6630.4 6697.4 6698.4 6706.8 1630.1 1663.6 1664.6 1666.7 1668.8 1072.6 1077.8 1080.7 1092.4 1102.6 6573.8 6577.3 6590.7 6591.8 6592.9 6929.8 6954.3 6958.7 6963.1 6970.1 6573.8 6577.0 6577.3 6581.5 6585.5 3722.7 3754.7 3757.0 3757.1 3757.2 7030.5 7287.4 7297.9 7322.3 7327.4 7097.9 7173.0 7177.8 7187.9 7192.8 7290.5 7291.6 7294.6 7304.3 7326.9 6827.0 7032.3 7034.5 7035.0 7037.7 6601.7 6917.6 6926.2 6929.9 6936.7 7054.4 7267.5 7275.0 7299.1 7307.6 4615.8 4696.9 4706.0 4706.1 4706.5 6909.1 6976.8 6989.7 6995.8 7000.8 6625.8 6747.2 6749.4 6757.1 6827.5 6765.7 6783.6 6793.2 6793.5 6798.2 6641.8 6664.1 6673.1 6680.2 6687.0 6812.3 6824.1 6834.9 6858.1 6917.8 6515.2 6640.6 6647.5 6654.8 6673.3 02:23:26 INFO - PROCESS | 9441 | 02:23:26 INFO - PROCESS | 9441 | [#5] yui.html Cycles:180 Average:15974.96 Median:27011.01 stddev:18152.23 (67.2%) stddev-sans-first:18167.72 02:23:26 INFO - PROCESS | 9441 | Values: 873.0 907.6 915.6 923.5 927.5 14996.0 15212.5 15219.9 15237.9 15245.5 14247.3 14414.9 14416.4 14423.6 14427.8 746.5 890.3 900.5 911.4 926.5 909.4 914.6 915.9 916.2 920.3 962.6 966.9 972.6 976.0 976.6 811.5 947.9 964.2 979.8 981.7 706.0 708.0 710.2 710.2 710.9 14440.7 14536.1 14577.6 14578.4 14603.1 14565.9 15016.9 15034.2 15132.4 15237.2 11879.6 12319.6 12821.9 12845.5 13007.3 4617.3 4628.0 4645.5 4658.6 4706.6 54780.5 55054.0 55251.4 55308.4 55568.7 11723.8 11993.8 12093.7 12289.8 12339.6 21623.6 21625.4 21651.0 22640.2 22716.4 8584.4 8674.2 8950.5 9040.5 9098.1 4977.8 5046.0 5173.5 5185.2 5402.6 3711.6 3770.0 3776.9 3786.9 3791.6 622.1 642.9 672.2 673.3 675.7 705.3 754.9 768.1 781.7 804.5 9282.4 9374.3 9412.8 9481.3 9556.0 685.6 817.2 821.6 835.7 837.9 4379.9 4481.8 4490.3 4686.5 4815.4 62361.0 63119.7 63340.4 63706.4 63780.4 56372.4 59578.7 59777.4 59983.7 60954.4 49044.3 52756.7 53804.2 54348.5 54517.0 9544.0 9577.4 9696.9 9891.8 9900.6 38366.0 39209.6 40076.8 42124.4 42170.6 51054.2 51253.7 52472.7 52681.0 54094.5 12913.7 13134.3 13246.8 13368.2 13475.0 14211.6 14273.3 14399.9 14784.4 14947.3 13585.3 13738.5 13748.8 14125.9 14415.4 13124.9 13392.9 13472.6 13822.8 13873.7 13345.7 13404.9 13435.5 13936.3 14020.1 11336.2 11393.3 11659.9 11741.6 11809.6 11568.8 11706.8 11764.3 11869.8 11917.5 02:23:26 INFO - PROCESS | 9441 | -------- Summary: end -------- 02:23:26 INFO - PROCESS | 9441 | 02:23:26 INFO - TEST-INFO | 9441: exit 0 02:23:26 INFO - TEST-OK | dromaeo_css | took 1111560ms 02:23:26 INFO - TEST-START | kraken 02:23:26 INFO - operating with platform_type : linux_ 02:23:26 INFO - Initialising browser for kraken test... 02:23:26 INFO - TEST-INFO | started process 9639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6H2ncA/profile http://localhost:50933/getInfo.html) 02:23:30 INFO - PROCESS | 9639 | __metrics Screen width/height:1600/1200 02:23:30 INFO - PROCESS | 9639 | colorDepth:24 02:23:30 INFO - PROCESS | 9639 | Browser inner width/height: 1024/697 02:23:30 INFO - PROCESS | 9639 | __metrics 02:23:31 ERROR - PROCESS | 9639 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:23:32 INFO - TEST-INFO | 9639: exit 0 02:23:32 INFO - Browser initialized. 02:23:32 INFO - Running cycle 1/1 for kraken test... 02:23:32 INFO - TEST-INFO | started process 9730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6H2ncA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:44 INFO - PROCESS | 9730 | RSS: Main: 141017088 02:23:44 INFO - PROCESS | 9730 | 02:23:47 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50933/tests/kraken/driver.html?testName=audio-beat-detection) 02:23:47 INFO - PROCESS | 9730 | RSS: Main: 197955584 02:23:47 INFO - PROCESS | 9730 | 02:23:50 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50933/tests/kraken/driver.html?testName=audio-dft) 02:23:51 INFO - PROCESS | 9730 | RSS: Main: 184111104 02:23:51 INFO - PROCESS | 9730 | 02:23:53 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50933/tests/kraken/driver.html?testName=audio-fft) 02:23:54 INFO - PROCESS | 9730 | RSS: Main: 273367040 02:23:54 INFO - PROCESS | 9730 | 02:23:56 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50933/tests/kraken/driver.html?testName=audio-oscillator) 02:23:57 INFO - PROCESS | 9730 | RSS: Main: 179224576 02:23:57 INFO - PROCESS | 9730 | 02:23:59 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50933/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:23:59 INFO - PROCESS | 9730 | RSS: Main: 177733632 02:23:59 INFO - PROCESS | 9730 | 02:24:02 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50933/tests/kraken/driver.html?testName=imaging-darkroom) 02:24:03 INFO - PROCESS | 9730 | RSS: Main: 212664320 02:24:03 INFO - PROCESS | 9730 | 02:24:06 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50933/tests/kraken/driver.html?testName=imaging-desaturate) 02:24:07 INFO - PROCESS | 9730 | RSS: Main: 212451328 02:24:07 INFO - PROCESS | 9730 | 02:24:10 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50933/tests/kraken/driver.html?testName=json-parse-financial) 02:24:10 INFO - PROCESS | 9730 | RSS: Main: 212021248 02:24:10 INFO - PROCESS | 9730 | 02:24:12 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50933/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:24:12 INFO - PROCESS | 9730 | RSS: Main: 191938560 02:24:12 INFO - PROCESS | 9730 | 02:24:14 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50933/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:24:15 INFO - PROCESS | 9730 | RSS: Main: 195526656 02:24:15 INFO - PROCESS | 9730 | 02:24:17 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50933/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:24:17 INFO - PROCESS | 9730 | RSS: Main: 209383424 02:24:17 INFO - PROCESS | 9730 | 02:24:20 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:24:20 INFO - PROCESS | 9730 | RSS: Main: 216260608 02:24:20 INFO - PROCESS | 9730 | 02:24:23 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:24:24 INFO - PROCESS | 9730 | RSS: Main: 213540864 02:24:24 INFO - PROCESS | 9730 | 02:24:25 INFO - PROCESS | 9730 | Cycle 1(1): loaded http://localhost:50933/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50933/tests/kraken/driver.html?testName=ai-astar) 02:24:25 INFO - PROCESS | 9730 | RSS: Main: 274370560 02:24:25 INFO - PROCESS | 9730 | 02:24:25 INFO - PROCESS | 9730 | __start_tp_report 02:24:25 INFO - PROCESS | 9730 | _x_x_mozilla_page_load 02:24:25 INFO - PROCESS | 9730 | _x_x_mozilla_page_load_details 02:24:26 INFO - PROCESS | 9730 | |i|pagename|runs| 02:24:26 INFO - PROCESS | 9730 | |0;ai-astar;110;110;111;109;111;111;108;109;109;110 02:24:26 INFO - PROCESS | 9730 | |1;audio-beat-detection;148;125;156;192;129;158;159;129;181;128 02:24:26 INFO - PROCESS | 9730 | |2;audio-dft;162;159;160;160;161;161;163;159;163;163 02:24:26 INFO - PROCESS | 9730 | |3;audio-fft;76;76;75;170;73;76;77;74;163;76 02:24:26 INFO - PROCESS | 9730 | |4;audio-oscillator;91;92;154;91;92;91;141;92;92;146 02:24:26 INFO - PROCESS | 9730 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;119;116 02:24:26 INFO - PROCESS | 9730 | |6;imaging-darkroom;145;145;145;144;145;145;145;145;145;145 02:24:26 INFO - PROCESS | 9730 | |7;imaging-desaturate;95;95;95;95;95;95;94;96;95;94 02:24:26 INFO - PROCESS | 9730 | |8;json-parse-financial;53;54;53;53;53;55;55;72;52;52 02:24:26 INFO - PROCESS | 9730 | |9;json-stringify-tinderbox;61;58;59;58;59;59;58;58;59;59 02:24:26 INFO - PROCESS | 9730 | |10;stanford-crypto-aes;72;72;71;72;73;79;73;72;73;72 02:24:26 INFO - PROCESS | 9730 | |11;stanford-crypto-ccm;118;118;113;112;112;112;111;111;127;113 02:24:26 INFO - PROCESS | 9730 | |12;stanford-crypto-pbkdf2;160;158;159;161;168;164;161;162;156;157 02:24:26 INFO - PROCESS | 9730 | |13;stanford-crypto-sha256-iterative;64;67;66;66;67;66;68;67;64;65 02:24:26 INFO - PROCESS | 9730 | __end_tp_report 02:24:26 INFO - PROCESS | 9730 | __start_cc_report 02:24:26 INFO - PROCESS | 9730 | _x_x_mozilla_cycle_collect,1624 02:24:26 INFO - PROCESS | 9730 | __end_cc_report 02:24:26 INFO - PROCESS | 9730 | __startTimestamp1465291465998__endTimestamp 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | ------- Summary: start ------- 02:24:26 INFO - PROCESS | 9730 | Number of tests: 14 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:1.03 (0.9%) stddev-sans-first:1.09 02:24:26 INFO - PROCESS | 9730 | Values: 110.0 110.0 111.0 109.0 111.0 111.0 108.0 109.0 109.0 110.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:157.00 stddev:23.33 (14.9%) stddev-sans-first:24.73 02:24:26 INFO - PROCESS | 9730 | Values: 148.0 125.0 156.0 192.0 129.0 158.0 159.0 129.0 181.0 128.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.60 (1.0%) stddev-sans-first:1.66 02:24:26 INFO - PROCESS | 9730 | Values: 162.0 159.0 160.0 160.0 161.0 161.0 163.0 159.0 163.0 163.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:38.47 (50.6%) stddev-sans-first:40.28 02:24:26 INFO - PROCESS | 9730 | Values: 76.0 76.0 75.0 170.0 73.0 76.0 77.0 74.0 163.0 76.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:91.50 stddev:26.96 (29.5%) stddev-sans-first:27.86 02:24:26 INFO - PROCESS | 9730 | Values: 91.0 92.0 154.0 91.0 92.0 91.0 141.0 92.0 92.0 146.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 02:24:26 INFO - PROCESS | 9730 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 119.0 116.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 02:24:26 INFO - PROCESS | 9730 | Values: 145.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 145.0 145.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 02:24:26 INFO - PROCESS | 9730 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 94.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:53.50 stddev:6.00 (11.2%) stddev-sans-first:6.31 02:24:26 INFO - PROCESS | 9730 | Values: 53.0 54.0 53.0 53.0 53.0 55.0 55.0 72.0 52.0 52.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.92 (1.6%) stddev-sans-first:0.53 02:24:26 INFO - PROCESS | 9730 | Values: 61.0 58.0 59.0 58.0 59.0 59.0 58.0 58.0 59.0 59.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:72.50 stddev:2.23 (3.1%) stddev-sans-first:2.35 02:24:26 INFO - PROCESS | 9730 | Values: 72.0 72.0 71.0 72.0 73.0 79.0 73.0 72.0 73.0 72.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#11] stanford-crypto-ccm Cycles:10 Average:114.70 Median:113.00 stddev:5.03 (4.5%) stddev-sans-first:5.20 02:24:26 INFO - PROCESS | 9730 | Values: 118.0 118.0 113.0 112.0 112.0 112.0 111.0 111.0 127.0 113.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.00 stddev:3.53 (2.2%) stddev-sans-first:3.74 02:24:26 INFO - PROCESS | 9730 | Values: 160.0 158.0 159.0 161.0 168.0 164.0 161.0 162.0 156.0 157.0 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - PROCESS | 9730 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.33 (2.0%) stddev-sans-first:1.20 02:24:26 INFO - PROCESS | 9730 | Values: 64.0 67.0 66.0 66.0 67.0 66.0 68.0 67.0 64.0 65.0 02:24:26 INFO - PROCESS | 9730 | -------- Summary: end -------- 02:24:26 INFO - PROCESS | 9730 | 02:24:26 INFO - TEST-INFO | 9730: exit 0 02:24:26 INFO - TEST-OK | kraken | took 59996ms 02:24:26 INFO - SUITE-END | took 1171s 02:24:27 INFO - Completed test suite (00:19:31) 02:24:27 INFO - javascript benchmark 02:24:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.4680851063827, 3351.715104216141, 3353.9161520961975, 3382.0868365541287, 3393.3043726036167, 5604.635698679583, 5625.32496100468, 5630.2117703521435, 5631.099024156136, 5654.632448890824, 5634.633748806335, 5649.6327738696955, 5660.9433905660935, 5661.688607126606, 5671.347795003576, 5031.2453132030305, 5151.76817043233, 5185.55922746567, 5253.658512196714, 5284.44513326101, 5034.748262586856, 5081.796728130888, 5089.083964886319, 5136.332276804029, 5182.585393168538, 5143.331366922295, 5181.948180518184, 5190.169572868342, 5192.1432963560965, 5228.503292187255, 5129.256257842592, 5145.99653067652, 5185.455527169631, 5204.245384419257, 5204.713740744258, 4890.5109489051165, 5119.923201151949, 5173.17229243323, 5179.766910489037, 5192.58459323257, 5503.147012213113, 5544.279243698334, 5548.833534993957, 5554.666719996813, 5563.610547261694, 5695.658260504383, 6031.0, 6043.516518678495, 6061.090836374535, 6077.36187700294, 5917.763289468459, 5922.58541902067, 5995.490383317423, 6008.48927841134, 6046.516278697693, 5607.0, 5631.380548139701, 5634.323881134208, 5637.46444087811, 5665.263515742927, 5945.554083443759, 6122.938770612237, 6127.938720612737, 6127.969360153171, 6172.629642221481, 5975.19334889793, 5980.790672326448, 5987.341392446914, 5989.520838332923, 6026.758929642853, 6087.239095113111, 6099.207103076572, 6108.267007959073, 6111.236095488064, 6111.786087487006, 5853.560982926212, 5962.3739507351975, 6017.308009578867, 6018.247719035121, 6029.78895738647, 6023.247094113236, 6067.848303792352, 6075.605085669417, 6078.483328917003, 6082.57421980466, 4530.365748795171, 4543.795529201194, 4545.636349092131, 4551.590356867898, 4575.26795712691, 3990.2418540477215, 4032.3145065338963, 4072.1855628874346, 4075.9592404076175, 4117.958820411817, 5851.678157701367, 5875.4124587541755, 5879.941200588025, 5889.764409423661, 5897.292324921037, 6106.480949119375, 6141.263048434127, 6143.047827586642, 6154.19995400604, 6157.692115394212, 5544.972275138679, 5823.272090988627, 5864.882702345929, 5884.735186916599, 5920.2895652521975, 5021.949780502221, 5034.244863270539, 5037.823676171316, 5038.420581633086, 5045.672031318026, 6252.843678908063, 6273.498120150377, 6276.246850377984, 6278.183836101278, 6287.402696743802, 5823.912641310299, 5853.03424934898, 5873.148393482836, 5898.1152827076285, 5926.199963005025, 6262.843428914313, 6319.8104056878365, 6324.0, 6325.367463253638, 6327.430531252209, 5626.099824028136, 5968.104784282393, 6012.428819262163, 6013.518918486423, 6019.903230155434, 5963.2844058713235, 5967.254093238345, 5994.460498555151, 6028.09578563219, 6028.156058151774, 5847.532197424281, 5851.561132914963, 5851.853703657443, 5854.297484301911, 5855.00464920956, 5663.150527420919, 5699.658020518782, 5835.883282334415, 5889.116632505158, 5903.380145084704, 5833.300003999378, 5835.737391817293, 5836.270466191726, 5845.707714614337, 5868.589198756217, 5950.761969521171, 5961.314448838266, 5969.0, 5969.074793407029, 5977.6114552553945, 5574.9163762542785, 5648.4633959773755, 5672.234248376416, 5853.94146058534, 5860.238169037998], "value": 5558.134228265912, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.9299377068521, 682.2154522299356, 689.4725534965752, 729.9707412548305, 737.0823324960425, 33479.497807532876, 34084.0, 40847.38728919069, 41091.79454102725, 41254.38118428218, 43907.3413898791, 44292.33561496572, 44476.0, 44481.33278000825, 44617.330740038924, 8173.836523269531, 8695.782605434868, 8906.910930890674, 8913.242374398184, 8919.821603567925, 8232.629531671058, 10612.416317102556, 10815.080718138968, 10855.185861060412, 10856.837147442755, 10565.260431769779, 10669.253152279343, 10672.573097076107, 10674.9466252669, 10678.946605266963, 10415.323004004715, 10422.062014418738, 10477.371357718484, 10479.161667066617, 10496.422696751713, 10420.478976051167, 10487.737806554896, 10543.367397956146, 10550.261481696285, 10552.15582753378, 44335.334969975156, 44800.77599612014, 44811.55188448139, 44878.775606122086, 44883.10233795339, 3766.6986641068647, 3821.3503704370323, 3917.2557214129224, 4135.731177473454, 4373.934390984138, 33699.0, 33893.322133557434, 34018.82990585056, 34096.31807363839, 34240.0, 4264.808083636244, 4392.472903251598, 4406.2949928011685, 4413.16149931512, 4442.311441726538, 350677.0, 357428.0, 359432.0, 359588.0, 360350.19824900967, 71211.0, 72270.0, 72575.0, 72703.6364818183, 72743.0, 67053.66473167604, 74199.0, 75721.0, 76074.3373981908, 76139.0, 17714.91142544305, 17741.11294435299, 17844.91077544604, 17874.642507150045, 17879.106044697714, 12716.682082947815, 13614.523491677744, 13751.862481375258, 14026.579202623938, 14057.0, 21659.67510487344, 21670.45823854416, 21787.455313617287, 21803.236886708888, 21923.0, 8116.350691944748, 8117.391195660349, 8281.8343633127, 8362.958185209034, 8436.535990520457, 1063.56393878511, 1075.188232884183, 1205.312971606176, 1235.3761350517932, 1270.8729127087402, 34272.0, 34320.31359372799, 35010.0, 35258.118547036014, 35326.82336588352, 1140.43548443521, 1222.4010234984794, 1248.656619429664, 1252.4990003998473, 1264.962051138449, 15695.607609809846, 16086.211461887828, 16365.672686546202, 16693.582660433345, 17272.913635431993, 444591.0, 446044.0, 447679.0, 447908.0, 448942.0, 60820.39179608147, 61424.0, 61485.38514614886, 61521.0, 61680.69159654173, 1414.6039109049277, 1501.6546194375355, 1516.9544913652608, 1533.9079655220946, 1545.706315800017, 29935.55096673508, 30416.391672166876, 34662.65337346695, 34974.0, 35913.82043089768, 55612.443875560726, 56406.0, 56641.0, 56647.0, 56655.43344566502, 461110.0, 466214.0, 466492.0, 467137.0, 467843.0, 40941.0, 47203.76398117987, 47616.52383476121, 48066.27900581564, 48232.758836206995, 46656.30015549837, 46657.53342466532, 47338.52661473479, 47433.762831185624, 47849.0, 39308.80345598254, 39668.603313966494, 39961.600383995785, 40135.79932100321, 40543.0, 38457.42313865238, 38972.0, 40399.0, 42580.5741942589, 43899.561004390824, 43923.0, 44547.554524455634, 44652.77673611741, 44662.106757864014, 44787.0, 37117.443238350905, 38169.618303816605, 38933.80533097316, 39521.80239098786, 39624.0, 29144.27139321534, 29358.082443724692, 30069.849650751607, 30132.69867301299, 30507.2373190672], "value": 21785.05178301439, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.24235800232566, 411.530854825499, 412.6719258189739, 414.76565740356693, 424.32955929631186, 18176.909115454404, 18395.908020459894, 19288.614227715436, 19305.227790888366, 19307.517312067186, 19424.125914333854, 19686.0, 19955.401337959847, 20565.38303850883, 20591.485212869648, 5344.839654810362, 5649.6327738696855, 5696.25948626679, 5919.704014799265, 5934.703264836762, 5658.632188907728, 5679.971600141994, 5690.317161940573, 5715.799947001856, 5720.141978703186, 5687.800926967557, 6014.278286605613, 6020.759169633209, 6021.367756385582, 6032.306284777241, 5683.431656834284, 5838.2994040715175, 5877.441643043904, 5880.176775251447, 5881.147233651118, 5667.858303542444, 5673.0, 5730.799422020209, 5742.856428589277, 5743.253377060997, 13768.793468097987, 13984.16095034291, 15339.0, 23461.0, 23574.882125589433, 2353.423411264251, 2452.914148004811, 2466.5313590417763, 2512.2337687005456, 2549.9362515937064, 9865.260105492116, 9989.800203995952, 10051.396916185053, 10298.897011029943, 10518.158547316272, 1959.964146997314, 1973.9309124180584, 1990.3431867483841, 2025.5442525431806, 2103.7475502939747, 59301.40698593002, 60526.69736651333, 82235.5888220561, 83401.58299208464, 84654.57672711597, 9820.45987470696, 10214.540345684461, 10235.59057637701, 10334.793304133875, 10668.14654827612, 12775.61673149807, 13847.376868040761, 13851.792223116661, 14649.780253296209, 15252.771208431883, 8086.757397278091, 8191.508509489449, 8408.159184081544, 8411.285040771481, 8432.283255923316, 8079.959600202079, 8173.713920012771, 8177.672893084329, 8214.096449390563, 8291.0, 4667.929981050287, 4746.28805679144, 4759.286107083965, 4860.854174374775, 4890.975545122252, 1968.193040853272, 1982.3260091568936, 1983.5338695406567, 1997.500624843789, 2005.8896760678304, 1009.3136667066466, 1046.5604446132643, 1086.1310951239136, 1137.5790957345835, 1145.8510393648771, 18875.811241887404, 18883.105058981946, 19165.32921347746, 19190.904045479685, 19782.802171978095, 1047.9947600262103, 1114.147677027075, 1134.8014097532898, 1149.5516748468103, 1166.2710805746408, 10669.78660426787, 10698.144148468104, 10893.891061089445, 10981.725456863642, 11069.391183484824, 542078.0, 554289.0, 570749.0, 587118.0, 589963.0, 89393.0, 89542.55228723814, 99581.0, 101800.96398071997, 107031.46484267684, 1175.4651633506735, 1179.0626451970704, 1182.9763404731857, 1191.4817054581285, 1228.8402507673945, 16565.668686626443, 16636.0, 16818.915905420396, 16948.0, 16961.74557381665, 31259.374812504077, 37940.810295948344, 37977.050573735876, 40107.59892401039, 42036.36945445882, 57653.0, 59302.40697592969, 59349.703251485196, 59680.0, 59946.700266500135, 8272.958635206785, 8374.036985746474, 8497.150284971452, 8591.140885911358, 8766.517841518522, 9540.475273860004, 13390.464381424634, 13678.110922790385, 13699.589012329647, 13734.313284335543, 11756.882431175578, 12127.454264558293, 12157.635270941886, 12220.511179553074, 12241.938790305992, 7082.220955694766, 8629.0, 10549.261551691616, 12134.271943683407, 12384.071194660257, 6857.622830744357, 9436.52817359143, 12613.30626815534, 12662.873371266169, 13058.824705776526, 8914.598843051948, 9034.27725781949, 9062.501562413867, 9250.907490925274, 9311.348205625542, 11687.88312116868, 11697.2981621103, 11776.941115294369, 11802.173847830569, 11833.408329583313], "value": 9260.547056885998, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.8231471066117, 1559.812822461305, 1568.85095915888, 1778.1240790965535, 1922.567422329976, 8188.54962977036, 8430.241278284953, 8436.282915952152, 8450.0, 8454.070052294242, 8237.423380363376, 8369.079401265855, 8422.789430264247, 8423.831523369528, 8428.704995325164, 2331.9883400583017, 2350.4946436516148, 2355.0697474497565, 2355.1639168095335, 2356.045801450415, 2381.3570336009266, 2391.1391898916377, 2437.573424650679, 2438.8414753041084, 2445.193086281523, 2371.8221133414977, 2396.892139853711, 2413.191580820427, 2414.6981627296586, 2416.9758302416926, 2359.6696462495265, 2381.559411508868, 2394.2817154853474, 2394.8682822444757, 2427.7693619106158, 2317.73346065203, 2403.471236328005, 2404.759524047581, 2412.5657381671294, 2417.3473162246096, 6926.58440493572, 8174.836503269901, 8644.870326945102, 8672.913270867273, 8694.826103477895, 5152.304438900738, 5214.374275086976, 5246.632735708502, 5254.8686282842855, 5264.578833693334, 3514.0, 3527.9294414111832, 3538.168530395355, 3590.6588874056924, 3597.190632107781, 1079.1151255970108, 1082.0099608857886, 1127.9735440748962, 1129.6328693174669, 1133.4955944604653, 11751.0, 12269.693257668541, 12277.324747138904, 12288.139830211889, 12300.384980750927, 4597.149527337453, 4605.171069207575, 4669.626429885601, 4703.95296047042, 4716.3632909557455, 10417.9479102604, 10426.843597346045, 10427.530761115768, 10427.791444171075, 10442.947785261176, 5402.91895621566, 5408.45915408456, 5411.161270003156, 5417.945820541823, 5419.105847535191, 4864.732439715779, 4913.926291105637, 4914.410270767531, 4918.311436398907, 4922.114019476457, 3693.169036966715, 3718.6095459976855, 3730.8880733578035, 3736.4208547675153, 3745.250949810049, 1152.251036826053, 1160.6576060062303, 1164.7088227943013, 1171.812509998396, 1171.9531218751154, 937.3813283233034, 942.9124744233824, 1006.2453160129902, 1011.0597144655394, 1044.3107549017611, 5980.342162362137, 6003.8198854034445, 6008.3390827009, 6106.114613381035, 6123.2652081750475, 1061.3631820907394, 1062.5909025025421, 1075.1398880895254, 1076.8815430302661, 1080.5947769586405, 4235.978820105941, 4293.635041021485, 4298.78506074695, 4343.435353404037, 4352.586504282088, 10332.070113689804, 10487.790244195226, 10567.15462762977, 10605.204609654307, 10749.140068794477, 10463.581456741797, 10483.947580262202, 10596.788064238672, 10637.787244255072, 10639.574417023387, 8128.227818357246, 8135.918640813635, 8274.503529788231, 8336.8332633347, 8366.163383661707, 5955.851103722442, 5962.582619216787, 6034.125051867367, 6076.0, 6098.969505152623, 9103.453792772454, 9420.670276540288, 9526.237900968044, 9694.272929530172, 9745.561449734922, 9055.411398259355, 9243.537823108683, 9345.859812102688, 9438.764030899283, 9450.243980481682, 7403.8149046274275, 7406.925930740624, 7437.330640242404, 7443.888341674771, 7488.438367122597, 7718.0, 7895.289423951872, 7921.643526041457, 7927.801804954922, 7954.522728636301, 7523.8495230093995, 7628.313451789366, 7720.613969301625, 7732.9226707732205, 7805.375569954276, 7506.361959233308, 7518.624068796647, 7636.694532218649, 7671.808204794925, 7705.22947705225, 6856.314368563104, 6994.405475534637, 6999.965000174967, 7053.647317634201, 7113.110861142357, 4482.372467854438, 5280.841574752763, 5334.51989320963, 5387.757550910297, 5412.675239485643, 5221.164613661796, 5247.4490178530705, 5305.442928492453, 5359.785608575613, 5380.784768609368], "value": 4632.543322978696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.18355945730247, 340.88409940620187, 341.693024182502, 352.04068912214217, 353.29693909120823, 6158.076288556713, 6272.65500397478, 6275.717592708328, 6289.528285378592, 6337.968310158454, 6281.057841323804, 6310.211223597051, 6311.116443697886, 6312.905306420396, 6313.463355614778, 4824.17988941879, 4824.927626085611, 4826.0, 4834.274858771178, 4837.298591704192, 4841.128596852565, 4842.927356089662, 4846.418429788413, 4853.199222128344, 4863.732494712789, 4777.880552986186, 4798.232282834747, 4803.903921921559, 4809.254565542329, 4811.566958973692, 4697.342372067913, 4791.568758811689, 4815.518448155174, 4821.325014497973, 4829.7585120744, 4218.430511880888, 4226.830926762926, 4234.745915245096, 4240.851570195059, 4241.978790106061, 6011.458968692795, 6016.338202797689, 6107.572469927107, 6110.175126357929, 6121.204243448323, 5598.58010649203, 5612.130119831392, 5612.971935140339, 5614.887702245932, 5615.494605485485, 6635.502337324671, 6641.335866413368, 6642.867142657168, 6648.268690444047, 6661.866762664768, 4488.147252022138, 4699.389079419653, 4713.175194341011, 4715.764211789431, 4717.198076327033, 6651.135352404156, 6864.519483636147, 6948.27043160471, 7015.508914375996, 7035.261297563733, 4558.1795276849825, 4573.268277075718, 4575.95424045762, 4620.722756634613, 4642.001969576557, 4720.291956206596, 4734.7159170449195, 4740.265258884879, 4744.240921452551, 4754.358161648202, 5244.868878277997, 5360.517553420133, 5406.8918621627345, 5421.620486565981, 5510.366307874566, 6615.470762339001, 6630.403263706193, 6697.3637504437, 6698.39714425704, 6706.832329191711, 1630.0627139394896, 1663.6173680053655, 1664.583854036491, 1666.6583350413136, 1668.7747154134036, 1072.5924148823397, 1077.8113830079706, 1080.702806728156, 1092.4323595640283, 1102.5611576892072, 6573.769918052845, 6577.3422657733845, 6590.670466476753, 6591.802245932629, 6592.901106483407, 6929.757458488929, 6954.3393377629045, 6958.721651133999, 6963.1296087989, 6970.093887794555, 6573.80278591643, 6577.0, 6577.309382514863, 6581.539292249497, 6585.506087043395, 3722.739408241397, 3754.737168398186, 3756.9624303756614, 3757.0607348162957, 3757.1546402059316, 7030.507864449542, 7287.417006639456, 7297.854042919112, 7322.304381083895, 7327.377172940253, 7097.89353159703, 7173.0, 7177.784666460015, 7187.89218161728, 7192.784216473514, 7290.489665723455, 7291.635418229067, 7294.598797066213, 7304.2695730427595, 7326.9375940488335, 6827.044213809972, 7032.296770322927, 7034.5427547209265, 7034.964825175842, 7037.683304251424, 6601.702923368364, 6917.619530925847, 6926.238113807578, 6929.861402771816, 6936.687849046704, 7054.365107140382, 7267.527610705287, 7274.96362518184, 7299.05112335393, 7307.634618269171, 4615.815367385267, 4696.929546056744, 4705.952940470552, 4706.058788242297, 4706.4822869485015, 6909.1018167637885, 6976.790696279119, 6989.650517474004, 6995.79012629622, 7000.754973576104, 6625.768098116543, 6747.190337159376, 6749.392554670103, 6757.121574195323, 6827.522073455009, 6765.729370825112, 6783.559068660521, 6793.150856142982, 6793.456523478011, 6798.218204906301, 6641.767538136142, 6664.133662623828, 6673.065770791996, 6680.231773346128, 6686.966565167338, 6812.318768123148, 6824.146981627297, 6834.897476537756, 6858.142732158481, 6917.827054323682, 6515.185601799775, 6640.634765087966, 6647.5014373921185, 6654.800355989328, 6673.265940746611], "value": 5055.434764677601, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.9781755456116, 907.5779762410477, 915.6108653822126, 923.487464457226, 927.4713413354388, 14996.0, 15212.543623691294, 15219.923900380483, 15237.923810380946, 15245.466408675698, 14247.28763561823, 14414.927925360385, 14416.423343066292, 14423.5672929812, 14427.78358324626, 746.4625469661862, 890.3011136258023, 900.4507250577176, 911.3848152497071, 926.4719110107242, 909.4134283387211, 914.5701520285455, 915.9084091590854, 916.1571354353977, 920.3097676742443, 962.6390103711109, 966.8646389505475, 972.5866506734645, 975.9707208783713, 976.599594166392, 811.5009269299397, 947.9194268487153, 964.1997142371849, 979.8236317462854, 981.7398389426808, 706.0221593093551, 707.9981825716604, 710.1691021504852, 710.2223065743003, 710.8507213485175, 14440.71118577633, 14536.127832330094, 14577.562673119823, 14578.416863325454, 14603.050801697962, 14565.854341456661, 15016.924915375354, 15034.17312047837, 15132.394704211929, 15237.238138093162, 11879.584214552535, 12319.63041108768, 12821.871781282254, 12845.48618055286, 13007.349632518337, 4617.30740388941, 4627.95372046282, 4645.5354464553275, 4658.580727734487, 4706.576408123286, 54780.452195477934, 55054.0, 55251.44748552544, 55308.44691553113, 55568.72215638896, 11723.765524689628, 11993.760124797629, 12093.697657558632, 12289.815652765215, 12339.62981110568, 21623.56752864934, 21625.3780966425, 21651.025703843367, 22640.207592734503, 22716.432089197573, 8584.39909206362, 8674.175953284428, 8950.507722075348, 9040.547972601475, 9098.135677110664, 4977.751112444364, 5046.0, 5173.508516690908, 5185.196294574347, 5402.567794576425, 3711.5917249102577, 3770.038640146745, 3776.9433458498142, 3786.8863934082024, 3791.6208379161862, 622.0884952327567, 642.9421352078335, 672.2034389248756, 673.2695025896859, 675.6554157379674, 705.28413660135, 754.9433792465477, 768.1358471719316, 781.6795114003231, 804.5373910001772, 9282.396644218104, 9374.250059995184, 9412.764680883032, 9481.336306458481, 9556.0, 685.6468918506973, 817.1664901800249, 821.6425854753202, 835.6573804740027, 837.8701301298308, 4379.868603941887, 4481.775911204427, 4490.348899409567, 4686.531346865286, 4815.374001379798, 62361.0, 63119.684401577695, 63340.36659633345, 63706.36293637097, 63780.36219637744, 56372.43627563754, 59578.702106490055, 59777.402225978054, 59983.700081499315, 60954.39045609576, 49044.26433603499, 52756.73621631867, 53804.192937105974, 54348.45651543513, 54517.0, 9544.0, 9577.425354478475, 9696.85454718194, 9891.802163956536, 9900.603975840886, 38366.0, 39209.607903920594, 40076.799616001736, 42124.368134477394, 42170.57829421666, 51054.23418648798, 51253.7437312811, 52472.737636311576, 52681.0, 54094.459055408945, 12913.741725165257, 13134.343282836011, 13246.801297980346, 13368.197908125543, 13475.0, 14211.573652790434, 14273.286335682966, 14399.856001439852, 14784.408623654934, 14947.313905543528, 13585.252811095485, 13738.519151829638, 13748.793768093687, 14125.929370353082, 14415.351309191321, 13124.868751312364, 13392.866071339162, 13472.595822125351, 13822.792658110338, 13873.653158671113, 13345.66635834073, 13404.865951340751, 13435.529756458476, 13936.303184840515, 14020.088694234842, 11336.206465547333, 11393.316401015965, 11659.883401166218, 11741.647750567497, 11809.645710628694, 11568.826467603161, 11706.76586468283, 11764.294142351486, 11869.762604747684, 11917.463714132711], "value": 7356.544697869864, "unit": "score"}], "name": "dromaeo_css", "value": 7603.312616077801, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 111.0, 109.0, 111.0, 111.0, 108.0, 109.0, 109.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 156.0, 192.0, 129.0, 158.0, 159.0, 129.0, 181.0, 128.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 160.0, 160.0, 161.0, 161.0, 163.0, 159.0, 163.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 170.0, 73.0, 76.0, 77.0, 74.0, 163.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 154.0, 91.0, 92.0, 91.0, 141.0, 92.0, 92.0, 146.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 144.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 53.0, 55.0, 55.0, 72.0, 52.0, 52.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 59.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 72.0, 73.0, 79.0, 73.0, 72.0, 73.0, 72.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 113.0, 112.0, 112.0, 112.0, 111.0, 111.0, 127.0, 113.0], "value": 114.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 159.0, 161.0, 168.0, 164.0, 161.0, 162.0, 156.0, 157.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 66.0, 66.0, 67.0, 66.0, 68.0, 67.0, 64.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1508.2, "alertThreshold": 2.0}]} 02:24:27 INFO - Return code: 0 02:24:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:24:27 ERROR - # TBPL SUCCESS # 02:24:27 INFO - Running post-action listener: _resource_record_post_action 02:24:27 INFO - Running post-run listener: _resource_record_post_run 02:24:28 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 3354624; Write bytes: 288514048; Read time: 620; Write time: 257600 02:24:28 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 52064256; Read time: 0; Write time: 45296 02:24:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 3354624; Write bytes: 216002560; Read time: 620; Write time: 206512 02:24:28 INFO - Running post-run listener: _upload_blobber_files 02:24:28 INFO - Blob upload gear active. 02:24:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:24:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:24:28 INFO - (blobuploader) - INFO - Open directory for files ... 02:24:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:24:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:24:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:24:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:24:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:24:29 INFO - (blobuploader) - INFO - Done attempting. 02:24:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:24:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:24:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:24:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:24:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:24:30 INFO - (blobuploader) - INFO - Done attempting. 02:24:30 INFO - (blobuploader) - INFO - Iteration through files over. 02:24:30 INFO - Return code: 0 02:24:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:24:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:24:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c06a12188bb477486a2fcd00f063dcb2a3a124e3d943052047078ea92c3967aa4871aeb9d2df48e0124a2dbee99b6903aaa24152e37eca92e96c029f17e81ab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72747434f92c8661ce3bcc5973f627aa9d89ed61e4d9098d31cb7628f66a1fd512814cabc1320046e57279051de449d870eb9e4a49ee13c6b74e29348ab98c0a"} 02:24:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:24:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:24:30 INFO - Contents: 02:24:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c06a12188bb477486a2fcd00f063dcb2a3a124e3d943052047078ea92c3967aa4871aeb9d2df48e0124a2dbee99b6903aaa24152e37eca92e96c029f17e81ab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72747434f92c8661ce3bcc5973f627aa9d89ed61e4d9098d31cb7628f66a1fd512814cabc1320046e57279051de449d870eb9e4a49ee13c6b74e29348ab98c0a"} 02:24:30 INFO - Running post-run listener: copy_logs_to_upload_dir 02:24:30 INFO - Copying logs to upload dir... 02:24:30 INFO - mkdir: /builds/slave/test/build/upload/logs 02:24:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.305191 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-06-07 02:24:30.422033) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:24:30.425984) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c06a12188bb477486a2fcd00f063dcb2a3a124e3d943052047078ea92c3967aa4871aeb9d2df48e0124a2dbee99b6903aaa24152e37eca92e96c029f17e81ab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72747434f92c8661ce3bcc5973f627aa9d89ed61e4d9098d31cb7628f66a1fd512814cabc1320046e57279051de449d870eb9e4a49ee13c6b74e29348ab98c0a"} build_url:https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011526 build_url: 'https://queue.taskcluster.net/v1/task/XY-M0xRzRJClayLdyjBPsw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c06a12188bb477486a2fcd00f063dcb2a3a124e3d943052047078ea92c3967aa4871aeb9d2df48e0124a2dbee99b6903aaa24152e37eca92e96c029f17e81ab4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72747434f92c8661ce3bcc5973f627aa9d89ed61e4d9098d31cb7628f66a1fd512814cabc1320046e57279051de449d870eb9e4a49ee13c6b74e29348ab98c0a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:24:30.454245) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:24:30.454811) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1465290240.467564-2119338104 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:24:30.537115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:24:30.537425) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:24:30.537724) ========= ========= Total master_lag: 0.18 =========