builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1465290468.09 results: success (0) buildid: 20160606194329 builduid: 3d31ab4f42854c829e06ac6160cc676b revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:48.092217) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:48.092760) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:48.093084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:48.149284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:48.149980) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:07:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.6M=0s 2016-06-07 02:07:48 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:48.264749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:48.265182) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018880 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:48.315390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:48.315784) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:07:48,743 truncating revision to first 12 chars 2016-06-07 02:07:48,743 Setting DEBUG logging. 2016-06-07 02:07:48,743 attempt 1/10 2016-06-07 02:07:48,743 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:07:49,106 unpacking tar archive at: mozilla-beta-1f9f6bdee31c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680257 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:49.010036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:49.010408) ========= script_repo_revision: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:49.010904) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:49.011213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:07:49.021201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-07 02:07:49.021548) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:07:49 INFO - MultiFileLogger online at 20160607 02:07:49 in /builds/slave/test 02:07:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:07:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:49 INFO - {'append_to_log': False, 02:07:49 INFO - 'base_work_dir': '/builds/slave/test', 02:07:49 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:07:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:49 INFO - 'branch': 'Mozilla-Beta', 02:07:49 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:49 INFO - 'config_files': ('talos/linux_config.py',), 02:07:49 INFO - 'default_actions': ('clobber', 02:07:49 INFO - 'read-buildbot-config', 02:07:49 INFO - 'download-and-extract', 02:07:49 INFO - 'populate-webroot', 02:07:49 INFO - 'create-virtualenv', 02:07:49 INFO - 'install', 02:07:49 INFO - 'run-tests'), 02:07:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:49 INFO - 'download_minidump_stackwalk': True, 02:07:49 INFO - 'download_symbols': 'ondemand', 02:07:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:49 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:49 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:49 INFO - 'installer_path': 'installer.exe', 02:07:49 INFO - 'log_level': 'info', 02:07:49 INFO - 'log_name': 'talos', 02:07:49 INFO - 'log_to_console': True, 02:07:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:07:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:07:49 INFO - 'opt_config_files': (), 02:07:49 INFO - 'pip_index': False, 02:07:49 INFO - 'sps_profile': False, 02:07:49 INFO - 'sps_profile_interval': 0, 02:07:49 INFO - 'suite': 'dromaeojs-e10s', 02:07:49 INFO - 'system_bits': '32', 02:07:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:49 INFO - 'title': 'talos-linux64-ix-039', 02:07:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:49 INFO - 'use_talos_json': True, 02:07:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:49 INFO - 'work_dir': 'build'} 02:07:49 INFO - ##### 02:07:49 INFO - ##### Running clobber step. 02:07:49 INFO - ##### 02:07:49 INFO - Running pre-action listener: _resource_record_pre_action 02:07:49 INFO - Running main action method: clobber 02:07:49 INFO - rmtree: /builds/slave/test/build 02:07:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:50 INFO - Running post-action listener: _resource_record_post_action 02:07:50 INFO - ##### 02:07:50 INFO - ##### Running read-buildbot-config step. 02:07:50 INFO - ##### 02:07:50 INFO - Running pre-action listener: _resource_record_pre_action 02:07:50 INFO - Running main action method: read_buildbot_config 02:07:50 INFO - Using buildbot properties: 02:07:50 INFO - { 02:07:50 INFO - "project": "", 02:07:50 INFO - "product": "firefox", 02:07:50 INFO - "script_repo_revision": "production", 02:07:50 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 02:07:50 INFO - "repository": "", 02:07:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 02:07:50 INFO - "buildid": "20160606194329", 02:07:50 INFO - "pgo_build": "True", 02:07:50 INFO - "basedir": "/builds/slave/test", 02:07:50 INFO - "buildnumber": 7, 02:07:50 INFO - "slavename": "talos-linux64-ix-039", 02:07:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:07:50 INFO - "platform": "ubuntu64_hw", 02:07:50 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 02:07:50 INFO - "branch": "mozilla-beta", 02:07:50 INFO - "repo_path": "releases/mozilla-beta", 02:07:50 INFO - "revision": "1f9f6bdee31c14fd5a39485e8ae326de2928ef7d", 02:07:50 INFO - "stage_platform": "linux64-pgo", 02:07:50 INFO - "builduid": "3d31ab4f42854c829e06ac6160cc676b", 02:07:50 INFO - "slavebuilddir": "test" 02:07:50 INFO - } 02:07:50 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:07:50 INFO - Running post-action listener: _resource_record_post_action 02:07:50 INFO - ##### 02:07:50 INFO - ##### Running download-and-extract step. 02:07:50 INFO - ##### 02:07:50 INFO - Running pre-action listener: _resource_record_pre_action 02:07:50 INFO - Running main action method: download_and_extract 02:07:50 INFO - mkdir: /builds/slave/test/build/tests 02:07:50 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:07:50 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:07:50 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:07:50 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:07:50 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:07:50 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:07:51 INFO - Downloaded 1327 bytes. 02:07:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 02:07:51 INFO - Using the following test package requirements: 02:07:51 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:07:51 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:51 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 02:07:51 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:51 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 02:07:51 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:51 INFO - u'jsshell-linux-x86_64.zip'], 02:07:51 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:51 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 02:07:51 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 02:07:51 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:51 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 02:07:51 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:51 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 02:07:51 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:51 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 02:07:51 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 02:07:51 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 02:07:51 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:07:51 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:07:51 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:07:51 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:07:51 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:07:51 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:07:51 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:07:52 INFO - Downloaded 24176679 bytes. 02:07:52 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:07:52 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:07:53 INFO - Return code: 0 02:07:53 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:07:53 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:07:53 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:07:53 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:07:53 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:07:53 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:07:53 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:07:54 INFO - Downloaded 24176679 bytes. 02:07:54 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:07:54 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:07:56 INFO - Return code: 0 02:07:56 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:07:56 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:07:56 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:07:56 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:07:56 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:07:56 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:07:57 INFO - Downloaded 10840145 bytes. 02:07:57 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:07:57 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:07:57 INFO - Return code: 0 02:07:57 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:07:57 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:07:57 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:07:57 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:07:57 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:07:57 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:07:59 INFO - Downloaded 55996763 bytes. 02:07:59 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:07:59 INFO - mkdir: /builds/slave/test/properties 02:07:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:07:59 INFO - Writing to file /builds/slave/test/properties/build_url 02:07:59 INFO - Contents: 02:07:59 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:07:59 INFO - Running post-action listener: _resource_record_post_action 02:07:59 INFO - Running post-action listener: set_extra_try_arguments 02:07:59 INFO - ##### 02:07:59 INFO - ##### Running populate-webroot step. 02:07:59 INFO - ##### 02:07:59 INFO - Running pre-action listener: _resource_record_pre_action 02:07:59 INFO - Running main action method: populate_webroot 02:07:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:07:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:07:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:07:59 INFO - '--tppagecycles', 02:07:59 INFO - '7'], 02:07:59 INFO - 'tests': ['tsvgm']}}, 02:07:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:07:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:07:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:07:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:07:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:07:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:07:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:59 INFO - 'talos_options': ['--disable-e10s'], 02:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:59 INFO - 'talos_options': ['--disable-e10s'], 02:07:59 INFO - 'tests': ['damp', 'tps']}, 02:07:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:59 INFO - 'tests': ['damp', 'tps']}, 02:07:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:07:59 INFO - 'tests': ['dromaeo_dom']}, 02:07:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:07:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:07:59 INFO - 'tests': ['a11yr', 02:07:59 INFO - 'ts_paint', 02:07:59 INFO - 'tpaint', 02:07:59 INFO - 'sessionrestore', 02:07:59 INFO - 'sessionrestore_no_auto_restore', 02:07:59 INFO - 'tabpaint']}, 02:07:59 INFO - 'other-e10s': {'tests': ['a11yr', 02:07:59 INFO - 'ts_paint', 02:07:59 INFO - 'tpaint', 02:07:59 INFO - 'sessionrestore', 02:07:59 INFO - 'sessionrestore_no_auto_restore', 02:07:59 INFO - 'tabpaint']}, 02:07:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:07:59 INFO - 'ts_paint', 02:07:59 INFO - 'tpaint', 02:07:59 INFO - 'sessionrestore', 02:07:59 INFO - 'sessionrestore_no_auto_restore', 02:07:59 INFO - 'tabpaint']}, 02:07:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:07:59 INFO - 'ts_paint', 02:07:59 INFO - 'tpaint', 02:07:59 INFO - 'sessionrestore', 02:07:59 INFO - 'sessionrestore_no_auto_restore', 02:07:59 INFO - 'tabpaint']}, 02:07:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:07:59 INFO - 'tests': ['a11yr', 02:07:59 INFO - 'ts_paint', 02:07:59 INFO - 'tpaint', 02:07:59 INFO - 'sessionrestore', 02:07:59 INFO - 'sessionrestore_no_auto_restore', 02:07:59 INFO - 'tabpaint']}, 02:07:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:07:59 INFO - 'tests': ['a11yr', 02:07:59 INFO - 'ts_paint', 02:07:59 INFO - 'tpaint', 02:07:59 INFO - 'sessionrestore', 02:07:59 INFO - 'sessionrestore_no_auto_restore', 02:07:59 INFO - 'tabpaint']}, 02:07:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:07:59 INFO - 'tests': ['tsvgx', 02:07:59 INFO - 'tsvgr_opacity', 02:07:59 INFO - 'tart', 02:07:59 INFO - 'tscrollx', 02:07:59 INFO - 'cart']}, 02:07:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:07:59 INFO - 'tsvgr_opacity', 02:07:59 INFO - 'tart', 02:07:59 INFO - 'tscrollx', 02:07:59 INFO - 'cart']}, 02:07:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:59 INFO - 'talos_options': ['--disable-e10s'], 02:07:59 INFO - 'tests': ['tp5o']}, 02:07:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:59 INFO - 'tests': ['tp5o']}, 02:07:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:59 INFO - 'talos_options': ['--disable-e10s', 02:07:59 INFO - '--xperf_path', 02:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:59 INFO - 'tests': ['tp5n']}, 02:07:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:59 INFO - 'talos_options': ['--xperf_path', 02:07:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:59 INFO - 'tests': ['tp5n']}}, 02:07:59 INFO - 'talos.zip': {'path': '', 02:07:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:07:59 INFO - Running post-action listener: _resource_record_post_action 02:07:59 INFO - ##### 02:07:59 INFO - ##### Running create-virtualenv step. 02:07:59 INFO - ##### 02:07:59 INFO - Running pre-action listener: _resource_record_pre_action 02:07:59 INFO - Running main action method: create_virtualenv 02:07:59 INFO - Creating virtualenv /builds/slave/test/build/venv 02:07:59 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:07:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:08:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:08:00 INFO - Using real prefix '/usr' 02:08:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:08:00 INFO - Installing distribute.............................................................................................................................................................................................done. 02:08:02 INFO - Installing pip.................done. 02:08:02 INFO - Return code: 0 02:08:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:08: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:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:02 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 0x7f36ca0a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79410>, '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 0x1b7a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', '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:08:02 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:08:02 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:08:02 INFO - Using env: {'DISPLAY': ':0', 02:08:02 INFO - 'HOME': '/home/cltbld', 02:08:02 INFO - 'LANG': 'en_US.UTF-8', 02:08:02 INFO - 'LANGUAGE': 'en_US:en', 02:08:02 INFO - 'LOGNAME': 'cltbld', 02:08:02 INFO - 'MAIL': '/var/mail/cltbld', 02:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:02 INFO - 'MOZ_NO_REMOTE': '1', 02:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:02 INFO - 'NO_EM_RESTART': '1', 02:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:02 INFO - 'PWD': '/builds/slave/test', 02:08:02 INFO - 'SHELL': '/bin/bash', 02:08:02 INFO - 'SHLVL': '1', 02:08:02 INFO - 'TERM': 'linux', 02:08:02 INFO - 'TMOUT': '86400', 02:08:02 INFO - 'USER': 'cltbld', 02:08:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', 02:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:02 INFO - '_': '/tools/buildbot/bin/python'} 02:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:02 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:08:02 INFO - Cleaning up... 02:08:02 INFO - Return code: 0 02:08:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:08: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:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:02 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 0x7f36ca0a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79410>, '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 0x1b7a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', '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:08:02 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:08:02 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:08:02 INFO - Using env: {'DISPLAY': ':0', 02:08:02 INFO - 'HOME': '/home/cltbld', 02:08:02 INFO - 'LANG': 'en_US.UTF-8', 02:08:02 INFO - 'LANGUAGE': 'en_US:en', 02:08:02 INFO - 'LOGNAME': 'cltbld', 02:08:02 INFO - 'MAIL': '/var/mail/cltbld', 02:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:02 INFO - 'MOZ_NO_REMOTE': '1', 02:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:02 INFO - 'NO_EM_RESTART': '1', 02:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:02 INFO - 'PWD': '/builds/slave/test', 02:08:02 INFO - 'SHELL': '/bin/bash', 02:08:02 INFO - 'SHLVL': '1', 02:08:02 INFO - 'TERM': 'linux', 02:08:02 INFO - 'TMOUT': '86400', 02:08:02 INFO - 'USER': 'cltbld', 02:08:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', 02:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:02 INFO - '_': '/tools/buildbot/bin/python'} 02:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:02 INFO - Downloading/unpacking psutil>=0.7.1 02:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:02 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:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:05 INFO - Installing collected packages: psutil 02:08:05 INFO - Running setup.py install for psutil 02:08:05 INFO - building 'psutil._psutil_linux' extension 02:08:05 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:08:05 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:08:05 INFO - building 'psutil._psutil_posix' extension 02:08:05 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:08:05 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:08:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:05 INFO - Successfully installed psutil 02:08:05 INFO - Cleaning up... 02:08:05 INFO - Return code: 0 02:08:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:08: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:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:05 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 0x7f36ca0a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79410>, '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 0x1b7a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', '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:08:05 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:08:05 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:08:05 INFO - Using env: {'DISPLAY': ':0', 02:08:05 INFO - 'HOME': '/home/cltbld', 02:08:05 INFO - 'LANG': 'en_US.UTF-8', 02:08:05 INFO - 'LANGUAGE': 'en_US:en', 02:08:05 INFO - 'LOGNAME': 'cltbld', 02:08:05 INFO - 'MAIL': '/var/mail/cltbld', 02:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:05 INFO - 'MOZ_NO_REMOTE': '1', 02:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:05 INFO - 'NO_EM_RESTART': '1', 02:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:05 INFO - 'PWD': '/builds/slave/test', 02:08:05 INFO - 'SHELL': '/bin/bash', 02:08:05 INFO - 'SHLVL': '1', 02:08:05 INFO - 'TERM': 'linux', 02:08:05 INFO - 'TMOUT': '86400', 02:08:05 INFO - 'USER': 'cltbld', 02:08:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', 02:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:05 INFO - '_': '/tools/buildbot/bin/python'} 02:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:08:07 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:08:07 INFO - Installing collected packages: mozsystemmonitor 02:08:07 INFO - Running setup.py install for mozsystemmonitor 02:08:07 INFO - Successfully installed mozsystemmonitor 02:08:07 INFO - Cleaning up... 02:08:07 INFO - Return code: 0 02:08:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:08:07 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:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:07 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:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:07 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 0x7f36ca0a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79410>, '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 0x1b7a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', '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:08:07 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:08:07 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:08:07 INFO - Using env: {'DISPLAY': ':0', 02:08:07 INFO - 'HOME': '/home/cltbld', 02:08:07 INFO - 'LANG': 'en_US.UTF-8', 02:08:07 INFO - 'LANGUAGE': 'en_US:en', 02:08:07 INFO - 'LOGNAME': 'cltbld', 02:08:07 INFO - 'MAIL': '/var/mail/cltbld', 02:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:07 INFO - 'MOZ_NO_REMOTE': '1', 02:08:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:07 INFO - 'NO_EM_RESTART': '1', 02:08:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:07 INFO - 'PWD': '/builds/slave/test', 02:08:07 INFO - 'SHELL': '/bin/bash', 02:08:07 INFO - 'SHLVL': '1', 02:08:07 INFO - 'TERM': 'linux', 02:08:07 INFO - 'TMOUT': '86400', 02:08:07 INFO - 'USER': 'cltbld', 02:08:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', 02:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:07 INFO - '_': '/tools/buildbot/bin/python'} 02:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:08:08 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:08:08 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:08:08 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:08:08 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:08:08 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:08:08 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:08:09 INFO - Downloading blobuploader-1.2.4.tar.gz 02:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:08:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:08:10 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:08:10 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:08:10 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:08:10 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:08:10 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:08:10 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:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:08:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:08:10 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:08:10 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:08:10 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:08:10 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:08:10 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:08:10 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:08:10 INFO - Downloading docopt-0.6.1.tar.gz 02:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:08:10 INFO - Installing collected packages: blobuploader, requests, docopt 02:08:10 INFO - Running setup.py install for blobuploader 02:08:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:08:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:08:10 INFO - Running setup.py install for requests 02:08:11 INFO - Running setup.py install for docopt 02:08:11 INFO - Successfully installed blobuploader requests docopt 02:08:11 INFO - Cleaning up... 02:08:11 INFO - Return code: 0 02:08:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08:11 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:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:11 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:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:11 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 0x7f36ca0a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79410>, '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 0x1b7a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', '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:08:11 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:08:11 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:08:11 INFO - Using env: {'DISPLAY': ':0', 02:08:11 INFO - 'HOME': '/home/cltbld', 02:08:11 INFO - 'LANG': 'en_US.UTF-8', 02:08:11 INFO - 'LANGUAGE': 'en_US:en', 02:08:11 INFO - 'LOGNAME': 'cltbld', 02:08:11 INFO - 'MAIL': '/var/mail/cltbld', 02:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:11 INFO - 'MOZ_NO_REMOTE': '1', 02:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:11 INFO - 'NO_EM_RESTART': '1', 02:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:11 INFO - 'PWD': '/builds/slave/test', 02:08:11 INFO - 'SHELL': '/bin/bash', 02:08:11 INFO - 'SHLVL': '1', 02:08:11 INFO - 'TERM': 'linux', 02:08:11 INFO - 'TMOUT': '86400', 02:08:11 INFO - 'USER': 'cltbld', 02:08:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', 02:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:11 INFO - '_': '/tools/buildbot/bin/python'} 02:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:11 INFO - Running setup.py (path:/tmp/pip-rlz1VJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:11 INFO - Running setup.py (path:/tmp/pip-uerAIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:11 INFO - Running setup.py (path:/tmp/pip-t3rsaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:11 INFO - Running setup.py (path:/tmp/pip-p9V4lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:11 INFO - Running setup.py (path:/tmp/pip-xuzMMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:11 INFO - Running setup.py (path:/tmp/pip-nzQqWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:11 INFO - Running setup.py (path:/tmp/pip-OlxuOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:12 INFO - Running setup.py (path:/tmp/pip-LPWba8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:12 INFO - Running setup.py (path:/tmp/pip-n6_lLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:12 INFO - Running setup.py (path:/tmp/pip-JHtjiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:12 INFO - Running setup.py (path:/tmp/pip-v7VMDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:12 INFO - Running setup.py (path:/tmp/pip-05QMBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:12 INFO - Running setup.py (path:/tmp/pip-ZE_H3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:12 INFO - Running setup.py (path:/tmp/pip-SVTUXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:12 INFO - Running setup.py (path:/tmp/pip-h_Qhgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:12 INFO - Running setup.py (path:/tmp/pip-7WmXIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:12 INFO - Running setup.py (path:/tmp/pip-HR3Vk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:08:12 INFO - Running setup.py install for manifestparser 02:08:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:08:12 INFO - Running setup.py install for mozcrash 02:08:12 INFO - Running setup.py install for mozdebug 02:08:13 INFO - Running setup.py install for mozdevice 02:08:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:08:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:08:13 INFO - Running setup.py install for mozfile 02:08:13 INFO - Running setup.py install for mozhttpd 02:08:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:08:13 INFO - Running setup.py install for mozinfo 02:08:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:08:13 INFO - Running setup.py install for mozInstall 02:08:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:08:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:08:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:08:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:08:13 INFO - Running setup.py install for mozleak 02:08:13 INFO - Running setup.py install for mozlog 02:08:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:08:13 INFO - Running setup.py install for moznetwork 02:08:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:08:13 INFO - Running setup.py install for mozprocess 02:08:13 INFO - Running setup.py install for mozprofile 02:08:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:08:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:08:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:08:14 INFO - Running setup.py install for mozrunner 02:08:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:08:14 INFO - Running setup.py install for mozscreenshot 02:08:14 INFO - Running setup.py install for moztest 02:08:14 INFO - Running setup.py install for mozversion 02:08:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:08:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:08:14 INFO - Cleaning up... 02:08:14 INFO - Return code: 0 02:08:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08:14 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:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:14 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:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:14 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 0x7f36ca0a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79410>, '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 0x1b7a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', '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:08:14 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:08:14 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:08:14 INFO - Using env: {'DISPLAY': ':0', 02:08:14 INFO - 'HOME': '/home/cltbld', 02:08:14 INFO - 'LANG': 'en_US.UTF-8', 02:08:14 INFO - 'LANGUAGE': 'en_US:en', 02:08:14 INFO - 'LOGNAME': 'cltbld', 02:08:14 INFO - 'MAIL': '/var/mail/cltbld', 02:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:14 INFO - 'MOZ_NO_REMOTE': '1', 02:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:14 INFO - 'NO_EM_RESTART': '1', 02:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:14 INFO - 'PWD': '/builds/slave/test', 02:08:14 INFO - 'SHELL': '/bin/bash', 02:08:14 INFO - 'SHLVL': '1', 02:08:14 INFO - 'TERM': 'linux', 02:08:14 INFO - 'TMOUT': '86400', 02:08:14 INFO - 'USER': 'cltbld', 02:08:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', 02:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:14 INFO - '_': '/tools/buildbot/bin/python'} 02:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:14 INFO - Running setup.py (path:/tmp/pip-c1kBrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:14 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:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:14 INFO - Running setup.py (path:/tmp/pip-UdoBRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:14 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:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:14 INFO - Running setup.py (path:/tmp/pip-uDzDuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:14 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:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:14 INFO - Running setup.py (path:/tmp/pip-Rg9nC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:15 INFO - Running setup.py (path:/tmp/pip-7HOrYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:15 INFO - Running setup.py (path:/tmp/pip-3Q1cnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:15 INFO - Running setup.py (path:/tmp/pip-6DREZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:15 INFO - Running setup.py (path:/tmp/pip-fe6hQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:15 INFO - Running setup.py (path:/tmp/pip-GNjXQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:15 INFO - Running setup.py (path:/tmp/pip-9TPt1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:15 INFO - Running setup.py (path:/tmp/pip-dHIRMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:15 INFO - Running setup.py (path:/tmp/pip-x_HdiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:15 INFO - Running setup.py (path:/tmp/pip-ZNjhuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:15 INFO - Running setup.py (path:/tmp/pip-ugIQ_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:15 INFO - Running setup.py (path:/tmp/pip-bwzZNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:15 INFO - Running setup.py (path:/tmp/pip-I1ka1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:15 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:08:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:15 INFO - Running setup.py (path:/tmp/pip-wLE29m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:16 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:08:16 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:08:16 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:08:16 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:08:16 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:08:16 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:08:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:08:16 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:08:16 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:08:16 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:08:16 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:08:16 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:08:16 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:08:17 INFO - Downloading blessings-1.6.tar.gz 02:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:08:17 INFO - Installing collected packages: blessings 02:08:17 INFO - Running setup.py install for blessings 02:08:18 INFO - Successfully installed blessings 02:08:18 INFO - Cleaning up... 02:08:18 INFO - Return code: 0 02:08:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:18 INFO - Reading from file tmpfile_stdout 02:08:18 INFO - Current package versions: 02:08:18 INFO - argparse == 1.2.1 02:08:18 INFO - blessings == 1.6 02:08:18 INFO - blobuploader == 1.2.4 02:08:18 INFO - docopt == 0.6.1 02:08:18 INFO - manifestparser == 1.1 02:08:18 INFO - mozInstall == 1.12 02:08:18 INFO - mozcrash == 0.17 02:08:18 INFO - mozdebug == 0.1 02:08:18 INFO - mozdevice == 0.48 02:08:18 INFO - mozfile == 1.2 02:08:18 INFO - mozhttpd == 0.7 02:08:18 INFO - mozinfo == 0.9 02:08:18 INFO - mozleak == 0.1 02:08:18 INFO - mozlog == 3.1 02:08:18 INFO - moznetwork == 0.27 02:08:18 INFO - mozprocess == 0.22 02:08:18 INFO - mozprofile == 0.28 02:08:18 INFO - mozrunner == 6.11 02:08:18 INFO - mozscreenshot == 0.1 02:08:18 INFO - mozsystemmonitor == 0.0 02:08:18 INFO - moztest == 0.7 02:08:18 INFO - mozversion == 1.4 02:08:18 INFO - psutil == 3.1.1 02:08:18 INFO - requests == 1.2.3 02:08:18 INFO - wsgiref == 0.1.2 02:08:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08: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:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:18 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 0x7f36ca0a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79410>, '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 0x1b7a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', '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:08:18 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:08:18 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:08:18 INFO - Using env: {'DISPLAY': ':0', 02:08:18 INFO - 'HOME': '/home/cltbld', 02:08:18 INFO - 'LANG': 'en_US.UTF-8', 02:08:18 INFO - 'LANGUAGE': 'en_US:en', 02:08:18 INFO - 'LOGNAME': 'cltbld', 02:08:18 INFO - 'MAIL': '/var/mail/cltbld', 02:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:18 INFO - 'MOZ_NO_REMOTE': '1', 02:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:18 INFO - 'NO_EM_RESTART': '1', 02:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:18 INFO - 'PWD': '/builds/slave/test', 02:08:18 INFO - 'SHELL': '/bin/bash', 02:08:18 INFO - 'SHLVL': '1', 02:08:18 INFO - 'TERM': 'linux', 02:08:18 INFO - 'TMOUT': '86400', 02:08:18 INFO - 'USER': 'cltbld', 02:08:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', 02:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:18 INFO - '_': '/tools/buildbot/bin/python'} 02:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 INFO - Cleaning up... 02:08:18 INFO - Return code: 0 02:08:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:08: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:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36ca0a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79410>, '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 0x1b7a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', '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:08: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', 'jsonschema'] in /builds/slave/test/build 02:08: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 jsonschema 02:08:18 INFO - Using env: {'DISPLAY': ':0', 02:08:18 INFO - 'HOME': '/home/cltbld', 02:08:18 INFO - 'LANG': 'en_US.UTF-8', 02:08:18 INFO - 'LANGUAGE': 'en_US:en', 02:08:18 INFO - 'LOGNAME': 'cltbld', 02:08:18 INFO - 'MAIL': '/var/mail/cltbld', 02:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:18 INFO - 'MOZ_NO_REMOTE': '1', 02:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:18 INFO - 'NO_EM_RESTART': '1', 02:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:18 INFO - 'PWD': '/builds/slave/test', 02:08:18 INFO - 'SHELL': '/bin/bash', 02:08:18 INFO - 'SHLVL': '1', 02:08:18 INFO - 'TERM': 'linux', 02:08:18 INFO - 'TMOUT': '86400', 02:08:18 INFO - 'USER': 'cltbld', 02:08:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', 02:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:18 INFO - '_': '/tools/buildbot/bin/python'} 02:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:18 INFO - Downloading/unpacking jsonschema 02:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:18 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:08:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:08:20 INFO - Downloading/unpacking functools32 (from jsonschema) 02:08:20 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:08:20 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:08:20 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:08:20 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:08:20 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:08:20 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:08:20 INFO - Downloading functools32-3.2.3-2.tar.gz 02:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:08:20 INFO - warning: no files found matching '*.txt' 02:08:20 INFO - no previously-included directories found matching 'build' 02:08:20 INFO - no previously-included directories found matching 'dist' 02:08:20 INFO - no previously-included directories found matching '.git*' 02:08:20 INFO - Installing collected packages: jsonschema, functools32 02:08:21 INFO - Running setup.py install for functools32 02:08:21 INFO - warning: no files found matching '*.txt' 02:08:21 INFO - no previously-included directories found matching 'build' 02:08:21 INFO - no previously-included directories found matching 'dist' 02:08:21 INFO - no previously-included directories found matching '.git*' 02:08:21 INFO - Successfully installed jsonschema functools32 02:08:21 INFO - Cleaning up... 02:08:21 INFO - Return code: 0 02:08:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:08: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:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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:08:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36ca0a8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b79410>, '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 0x1b7a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', '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:08: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', 'flake8'] in /builds/slave/test/build 02:08: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 flake8 02:08:21 INFO - Using env: {'DISPLAY': ':0', 02:08:21 INFO - 'HOME': '/home/cltbld', 02:08:21 INFO - 'LANG': 'en_US.UTF-8', 02:08:21 INFO - 'LANGUAGE': 'en_US:en', 02:08:21 INFO - 'LOGNAME': 'cltbld', 02:08:21 INFO - 'MAIL': '/var/mail/cltbld', 02:08:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:21 INFO - 'MOZ_NO_REMOTE': '1', 02:08:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:21 INFO - 'NO_EM_RESTART': '1', 02:08:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:21 INFO - 'PWD': '/builds/slave/test', 02:08:21 INFO - 'SHELL': '/bin/bash', 02:08:21 INFO - 'SHLVL': '1', 02:08:21 INFO - 'TERM': 'linux', 02:08:21 INFO - 'TMOUT': '86400', 02:08:21 INFO - 'USER': 'cltbld', 02:08:21 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', 02:08:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:21 INFO - '_': '/tools/buildbot/bin/python'} 02:08:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:21 INFO - Downloading/unpacking flake8 02:08:21 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:08:21 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:08:21 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:08:21 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:08:21 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:08:21 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:08:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:08:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:08:23 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:08:23 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:08:23 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:08:23 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:08:23 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:08:23 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:08:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:08:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:08:23 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:08:23 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:08:23 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:08:23 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:08:23 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:08:23 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:08:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:08:23 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:08:23 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:08:23 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:08:23 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:08:23 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:08:23 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:08:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:08:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:24 INFO - no previously-included directories found matching 'docs/_build' 02:08:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:08:24 INFO - Running setup.py install for pep8 02:08:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:24 INFO - no previously-included directories found matching 'docs/_build' 02:08:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:08:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:08:24 INFO - Cleaning up... 02:08:24 INFO - Return code: 0 02:08:24 INFO - Running post-action listener: _resource_record_post_action 02:08:24 INFO - Running post-action listener: _start_resource_monitoring 02:08:24 INFO - Starting resource monitoring. 02:08:24 INFO - ##### 02:08:24 INFO - ##### Running install step. 02:08:24 INFO - ##### 02:08:24 INFO - Running pre-action listener: _resource_record_pre_action 02:08:24 INFO - Running main action method: install 02:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:24 INFO - Reading from file tmpfile_stdout 02:08:24 INFO - Detecting whether we're running mozinstall >=1.0... 02:08:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:08:24 INFO - Reading from file tmpfile_stdout 02:08:24 INFO - Output received: 02:08:24 INFO - Usage: mozinstall [options] installer 02:08:24 INFO - Options: 02:08:24 INFO - -h, --help show this help message and exit 02:08:24 INFO - -d DEST, --destination=DEST 02:08:24 INFO - Directory to install application into. [default: 02:08:24 INFO - "/builds/slave/test"] 02:08:24 INFO - --app=APP Application being installed. [default: firefox] 02:08:24 INFO - mkdir: /builds/slave/test/build/application 02:08:24 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:08:24 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:08:37 INFO - Reading from file tmpfile_stdout 02:08:37 INFO - Output received: 02:08:37 INFO - /builds/slave/test/build/application/firefox/firefox 02:08:37 INFO - Running post-action listener: _resource_record_post_action 02:08:37 INFO - ##### 02:08:37 INFO - ##### Running run-tests step. 02:08:37 INFO - ##### 02:08:37 INFO - Running pre-action listener: _resource_record_pre_action 02:08:37 INFO - Running main action method: run_tests 02:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:08:37 INFO - Python 2.7.3 02:08:37 INFO - Return code: 0 02:08:37 INFO - grabbing minidump binary from tooltool 02:08: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:08:37 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 0x1b79410>, '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 0x1b7a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:08:37 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:08:37 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:08:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:08:37 INFO - Return code: 0 02:08:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:08:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:08:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:08:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:08:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:08:38 INFO - Return code: 0 02:08:38 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-e10s', '--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-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:08:38 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-e10s --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-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:08:38 INFO - Using env: {'DISPLAY': ':0', 02:08:38 INFO - 'HOME': '/home/cltbld', 02:08:38 INFO - 'LANG': 'en_US.UTF-8', 02:08:38 INFO - 'LANGUAGE': 'en_US:en', 02:08:38 INFO - 'LOGNAME': 'cltbld', 02:08:38 INFO - 'MAIL': '/var/mail/cltbld', 02:08:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:08:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:38 INFO - 'MOZ_NO_REMOTE': '1', 02:08:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:38 INFO - 'NO_EM_RESTART': '1', 02:08:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:38 INFO - 'PWD': '/builds/slave/test', 02:08:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:08:38 INFO - 'SHELL': '/bin/bash', 02:08:38 INFO - 'SHLVL': '1', 02:08:38 INFO - 'TERM': 'linux', 02:08:38 INFO - 'TMOUT': '86400', 02:08:38 INFO - 'USER': 'cltbld', 02:08:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374', 02:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:38 INFO - '_': '/tools/buildbot/bin/python'} 02:08:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--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-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:08:39 INFO - mozversion application_buildid: 20160606194329 02:08:39 INFO - mozversion application_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 02:08:39 INFO - mozversion application_display_name: Firefox 02:08:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:08:39 INFO - mozversion application_name: Firefox 02:08:39 INFO - mozversion application_remotingname: firefox 02:08:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:08:39 INFO - mozversion application_vendor: Mozilla 02:08:39 INFO - mozversion application_version: 48.0 02:08:39 INFO - mozversion platform_buildid: 20160606194329 02:08:39 INFO - mozversion platform_changeset: 1f9f6bdee31c14fd5a39485e8ae326de2928ef7d 02:08:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:08:39 INFO - mozversion platform_version: 48.0 02:08:39 INFO - using testdate: 1465290519 02:08:39 INFO - actual date: 1465290519 02:08:39 INFO - starting webserver on 'localhost:41404' 02:08:39 INFO - SUITE-START | Running 2 tests 02:08:39 INFO - TEST-START | dromaeo_css 02:08:39 INFO - operating with platform_type : linux_ 02:08:39 INFO - Initialising browser for dromaeo_css test... 02:08:39 INFO - TEST-INFO | started process 21789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYdZBT_/profile http://localhost:41404/getInfo.html) 02:08:43 INFO - PROCESS | 21789 | 02:08:43 INFO - PROCESS | 21789 | (process:21870): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:08:44 INFO - PROCESS | 21789 | __metrics Screen width/height:1600/1200 02:08:44 INFO - PROCESS | 21789 | colorDepth:24 02:08:44 INFO - PROCESS | 21789 | Browser inner width/height: 1024/697 02:08:44 INFO - PROCESS | 21789 | __metrics 02:08:44 ERROR - PROCESS | 21789 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:08:45 INFO - TEST-INFO | 21789: exit 0 02:08:45 INFO - Browser initialized. 02:08:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:08:45 INFO - TEST-INFO | started process 21921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYdZBT_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:47 INFO - PROCESS | 21921 | 02:08:47 INFO - PROCESS | 21921 | (process:21986): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:08:57 INFO - PROCESS | 21921 | RSS: Main: 151146496 02:08:57 INFO - PROCESS | 21921 | 02:09:46 INFO - PROCESS | 21921 | 1465290586907 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:11:54 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:41404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41404/tests/dromaeo/cssquery-ext.html) 02:11:55 INFO - PROCESS | 21921 | RSS: Main: 154624000 02:11:55 INFO - PROCESS | 21921 | 02:14:57 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:41404/tests/dromaeo/cssquery-ext.html (next: http://localhost:41404/tests/dromaeo/cssquery-jquery.html) 02:14:57 INFO - PROCESS | 21921 | RSS: Main: 152891392 02:14:57 INFO - PROCESS | 21921 | 02:17:59 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:41404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41404/tests/dromaeo/cssquery-mootools.html) 02:18:00 INFO - PROCESS | 21921 | RSS: Main: 152219648 02:18:00 INFO - PROCESS | 21921 | 02:21:01 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:41404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41404/tests/dromaeo/cssquery-prototype.html) 02:21:02 INFO - PROCESS | 21921 | RSS: Main: 153948160 02:21:02 INFO - PROCESS | 21921 | 02:24:04 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:41404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41404/tests/dromaeo/cssquery-yui.html) 02:24:05 INFO - PROCESS | 21921 | RSS: Main: 152522752 02:24:05 INFO - PROCESS | 21921 | 02:27:07 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:41404/tests/dromaeo/cssquery-yui.html (next: http://localhost:41404/tests/dromaeo/cssquery-dojo.html) 02:27:07 INFO - PROCESS | 21921 | RSS: Main: 156356608 02:27:07 INFO - PROCESS | 21921 | 02:27:07 INFO - PROCESS | 21921 | __start_tp_report 02:27:07 INFO - PROCESS | 21921 | _x_x_mozilla_page_load 02:27:07 INFO - PROCESS | 21921 | _x_x_mozilla_page_load_details 02:27:07 INFO - PROCESS | 21921 | |i|pagename|runs| 02:27:07 INFO - PROCESS | 21921 | |0;dojo.html;3336.4828451590006;3383.120388698939;3388.1698983748984;3392.406328892444;3434.4676575130848;5530.05988981873;5554.972225138868;5588.469095435927;5591.412901645324;5594.021046316889;5579.497845193931;5581.441855814416;5592.217089607448;5614.3543492498375;5627.549796016319;5059.064073146461;5072.213806859942;5130.384353877521;5132.28148059272;5224.660397074178;5183.611229157809;5232.3197984262;5244.737763111848;5277.366715994086;5292.470752924715;5255.159174532076;5281.128613778722;5332.760025798829;5333.093374126388;5334.893302133955;5192.169252919533;5205.349331333583;5205.7397130143345;5210.088234558937;5230.738463076869;4906.386701662293;5079.923801142986;5105.208692652608;5122.359705036871;5125.256837758541;5485.232067510552;5520.1167813150105;5525.336959564837;5534.584906132016;5544.972275138599;6030.065339872327;6034.758609655609;6039.5772295939305;6046.365131661156;6057.545684073668;6032.45707886288;6062.636241825505;6073.392660733935;6095.512359011313;6114.266288045418;5781.392953739881;5803.158542011427;5804.361520232771;5807.448292412214;5811.506021988136;6332.873342533124;6339.524535659844;6340.429361357407;6342.365763423713;6343.9682801585695;5899.911501327398;6051.092336149525;6055.364186760415;6104.633721976696;6141.324454310023;6072.574919755663;6082.2701275847185;6087.086936959403;6088.238970128734;6090.23872015998;6052.6671033092725;6062;6066.757329706762;6069.757209711562;6072.787452439144;5905.4685078343155;5964.671943043174;6033.095035744585;6035.8792824143275;6038.516918646497;4539.046800171935;4544.045750392388;4561.543845615412;4570.177368073712;4583.175028494837;4097.364908439196;4099.385092236129;4136.627703506699;4146.0464093258115;4162.62536371728;5856.443637854397;5889.146073819272;5905.586608937333;5970.134330522137;5970.880582388328;6101.054336577838;6137;6140.17107690465;6145.846353841101;6152.2924863640355;5822.243108395882;5846.883062338729;5881.970590147107;5888.4700376966275;5912.379200183918;5144.382674079135;5153.098207813618;5184.11869982104;5195.090859099642;5209.6874187548865;6524.021396790425;6530.510211734139;6535.248446428626;6546.18172728409;6554.606723596599;5991.430814072656;6011.6693581853415;6069.271687397364;6264;6288.6855657217875;6239.500839932885;6256.937430625636;6257.5932564383165;6257.937420625735;6259.374062593704;5828.388019257917;5899.085641725539;5902.6458412495385;5913.615614985012;5939.524838012862;6024.939750602438;6047;6103;6139.890808645427;6160.075988601746;6087.57386982907;6096.573239873166;6098.603590766586;6099.817005489843;6110.7861224856915;6075.088736689532;6128.693565321627;6130.111133885473;6132.601380910227;6141.109539116893;5790.131480277992;5976.372480889444;5994.07091900756;5998.9100163496705;6047.455728984412;5860.619059761102;5902.704864756659;5921.555883308855;5926.318473375617;5957.255343082114;5758.942410576008;5765.279340082489;5850.619709718854;5852.619579727304;5854.443827836349 02:27:07 INFO - PROCESS | 21921 | |1;ext.html;662.8972509261066;663.8937769956808;680.3740558686009;729.602366710143;740.2375553180225;41366.17267654649;42530.936726581815;42533.36199956999;42599;42613.36079958795;44268;44699;44754;44856.3271550927;44868.551314486846;8992.505412202327;9142.405743626643;9146.908530914672;9156.542172891362;9173.816523669522;8992.505412202327;9060.728178154666;9080.682176123837;9095.818083638324;9139.451632902013;9286.257099432029;9319.95340023299;9320.62717491303;9330.160285574297;9367.718968430923;9218.400803947721;9268;9293.58178881952;9296.8605470918;9320.021397753206;9218.585163667583;9305.627774889064;9314.254859611216;9325.626974920995;9327.626894924195;44776.3283550747;44946.77526612346;45051.324230136575;45071.098578028585;45416;3779.8110094495164;3840.7695538267794;3878.3019056569806;3982.8008599569907;4458.977705111486;33905.83047084749;33915.15212119692;34135.829320853234;34484.48273275903;34564;4505.684602077856;4674.929876051862;4685.929711054337;4686.812527498896;4691.202495575761;329575;330427.9999999976;330500;330935;331060;40321;63581;64255;64545;64661;38555.42166867499;38726.6127338723;38765.61234387676;38907.416388754194;38971.61028389737;15922.840771592368;16247.837521624633;16248;16248.675026499404;16287.837121628869;12353.073519486075;12359.134860559674;12377.62867113988;12381.195222310522;12386.5664701735;9531.857022144673;9560.90439095614;9565.186959108414;9621.27840411972;9648.131668149901;3601.1177261571083;3638.3450978824067;3692.5015122958057;3709.666130048309;3748.156664750409;1096.8738595061511;1110.4336788238056;1122.8708698499777;1142.948567314473;1163.5869266410302;33971.83014084963;34288.53656346362;34434.483482747775;34509.827450862584;34687.65312346895;1236.2644226685109;1251.2617555642214;1267.9982813577356;1284.5247258514223;1288.407332627002;17485.562860928323;17687.115644217738;17861.196246168955;18107.275708971756;18226.726599101024;483115;550380;582628;596690;600315;56896.431035689115;58002.709986449794;58224.12663810046;58368.708156458946;58412.70793646004;823.5635113389912;1391.325207274471;1539.9846001540066;1558.0885182168558;1564.2491604030129;31044.534331984585;32089;32890;33430.16424589405;34957.65042349544;55338.44661553494;57045.42954570567;57287.71356143193;57469.13796292975;58267.4173258262;312606;315038;316683;318472;319847;45781.54218457773;45913;46488;46577.3013404806;47434.76282618565;54338.18492722692;55434.44565554454;56147.43852561422;56376.43623563712;56403.71798140983;46171.30743038924;46355.768221160026;46620.7668961653;47422;47641;45277.43428534527;45625.77187114043;46405.30392044054;46504.7674761624;47544;45696.08607827892;46400.53599464097;46724;46860.29709554427;46955.53044469511;38485.4227186598;39954.60045399509;40113.39829902496;40541.87973203365;41437.79281103575;30976.69023309828;31773.36453270968;31876;31889.362212756077;32117.357652846345 02:27:07 INFO - PROCESS | 21921 | |2;jquery.html;400.877732291651;405.943167956486;406.8108329626727;415.18623497944026;418.2645498440201;18035.639287214282;18563.16465759041;19262.711059334102;19361.903190484063;20502.692459613118;12011.819822702666;12782.616521504346;12836;12921.224726516391;19911.60176796467;5171.4311425743135;5349.438308977559;5356.223347614594;5367.490088441592;5368.32895888014;5276.050310944029;5343.812966546172;5349.43830897754;5544;5788.797392091277;5708.600397972144;5747.655140691572;5772.278465191851;5777.740001699913;5795.913061304083;5695.345035320929;5990.760369585255;5992.550558708114;5995.7901473448655;6011.849703757397;5780.450857168562;5817.563682723812;5841.357450680422;5848;5851.23933888596;13428.462861485528;13693.452261909511;13803.654908627364;13809.102408343426;13810.723785524233;2440.0727723465147;2491.638712386694;2552.7574880386333;2633.789296856247;3056.3276079262528;10189.184865210766;10431.269811113225;10505.68482945513;12702.174358666656;14080.92959535206;1966.7344908437321;1966.8918209498615;2009.8090681385245;2070.4099331690395;2142.860714053597;80000;81021.78467322995;81802.59098704527;83523;84180.57909710413;10914.345139291669;10952.123830093733;10974.231803773659;11005;11007.61473348429;14809.555713328402;14967.625809354853;15043.398264069314;15082.924585377003;15085.24573771307;8239.382046346547;8280.751577452565;8286;8437.662493500191;8550.914490855012;8236.299914507334;8379.790505237295;8392.790180245544;8403.07566167721;8471.279941205066;4543.886402839956;4592.10453961481;4595.379623750818;4641.094986477605;4704.788284527204;1961.264525802824;1986.4636548131923;2006.8360350996386;2055.7944205579324;2069.906854191565;980.7302991677203;1016.1972042086817;1069.3102948598112;1073.7208325835338;1133.2803669669654;19449.416517504214;19753.111109999798;19897.801021989886;20031.499212519804;20365;1014.1075853249093;1030.845373194012;1063.5905176507101;1100.1693721240572;1103.6358001859367;9085.36402451822;10737.570497180182;10885.510152043176;10908.50911708975;10933.507992140214;561333;562797;572034;576181;577311;80161.59919200366;83824.16175838285;100509.49745251227;103143.48428257811;107334;1133.7505748735266;1149.7010777197988;1165.9650210493699;1182.722060315825;1212.3635091576994;17411.303547857944;17418.82581174172;17445.563860903578;17833.910830445766;18429.26282948721;40747.57383491564;41562.792186038874;41731.157637930104;42298.577014230694;42495.362569560864;59091.40908591031;60665.09002365056;60934;61008.389916102045;61087.38912610817;8347;8363.20549547792;8368.246857782586;8447.535385553854;8517.105703901001;9067.319951003568;13627.38676759568;14119.929400352932;14141.292935353396;14293.57119286423;12024.398780061138;12409.317487538272;12600.74798504043;12727.23636581808;12764.170328928962;12375.195612285173;12497.18768280059;12547.05897057706;12590.559330423392;12703.555375561811;12900.290484023093;12905.096643234883;13036.934815325863;13043.739125217253;13114.409851556893;8926.464412135292;8969.14793094655;9068.727938161866;9167.44995300284;9472.810543788948;12709.745805084032;12778.68053298675;12826.23042617446;12856.742865142833;12879.162854414808 02:27:07 INFO - PROCESS | 21921 | |3;mootools.html;1603.839616038396;1617.5632579203611;1839.9632007359853;1944.883307001581;1955.2667749593902;7672.884906726404;8293.751187464371;8450.957745211274;8698.130186981298;8698.478091314517;8275.131111233324;8397.076321604634;8408.873866891987;8412.327013838894;8471.745847624567;2335.2177020698086;2377.3818807110188;2381.1903952656094;2390.9043638254448;2397.244867866625;2362.7164740231196;2390.103711108334;2425.7816796488314;2443.1937460638037;2458.7787099161073;2373.821963352747;2398.0767404549288;2424.272718184546;2460.0774709483944;2472.4931389065287;2423.709154901423;2425.16331865507;2428.7085549734056;2443.596806526921;2447.05788271515;2406.338256979327;2424.806015518754;2429.769171928664;2431.732509423962;2435.147698305579;8534;8559.786005349915;8566.700165494178;8577.957110214471;8588.141185881424;5224.059669259532;5306.602004849652;5332.626716129873;5334.866628334284;5339.599530035263;3431.4166591679473;3453.879114231015;3454.9309013819584;3469.5663042119736;3523.1016090896915;1146.7591805720808;1149.4769879704713;1154.0709728668419;1157.6179860645966;1162.482695200636;12049.216800908001;12080.395980200954;12111.757764844653;12153.93923030388;12185.939070304592;4520.909581808345;4533.52397998212;4653.325267836145;4657.720536767804;4693.6949098308505;10240.078392944522;10357.119644830123;10395.84406233907;10403.5838566458;10417.739556510996;5294.391145018295;5338.306020217425;5348.946510534923;5354.705491198021;5362.731863406892;4746.857594272177;4892.706437613754;4897.094037603055;4921.655484116078;4928.457869634337;3964.60353964607;3966.484357033567;4069.654079403284;4080.836766529365;4119;1283.813846992181;1284.7173621803188;1286.414681319997;1299.493197652916;1315.7368526294779;1039.896010398954;1046.7540128069897;1051.9894801052044;1063.2132222155549;1074.6023971130576;5915.852103697442;5934.19888315072;5948.196993405922;6088.299845517822;6162.599431036968;1050.09167070485;1056.9260151789301;1057.143713591993;1071.8867485276442;1073.0717928991367;3936.842526298973;4082.81627326771;4113.218488487238;4138.627523522898;4158.6465150461945;10162.441065741456;10485.213608979357;10514.158867290598;10518.263721539419;10575;10331.32846364984;10331.793364132674;10344.32761870476;10345.637902673521;10349.379037257639;7905.090914544786;7938.3252423544645;7997.960010199912;8000.679972801023;8169.223923727236;5755.798547050833;5811.1573821794755;5833.066709326487;5902.085176797603;5936.079907614327;9286.164245217962;9350.906490935004;9429.339946203974;9445.102715242041;9614;9513.476758778057;9597.952010239904;9715.951420242853;9729.805403892024;9755.414675119515;7698.807529811799;7733.922660773545;7763.961180194063;7773.3004029637605;7789.961050194713;8394.37042221848;8404.579771011302;8423.831523369621;8430.36772242072;8489.363297752816;7453.180150183367;7455.440841936768;7543.962280188564;7676.731314403969;7763.961180194289;7296.233895440902;7432.665530051268;7467.141278753013;7503.9249607503225;7549.547027178387;6971.268016858156;7000.159980802337;7039.507234493741;7048.436125109876;7054.906489493931;5216.40011398694;5269.341332333458;5293.708846013352;5314.62797604164;5356.544693700923;5214.530692237717;5234.7906083756225;5250;5302.469753024821;5308.124159513637 02:27:07 INFO - PROCESS | 21921 | |4;prototype.html;326.44341397916554;335.2942056970078;340.7189069018059;340.7733856985105;342.36491308622504;6393.712282947267;6672.232693240273;6794.1167648205665;6866.347696968793;6871.931280687191;6620.073189753439;6647.734090636369;6648.434883034935;6654.3345665433435;6699.832504187398;4965.950340496603;4980.327655766479;4990.75046247688;4998.5501304882555;5004;4996.050750357439;4999.7500124993785;5006.374203224597;5006.399232092154;5015.197568389059;4939.950600494003;4952.529509696573;4966.875828104308;4967.428745694256;4971.751412429382;4821.252705830584;4889.902201955941;4904.975475122602;4951;4959.950400496003;4191.11986482839;4221.451211342536;4222.577742225783;4224.366345048267;4226.577342265779;6368.363163683641;6392.1370614966845;6396.5842220256;6397.9360206397805;6404.103425520431;5640.746166422521;5653.462921022497;5674.290713660793;5688.232088668018;5699.68651724155;7047.295270472963;7054.611996340199;7056.364927156581;7060.964695176543;7093.787186384417;4601.539846015406;4682.344471773954;4694.08465349257;4706.835260765891;4721.693089949143;7331.450141239428;7333.376662983653;7335.606234815368;7359.190489046201;7373.446991475661;4778.808847646124;4784.0192760484015;4786.736729479912;4788.04239152164;4803.927941080887;4845.345878306454;4853.854384368475;4858.02839432115;4865.5864251538305;4872.975635121802;5678.488935995781;5689.402612725687;5700.743466543932;5705.2012718219485;5719.027765279912;6787.2534021257625;7029;7048.083749112582;7063.223045464994;7078.539894906815;1725.258139000242;1737.7567140600327;1743.2939659437948;1746.9475915722549;1748.2307784574746;1136.732867776072;1146.5356530605118;1148.6496618531262;1153.2849633227286;1167.2121318110412;6780.627065511444;6795.524313298021;6807.2512023677355;6819.693113809891;6823.522353435212;7223.2415596361625;7232.0959880015;7232.855342893218;7236.421086313082;7240.637968101574;6723.092382528296;6798.354156355138;6804.3195680432555;6806.353396427331;6807.761728339583;3892.5134358205223;3906.7265291429326;3908.863189788344;3913.1391093959282;3913.8630147945255;7364.705411783469;7750.263724946121;7752.147263800977;7764.650590723431;7766.534007959541;7481.85036299271;7512.13610434807;7525.887111693329;7538.547687138789;7545.056867891513;7644.923550764533;7647.311741943252;7652.617369131521;7668.923310766932;7685.462017658822;7246.927530724625;7297.635118244173;7322.194558598443;7354.043974283309;7377.3360397564475;7187.532810367309;7218.963905180441;7246.492745507975;7254.927450725636;7255.927440725525;7602.7339043133225;7609.086909570887;7610.619469026416;7630.046244219473;7645.273698998586;4648.349231107715;4689.577937985598;4697.459792123949;4697.8355757548325;4699.953000469952;7105.602379771938;7226;7300.926990730025;7310.049693539806;7321.963390183015;7061;7079.2566780487305;7097.432205423657;7102.715891364494;7103.431725461847;7040.5071644984355;7056.259092795182;7061.435085193275;7065.364117229268;7079.787606371817;6961.756338528127;6963.6866341013765;6963.79108626742;6964.781163296301;6976.895346569907;6992.1259842519685;7106.360427561544;7133.464990125865;7135.322144396274;7139.357457828821;6756.898646520208;6954.930450695429;6964.4080253179045;6994.33553812387;6994.720211191496 02:27:07 INFO - PROCESS | 21921 | |5;yui.html;813.3899575318511;841.8989721233452;842.6545116502235;889.0398369760659;913.6665117232212;16320;16629.251683674232;16648.417305394312;16678.83321166788;16692.83307166928;15132.697346053072;15169.92415037926;15193.164375959317;15272.770908436383;15321.846781532182;819.565630215985;826.983460330793;856.1224744636766;862.094800459515;869.009329364525;843.4896887383137;880.1242763450376;882.4484697064335;886.8714036464709;887.2325438495719;881.030866047346;922.6493932305748;923.3167456082484;925.6945208081318;930.6696122876349;878.8857448531681;905.6558507767039;913.1051569461964;913.3697748553477;917.4632839788732;679.3444326225167;683.8803209438329;684.555039224503;686.6703982088576;690.4372936057098;15772.76340854888;15811.367545298175;15879.682406351809;15885.444009459614;15886.443974460839;13974.51089211883;13974.720505589832;13990.930045349709;14007.159570425807;14304.213268270241;12083.516659333616;12153.696157596043;12179.208351457215;12201.20692155016;12374;4480.910381792379;4511.481179664348;4524.909501809978;4650.837220697294;4697.929531057037;48287.27569086466;52243.73878130585;55533.44466555364;57051.429485705026;57292.71353643205;11301.041330119013;11395.886041139482;11400.315981041163;11634.127440441831;11819.172657913863;20171.899140504203;20218.090185941666;20239.4940126498;20285.695714564292;20378.082986265654;8870.283701390063;8871.645134194689;8875.334349923782;8914.598843052077;8987.955060224656;4684.110019096361;4952.257161425743;5030.89938201234;5101.107306221471;5174.43081261061;3487.6861082502696;3548.8048157351595;3563.5367402237544;3566.179778650873;3567.3935430976794;647.5790736021529;648.3743187823773;651.3258777165705;651.5536857252703;658.5127006015609;671.6071098407486;764.7055883484899;769.830637259802;785.0932173339802;813.9186081391813;9570.473623950611;9956.303058785816;9959.850602240973;9998.150157236716;10121.291509594404;754.7056946881529;771.4021633234288;796.4146352430959;823.9340852731767;830.3979614779237;4435.756033418128;4577.382053422745;4580.427446569179;4582.083583283356;4710.317004034396;56808.715956419954;62646.37353626497;62970;69344;69812.65093674499;52584.47415525872;52865;54895.72552137294;59306;59355.109673354935;46486.302705458766;46909.5309046912;50661.74669126704;50882.745586271834;51785.48214517882;9766.82013961104;10225.897741022494;10310.845337320095;10320.277580569287;10345.431001295;39306;39944.40083398693;40238.39642405308;40299.59700402959;41150;47342.81642958816;47928;51294.48705513046;51365.48634513607;51809;11848.229865058744;12303.876961230631;12309.876901230873;12414.641892964675;12845.165064270792;14044.438222471395;14353.712925741636;14410.351534180778;14519.854801451851;14648.414063437343;13512.6621834451;13582.728345433234;13744;14027.929860350632;14039.859601403856;12812.679683008;13224.537141200011;13444.39500222512;13603.659908502366;14135.575932722035;13391.665208369868;13637.249951252776;13672.794908076188;13842.30788460593;14270.143791372551;11300.378479183724;11490.88509114898;11765.823512647146;11836.82244766312;11856.644300670994;11782.882171178178;11839.112066594867;11886.465109070286;12038.699032523906;12044.156909016285 02:27:07 INFO - PROCESS | 21921 | __end_tp_report 02:27:07 INFO - PROCESS | 21921 | __start_cc_report 02:27:07 INFO - PROCESS | 21921 | _x_x_mozilla_cycle_collect,335 02:27:07 INFO - PROCESS | 21921 | __end_cc_report 02:27:07 INFO - PROCESS | 21921 | __startTimestamp1465291627717__endTimestamp 02:27:07 INFO - PROCESS | 21921 | 02:27:07 INFO - PROCESS | 21921 | ------- Summary: start ------- 02:27:07 INFO - PROCESS | 21921 | Number of tests: 6 02:27:07 INFO - PROCESS | 21921 | 02:27:07 INFO - PROCESS | 21921 | [#0] dojo.html Cycles:165 Average:5669.62 Median:5902.70 stddev:655.68 (11.1%) stddev-sans-first:631.63 02:27:07 INFO - PROCESS | 21921 | Values: 3336.5 3383.1 3388.2 3392.4 3434.5 5530.1 5555.0 5588.5 5591.4 5594.0 5579.5 5581.4 5592.2 5614.4 5627.5 5059.1 5072.2 5130.4 5132.3 5224.7 5183.6 5232.3 5244.7 5277.4 5292.5 5255.2 5281.1 5332.8 5333.1 5334.9 5192.2 5205.3 5205.7 5210.1 5230.7 4906.4 5079.9 5105.2 5122.4 5125.3 5485.2 5520.1 5525.3 5534.6 5545.0 6030.1 6034.8 6039.6 6046.4 6057.5 6032.5 6062.6 6073.4 6095.5 6114.3 5781.4 5803.2 5804.4 5807.4 5811.5 6332.9 6339.5 6340.4 6342.4 6344.0 5899.9 6051.1 6055.4 6104.6 6141.3 6072.6 6082.3 6087.1 6088.2 6090.2 6052.7 6062.0 6066.8 6069.8 6072.8 5905.5 5964.7 6033.1 6035.9 6038.5 4539.0 4544.0 4561.5 4570.2 4583.2 4097.4 4099.4 4136.6 4146.0 4162.6 5856.4 5889.1 5905.6 5970.1 5970.9 6101.1 6137.0 6140.2 6145.8 6152.3 5822.2 5846.9 5882.0 5888.5 5912.4 5144.4 5153.1 5184.1 5195.1 5209.7 6524.0 6530.5 6535.2 6546.2 6554.6 5991.4 6011.7 6069.3 6264.0 6288.7 6239.5 6256.9 6257.6 6257.9 6259.4 5828.4 5899.1 5902.6 5913.6 5939.5 6024.9 6047.0 6103.0 6139.9 6160.1 6087.6 6096.6 6098.6 6099.8 6110.8 6075.1 6128.7 6130.1 6132.6 6141.1 5790.1 5976.4 5994.1 5998.9 6047.5 5860.6 5902.7 5921.6 5926.3 5957.3 5758.9 5765.3 5850.6 5852.6 5854.4 02:27:07 INFO - PROCESS | 21921 | 02:27:07 INFO - PROCESS | 21921 | [#1] ext.html Cycles:180 Average:58029.42 Median:44907.66 stddev:111282.12 (247.8%) stddev-sans-first:111510.94 02:27:07 INFO - PROCESS | 21921 | Values: 662.9 663.9 680.4 729.6 740.2 41366.2 42530.9 42533.4 42599.0 42613.4 44268.0 44699.0 44754.0 44856.3 44868.6 8992.5 9142.4 9146.9 9156.5 9173.8 8992.5 9060.7 9080.7 9095.8 9139.5 9286.3 9320.0 9320.6 9330.2 9367.7 9218.4 9268.0 9293.6 9296.9 9320.0 9218.6 9305.6 9314.3 9325.6 9327.6 44776.3 44946.8 45051.3 45071.1 45416.0 3779.8 3840.8 3878.3 3982.8 4459.0 33905.8 33915.2 34135.8 34484.5 34564.0 4505.7 4674.9 4685.9 4686.8 4691.2 329575.0 330428.0 330500.0 330935.0 331060.0 40321.0 63581.0 64255.0 64545.0 64661.0 38555.4 38726.6 38765.6 38907.4 38971.6 15922.8 16247.8 16248.0 16248.7 16287.8 12353.1 12359.1 12377.6 12381.2 12386.6 9531.9 9560.9 9565.2 9621.3 9648.1 3601.1 3638.3 3692.5 3709.7 3748.2 1096.9 1110.4 1122.9 1142.9 1163.6 33971.8 34288.5 34434.5 34509.8 34687.7 1236.3 1251.3 1268.0 1284.5 1288.4 17485.6 17687.1 17861.2 18107.3 18226.7 483115.0 550380.0 582628.0 596690.0 600315.0 56896.4 58002.7 58224.1 58368.7 58412.7 823.6 1391.3 1540.0 1558.1 1564.2 31044.5 32089.0 32890.0 33430.2 34957.7 55338.4 57045.4 57287.7 57469.1 58267.4 312606.0 315038.0 316683.0 318472.0 319847.0 45781.5 45913.0 46488.0 46577.3 47434.8 54338.2 55434.4 56147.4 56376.4 56403.7 46171.3 46355.8 46620.8 47422.0 47641.0 45277.4 45625.8 46405.3 46504.8 47544.0 45696.1 46400.5 46724.0 46860.3 46955.5 38485.4 39954.6 40113.4 40541.9 41437.8 30976.7 31773.4 31876.0 31889.4 32117.4 02:27:07 INFO - PROCESS | 21921 | 02:27:07 INFO - PROCESS | 21921 | [#2] jquery.html Cycles:180 Average:31206.80 Median:11279.24 stddev:93725.97 (831.0%) stddev-sans-first:93960.35 02:27:07 INFO - PROCESS | 21921 | Values: 400.9 405.9 406.8 415.2 418.3 18035.6 18563.2 19262.7 19361.9 20502.7 12011.8 12782.6 12836.0 12921.2 19911.6 5171.4 5349.4 5356.2 5367.5 5368.3 5276.1 5343.8 5349.4 5544.0 5788.8 5708.6 5747.7 5772.3 5777.7 5795.9 5695.3 5990.8 5992.6 5995.8 6011.8 5780.5 5817.6 5841.4 5848.0 5851.2 13428.5 13693.5 13803.7 13809.1 13810.7 2440.1 2491.6 2552.8 2633.8 3056.3 10189.2 10431.3 10505.7 12702.2 14080.9 1966.7 1966.9 2009.8 2070.4 2142.9 80000.0 81021.8 81802.6 83523.0 84180.6 10914.3 10952.1 10974.2 11005.0 11007.6 14809.6 14967.6 15043.4 15082.9 15085.2 8239.4 8280.8 8286.0 8437.7 8550.9 8236.3 8379.8 8392.8 8403.1 8471.3 4543.9 4592.1 4595.4 4641.1 4704.8 1961.3 1986.5 2006.8 2055.8 2069.9 980.7 1016.2 1069.3 1073.7 1133.3 19449.4 19753.1 19897.8 20031.5 20365.0 1014.1 1030.8 1063.6 1100.2 1103.6 9085.4 10737.6 10885.5 10908.5 10933.5 561333.0 562797.0 572034.0 576181.0 577311.0 80161.6 83824.2 100509.5 103143.5 107334.0 1133.8 1149.7 1166.0 1182.7 1212.4 17411.3 17418.8 17445.6 17833.9 18429.3 40747.6 41562.8 41731.2 42298.6 42495.4 59091.4 60665.1 60934.0 61008.4 61087.4 8347.0 8363.2 8368.2 8447.5 8517.1 9067.3 13627.4 14119.9 14141.3 14293.6 12024.4 12409.3 12600.7 12727.2 12764.2 12375.2 12497.2 12547.1 12590.6 12703.6 12900.3 12905.1 13036.9 13043.7 13114.4 8926.5 8969.1 9068.7 9167.4 9472.8 12709.7 12778.7 12826.2 12856.7 12879.2 02:27:07 INFO - PROCESS | 21921 | 02:27:07 INFO - PROCESS | 21921 | [#3] mootools.html Cycles:180 Average:5735.76 Median:4819.78 stddev:3126.94 (64.9%) stddev-sans-first:3120.29 02:27:07 INFO - PROCESS | 21921 | Values: 1603.8 1617.6 1840.0 1944.9 1955.3 7672.9 8293.8 8451.0 8698.1 8698.5 8275.1 8397.1 8408.9 8412.3 8471.7 2335.2 2377.4 2381.2 2390.9 2397.2 2362.7 2390.1 2425.8 2443.2 2458.8 2373.8 2398.1 2424.3 2460.1 2472.5 2423.7 2425.2 2428.7 2443.6 2447.1 2406.3 2424.8 2429.8 2431.7 2435.1 8534.0 8559.8 8566.7 8578.0 8588.1 5224.1 5306.6 5332.6 5334.9 5339.6 3431.4 3453.9 3454.9 3469.6 3523.1 1146.8 1149.5 1154.1 1157.6 1162.5 12049.2 12080.4 12111.8 12153.9 12185.9 4520.9 4533.5 4653.3 4657.7 4693.7 10240.1 10357.1 10395.8 10403.6 10417.7 5294.4 5338.3 5348.9 5354.7 5362.7 4746.9 4892.7 4897.1 4921.7 4928.5 3964.6 3966.5 4069.7 4080.8 4119.0 1283.8 1284.7 1286.4 1299.5 1315.7 1039.9 1046.8 1052.0 1063.2 1074.6 5915.9 5934.2 5948.2 6088.3 6162.6 1050.1 1056.9 1057.1 1071.9 1073.1 3936.8 4082.8 4113.2 4138.6 4158.6 10162.4 10485.2 10514.2 10518.3 10575.0 10331.3 10331.8 10344.3 10345.6 10349.4 7905.1 7938.3 7998.0 8000.7 8169.2 5755.8 5811.2 5833.1 5902.1 5936.1 9286.2 9350.9 9429.3 9445.1 9614.0 9513.5 9598.0 9716.0 9729.8 9755.4 7698.8 7733.9 7764.0 7773.3 7790.0 8394.4 8404.6 8423.8 8430.4 8489.4 7453.2 7455.4 7544.0 7676.7 7764.0 7296.2 7432.7 7467.1 7503.9 7549.5 6971.3 7000.2 7039.5 7048.4 7054.9 5216.4 5269.3 5293.7 5314.6 5356.5 5214.5 5234.8 5250.0 5302.5 5308.1 02:27:07 INFO - PROCESS | 21921 | 02:27:07 INFO - PROCESS | 21921 | [#4] prototype.html Cycles:180 Average:5862.02 Median:6790.69 stddev:1830.34 (27.0%) stddev-sans-first:1787.70 02:27:07 INFO - PROCESS | 21921 | Values: 326.4 335.3 340.7 340.8 342.4 6393.7 6672.2 6794.1 6866.3 6871.9 6620.1 6647.7 6648.4 6654.3 6699.8 4966.0 4980.3 4990.8 4998.6 5004.0 4996.1 4999.8 5006.4 5006.4 5015.2 4940.0 4952.5 4966.9 4967.4 4971.8 4821.3 4889.9 4905.0 4951.0 4960.0 4191.1 4221.5 4222.6 4224.4 4226.6 6368.4 6392.1 6396.6 6397.9 6404.1 5640.7 5653.5 5674.3 5688.2 5699.7 7047.3 7054.6 7056.4 7061.0 7093.8 4601.5 4682.3 4694.1 4706.8 4721.7 7331.5 7333.4 7335.6 7359.2 7373.4 4778.8 4784.0 4786.7 4788.0 4803.9 4845.3 4853.9 4858.0 4865.6 4873.0 5678.5 5689.4 5700.7 5705.2 5719.0 6787.3 7029.0 7048.1 7063.2 7078.5 1725.3 1737.8 1743.3 1746.9 1748.2 1136.7 1146.5 1148.6 1153.3 1167.2 6780.6 6795.5 6807.3 6819.7 6823.5 7223.2 7232.1 7232.9 7236.4 7240.6 6723.1 6798.4 6804.3 6806.4 6807.8 3892.5 3906.7 3908.9 3913.1 3913.9 7364.7 7750.3 7752.1 7764.7 7766.5 7481.9 7512.1 7525.9 7538.5 7545.1 7644.9 7647.3 7652.6 7668.9 7685.5 7246.9 7297.6 7322.2 7354.0 7377.3 7187.5 7219.0 7246.5 7254.9 7255.9 7602.7 7609.1 7610.6 7630.0 7645.3 4648.3 4689.6 4697.5 4697.8 4700.0 7105.6 7226.0 7300.9 7310.0 7322.0 7061.0 7079.3 7097.4 7102.7 7103.4 7040.5 7056.3 7061.4 7065.4 7079.8 6961.8 6963.7 6963.8 6964.8 6976.9 6992.1 7106.4 7133.5 7135.3 7139.4 6756.9 6954.9 6964.4 6994.3 6994.7 02:27:07 INFO - PROCESS | 21921 | 02:27:07 INFO - PROCESS | 21921 | [#5] yui.html Cycles:180 Average:15684.89 Median:4581.26 stddev:17630.97 (384.9%) stddev-sans-first:17645.06 02:27:07 INFO - PROCESS | 21921 | Values: 813.4 841.9 842.7 889.0 913.7 16320.0 16629.3 16648.4 16678.8 16692.8 15132.7 15169.9 15193.2 15272.8 15321.8 819.6 827.0 856.1 862.1 869.0 843.5 880.1 882.4 886.9 887.2 881.0 922.6 923.3 925.7 930.7 878.9 905.7 913.1 913.4 917.5 679.3 683.9 684.6 686.7 690.4 15772.8 15811.4 15879.7 15885.4 15886.4 13974.5 13974.7 13990.9 14007.2 14304.2 12083.5 12153.7 12179.2 12201.2 12374.0 4480.9 4511.5 4524.9 4650.8 4697.9 48287.3 52243.7 55533.4 57051.4 57292.7 11301.0 11395.9 11400.3 11634.1 11819.2 20171.9 20218.1 20239.5 20285.7 20378.1 8870.3 8871.6 8875.3 8914.6 8988.0 4684.1 4952.3 5030.9 5101.1 5174.4 3487.7 3548.8 3563.5 3566.2 3567.4 647.6 648.4 651.3 651.6 658.5 671.6 764.7 769.8 785.1 813.9 9570.5 9956.3 9959.9 9998.2 10121.3 754.7 771.4 796.4 823.9 830.4 4435.8 4577.4 4580.4 4582.1 4710.3 56808.7 62646.4 62970.0 69344.0 69812.7 52584.5 52865.0 54895.7 59306.0 59355.1 46486.3 46909.5 50661.7 50882.7 51785.5 9766.8 10225.9 10310.8 10320.3 10345.4 39306.0 39944.4 40238.4 40299.6 41150.0 47342.8 47928.0 51294.5 51365.5 51809.0 11848.2 12303.9 12309.9 12414.6 12845.2 14044.4 14353.7 14410.4 14519.9 14648.4 13512.7 13582.7 13744.0 14027.9 14039.9 12812.7 13224.5 13444.4 13603.7 14135.6 13391.7 13637.2 13672.8 13842.3 14270.1 11300.4 11490.9 11765.8 11836.8 11856.6 11782.9 11839.1 11886.5 12038.7 12044.2 02:27:07 INFO - PROCESS | 21921 | -------- Summary: end -------- 02:27:07 INFO - PROCESS | 21921 | 02:27:08 INFO - TEST-INFO | 21921: exit 0 02:27:08 INFO - TEST-OK | dromaeo_css | took 1109309ms 02:27:08 INFO - TEST-START | kraken 02:27:08 INFO - operating with platform_type : linux_ 02:27:08 INFO - Initialising browser for kraken test... 02:27:08 INFO - TEST-INFO | started process 22160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLWTgeD/profile http://localhost:41404/getInfo.html) 02:27:12 INFO - PROCESS | 22160 | 02:27:12 INFO - PROCESS | 22160 | (process:22239): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:27:12 INFO - PROCESS | 22160 | __metrics Screen width/height:1600/1200 02:27:12 INFO - PROCESS | 22160 | colorDepth:24 02:27:12 INFO - PROCESS | 22160 | Browser inner width/height: 1024/697 02:27:12 INFO - PROCESS | 22160 | __metrics 02:27:13 ERROR - PROCESS | 22160 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 02:27:14 INFO - TEST-INFO | 22160: exit 0 02:27:14 INFO - Browser initialized. 02:27:14 INFO - Running cycle 1/1 for kraken test... 02:27:14 INFO - TEST-INFO | started process 22289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLWTgeD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:16 INFO - PROCESS | 22289 | 02:27:16 INFO - PROCESS | 22289 | (process:22361): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:27:26 INFO - PROCESS | 22289 | RSS: Main: 150986752 02:27:26 INFO - PROCESS | 22289 | 02:27:28 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41404/tests/kraken/driver.html?testName=audio-beat-detection) 02:27:29 INFO - PROCESS | 22289 | RSS: Main: 156057600 02:27:29 INFO - PROCESS | 22289 | 02:27:32 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41404/tests/kraken/driver.html?testName=audio-dft) 02:27:32 INFO - PROCESS | 22289 | RSS: Main: 156098560 02:27:32 INFO - PROCESS | 22289 | 02:27:35 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41404/tests/kraken/driver.html?testName=audio-fft) 02:27:36 INFO - PROCESS | 22289 | RSS: Main: 156270592 02:27:36 INFO - PROCESS | 22289 | 02:27:38 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41404/tests/kraken/driver.html?testName=audio-oscillator) 02:27:38 INFO - PROCESS | 22289 | RSS: Main: 156893184 02:27:38 INFO - PROCESS | 22289 | 02:27:41 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:41 INFO - PROCESS | 22289 | RSS: Main: 156659712 02:27:41 INFO - PROCESS | 22289 | 02:27:44 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41404/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:45 INFO - PROCESS | 22289 | RSS: Main: 157212672 02:27:45 INFO - PROCESS | 22289 | 02:27:48 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41404/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:49 INFO - PROCESS | 22289 | RSS: Main: 156700672 02:27:49 INFO - PROCESS | 22289 | 02:27:52 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41404/tests/kraken/driver.html?testName=json-parse-financial) 02:27:52 INFO - PROCESS | 22289 | RSS: Main: 156405760 02:27:52 INFO - PROCESS | 22289 | 02:27:54 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:27:54 INFO - PROCESS | 22289 | RSS: Main: 156114944 02:27:54 INFO - PROCESS | 22289 | 02:27:56 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41404/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:27:57 INFO - PROCESS | 22289 | RSS: Main: 156086272 02:27:57 INFO - PROCESS | 22289 | 02:27:59 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:27:59 INFO - PROCESS | 22289 | RSS: Main: 156512256 02:27:59 INFO - PROCESS | 22289 | 02:28:02 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:28:02 INFO - PROCESS | 22289 | RSS: Main: 157093888 02:28:02 INFO - PROCESS | 22289 | 02:28:05 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:28:06 INFO - PROCESS | 22289 | RSS: Main: 157212672 02:28:06 INFO - PROCESS | 22289 | 02:28:07 INFO - PROCESS | 22289 | Cycle 1(1): loaded http://localhost:41404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41404/tests/kraken/driver.html?testName=ai-astar) 02:28:08 INFO - PROCESS | 22289 | RSS: Main: 158404608 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | __start_tp_report 02:28:08 INFO - PROCESS | 22289 | _x_x_mozilla_page_load 02:28:08 INFO - PROCESS | 22289 | _x_x_mozilla_page_load_details 02:28:08 INFO - PROCESS | 22289 | |i|pagename|runs| 02:28:08 INFO - PROCESS | 22289 | |0;ai-astar;109;112;104;112;110;112;103;113;111;111 02:28:08 INFO - PROCESS | 22289 | |1;audio-beat-detection;154;133;161;176;133;162;159;128;184;127 02:28:08 INFO - PROCESS | 22289 | |2;audio-dft;163;163;163;163;164;162;161;163;163;163 02:28:08 INFO - PROCESS | 22289 | |3;audio-fft;77;77;75;172;74;77;75;75;166;77 02:28:08 INFO - PROCESS | 22289 | |4;audio-oscillator;92;92;156;91;91;92;151;93;93;146 02:28:08 INFO - PROCESS | 22289 | |5;imaging-gaussian-blur;117;116;117;117;118;117;117;117;118;117 02:28:08 INFO - PROCESS | 22289 | |6;imaging-darkroom;147;147;146;146;149;146;146;146;146;146 02:28:08 INFO - PROCESS | 22289 | |7;imaging-desaturate;95;95;96;96;96;94;95;94;95;95 02:28:08 INFO - PROCESS | 22289 | |8;json-parse-financial;57;56;54;53;54;57;54;71;54;52 02:28:08 INFO - PROCESS | 22289 | |9;json-stringify-tinderbox;60;60;59;61;59;60;61;60;63;61 02:28:08 INFO - PROCESS | 22289 | |10;stanford-crypto-aes;80;74;73;73;75;74;73;73;82;75 02:28:08 INFO - PROCESS | 22289 | |11;stanford-crypto-ccm;115;124;115;114;113;113;121;117;127;137 02:28:08 INFO - PROCESS | 22289 | |12;stanford-crypto-pbkdf2;163;165;160;166;166;161;163;161;161;159 02:28:08 INFO - PROCESS | 22289 | |13;stanford-crypto-sha256-iterative;68;65;66;71;65;69;65;67;65;65 02:28:08 INFO - PROCESS | 22289 | __end_tp_report 02:28:08 INFO - PROCESS | 22289 | __start_cc_report 02:28:08 INFO - PROCESS | 22289 | _x_x_mozilla_cycle_collect,822 02:28:08 INFO - PROCESS | 22289 | __end_cc_report 02:28:08 INFO - PROCESS | 22289 | __startTimestamp1465291688126__endTimestamp 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | ------- Summary: start ------- 02:28:08 INFO - PROCESS | 22289 | Number of tests: 14 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:3.47 (3.1%) stddev-sans-first:3.67 02:28:08 INFO - PROCESS | 22289 | Values: 109.0 112.0 104.0 112.0 110.0 112.0 103.0 113.0 111.0 111.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:160.00 stddev:20.43 (12.8%) stddev-sans-first:21.65 02:28:08 INFO - PROCESS | 22289 | Values: 154.0 133.0 161.0 176.0 133.0 162.0 159.0 128.0 184.0 127.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 02:28:08 INFO - PROCESS | 22289 | Values: 163.0 163.0 163.0 163.0 164.0 162.0 161.0 163.0 163.0 163.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:39.31 (51.7%) stddev-sans-first:41.18 02:28:08 INFO - PROCESS | 22289 | Values: 77.0 77.0 75.0 172.0 74.0 77.0 75.0 75.0 166.0 77.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:92.00 stddev:28.60 (31.1%) stddev-sans-first:29.61 02:28:08 INFO - PROCESS | 22289 | Values: 92.0 92.0 156.0 91.0 91.0 92.0 151.0 93.0 93.0 146.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 02:28:08 INFO - PROCESS | 22289 | Values: 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 02:28:08 INFO - PROCESS | 22289 | Values: 147.0 147.0 146.0 146.0 149.0 146.0 146.0 146.0 146.0 146.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 02:28:08 INFO - PROCESS | 22289 | Values: 95.0 95.0 96.0 96.0 96.0 94.0 95.0 94.0 95.0 95.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.00 stddev:5.45 (9.9%) stddev-sans-first:5.78 02:28:08 INFO - PROCESS | 22289 | Values: 57.0 56.0 54.0 53.0 54.0 57.0 54.0 71.0 54.0 52.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:1.17 (1.9%) stddev-sans-first:1.24 02:28:08 INFO - PROCESS | 22289 | Values: 60.0 60.0 59.0 61.0 59.0 60.0 61.0 60.0 63.0 61.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:74.50 stddev:3.19 (4.3%) stddev-sans-first:2.87 02:28:08 INFO - PROCESS | 22289 | Values: 80.0 74.0 73.0 73.0 75.0 74.0 73.0 73.0 82.0 75.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:119.00 stddev:7.79 (6.5%) stddev-sans-first:8.08 02:28:08 INFO - PROCESS | 22289 | Values: 115.0 124.0 115.0 114.0 113.0 113.0 121.0 117.0 127.0 137.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.00 stddev:2.51 (1.5%) stddev-sans-first:2.65 02:28:08 INFO - PROCESS | 22289 | Values: 163.0 165.0 160.0 166.0 166.0 161.0 163.0 161.0 161.0 159.0 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - PROCESS | 22289 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:2.12 (3.2%) stddev-sans-first:2.19 02:28:08 INFO - PROCESS | 22289 | Values: 68.0 65.0 66.0 71.0 65.0 69.0 65.0 67.0 65.0 65.0 02:28:08 INFO - PROCESS | 22289 | -------- Summary: end -------- 02:28:08 INFO - PROCESS | 22289 | 02:28:08 INFO - TEST-INFO | 22289: exit 0 02:28:09 INFO - TEST-OK | kraken | took 60668ms 02:28:09 INFO - SUITE-END | took 1169s 02:28:09 INFO - Completed test suite (00:19:30) 02:28:09 INFO - javascript benchmark 02:28:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3336.4828451590006, 3383.120388698939, 3388.1698983748984, 3392.406328892444, 3434.4676575130848, 5530.05988981873, 5554.972225138868, 5588.469095435927, 5591.412901645324, 5594.021046316889, 5579.497845193931, 5581.441855814416, 5592.217089607448, 5614.3543492498375, 5627.549796016319, 5059.064073146461, 5072.213806859942, 5130.384353877521, 5132.28148059272, 5224.660397074178, 5183.611229157809, 5232.3197984262, 5244.737763111848, 5277.366715994086, 5292.470752924715, 5255.159174532076, 5281.128613778722, 5332.760025798829, 5333.093374126388, 5334.893302133955, 5192.169252919533, 5205.349331333583, 5205.7397130143345, 5210.088234558937, 5230.738463076869, 4906.386701662293, 5079.923801142986, 5105.208692652608, 5122.359705036871, 5125.256837758541, 5485.232067510552, 5520.1167813150105, 5525.336959564837, 5534.584906132016, 5544.972275138599, 6030.065339872327, 6034.758609655609, 6039.5772295939305, 6046.365131661156, 6057.545684073668, 6032.45707886288, 6062.636241825505, 6073.392660733935, 6095.512359011313, 6114.266288045418, 5781.392953739881, 5803.158542011427, 5804.361520232771, 5807.448292412214, 5811.506021988136, 6332.873342533124, 6339.524535659844, 6340.429361357407, 6342.365763423713, 6343.9682801585695, 5899.911501327398, 6051.092336149525, 6055.364186760415, 6104.633721976696, 6141.324454310023, 6072.574919755663, 6082.2701275847185, 6087.086936959403, 6088.238970128734, 6090.23872015998, 6052.6671033092725, 6062.0, 6066.757329706762, 6069.757209711562, 6072.787452439144, 5905.4685078343155, 5964.671943043174, 6033.095035744585, 6035.8792824143275, 6038.516918646497, 4539.046800171935, 4544.045750392388, 4561.543845615412, 4570.177368073712, 4583.175028494837, 4097.364908439196, 4099.385092236129, 4136.627703506699, 4146.0464093258115, 4162.62536371728, 5856.443637854397, 5889.146073819272, 5905.586608937333, 5970.134330522137, 5970.880582388328, 6101.054336577838, 6137.0, 6140.17107690465, 6145.846353841101, 6152.2924863640355, 5822.243108395882, 5846.883062338729, 5881.970590147107, 5888.4700376966275, 5912.379200183918, 5144.382674079135, 5153.098207813618, 5184.11869982104, 5195.090859099642, 5209.6874187548865, 6524.021396790425, 6530.510211734139, 6535.248446428626, 6546.18172728409, 6554.606723596599, 5991.430814072656, 6011.6693581853415, 6069.271687397364, 6264.0, 6288.6855657217875, 6239.500839932885, 6256.937430625636, 6257.5932564383165, 6257.937420625735, 6259.374062593704, 5828.388019257917, 5899.085641725539, 5902.6458412495385, 5913.615614985012, 5939.524838012862, 6024.939750602438, 6047.0, 6103.0, 6139.890808645427, 6160.075988601746, 6087.57386982907, 6096.573239873166, 6098.603590766586, 6099.817005489843, 6110.7861224856915, 6075.088736689532, 6128.693565321627, 6130.111133885473, 6132.601380910227, 6141.109539116893, 5790.131480277992, 5976.372480889444, 5994.07091900756, 5998.9100163496705, 6047.455728984412, 5860.619059761102, 5902.704864756659, 5921.555883308855, 5926.318473375617, 5957.255343082114, 5758.942410576008, 5765.279340082489, 5850.619709718854, 5852.619579727304, 5854.443827836349], "value": 5625.252930713826, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.8972509261066, 663.8937769956808, 680.3740558686009, 729.602366710143, 740.2375553180225, 41366.17267654649, 42530.936726581815, 42533.36199956999, 42599.0, 42613.36079958795, 44268.0, 44699.0, 44754.0, 44856.3271550927, 44868.551314486846, 8992.505412202327, 9142.405743626643, 9146.908530914672, 9156.542172891362, 9173.816523669522, 8992.505412202327, 9060.728178154666, 9080.682176123837, 9095.818083638324, 9139.451632902013, 9286.257099432029, 9319.95340023299, 9320.62717491303, 9330.160285574297, 9367.718968430923, 9218.400803947721, 9268.0, 9293.58178881952, 9296.8605470918, 9320.021397753206, 9218.585163667583, 9305.627774889064, 9314.254859611216, 9325.626974920995, 9327.626894924195, 44776.3283550747, 44946.77526612346, 45051.324230136575, 45071.098578028585, 45416.0, 3779.8110094495164, 3840.7695538267794, 3878.3019056569806, 3982.8008599569907, 4458.977705111486, 33905.83047084749, 33915.15212119692, 34135.829320853234, 34484.48273275903, 34564.0, 4505.684602077856, 4674.929876051862, 4685.929711054337, 4686.812527498896, 4691.202495575761, 329575.0, 330427.9999999976, 330500.0, 330935.0, 331060.0, 40321.0, 63581.0, 64255.0, 64545.0, 64661.0, 38555.42166867499, 38726.6127338723, 38765.61234387676, 38907.416388754194, 38971.61028389737, 15922.840771592368, 16247.837521624633, 16248.0, 16248.675026499404, 16287.837121628869, 12353.073519486075, 12359.134860559674, 12377.62867113988, 12381.195222310522, 12386.5664701735, 9531.857022144673, 9560.90439095614, 9565.186959108414, 9621.27840411972, 9648.131668149901, 3601.1177261571083, 3638.3450978824067, 3692.5015122958057, 3709.666130048309, 3748.156664750409, 1096.8738595061511, 1110.4336788238056, 1122.8708698499777, 1142.948567314473, 1163.5869266410302, 33971.83014084963, 34288.53656346362, 34434.483482747775, 34509.827450862584, 34687.65312346895, 1236.2644226685109, 1251.2617555642214, 1267.9982813577356, 1284.5247258514223, 1288.407332627002, 17485.562860928323, 17687.115644217738, 17861.196246168955, 18107.275708971756, 18226.726599101024, 483115.0, 550380.0, 582628.0, 596690.0, 600315.0, 56896.431035689115, 58002.709986449794, 58224.12663810046, 58368.708156458946, 58412.70793646004, 823.5635113389912, 1391.325207274471, 1539.9846001540066, 1558.0885182168558, 1564.2491604030129, 31044.534331984585, 32089.0, 32890.0, 33430.16424589405, 34957.65042349544, 55338.44661553494, 57045.42954570567, 57287.71356143193, 57469.13796292975, 58267.4173258262, 312606.0, 315038.0, 316683.0, 318472.0, 319847.0, 45781.54218457773, 45913.0, 46488.0, 46577.3013404806, 47434.76282618565, 54338.18492722692, 55434.44565554454, 56147.43852561422, 56376.43623563712, 56403.71798140983, 46171.30743038924, 46355.768221160026, 46620.7668961653, 47422.0, 47641.0, 45277.43428534527, 45625.77187114043, 46405.30392044054, 46504.7674761624, 47544.0, 45696.08607827892, 46400.53599464097, 46724.0, 46860.29709554427, 46955.53044469511, 38485.4227186598, 39954.60045399509, 40113.39829902496, 40541.87973203365, 41437.79281103575, 30976.69023309828, 31773.36453270968, 31876.0, 31889.362212756077, 32117.357652846345], "value": 20237.049194597697, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.877732291651, 405.943167956486, 406.8108329626727, 415.18623497944026, 418.2645498440201, 18035.639287214282, 18563.16465759041, 19262.711059334102, 19361.903190484063, 20502.692459613118, 12011.819822702666, 12782.616521504346, 12836.0, 12921.224726516391, 19911.60176796467, 5171.4311425743135, 5349.438308977559, 5356.223347614594, 5367.490088441592, 5368.32895888014, 5276.050310944029, 5343.812966546172, 5349.43830897754, 5544.0, 5788.797392091277, 5708.600397972144, 5747.655140691572, 5772.278465191851, 5777.740001699913, 5795.913061304083, 5695.345035320929, 5990.760369585255, 5992.550558708114, 5995.7901473448655, 6011.849703757397, 5780.450857168562, 5817.563682723812, 5841.357450680422, 5848.0, 5851.23933888596, 13428.462861485528, 13693.452261909511, 13803.654908627364, 13809.102408343426, 13810.723785524233, 2440.0727723465147, 2491.638712386694, 2552.7574880386333, 2633.789296856247, 3056.3276079262528, 10189.184865210766, 10431.269811113225, 10505.68482945513, 12702.174358666656, 14080.92959535206, 1966.7344908437321, 1966.8918209498615, 2009.8090681385245, 2070.4099331690395, 2142.860714053597, 80000.0, 81021.78467322995, 81802.59098704527, 83523.0, 84180.57909710413, 10914.345139291669, 10952.123830093733, 10974.231803773659, 11005.0, 11007.61473348429, 14809.555713328402, 14967.625809354853, 15043.398264069314, 15082.924585377003, 15085.24573771307, 8239.382046346547, 8280.751577452565, 8286.0, 8437.662493500191, 8550.914490855012, 8236.299914507334, 8379.790505237295, 8392.790180245544, 8403.07566167721, 8471.279941205066, 4543.886402839956, 4592.10453961481, 4595.379623750818, 4641.094986477605, 4704.788284527204, 1961.264525802824, 1986.4636548131923, 2006.8360350996386, 2055.7944205579324, 2069.906854191565, 980.7302991677203, 1016.1972042086817, 1069.3102948598112, 1073.7208325835338, 1133.2803669669654, 19449.416517504214, 19753.111109999798, 19897.801021989886, 20031.499212519804, 20365.0, 1014.1075853249093, 1030.845373194012, 1063.5905176507101, 1100.1693721240572, 1103.6358001859367, 9085.36402451822, 10737.570497180182, 10885.510152043176, 10908.50911708975, 10933.507992140214, 561333.0, 562797.0, 572034.0, 576181.0, 577311.0, 80161.59919200366, 83824.16175838285, 100509.49745251227, 103143.48428257811, 107334.0, 1133.7505748735266, 1149.7010777197988, 1165.9650210493699, 1182.722060315825, 1212.3635091576994, 17411.303547857944, 17418.82581174172, 17445.563860903578, 17833.910830445766, 18429.26282948721, 40747.57383491564, 41562.792186038874, 41731.157637930104, 42298.577014230694, 42495.362569560864, 59091.40908591031, 60665.09002365056, 60934.0, 61008.389916102045, 61087.38912610817, 8347.0, 8363.20549547792, 8368.246857782586, 8447.535385553854, 8517.105703901001, 9067.319951003568, 13627.38676759568, 14119.929400352932, 14141.292935353396, 14293.57119286423, 12024.398780061138, 12409.317487538272, 12600.74798504043, 12727.23636581808, 12764.170328928962, 12375.195612285173, 12497.18768280059, 12547.05897057706, 12590.559330423392, 12703.555375561811, 12900.290484023093, 12905.096643234883, 13036.934815325863, 13043.739125217253, 13114.409851556893, 8926.464412135292, 8969.14793094655, 9068.727938161866, 9167.44995300284, 9472.810543788948, 12709.745805084032, 12778.68053298675, 12826.23042617446, 12856.742865142833, 12879.162854414808], "value": 9333.751716438972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1603.839616038396, 1617.5632579203611, 1839.9632007359853, 1944.883307001581, 1955.2667749593902, 7672.884906726404, 8293.751187464371, 8450.957745211274, 8698.130186981298, 8698.478091314517, 8275.131111233324, 8397.076321604634, 8408.873866891987, 8412.327013838894, 8471.745847624567, 2335.2177020698086, 2377.3818807110188, 2381.1903952656094, 2390.9043638254448, 2397.244867866625, 2362.7164740231196, 2390.103711108334, 2425.7816796488314, 2443.1937460638037, 2458.7787099161073, 2373.821963352747, 2398.0767404549288, 2424.272718184546, 2460.0774709483944, 2472.4931389065287, 2423.709154901423, 2425.16331865507, 2428.7085549734056, 2443.596806526921, 2447.05788271515, 2406.338256979327, 2424.806015518754, 2429.769171928664, 2431.732509423962, 2435.147698305579, 8534.0, 8559.786005349915, 8566.700165494178, 8577.957110214471, 8588.141185881424, 5224.059669259532, 5306.602004849652, 5332.626716129873, 5334.866628334284, 5339.599530035263, 3431.4166591679473, 3453.879114231015, 3454.9309013819584, 3469.5663042119736, 3523.1016090896915, 1146.7591805720808, 1149.4769879704713, 1154.0709728668419, 1157.6179860645966, 1162.482695200636, 12049.216800908001, 12080.395980200954, 12111.757764844653, 12153.93923030388, 12185.939070304592, 4520.909581808345, 4533.52397998212, 4653.325267836145, 4657.720536767804, 4693.6949098308505, 10240.078392944522, 10357.119644830123, 10395.84406233907, 10403.5838566458, 10417.739556510996, 5294.391145018295, 5338.306020217425, 5348.946510534923, 5354.705491198021, 5362.731863406892, 4746.857594272177, 4892.706437613754, 4897.094037603055, 4921.655484116078, 4928.457869634337, 3964.60353964607, 3966.484357033567, 4069.654079403284, 4080.836766529365, 4119.0, 1283.813846992181, 1284.7173621803188, 1286.414681319997, 1299.493197652916, 1315.7368526294779, 1039.896010398954, 1046.7540128069897, 1051.9894801052044, 1063.2132222155549, 1074.6023971130576, 5915.852103697442, 5934.19888315072, 5948.196993405922, 6088.299845517822, 6162.599431036968, 1050.09167070485, 1056.9260151789301, 1057.143713591993, 1071.8867485276442, 1073.0717928991367, 3936.842526298973, 4082.81627326771, 4113.218488487238, 4138.627523522898, 4158.6465150461945, 10162.441065741456, 10485.213608979357, 10514.158867290598, 10518.263721539419, 10575.0, 10331.32846364984, 10331.793364132674, 10344.32761870476, 10345.637902673521, 10349.379037257639, 7905.090914544786, 7938.3252423544645, 7997.960010199912, 8000.679972801023, 8169.223923727236, 5755.798547050833, 5811.1573821794755, 5833.066709326487, 5902.085176797603, 5936.079907614327, 9286.164245217962, 9350.906490935004, 9429.339946203974, 9445.102715242041, 9614.0, 9513.476758778057, 9597.952010239904, 9715.951420242853, 9729.805403892024, 9755.414675119515, 7698.807529811799, 7733.922660773545, 7763.961180194063, 7773.3004029637605, 7789.961050194713, 8394.37042221848, 8404.579771011302, 8423.831523369621, 8430.36772242072, 8489.363297752816, 7453.180150183367, 7455.440841936768, 7543.962280188564, 7676.731314403969, 7763.961180194289, 7296.233895440902, 7432.665530051268, 7467.141278753013, 7503.9249607503225, 7549.547027178387, 6971.268016858156, 7000.159980802337, 7039.507234493741, 7048.436125109876, 7054.906489493931, 5216.40011398694, 5269.341332333458, 5293.708846013352, 5314.62797604164, 5356.544693700923, 5214.530692237717, 5234.7906083756225, 5250.0, 5302.469753024821, 5308.124159513637], "value": 4681.287407672625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.44341397916554, 335.2942056970078, 340.7189069018059, 340.7733856985105, 342.36491308622504, 6393.712282947267, 6672.232693240273, 6794.1167648205665, 6866.347696968793, 6871.931280687191, 6620.073189753439, 6647.734090636369, 6648.434883034935, 6654.3345665433435, 6699.832504187398, 4965.950340496603, 4980.327655766479, 4990.75046247688, 4998.5501304882555, 5004.0, 4996.050750357439, 4999.7500124993785, 5006.374203224597, 5006.399232092154, 5015.197568389059, 4939.950600494003, 4952.529509696573, 4966.875828104308, 4967.428745694256, 4971.751412429382, 4821.252705830584, 4889.902201955941, 4904.975475122602, 4951.0, 4959.950400496003, 4191.11986482839, 4221.451211342536, 4222.577742225783, 4224.366345048267, 4226.577342265779, 6368.363163683641, 6392.1370614966845, 6396.5842220256, 6397.9360206397805, 6404.103425520431, 5640.746166422521, 5653.462921022497, 5674.290713660793, 5688.232088668018, 5699.68651724155, 7047.295270472963, 7054.611996340199, 7056.364927156581, 7060.964695176543, 7093.787186384417, 4601.539846015406, 4682.344471773954, 4694.08465349257, 4706.835260765891, 4721.693089949143, 7331.450141239428, 7333.376662983653, 7335.606234815368, 7359.190489046201, 7373.446991475661, 4778.808847646124, 4784.0192760484015, 4786.736729479912, 4788.04239152164, 4803.927941080887, 4845.345878306454, 4853.854384368475, 4858.02839432115, 4865.5864251538305, 4872.975635121802, 5678.488935995781, 5689.402612725687, 5700.743466543932, 5705.2012718219485, 5719.027765279912, 6787.2534021257625, 7029.0, 7048.083749112582, 7063.223045464994, 7078.539894906815, 1725.258139000242, 1737.7567140600327, 1743.2939659437948, 1746.9475915722549, 1748.2307784574746, 1136.732867776072, 1146.5356530605118, 1148.6496618531262, 1153.2849633227286, 1167.2121318110412, 6780.627065511444, 6795.524313298021, 6807.2512023677355, 6819.693113809891, 6823.522353435212, 7223.2415596361625, 7232.0959880015, 7232.855342893218, 7236.421086313082, 7240.637968101574, 6723.092382528296, 6798.354156355138, 6804.3195680432555, 6806.353396427331, 6807.761728339583, 3892.5134358205223, 3906.7265291429326, 3908.863189788344, 3913.1391093959282, 3913.8630147945255, 7364.705411783469, 7750.263724946121, 7752.147263800977, 7764.650590723431, 7766.534007959541, 7481.85036299271, 7512.13610434807, 7525.887111693329, 7538.547687138789, 7545.056867891513, 7644.923550764533, 7647.311741943252, 7652.617369131521, 7668.923310766932, 7685.462017658822, 7246.927530724625, 7297.635118244173, 7322.194558598443, 7354.043974283309, 7377.3360397564475, 7187.532810367309, 7218.963905180441, 7246.492745507975, 7254.927450725636, 7255.927440725525, 7602.7339043133225, 7609.086909570887, 7610.619469026416, 7630.046244219473, 7645.273698998586, 4648.349231107715, 4689.577937985598, 4697.459792123949, 4697.8355757548325, 4699.953000469952, 7105.602379771938, 7226.0, 7300.926990730025, 7310.049693539806, 7321.963390183015, 7061.0, 7079.2566780487305, 7097.432205423657, 7102.715891364494, 7103.431725461847, 7040.5071644984355, 7056.259092795182, 7061.435085193275, 7065.364117229268, 7079.787606371817, 6961.756338528127, 6963.6866341013765, 6963.79108626742, 6964.781163296301, 6976.895346569907, 6992.1259842519685, 7106.360427561544, 7133.464990125865, 7135.322144396274, 7139.357457828821, 6756.898646520208, 6954.930450695429, 6964.4080253179045, 6994.33553812387, 6994.720211191496], "value": 5253.19369622065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.3899575318511, 841.8989721233452, 842.6545116502235, 889.0398369760659, 913.6665117232212, 16320.0, 16629.251683674232, 16648.417305394312, 16678.83321166788, 16692.83307166928, 15132.697346053072, 15169.92415037926, 15193.164375959317, 15272.770908436383, 15321.846781532182, 819.565630215985, 826.983460330793, 856.1224744636766, 862.094800459515, 869.009329364525, 843.4896887383137, 880.1242763450376, 882.4484697064335, 886.8714036464709, 887.2325438495719, 881.030866047346, 922.6493932305748, 923.3167456082484, 925.6945208081318, 930.6696122876349, 878.8857448531681, 905.6558507767039, 913.1051569461964, 913.3697748553477, 917.4632839788732, 679.3444326225167, 683.8803209438329, 684.555039224503, 686.6703982088576, 690.4372936057098, 15772.76340854888, 15811.367545298175, 15879.682406351809, 15885.444009459614, 15886.443974460839, 13974.51089211883, 13974.720505589832, 13990.930045349709, 14007.159570425807, 14304.213268270241, 12083.516659333616, 12153.696157596043, 12179.208351457215, 12201.20692155016, 12374.0, 4480.910381792379, 4511.481179664348, 4524.909501809978, 4650.837220697294, 4697.929531057037, 48287.27569086466, 52243.73878130585, 55533.44466555364, 57051.429485705026, 57292.71353643205, 11301.041330119013, 11395.886041139482, 11400.315981041163, 11634.127440441831, 11819.172657913863, 20171.899140504203, 20218.090185941666, 20239.4940126498, 20285.695714564292, 20378.082986265654, 8870.283701390063, 8871.645134194689, 8875.334349923782, 8914.598843052077, 8987.955060224656, 4684.110019096361, 4952.257161425743, 5030.89938201234, 5101.107306221471, 5174.43081261061, 3487.6861082502696, 3548.8048157351595, 3563.5367402237544, 3566.179778650873, 3567.3935430976794, 647.5790736021529, 648.3743187823773, 651.3258777165705, 651.5536857252703, 658.5127006015609, 671.6071098407486, 764.7055883484899, 769.830637259802, 785.0932173339802, 813.9186081391813, 9570.473623950611, 9956.303058785816, 9959.850602240973, 9998.150157236716, 10121.291509594404, 754.7056946881529, 771.4021633234288, 796.4146352430959, 823.9340852731767, 830.3979614779237, 4435.756033418128, 4577.382053422745, 4580.427446569179, 4582.083583283356, 4710.317004034396, 56808.715956419954, 62646.37353626497, 62970.0, 69344.0, 69812.65093674499, 52584.47415525872, 52865.0, 54895.72552137294, 59306.0, 59355.109673354935, 46486.302705458766, 46909.5309046912, 50661.74669126704, 50882.745586271834, 51785.48214517882, 9766.82013961104, 10225.897741022494, 10310.845337320095, 10320.277580569287, 10345.431001295, 39306.0, 39944.40083398693, 40238.39642405308, 40299.59700402959, 41150.0, 47342.81642958816, 47928.0, 51294.48705513046, 51365.48634513607, 51809.0, 11848.229865058744, 12303.876961230631, 12309.876901230873, 12414.641892964675, 12845.165064270792, 14044.438222471395, 14353.712925741636, 14410.351534180778, 14519.854801451851, 14648.414063437343, 13512.6621834451, 13582.728345433234, 13744.0, 14027.929860350632, 14039.859601403856, 12812.679683008, 13224.537141200011, 13444.39500222512, 13603.659908502366, 14135.575932722035, 13391.665208369868, 13637.249951252776, 13672.794908076188, 13842.30788460593, 14270.143791372551, 11300.378479183724, 11490.88509114898, 11765.823512647146, 11836.82244766312, 11856.644300670994, 11782.882171178178, 11839.112066594867, 11886.465109070286, 12038.699032523906, 12044.156909016285], "value": 7248.5394981511645, "unit": "score"}], "name": "dromaeo_css", "value": 7578.272814105186, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 104.0, 112.0, 110.0, 112.0, 103.0, 113.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 161.0, 176.0, 133.0, 162.0, 159.0, 128.0, 184.0, 127.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 164.0, 162.0, 161.0, 163.0, 163.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 172.0, 74.0, 77.0, 75.0, 75.0, 166.0, 77.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 156.0, 91.0, 91.0, 92.0, 151.0, 93.0, 93.0, 146.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 149.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 53.0, 54.0, 57.0, 54.0, 71.0, 54.0, 52.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 61.0, 59.0, 60.0, 61.0, 60.0, 63.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 74.0, 73.0, 73.0, 75.0, 74.0, 73.0, 73.0, 82.0, 75.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 124.0, 115.0, 114.0, 113.0, 113.0, 121.0, 117.0, 127.0, 137.0], "value": 119.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 160.0, 166.0, 166.0, 161.0, 163.0, 161.0, 161.0, 159.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 66.0, 71.0, 65.0, 69.0, 65.0, 67.0, 65.0, 65.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1527.6000000000001, "alertThreshold": 2.0}]} 02:28:09 INFO - Return code: 0 02:28:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:28:09 ERROR - # TBPL SUCCESS # 02:28:09 INFO - Running post-action listener: _resource_record_post_action 02:28:09 INFO - Running post-run listener: _resource_record_post_run 02:28:10 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 463015936; Read time: 12; Write time: 440116 02:28:10 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242536448; Read time: 0; Write time: 310724 02:28:10 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220479488; Read time: 12; Write time: 129392 02:28:10 INFO - Running post-run listener: _upload_blobber_files 02:28:10 INFO - Blob upload gear active. 02:28:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:28:10 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:28:10 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:28:10 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:28:10 INFO - (blobuploader) - INFO - Open directory for files ... 02:28:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:28:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:28:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:12 INFO - (blobuploader) - INFO - Done attempting. 02:28:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:28:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:28:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:13 INFO - (blobuploader) - INFO - Done attempting. 02:28:13 INFO - (blobuploader) - INFO - Iteration through files over. 02:28:13 INFO - Return code: 0 02:28:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:28:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:28:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26857490a62590d4c123e7e274d3c72c94dce07955a03f4cebc450303d36ca6d41ec2c25550c9f5f132938ba55a02b397594627071c3a5318d632f38602079f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa80703fc7ea8baba7906ee49a1d5cc26af7f8d413b390da28e3f0e16a2f32ea2369f65ae176f1882825b6e4c9ed8dcc4e5dc17acb175ab2b048c042cad6ed6"} 02:28:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:28:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:28:13 INFO - Contents: 02:28:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26857490a62590d4c123e7e274d3c72c94dce07955a03f4cebc450303d36ca6d41ec2c25550c9f5f132938ba55a02b397594627071c3a5318d632f38602079f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa80703fc7ea8baba7906ee49a1d5cc26af7f8d413b390da28e3f0e16a2f32ea2369f65ae176f1882825b6e4c9ed8dcc4e5dc17acb175ab2b048c042cad6ed6"} 02:28:13 INFO - Running post-run listener: copy_logs_to_upload_dir 02:28:13 INFO - Copying logs to upload dir... 02:28:13 INFO - mkdir: /builds/slave/test/build/upload/logs 02:28:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.414466 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-07 02:28:13.454872) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:13.458926) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26857490a62590d4c123e7e274d3c72c94dce07955a03f4cebc450303d36ca6d41ec2c25550c9f5f132938ba55a02b397594627071c3a5318d632f38602079f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa80703fc7ea8baba7906ee49a1d5cc26af7f8d413b390da28e3f0e16a2f32ea2369f65ae176f1882825b6e4c9ed8dcc4e5dc17acb175ab2b048c042cad6ed6"} 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.011346 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/26857490a62590d4c123e7e274d3c72c94dce07955a03f4cebc450303d36ca6d41ec2c25550c9f5f132938ba55a02b397594627071c3a5318d632f38602079f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/caa80703fc7ea8baba7906ee49a1d5cc26af7f8d413b390da28e3f0e16a2f32ea2369f65ae176f1882825b6e4c9ed8dcc4e5dc17acb175ab2b048c042cad6ed6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:13.489727) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:13.490069) ========= 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=5bd038846534b2fdfa68eeae000001e2-1465290464.243792-1564685374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:28:13.575574) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:28:13.576333) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:28:13.577238) ========= ========= Total master_lag: 0.18 =========