builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1463422712.77 results: success (0) buildid: 20160516083029 builduid: 8f664dff4974456ab19959ee3e861b6c revision: e9533997fcef31fa5d2db464c6ceec0ca6ea560f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:32.767523) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:32.768011) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:32.768514) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:32.788070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:32.788559) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 11:18:32-- 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% 33.7M=0s 2016-05-16 11:18:33 (33.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111434 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:32.916322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:32.916696) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014416 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:32.971198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:32.972190) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e9533997fcef31fa5d2db464c6ceec0ca6ea560f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e9533997fcef31fa5d2db464c6ceec0ca6ea560f --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=c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 11:18:33,158 truncating revision to first 12 chars 2016-05-16 11:18:33,159 Setting DEBUG logging. 2016-05-16 11:18:33,159 attempt 1/10 2016-05-16 11:18:33,159 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e9533997fcef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 11:18:33,570 unpacking tar archive at: fx-team-e9533997fcef/testing/mozharness/ program finished with exit code 0 elapsedTime=0.732482 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:33.722649) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:33.723418) ========= script_repo_revision: e9533997fcef31fa5d2db464c6ceec0ca6ea560f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:33.724380) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:33.724745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 11:18:33.735564) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-16 11:18:33.736092) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:18:34 INFO - MultiFileLogger online at 20160516 11:18:34 in /builds/slave/test 11:18:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:18:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:34 INFO - {'append_to_log': False, 11:18:34 INFO - 'base_work_dir': '/builds/slave/test', 11:18:34 INFO - 'blob_upload_branch': 'Fx-Team', 11:18:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:34 INFO - 'branch': 'Fx-Team', 11:18:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:34 INFO - 'config_files': ('talos/linux_config.py',), 11:18:34 INFO - 'default_actions': ('clobber', 11:18:34 INFO - 'read-buildbot-config', 11:18:34 INFO - 'download-and-extract', 11:18:34 INFO - 'populate-webroot', 11:18:34 INFO - 'create-virtualenv', 11:18:34 INFO - 'install', 11:18:34 INFO - 'run-tests'), 11:18:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:34 INFO - 'download_minidump_stackwalk': True, 11:18:34 INFO - 'download_symbols': 'ondemand', 11:18:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:34 INFO - 'installer_path': 'installer.exe', 11:18:34 INFO - 'log_level': 'info', 11:18:34 INFO - 'log_name': 'talos', 11:18:34 INFO - 'log_to_console': True, 11:18:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:18:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:18:34 INFO - 'opt_config_files': (), 11:18:34 INFO - 'pip_index': False, 11:18:34 INFO - 'sps_profile': False, 11:18:34 INFO - 'sps_profile_interval': 0, 11:18:34 INFO - 'suite': 'dromaeojs-e10s', 11:18:34 INFO - 'system_bits': '32', 11:18:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:34 INFO - 'title': 'talos-linux64-ix-004', 11:18:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:34 INFO - 'use_talos_json': True, 11:18:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:34 INFO - 'work_dir': 'build'} 11:18:34 INFO - ##### 11:18:34 INFO - ##### Running clobber step. 11:18:34 INFO - ##### 11:18:34 INFO - Running pre-action listener: _resource_record_pre_action 11:18:34 INFO - Running main action method: clobber 11:18:34 INFO - rmtree: /builds/slave/test/build 11:18:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:34 INFO - Running post-action listener: _resource_record_post_action 11:18:34 INFO - ##### 11:18:34 INFO - ##### Finished clobber step (success) 11:18:34 INFO - ##### 11:18:34 INFO - ##### 11:18:34 INFO - ##### Running read-buildbot-config step. 11:18:34 INFO - ##### 11:18:34 INFO - Running pre-action listener: _resource_record_pre_action 11:18:34 INFO - Running main action method: read_buildbot_config 11:18:34 INFO - Using buildbot properties: 11:18:34 INFO - { 11:18:34 INFO - "project": "", 11:18:34 INFO - "product": "firefox", 11:18:34 INFO - "script_repo_revision": "production", 11:18:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:18:34 INFO - "repository": "", 11:18:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:18:34 INFO - "buildid": "20160516083029", 11:18:34 INFO - "pgo_build": "True", 11:18:34 INFO - "basedir": "/builds/slave/test", 11:18:34 INFO - "buildnumber": 467, 11:18:34 INFO - "slavename": "talos-linux64-ix-004", 11:18:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:18:34 INFO - "platform": "ubuntu64_hw", 11:18:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:18:34 INFO - "branch": "fx-team", 11:18:34 INFO - "repo_path": "integration/fx-team", 11:18:34 INFO - "revision": "e9533997fcef31fa5d2db464c6ceec0ca6ea560f", 11:18:34 INFO - "stage_platform": "linux64-pgo", 11:18:34 INFO - "builduid": "8f664dff4974456ab19959ee3e861b6c", 11:18:34 INFO - "slavebuilddir": "test" 11:18:34 INFO - } 11:18:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:18:34 INFO - Running post-action listener: _resource_record_post_action 11:18:34 INFO - ##### 11:18:34 INFO - ##### Finished read-buildbot-config step (success) 11:18:34 INFO - ##### 11:18:34 INFO - ##### 11:18:34 INFO - ##### Running download-and-extract step. 11:18:34 INFO - ##### 11:18:34 INFO - Running pre-action listener: _resource_record_pre_action 11:18:34 INFO - Running main action method: download_and_extract 11:18:34 INFO - mkdir: /builds/slave/test/build/tests 11:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:34 INFO - https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:18:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:18:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:18:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:18:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:18:35 INFO - Downloaded 1361 bytes. 11:18:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:18:35 INFO - Using the following test package requirements: 11:18:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:18:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:18:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:35 INFO - u'jsshell-linux-x86_64.zip'], 11:18:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:18:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:18:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:18:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:18:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:18:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:18:35 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')]} 11:18:35 INFO - https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:18:36 INFO - Downloaded 24023786 bytes. 11:18:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:18:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:18:38 INFO - Return code: 0 11:18:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:18:38 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')]} 11:18:38 INFO - https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:18:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:18:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:18:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:18:39 INFO - Downloaded 24023786 bytes. 11:18:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:18:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:18:40 INFO - Return code: 0 11:18:40 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')]} 11:18:40 INFO - https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:18:41 INFO - Downloaded 10840194 bytes. 11:18:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:18:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:18:41 INFO - Return code: 0 11:18:41 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')]} 11:18:41 INFO - https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:18:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:18:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:18:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:18:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:18:43 INFO - Downloaded 58395842 bytes. 11:18:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:18:43 INFO - mkdir: /builds/slave/test/properties 11:18:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:43 INFO - Contents: 11:18:43 INFO - build_url:https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:18:44 INFO - Running post-action listener: _resource_record_post_action 11:18:44 INFO - Running post-action listener: set_extra_try_arguments 11:18:44 INFO - ##### 11:18:44 INFO - ##### Finished download-and-extract step (success) 11:18:44 INFO - ##### 11:18:44 INFO - ##### 11:18:44 INFO - ##### Running populate-webroot step. 11:18:44 INFO - ##### 11:18:44 INFO - Running pre-action listener: _resource_record_pre_action 11:18:44 INFO - Running main action method: populate_webroot 11:18:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:44 INFO - '--tppagecycles', 11:18:44 INFO - '7'], 11:18:44 INFO - 'tests': ['tsvgm']}}, 11:18:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:44 INFO - 'talos_options': ['--disable-e10s'], 11:18:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:44 INFO - 'talos_options': ['--disable-e10s'], 11:18:44 INFO - 'tests': ['damp', 'tps']}, 11:18:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:44 INFO - 'tests': ['damp', 'tps']}, 11:18:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:44 INFO - 'tests': ['dromaeo_dom']}, 11:18:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:44 INFO - 'tests': ['a11yr', 11:18:44 INFO - 'ts_paint', 11:18:44 INFO - 'tpaint', 11:18:44 INFO - 'sessionrestore', 11:18:44 INFO - 'sessionrestore_no_auto_restore', 11:18:44 INFO - 'tabpaint']}, 11:18:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:44 INFO - 'ts_paint', 11:18:44 INFO - 'tpaint', 11:18:44 INFO - 'sessionrestore', 11:18:44 INFO - 'sessionrestore_no_auto_restore', 11:18:44 INFO - 'tabpaint']}, 11:18:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:44 INFO - 'ts_paint', 11:18:44 INFO - 'tpaint', 11:18:44 INFO - 'sessionrestore', 11:18:44 INFO - 'sessionrestore_no_auto_restore', 11:18:44 INFO - 'tabpaint']}, 11:18:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:44 INFO - 'ts_paint', 11:18:44 INFO - 'tpaint', 11:18:44 INFO - 'sessionrestore', 11:18:44 INFO - 'sessionrestore_no_auto_restore', 11:18:44 INFO - 'tabpaint']}, 11:18:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:44 INFO - 'tests': ['a11yr', 11:18:44 INFO - 'ts_paint', 11:18:44 INFO - 'tpaint', 11:18:44 INFO - 'sessionrestore', 11:18:44 INFO - 'sessionrestore_no_auto_restore', 11:18:44 INFO - 'tabpaint']}, 11:18:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:44 INFO - 'tests': ['a11yr', 11:18:44 INFO - 'ts_paint', 11:18:44 INFO - 'tpaint', 11:18:44 INFO - 'sessionrestore', 11:18:44 INFO - 'sessionrestore_no_auto_restore', 11:18:44 INFO - 'tabpaint']}, 11:18:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:44 INFO - 'tests': ['tsvgx', 11:18:44 INFO - 'tsvgr_opacity', 11:18:44 INFO - 'tart', 11:18:44 INFO - 'tscrollx', 11:18:44 INFO - 'cart']}, 11:18:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:44 INFO - 'tsvgr_opacity', 11:18:44 INFO - 'tart', 11:18:44 INFO - 'tscrollx', 11:18:44 INFO - 'cart']}, 11:18:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:44 INFO - 'talos_options': ['--disable-e10s'], 11:18:44 INFO - 'tests': ['tp5o']}, 11:18:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:44 INFO - 'tests': ['tp5o']}, 11:18:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:44 INFO - 'talos_options': ['--disable-e10s', 11:18:44 INFO - '--xperf_path', 11:18:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:44 INFO - 'tests': ['tp5n']}, 11:18:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:44 INFO - 'talos_options': ['--xperf_path', 11:18:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:44 INFO - 'tests': ['tp5n']}}, 11:18:44 INFO - 'talos.zip': {'path': '', 11:18:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:44 INFO - Running post-action listener: _resource_record_post_action 11:18:44 INFO - ##### 11:18:44 INFO - ##### Finished populate-webroot step (success) 11:18:44 INFO - ##### 11:18:44 INFO - ##### 11:18:44 INFO - ##### Running create-virtualenv step. 11:18:44 INFO - ##### 11:18:44 INFO - Running pre-action listener: _resource_record_pre_action 11:18:44 INFO - Running main action method: create_virtualenv 11:18:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:44 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 11:18:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:44 INFO - Using real prefix '/usr' 11:18:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:47 INFO - Installing pip.................done. 11:18:47 INFO - Return code: 0 11:18:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18:47 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')]} 11:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:47 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')]} 11:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:47 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 0x7f78ce522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1d9c0>, '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 0xf1e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ed50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', '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 11:18:47 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 11:18:47 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 11:18:47 INFO - Using env: {'DISPLAY': ':0', 11:18:47 INFO - 'HOME': '/home/cltbld', 11:18:47 INFO - 'LANG': 'en_US.UTF-8', 11:18:47 INFO - 'LANGUAGE': 'en_US:en', 11:18:47 INFO - 'LOGNAME': 'cltbld', 11:18:47 INFO - 'MAIL': '/var/mail/cltbld', 11:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:47 INFO - 'MOZ_NO_REMOTE': '1', 11:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:47 INFO - 'NO_EM_RESTART': '1', 11:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:47 INFO - 'PWD': '/builds/slave/test', 11:18:47 INFO - 'SHELL': '/bin/bash', 11:18:47 INFO - 'SHLVL': '1', 11:18:47 INFO - 'TERM': 'linux', 11:18:47 INFO - 'TMOUT': '86400', 11:18:47 INFO - 'USER': 'cltbld', 11:18:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', 11:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:47 INFO - '_': '/tools/buildbot/bin/python'} 11:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:47 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 11:18:47 INFO - Cleaning up... 11:18:47 INFO - Return code: 0 11:18:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:18:47 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')]} 11:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:47 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')]} 11:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:47 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78ce522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1d9c0>, '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 0xf1e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ed50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', '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 11:18:47 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>=3.1.1'] in /builds/slave/test/build 11:18:47 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>=3.1.1 11:18:47 INFO - Using env: {'DISPLAY': ':0', 11:18:47 INFO - 'HOME': '/home/cltbld', 11:18:47 INFO - 'LANG': 'en_US.UTF-8', 11:18:47 INFO - 'LANGUAGE': 'en_US:en', 11:18:47 INFO - 'LOGNAME': 'cltbld', 11:18:47 INFO - 'MAIL': '/var/mail/cltbld', 11:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:47 INFO - 'MOZ_NO_REMOTE': '1', 11:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:47 INFO - 'NO_EM_RESTART': '1', 11:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:47 INFO - 'PWD': '/builds/slave/test', 11:18:47 INFO - 'SHELL': '/bin/bash', 11:18:47 INFO - 'SHLVL': '1', 11:18:47 INFO - 'TERM': 'linux', 11:18:47 INFO - 'TMOUT': '86400', 11:18:47 INFO - 'USER': 'cltbld', 11:18:47 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', 11:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:47 INFO - '_': '/tools/buildbot/bin/python'} 11:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:47 INFO - Downloading/unpacking psutil>=3.1.1 11:18:47 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 11:18:47 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 11:18:47 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 11:18:47 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 11:18:47 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 11:18:47 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 11:18:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:49 INFO - Installing collected packages: psutil 11:18:49 INFO - Running setup.py install for psutil 11:18:49 INFO - building 'psutil._psutil_linux' extension 11:18:49 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 11:18:49 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 11:18:49 INFO - building 'psutil._psutil_posix' extension 11:18:49 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 11:18:49 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 11:18:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:49 INFO - Successfully installed psutil 11:18:49 INFO - Cleaning up... 11:18:50 INFO - Return code: 0 11:18:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:50 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78ce522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1d9c0>, '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 0xf1e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ed50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', '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 11:18:50 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.3'] in /builds/slave/test/build 11:18:50 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.3 11:18:50 INFO - Using env: {'DISPLAY': ':0', 11:18:50 INFO - 'HOME': '/home/cltbld', 11:18:50 INFO - 'LANG': 'en_US.UTF-8', 11:18:50 INFO - 'LANGUAGE': 'en_US:en', 11:18:50 INFO - 'LOGNAME': 'cltbld', 11:18:50 INFO - 'MAIL': '/var/mail/cltbld', 11:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:50 INFO - 'MOZ_NO_REMOTE': '1', 11:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:50 INFO - 'NO_EM_RESTART': '1', 11:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:50 INFO - 'PWD': '/builds/slave/test', 11:18:50 INFO - 'SHELL': '/bin/bash', 11:18:50 INFO - 'SHLVL': '1', 11:18:50 INFO - 'TERM': 'linux', 11:18:50 INFO - 'TMOUT': '86400', 11:18:50 INFO - 'USER': 'cltbld', 11:18:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', 11:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:50 INFO - '_': '/tools/buildbot/bin/python'} 11:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:18:50 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 11:18:50 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 11:18:50 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 11:18:50 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 11:18:50 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 11:18:50 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 11:18:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:18:52 INFO - Installing collected packages: mozsystemmonitor 11:18:52 INFO - Running setup.py install for mozsystemmonitor 11:18:52 INFO - Successfully installed mozsystemmonitor 11:18:52 INFO - Cleaning up... 11:18:52 INFO - Return code: 0 11:18:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:52 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')]} 11:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:52 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')]} 11:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:52 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 0x7f78ce522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1d9c0>, '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 0xf1e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ed50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', '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 11:18:52 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 11:18:52 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 11:18:52 INFO - Using env: {'DISPLAY': ':0', 11:18:52 INFO - 'HOME': '/home/cltbld', 11:18:52 INFO - 'LANG': 'en_US.UTF-8', 11:18:52 INFO - 'LANGUAGE': 'en_US:en', 11:18:52 INFO - 'LOGNAME': 'cltbld', 11:18:52 INFO - 'MAIL': '/var/mail/cltbld', 11:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:52 INFO - 'MOZ_NO_REMOTE': '1', 11:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:52 INFO - 'NO_EM_RESTART': '1', 11:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:52 INFO - 'PWD': '/builds/slave/test', 11:18:52 INFO - 'SHELL': '/bin/bash', 11:18:52 INFO - 'SHLVL': '1', 11:18:52 INFO - 'TERM': 'linux', 11:18:52 INFO - 'TMOUT': '86400', 11:18:52 INFO - 'USER': 'cltbld', 11:18:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', 11:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:52 INFO - '_': '/tools/buildbot/bin/python'} 11:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:18:52 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 11:18:52 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 11:18:52 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 11:18:52 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 11:18:52 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 11:18:52 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 11:18:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:54 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 11:18:54 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 11:18:54 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 11:18:54 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 11:18:54 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 11:18:54 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 11:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:54 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 11:18:54 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 11:18:54 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 11:18:54 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 11:18:54 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 11:18:54 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 11:18:55 INFO - Downloading docopt-0.6.1.tar.gz 11:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:55 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:55 INFO - Running setup.py install for blobuploader 11:18:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:55 INFO - Running setup.py install for requests 11:18:55 INFO - Running setup.py install for docopt 11:18:55 INFO - Successfully installed blobuploader requests docopt 11:18:55 INFO - Cleaning up... 11:18:55 INFO - Return code: 0 11:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:55 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')]} 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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')]} 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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 0x7f78ce522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1d9c0>, '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 0xf1e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ed50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', '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 11:18:55 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 11:18:55 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 11:18:55 INFO - Using env: {'DISPLAY': ':0', 11:18:55 INFO - 'HOME': '/home/cltbld', 11:18:55 INFO - 'LANG': 'en_US.UTF-8', 11:18:55 INFO - 'LANGUAGE': 'en_US:en', 11:18:55 INFO - 'LOGNAME': 'cltbld', 11:18:55 INFO - 'MAIL': '/var/mail/cltbld', 11:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:55 INFO - 'MOZ_NO_REMOTE': '1', 11:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:55 INFO - 'NO_EM_RESTART': '1', 11:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:55 INFO - 'PWD': '/builds/slave/test', 11:18:55 INFO - 'SHELL': '/bin/bash', 11:18:55 INFO - 'SHLVL': '1', 11:18:55 INFO - 'TERM': 'linux', 11:18:55 INFO - 'TMOUT': '86400', 11:18:55 INFO - 'USER': 'cltbld', 11:18:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', 11:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:55 INFO - '_': '/tools/buildbot/bin/python'} 11:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:56 INFO - Running setup.py (path:/tmp/pip-WzgdBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:56 INFO - Running setup.py (path:/tmp/pip-qA3tXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:56 INFO - Running setup.py (path:/tmp/pip-gSIOup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:56 INFO - Running setup.py (path:/tmp/pip-33kAVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:56 INFO - Running setup.py (path:/tmp/pip-59HTrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:56 INFO - Running setup.py (path:/tmp/pip-OLDfOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:56 INFO - Running setup.py (path:/tmp/pip-yPnR4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:56 INFO - Running setup.py (path:/tmp/pip-9Msyxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:56 INFO - Running setup.py (path:/tmp/pip-NUoSfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:56 INFO - Running setup.py (path:/tmp/pip-rI8tyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:56 INFO - Running setup.py (path:/tmp/pip-8wGOqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:56 INFO - Running setup.py (path:/tmp/pip-XGcH7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:56 INFO - Running setup.py (path:/tmp/pip-27cgfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:56 INFO - Running setup.py (path:/tmp/pip-5CSk8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:57 INFO - Running setup.py (path:/tmp/pip-BnK1qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:57 INFO - Running setup.py (path:/tmp/pip-ov546e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:57 INFO - Running setup.py (path:/tmp/pip-zF8baR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:57 INFO - Running setup.py install for manifestparser 11:18:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:57 INFO - Running setup.py install for mozcrash 11:18:57 INFO - Running setup.py install for mozdebug 11:18:57 INFO - Running setup.py install for mozdevice 11:18:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:57 INFO - Running setup.py install for mozfile 11:18:57 INFO - Running setup.py install for mozhttpd 11:18:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:57 INFO - Running setup.py install for mozinfo 11:18:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:57 INFO - Running setup.py install for mozInstall 11:18:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Running setup.py install for mozleak 11:18:58 INFO - Running setup.py install for mozlog 11:18:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Running setup.py install for moznetwork 11:18:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Running setup.py install for mozprocess 11:18:58 INFO - Running setup.py install for mozprofile 11:18:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Running setup.py install for mozrunner 11:18:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Running setup.py install for mozscreenshot 11:18:58 INFO - Running setup.py install for moztest 11:18:58 INFO - Running setup.py install for mozversion 11:18:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:58 INFO - Cleaning up... 11:18:59 INFO - Return code: 0 11:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:59 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')]} 11:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:59 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')]} 11:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:59 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 0x7f78ce522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1d9c0>, '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 0xf1e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ed50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', '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 11:18:59 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 11:18:59 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 11:18:59 INFO - Using env: {'DISPLAY': ':0', 11:18:59 INFO - 'HOME': '/home/cltbld', 11:18:59 INFO - 'LANG': 'en_US.UTF-8', 11:18:59 INFO - 'LANGUAGE': 'en_US:en', 11:18:59 INFO - 'LOGNAME': 'cltbld', 11:18:59 INFO - 'MAIL': '/var/mail/cltbld', 11:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:59 INFO - 'MOZ_NO_REMOTE': '1', 11:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:59 INFO - 'NO_EM_RESTART': '1', 11:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:59 INFO - 'PWD': '/builds/slave/test', 11:18:59 INFO - 'SHELL': '/bin/bash', 11:18:59 INFO - 'SHLVL': '1', 11:18:59 INFO - 'TERM': 'linux', 11:18:59 INFO - 'TMOUT': '86400', 11:18:59 INFO - 'USER': 'cltbld', 11:18:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', 11:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:59 INFO - '_': '/tools/buildbot/bin/python'} 11:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:59 INFO - Running setup.py (path:/tmp/pip-8JjyYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:59 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)) 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:59 INFO - Running setup.py (path:/tmp/pip-nukxs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:59 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)) 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:59 INFO - Running setup.py (path:/tmp/pip-H2x6Xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:59 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)) 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:59 INFO - Running setup.py (path:/tmp/pip-WMtkmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:59 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)) 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:59 INFO - Running setup.py (path:/tmp/pip-rHX28a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:59 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)) 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:59 INFO - Running setup.py (path:/tmp/pip-h_zdch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:59 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)) 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:59 INFO - Running setup.py (path:/tmp/pip-J2pS9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:59 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)) 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:59 INFO - Running setup.py (path:/tmp/pip-p9qghR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:59 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)) 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:59 INFO - Running setup.py (path:/tmp/pip-4UmULx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:59 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)) 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:59 INFO - Running setup.py (path:/tmp/pip-73psbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 11:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:59 INFO - Running setup.py (path:/tmp/pip-IHYDql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:00 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)) 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:00 INFO - Running setup.py (path:/tmp/pip-7o8vbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:00 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)) 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:00 INFO - Running setup.py (path:/tmp/pip-D937Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:00 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)) 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:00 INFO - Running setup.py (path:/tmp/pip-rAgr_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:00 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)) 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:00 INFO - Running setup.py (path:/tmp/pip-eFY9NH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:00 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)) 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:00 INFO - Running setup.py (path:/tmp/pip-UiMz8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:00 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)) 11:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:00 INFO - Running setup.py (path:/tmp/pip-vOHPMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:00 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)) 11:19:00 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)) 11:19:00 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)) 11:19:00 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)) 11:19:00 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)) 11:19:00 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)) 11:19:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:19:00 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 11:19:00 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 11:19:00 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 11:19:00 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 11:19:00 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 11:19:00 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 11:19:02 INFO - Downloading blessings-1.6.tar.gz 11:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:19:02 INFO - Installing collected packages: blessings 11:19:02 INFO - Running setup.py install for blessings 11:19:02 INFO - Successfully installed blessings 11:19:02 INFO - Cleaning up... 11:19:02 INFO - Return code: 0 11:19:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:19:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:02 INFO - Reading from file tmpfile_stdout 11:19:02 INFO - Current package versions: 11:19:02 INFO - argparse == 1.2.1 11:19:02 INFO - blessings == 1.6 11:19:02 INFO - blobuploader == 1.2.4 11:19:02 INFO - docopt == 0.6.1 11:19:02 INFO - manifestparser == 1.1 11:19:02 INFO - mozInstall == 1.12 11:19:02 INFO - mozcrash == 0.17 11:19:02 INFO - mozdebug == 0.1 11:19:02 INFO - mozdevice == 0.48 11:19:02 INFO - mozfile == 1.2 11:19:02 INFO - mozhttpd == 0.7 11:19:02 INFO - mozinfo == 0.9 11:19:02 INFO - mozleak == 0.1 11:19:02 INFO - mozlog == 3.2 11:19:02 INFO - moznetwork == 0.27 11:19:02 INFO - mozprocess == 0.22 11:19:02 INFO - mozprofile == 0.28 11:19:02 INFO - mozrunner == 6.11 11:19:02 INFO - mozscreenshot == 0.1 11:19:02 INFO - mozsystemmonitor == 0.3 11:19:02 INFO - moztest == 0.7 11:19:02 INFO - mozversion == 1.4 11:19:02 INFO - psutil == 3.1.1 11:19:02 INFO - requests == 1.2.3 11:19:02 INFO - wsgiref == 0.1.2 11:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:02 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 0x7f78ce522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1d9c0>, '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 0xf1e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ed50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', '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 11:19:02 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 11:19:02 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 11:19:02 INFO - Using env: {'DISPLAY': ':0', 11:19:02 INFO - 'HOME': '/home/cltbld', 11:19:02 INFO - 'LANG': 'en_US.UTF-8', 11:19:02 INFO - 'LANGUAGE': 'en_US:en', 11:19:02 INFO - 'LOGNAME': 'cltbld', 11:19:02 INFO - 'MAIL': '/var/mail/cltbld', 11:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:02 INFO - 'MOZ_NO_REMOTE': '1', 11:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:02 INFO - 'NO_EM_RESTART': '1', 11:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:02 INFO - 'PWD': '/builds/slave/test', 11:19:02 INFO - 'SHELL': '/bin/bash', 11:19:02 INFO - 'SHLVL': '1', 11:19:02 INFO - 'TERM': 'linux', 11:19:02 INFO - 'TMOUT': '86400', 11:19:02 INFO - 'USER': 'cltbld', 11:19:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', 11:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:02 INFO - '_': '/tools/buildbot/bin/python'} 11:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 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)) 11:19:03 INFO - Cleaning up... 11:19:03 INFO - Return code: 0 11:19:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:03 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 0x7f78ce522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1d9c0>, '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 0xf1e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ed50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', '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 11:19:03 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 11:19:03 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 11:19:03 INFO - Using env: {'DISPLAY': ':0', 11:19:03 INFO - 'HOME': '/home/cltbld', 11:19:03 INFO - 'LANG': 'en_US.UTF-8', 11:19:03 INFO - 'LANGUAGE': 'en_US:en', 11:19:03 INFO - 'LOGNAME': 'cltbld', 11:19:03 INFO - 'MAIL': '/var/mail/cltbld', 11:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:03 INFO - 'MOZ_NO_REMOTE': '1', 11:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:03 INFO - 'NO_EM_RESTART': '1', 11:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:03 INFO - 'PWD': '/builds/slave/test', 11:19:03 INFO - 'SHELL': '/bin/bash', 11:19:03 INFO - 'SHLVL': '1', 11:19:03 INFO - 'TERM': 'linux', 11:19:03 INFO - 'TMOUT': '86400', 11:19:03 INFO - 'USER': 'cltbld', 11:19:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', 11:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:03 INFO - '_': '/tools/buildbot/bin/python'} 11:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:03 INFO - Downloading/unpacking jsonschema 11:19:03 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 11:19:03 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 11:19:03 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 11:19:03 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 11:19:03 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 11:19:03 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 11:19:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:19:05 INFO - Downloading/unpacking functools32 (from jsonschema) 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19:05 INFO - Downloading functools32-3.2.3-2.tar.gz 11:19:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:19:05 INFO - warning: no files found matching '*.txt' 11:19:05 INFO - no previously-included directories found matching 'build' 11:19:05 INFO - no previously-included directories found matching 'dist' 11:19:05 INFO - no previously-included directories found matching '.git*' 11:19:05 INFO - Installing collected packages: jsonschema, functools32 11:19:05 INFO - Running setup.py install for functools32 11:19:05 INFO - warning: no files found matching '*.txt' 11:19:05 INFO - no previously-included directories found matching 'build' 11:19:05 INFO - no previously-included directories found matching 'dist' 11:19:05 INFO - no previously-included directories found matching '.git*' 11:19:05 INFO - Successfully installed jsonschema functools32 11:19:05 INFO - Cleaning up... 11:19:05 INFO - Return code: 0 11:19:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:19: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')]} 11:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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')]} 11:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78ce522f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe8e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1d9c0>, '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 0xf1e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ed50>, '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': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', '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 11:19: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', 'flake8'] in /builds/slave/test/build 11:19: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 flake8 11:19:05 INFO - Using env: {'DISPLAY': ':0', 11:19:05 INFO - 'HOME': '/home/cltbld', 11:19:05 INFO - 'LANG': 'en_US.UTF-8', 11:19:05 INFO - 'LANGUAGE': 'en_US:en', 11:19:05 INFO - 'LOGNAME': 'cltbld', 11:19:05 INFO - 'MAIL': '/var/mail/cltbld', 11:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:05 INFO - 'MOZ_NO_REMOTE': '1', 11:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:05 INFO - 'NO_EM_RESTART': '1', 11:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:05 INFO - 'PWD': '/builds/slave/test', 11:19:05 INFO - 'SHELL': '/bin/bash', 11:19:05 INFO - 'SHLVL': '1', 11:19:05 INFO - 'TERM': 'linux', 11:19:05 INFO - 'TMOUT': '86400', 11:19:05 INFO - 'USER': 'cltbld', 11:19:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', 11:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:05 INFO - '_': '/tools/buildbot/bin/python'} 11:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:05 INFO - Downloading/unpacking flake8 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:19:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:19:07 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 11:19:07 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 11:19:07 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 11:19:07 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 11:19:07 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 11:19:07 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 11:19:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:19:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:19:07 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 11:19:07 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 11:19:07 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 11:19:07 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 11:19:07 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 11:19:07 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 11:19:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19: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 11:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:19:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:19:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:19:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:19:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:19:08 INFO - no previously-included directories found matching 'docs/_build' 11:19:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:19:08 INFO - Running setup.py install for pep8 11:19:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:19:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:19:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:19:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:19:08 INFO - no previously-included directories found matching 'docs/_build' 11:19:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:19:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:19:08 INFO - Cleaning up... 11:19:08 INFO - Return code: 0 11:19:08 INFO - Running post-action listener: _resource_record_post_action 11:19:08 INFO - Running post-action listener: _start_resource_monitoring 11:19:08 INFO - Starting resource monitoring. 11:19:08 INFO - ##### 11:19:08 INFO - ##### Finished create-virtualenv step (success) 11:19:08 INFO - ##### 11:19:08 INFO - ##### 11:19:08 INFO - ##### Running install step. 11:19:08 INFO - ##### 11:19:08 INFO - Running pre-action listener: _resource_record_pre_action 11:19:08 INFO - Running main action method: install 11:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:08 INFO - Reading from file tmpfile_stdout 11:19:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:19:08 INFO - Reading from file tmpfile_stdout 11:19:08 INFO - Output received: 11:19:08 INFO - Usage: mozinstall [options] installer 11:19:08 INFO - Options: 11:19:08 INFO - -h, --help show this help message and exit 11:19:08 INFO - -d DEST, --destination=DEST 11:19:08 INFO - Directory to install application into. [default: 11:19:08 INFO - "/builds/slave/test"] 11:19:08 INFO - --app=APP Application being installed. [default: firefox] 11:19:08 INFO - mkdir: /builds/slave/test/build/application 11:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:19:25 INFO - Reading from file tmpfile_stdout 11:19:25 INFO - Output received: 11:19:25 INFO - /builds/slave/test/build/application/firefox/firefox 11:19:25 INFO - Running post-action listener: _resource_record_post_action 11:19:25 INFO - ##### 11:19:25 INFO - ##### Finished install step (success) 11:19:25 INFO - ##### 11:19:25 INFO - ##### 11:19:25 INFO - ##### Running run-tests step. 11:19:25 INFO - ##### 11:19:25 INFO - Running pre-action listener: _resource_record_pre_action 11:19:25 INFO - Running main action method: run_tests 11:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:25 INFO - Python 2.7.3 11:19:25 INFO - Return code: 0 11:19:25 INFO - grabbing minidump binary from tooltool 11:19:25 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')]} 11:19:25 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1d9c0>, '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 0xf1e8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ed50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:25 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 11:19:25 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 11:19:25 INFO - Calling ['/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'] with output_timeout 600 11:19:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:25 INFO - Return code: 0 11:19:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:19:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:19:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:19:26 INFO - Return code: 0 11:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 11:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 11:19:26 INFO - Using env: {'DISPLAY': ':0', 11:19:26 INFO - 'HOME': '/home/cltbld', 11:19:26 INFO - 'LANG': 'en_US.UTF-8', 11:19:26 INFO - 'LANGUAGE': 'en_US:en', 11:19:26 INFO - 'LOGNAME': 'cltbld', 11:19:26 INFO - 'MAIL': '/var/mail/cltbld', 11:19:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:26 INFO - 'MOZ_NO_REMOTE': '1', 11:19:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:26 INFO - 'NO_EM_RESTART': '1', 11:19:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:26 INFO - 'PWD': '/builds/slave/test', 11:19:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:26 INFO - 'SHELL': '/bin/bash', 11:19:26 INFO - 'SHLVL': '1', 11:19:26 INFO - 'TERM': 'linux', 11:19:26 INFO - 'TMOUT': '86400', 11:19:26 INFO - 'USER': 'cltbld', 11:19:26 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311', 11:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:26 INFO - '_': '/tools/buildbot/bin/python'} 11:19:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 11:19:26 INFO - mozversion application_buildid: 20160516083029 11:19:26 INFO - mozversion application_changeset: e9533997fcef31fa5d2db464c6ceec0ca6ea560f 11:19:26 INFO - mozversion application_display_name: Nightly 11:19:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:26 INFO - mozversion application_name: Firefox 11:19:26 INFO - mozversion application_remotingname: firefox 11:19:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:19:26 INFO - mozversion application_vendor: Mozilla 11:19:26 INFO - mozversion application_version: 49.0a1 11:19:26 INFO - mozversion platform_buildid: 20160516083029 11:19:26 INFO - mozversion platform_changeset: e9533997fcef31fa5d2db464c6ceec0ca6ea560f 11:19:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:19:26 INFO - mozversion platform_version: 49.0a1 11:19:26 INFO - using testdate: 1463422766 11:19:26 INFO - actual date: 1463422766 11:19:26 INFO - starting webserver on 'localhost:46833' 11:19:26 INFO - SUITE-START | Running 2 tests 11:19:26 INFO - TEST-START | dromaeo_css 11:19:26 INFO - operating with platform_type : linux_ 11:19:26 INFO - Initialising browser for dromaeo_css test... 11:19:26 INFO - TEST-INFO | started process 12398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphwaj3C/profile http://localhost:46833/getInfo.html) 11:19:30 INFO - PROCESS | 12398 | 11:19:30 INFO - PROCESS | 12398 | (process:12468): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:19:31 INFO - PROCESS | 12398 | __metrics Screen width/height:1600/1200 11:19:31 INFO - PROCESS | 12398 | colorDepth:24 11:19:31 INFO - PROCESS | 12398 | Browser inner width/height: 1024/697 11:19:31 INFO - PROCESS | 12398 | __metrics 11:19:31 ERROR - PROCESS | 12398 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:19:32 INFO - TEST-INFO | 12398: exit 0 11:19:32 INFO - Browser initialized. 11:19:32 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:32 INFO - TEST-INFO | started process 12519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphwaj3C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:34 INFO - PROCESS | 12519 | 11:19:34 INFO - PROCESS | 12519 | (process:12580): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:19:44 INFO - PROCESS | 12519 | RSS: Main: 163348480 11:19:44 INFO - PROCESS | 12519 | 11:20:34 INFO - PROCESS | 12519 | 1463422834370 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] 11:22:43 INFO - PROCESS | 12519 | Cycle 1(1): loaded http://localhost:46833/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46833/tests/dromaeo/cssquery-ext.html) 11:22:44 INFO - PROCESS | 12519 | RSS: Main: 166903808 11:22:44 INFO - PROCESS | 12519 | 11:25:46 INFO - PROCESS | 12519 | Cycle 1(1): loaded http://localhost:46833/tests/dromaeo/cssquery-ext.html (next: http://localhost:46833/tests/dromaeo/cssquery-jquery.html) 11:25:46 INFO - PROCESS | 12519 | RSS: Main: 166330368 11:25:46 INFO - PROCESS | 12519 | 11:28:48 INFO - PROCESS | 12519 | Cycle 1(1): loaded http://localhost:46833/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46833/tests/dromaeo/cssquery-mootools.html) 11:28:49 INFO - PROCESS | 12519 | RSS: Main: 167739392 11:28:49 INFO - PROCESS | 12519 | 11:31:50 INFO - PROCESS | 12519 | Cycle 1(1): loaded http://localhost:46833/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46833/tests/dromaeo/cssquery-prototype.html) 11:31:51 INFO - PROCESS | 12519 | RSS: Main: 165371904 11:31:51 INFO - PROCESS | 12519 | 11:34:53 INFO - PROCESS | 12519 | Cycle 1(1): loaded http://localhost:46833/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46833/tests/dromaeo/cssquery-yui.html) 11:34:54 INFO - PROCESS | 12519 | RSS: Main: 166440960 11:34:54 INFO - PROCESS | 12519 | 11:37:57 INFO - PROCESS | 12519 | Cycle 1(1): loaded http://localhost:46833/tests/dromaeo/cssquery-yui.html (next: http://localhost:46833/tests/dromaeo/cssquery-dojo.html) 11:37:57 INFO - PROCESS | 12519 | RSS: Main: 168542208 11:37:57 INFO - PROCESS | 12519 | 11:37:57 INFO - PROCESS | 12519 | __start_tp_report 11:37:57 INFO - PROCESS | 12519 | _x_x_mozilla_page_load 11:37:57 INFO - PROCESS | 12519 | _x_x_mozilla_page_load_details 11:37:57 INFO - PROCESS | 12519 | |i|pagename|runs| 11:37:57 INFO - PROCESS | 12519 | |0;dojo.html;3125.093722820382;3150.9212269693253;3172.317951640397;3186.569813075234;3203.855826487808;5328.067588172069;5347.064263753838;5378.112611419116;5505.146702261146;5535.778568857241;5305.708186049766;5419.458054194579;5442.945570544293;5490.423505531921;5506.284183056207;4876.731779752112;4889.9511004889855;4962.0324036812835;5051.595872330205;5093.286939828427;4882.707037577739;5061.9876024795;5113.846584602449;5128.128218202895;5142.357205349332;4902.3872015998;4921.237208232729;4950.653454258186;4955.08330958772;4958.057968985881;4971.37857767779;4975.5522003019905;4978.805086779147;4987.700737955734;5047.873803154914;4961.18140506816;4973.3286006389035;4976.0545496355935;4980.576650984671;5018.749062546858;5185.922211166836;5342.786288548454;5346.8395948121615;5391.433899440542;5404.540614047811;5818.2145410369485;5818.5926985111055;5827.592068555203;5835.679037652927;5852.56105792063;5639.548836093103;5888.5877988540815;5890.941090589082;5920.31916329619;5922.703864806743;5293.550048245904;5370.516653501204;5378.273933019032;5386.676799392049;5386.946130538684;5961.254843144607;6034.728437220336;6048.123022161762;6124.050772130327;6148.508119350441;5863.560232982543;5865.648061116347;5868.149118377812;5872.148538461899;5877.265341832271;5651.124075768263;5790.536757059425;5887.0580707086665;5973.820785376446;5978;5657.632253903483;5736.139579063174;5789.710514474259;5858.2677165354335;5923.407659234128;5909.615874968199;5919.881602367928;5921.230240068763;5943.673097979653;5960.612560183574;4258.127083947783;4360.324149756792;4457.955420445819;4460.531644177315;4516.88707782308;3884.669803066771;3923.509561304837;3933.3116704576582;3961.8217180226957;3971.543272523639;5510.834674959758;5527.917081243784;5565.610407271533;5568.303962004749;5600.803971860965;5843.935707733429;5869.090291004901;5890.204822349014;5904;5967.045272756338;5588.636738612058;5608.186812912105;5616.85957851057;5621.241132447068;5625.071863142617;5018.924716129261;5046.318746969186;5051.419086804991;5067.442581316052;5098.337216161875;5849.824505264849;6002.909956350658;6060.515158787286;6078.240219972504;6123.601965872115;5908.852278692895;5936.28764548257;5938.762449502145;5963.194968679173;5964.582479226413;5838.912416313844;6126.693665316628;6133.080037994337;6134.754609815557;6135.509159267337;5707.172459993195;5736.971315143564;5777.480026797609;5809.622374545641;5825.009748342707;5903.2325797646035;5907.5273978080795;5912.822615321547;5915.024021036481;5918.704064796829;5568.638038527482;5653.038983372919;5709.457601527848;5733.627314224562;5745.971270143623;5523.28197334344;5646.7458964347525;5662.971685141548;5761.078227483583;5801.042827933513;5586.525145362527;5617.775288988558;5643.548516118619;5648;5648.491635752802;5609.354924183771;5741.770329186786;5744.885102298014;5749.8562535936935;5794.855128621818;5602.047651899105;5645.096784514622;5650.463205995424;5678.829635110953;5727.11229759388 11:37:57 INFO - PROCESS | 12519 | |1;ext.html;579.2527639345245;611.1443978430198;628.9968550157251;633.5280216238901;660.689475946305;39033.60966390335;43758.34362484561;43760.343594846105;43848.12303753931;43902.12195756087;43879.34180987288;44394.890127746745;44459.55540444594;44608.55391446085;44668.3299750504;8808.515531645757;8859.822803543926;8892.822143557125;8895.332850036273;8926.509042002688;8855;8888.955555222246;8930.86603700945;8934.28525717941;8936.8659470108;8895.421797583169;8933.28533717301;8951.820963580725;8981.506017169053;8989.685361012365;8937.955310223473;8963.641454341818;8967.148120928501;8976.640934362618;8983.236424903826;8818.823623527558;8867.270882177978;8904.910950890473;8905.821883562292;8908.420952638058;41719;42040.78979605083;42076.57923420757;42098.78950605258;42150.78924605357;3534.593521744981;3727.4967879336214;3737.626237376268;3813.4470501777364;4051.8176682049084;32644;32842.83578582116;33042.834785826155;33163.33673326544;34818.82590587056;4437.356583295436;4462.687611867171;4472;4477.7984990675495;4484.1928452878465;351792;352618;354802;359229;360658;35214.29571408557;35913;57442.7127864358;58348.416515835146;58456.70771646115;37850.810745946095;38222.23555528874;38234.80882595625;38249;38460;15960.920195398949;16070.67858642844;16154.273057712431;16165.757513637305;16181;13466.394012269471;13640.113392629448;13651.795223071662;13652.863471365357;13689.452421903012;8552.61513231906;8558.95720521406;8580.485170889766;8607.440516366416;8706.434081784664;3257.267114899129;3301.669833016679;3303.587051618548;3306.9834650827074;3328.7170590499595;998.9400635961865;1039.594558122333;1053.5259133390005;1104.4036220440871;1197.1978774221293;31260.218494537363;31632.55117324014;31812.681873181435;31823;32186;1115.8437818705388;1152.9135314851253;1163.243891470534;1236.536298887917;1242.782513060229;17108.914455427894;17140.40008599693;17213.1393430328;17386.65226695459;17722.02528860899;504379;508023;509963;512674;515353;59901;60319.39680603226;60368.39631603628;60445.395546044856;60483;1378.179982910167;1402.4923207551922;1411.6470882279225;1422.153818478004;1426.3866537388815;32051.519227211145;32311.35377292488;32333.51499727553;32794.67205328012;32841.17897052593;51696;52002.47997520128;52181;52257.47742522526;52454;362093;362094;362766;363294;364645;28637.28406789847;29112;29495.410091797614;29542.704572954855;29550.408991820474;49518.257226140915;49580;50047.499525004285;50094.24858627196;50408.387418871695;41324.38013429741;42217.78891105648;42377.5762242386;42760.78619606882;43668.34497482604;41061.58938410578;42165.57834421616;42543;42590.361144583476;42878.14243715046;37859;42487.5751242496;43168.35247471228;43777.343339850566;43914.12171756483;36479.45280820737;37499.25001500009;38334.61665383422;38822.80588597039;39028.414573781985;29400.7059929398;29681.406371872872;29740.553891692074;29746.405071898873;30041.248968775955 11:37:57 INFO - PROCESS | 12519 | |2;jquery.html;383.9040239940015;385.69722767627417;388.64827331265207;396.84919730502406;409.9692523060771;17309.82690173098;19331.420057398267;20436.89781551092;20448.591028179428;20458.590828183427;17588;18164.909175454137;18375.90812045941;18961.336353227638;18975.14611842467;5420.105682562392;5429.56563474923;5588.273524441837;5613.270274864262;5643.971780141093;5560.610757246974;5563.499285064343;5615.2700148980775;5617.691026993513;5626.943730562703;5266.7629956652045;5571.693556854371;5613.550915926737;5630.859228519279;5637.520810731072;5489.533389661883;5558.416366281543;5579.218909352694;5622.240997465351;5655.575831812631;5593.804216852391;5614.045612245928;5630.014747419226;5634.1830434586755;5646.096624540054;12571.308578028205;12846.550370737074;18315;23189.53620927572;23219.3034208974;2146.270268108835;2356.5286942611547;2382.1900553811615;2445.5231229910173;2477.677901872745;9049.095090490964;9137.086291370877;9624.90375096247;9697;9775.51122443875;1914.5787926656253;1949.6393167264102;1989.9005049747454;2014.7985201479735;2029.8579099463043;68869.65565172193;69802.65098674526;71728.28271717268;76823;86018.13981860227;10710;11051.557937682563;11149.665510034549;11223.490375582143;11297.26567773092;15110.471133510275;15173.393064277527;15294.388224470897;15314.617134571503;15381.615459613598;8085.838283234302;8120.512769233865;8125.3905957052275;8229.25936665703;8534.914650853536;7885.053793544811;8174;8225;8350.290225330915;8357.289630381363;4663.673542851968;4680.227762419163;4695.882602934954;4742.549457801503;4851.078295123915;1951.8731282466595;1979.0995097230725;2011.688188330811;2013.7986201380038;2019.6061767955107;459.97700114994115;972.5866506734751;1040.1782591752583;1091.44881834673;1107.8005958927308;11678.124140689482;12081.275123492444;12206.511739530319;12238.81641775374;12263.080268979862;483.2268370607071;485.6042325504702;488.16280079663545;492.63298842362667;512.9051125541712;6374.458171055419;6538.126632665754;6602.207735071822;6614.669266536654;6686.3313668632745;483167;488027;510048;543501;544460;91664.54167729118;98975.50512247393;99188;99537.50231248942;99813.50093249488;474.5776259129378;485.57754753364094;486.63502373220086;487.2180150857893;488.1481814234184;10923.399213043358;16403.589910251863;17367.13164341803;17427.56431089233;18677.533061673566;39675.60324396719;41723.1655366897;42619.57380426156;43540;43916.56083439253;52249.73875130752;54286.45713542972;55698.72150639221;58739;61646;12442.81335779946;13067.738645227233;13116.868831311565;13603.659908502366;13689.931550342184;8494.53280069602;9413.199878010446;13046.956243500686;14248.786268205778;14876.330565124379;8405.327573794204;8693.521856297964;8741.475511469333;8841.911580884109;8886;8623.568821559022;8732.956335218283;8825.382223244567;8884.511351875708;8994.730158095268;6667.899981500378;8809.471431714117;8946.507942062988;8958.372913896226;8973.37186396972;13289.468421263042;13567.321633918462;13775.931120344334;13779;13818.86181138216;12809.935950320189;12871.871281287067;12919.095663303478;12930.094893357375;12984 11:37:57 INFO - PROCESS | 12519 | |3;mootools.html;1550.2481296571164;1572.5754046407471;1747.3884140550801;1781.9198136083876;1843.695790194617;7860.371170306376;8694.087120852306;8720.738377848658;9285.628574857006;9293.90706092938;8793.076726943675;9002.774930626721;9067.546622668873;9081.545922703855;9091.272698184146;2292.5529521743224;2328.511012687338;2334.9649755253686;2336.8247381446376;2339.9064037438484;2287.5653625811124;2292.381057114578;2309.3072078376504;2311.976880231193;2325.7092863392077;2320.628699408095;2324.1981516376823;2331.7901388875;2362.2795047510504;2363.161077817376;2260.6156953317977;2268.546290741842;2291.0721157931066;2292.3352227853984;2300.861948283108;2268.2968279833303;2277.7608351123226;2278.8176945844293;2285.6000199964938;2291.679164916913;8958.37291389603;9080.455172689593;9103.36276460648;9107.225885799715;9146.634134634607;5392.622516423852;5571.415001424833;5571.693556854371;5580.944190558083;5605.271314729059;3404.8638054478038;3452.1197094740933;3497.6327485613897;3655.469956856241;3656.4149736042373;1162.3839365136491;1182.5801840346726;1183.4556104191995;1192.4097571701977;1208.1301462946665;12881.484740610364;13026.80459793104;13073.280969546671;13096.607101786962;13097.86902130976;4804.615630749532;4845.103655823684;4886.926696099561;4892.535209155125;4912.631552633496;10890;10899.891001089887;10952.671419857417;10959.178061645249;10981.670549883516;5513;5529.474699903502;5540.584456165804;5544.112941929272;5544.140658197985;4397.890052748643;4895.7062576245535;5081.898362032813;5088.592912566985;5113.105206588906;4159.729617574848;4185.874423767292;4196.769177695256;4259.807253968894;4341.261985462479;1297.280009594684;1303.4264923433848;1304.6803533134444;1309.9869001310055;1316;760.7717684694569;837.7026155714756;889.235257678396;972.2756546372998;977.3012296208103;5952.851178720567;5963.463288304073;6101.633901965896;6165.106059621419;6376.362363763679;937.8686983822271;970.898055704155;987.1559816357055;997.8303688372994;1110.616837191184;3605.152789094561;3728.440733889884;3734.9066273343383;3744.6068162843053;3745.7752534847996;11432.199746017865;11607.129465290138;11673.941630291964;11697.590584329508;11817.231879927776;11406.372649504357;11534.077273818075;11670.708232294091;11673.124515661359;11702.824457633142;8442.282405995558;8467.53428561435;8572.099929507436;8617.48295102296;8627.137286271449;5472.5621950243085;5557.083081291542;5603.607747457639;5627.803026894039;5653.010723123355;10692.679219623424;10882.40146791934;10884.183686223723;10904.836427453753;10907.29102608328;10649.733756656145;10864.619738309122;10972.615958441416;10984.450777461256;11059.281146725438;7239.4932354734665;7842.764717058498;7948.324392426708;8247.917520824714;8686.739397818075;8482.745517634481;8693.04376518595;8768.649254029768;8777.956110219407;8793.252573531066;7698.0762308523335;7724.613769311624;7792.259735325135;7843.333316668147;8021.782385590198;7533.510321829063;7586.582737949466;7588.317051465174;7588.468807183444;7735.419843511647;7297.708091676273;7403.370713489198;7451.888221676788;7461.067366579177;7466.664000120117;4938.135826230324;4964.702117872939;5103.515166059218;5128.6153538485505;5136.897262054663;5240.213967904845;5282.788688452419;5326.946730532645;5332.813351532678;5406.918896216481 11:37:57 INFO - PROCESS | 12519 | |4;prototype.html;335.08855911919585;344.70699905080676;345.9809710465925;349.33626110390253;352.218075871565;5577.330720313563;5657.405972372903;5683.431656834319;5692.260006199188;5716.22830917826;5553.583481238903;5553.611247212697;5575.637583557066;5595.21666966624;5614.635048721841;4164.583541645841;4423.380726698265;4437.977810110945;4443.311286750559;4448.555144485558;4293.785310734466;4366.214081465335;4389.188000219953;4402.4937132229725;4405.295152775557;4358.564143585648;4375.715578487404;4400.581944715247;4409.735415875041;4416.470023597173;4299.763513006784;4377.496587892385;4396.604305612478;4424.734515929038;4429.844955426544;3877.399003154487;3877.9030524236837;3895.8831235062994;3898.966773804944;3915.197384536163;5433.239346491494;5445.237666726622;5454.91817622736;5469.468548806341;5483.8080667176455;4827.662063655545;5004.474530174352;5058.620603454756;5075.111855425323;5077.238414237857;5810.1865738796605;5810.622309549865;5858.326292476378;5871.765129394819;5925.259342582177;4245.532991370947;4245.9787701061605;4257.127288905767;4271.252530807096;4284.764337961411;5873.970630146822;6080.908786368208;6088.878222435571;6112.969435152796;6132.95739724248;4374.256376416017;4380.846670366522;4384.298512238027;4388.319810429389;4425.867223983286;4461.260108557665;4475.507694153641;4486.102779444124;4494.797734101973;4498.145352383037;4668.673192876466;5032.993401319751;5075.416327122428;5090.338256026767;5112.437631860493;5895.41045895407;5912.704364781744;5917.082852157922;5936.762529498858;5945;1483.6439254578822;1489.9106053636817;1491.455618699167;1500.2498750624688;1504.255393580163;922.4050487435701;937.9531023448936;943.3349488610513;951.9381240219363;966.1980556138388;5113.411957624847;5576.525995290364;5730.226419433407;5731.8567035824435;5742.454466825645;6084.726187321581;6085.665288409092;6111.572189946661;6125.203723516003;6158.137860699506;5498.645826046109;5633.57748168889;5683.346415162309;5692.402297758758;5744.195812586241;3210.5826242588314;3219.8712051517678;3251.2847173621767;3253.902382928516;3256.2741746874194;6166.784162554289;6212.47193988507;6221.222347206599;6304.873902522016;6307.391615138111;5979.910301345483;6168.506519478431;6172.105044768484;6177.7837775677635;6235.906461402992;6244;6286.591371560834;6289.622622642564;6300.621962682254;6300.653464059429;5751.424857514383;6017.18767966319;6096.878062438637;6097;6122.387761223842;6010.497375656086;6014.188084608521;6053.727582258721;6097.506111002833;6116.938830611815;6128;6206.348333424925;6315.3053164152825;6330.936690633219;6351.587146835441;4181.749095054306;4211.1998720243055;4212.831486740619;4214.515330737005;4226.95773042278;6070.2412198475195;6072.33010922;6092.299385570716;6129.754809807558;6154.569180157346;5733.226014487991;5842.824715258549;5856.648601083949;5914.408559144051;5923.48951017505;5901.409859014236;5905.202797622438;5931.673757943355;5936.7922122725495;5974.163617093697;5695.772169113189;5789;5795;5816.1857339973285;5825.766969321349;5878.353381127987;5886.79320739256;5936.762529498772;5963.91054134197;5969.850753731192;5727.226824378656;5740.339860916049;5805.883882322414;5837.270341207349;5854.853628659318 11:37:57 INFO - PROCESS | 12519 | |5;yui.html;739.4971419434783;755.4673954861823;842.5155535567047;864.7794812322859;889.0220757167112;14513.564593062212;15401.922990385046;16082.195890205501;16144.677106457893;16165.43420980266;14630.780538291907;14674.559763207095;14676.633084172901;14712.926435367835;14715;682.0689758479676;825.1130035212141;850.4387104511025;850.6087199888059;852.4288726553224;839.8992120945464;842.7387509871928;845.0619812008665;846.2933450568783;847.4195176304221;889.7686601483629;891.745852432057;892.4868200784542;893.0132203914678;894.2845723421269;880.2737741363369;883.6553744039829;884.4737381258141;884.6505630276005;886.3485338276394;633.3160186998077;636.1316802564467;638.0174531221912;639;642.8103709405736;15013.174275414847;15090.24548772557;15091.320890559951;15122.54632361031;15262.618434539114;14782.926085369505;14810.111393316327;14825.925870370687;14912.70174596502;15007.474738384213;12096.395180240952;12246.142770006103;12246.203996740183;12343.691407714789;12409.75180496394;3963.9009024774323;3968.7420317679257;4001.6198461146146;4031.97984010081;4055.7363771354767;59212.703936480044;59436;59597.40402595962;60791.39208607902;61716.69141654263;11314.886851131383;11824.23142495735;11837.644870653894;11932.68639241126;11976.461059252355;21317.78682213189;21330.57338853245;21342.146314147572;21406.678899816514;21722.13111475555;8663.696770612998;8664.696735614223;8749.637597848545;8815.471071735588;8853.778655533535;4852.417709874838;4906.803727850917;4938.777755001033;4957.578605818474;4968.527989840959;3703.814809259526;3803.391457366808;3824.464574959508;3833.463315135883;3835.347990841564;699.6956323998975;699.7550857200041;737.3953358246187;745.9477836551498;785.7328508307203;705.2735682247294;730.8684436801427;770.1874522378944;796.482286513759;810.3274282345639;10355.534000969974;10597.682069537927;10654.200934929911;10666.306690065121;10825.079868211133;643.5398689936718;663.4393937123124;832.592029905342;841.2680967558141;851.1913682002123;4898.387701537308;4932.580730637936;5046.26829109777;5050.191969284897;5097.566706829887;61925;63931.36068639254;67942.66028669824;68302.65848670725;69613.65193174002;62387;63813.36186638167;65101;66104.66947665327;66479;58869.70565147147;58975.705121474115;59067.113993290135;59276;61874.69062654658;9428.717138485856;9526.666566670134;9589.729554897785;9803.2488551441;9898.208143348658;38345.61654383421;38476.80761596174;38669.806650966566;39100.80449597734;39142.412863806494;46548.767256163504;51912.48087519076;52432;52451;53236.73381633067;12662.746745064864;12736.60618890729;13069.085164038426;13248.20510769357;13625.591232263048;14458.06022608527;14536.781948270573;14551.27243637835;14779.704405912036;14900.925495372454;14108.647283817576;14657.340419681354;15041.172735499653;15148.924255378653;15395.61510962235;14283.357248923616;14586.322572904252;14888.404463821325;14921.477748278758;15066.09603423798;13648.317584120952;13811.240381779098;14297.213653249171;14327.498537551135;14535.200563969083;11715.472803724024;11841.763164736485;11895.583654572049;11898.881011190124;11946;11411.60059397917;11670.358130302915;11679.591214307458;11845.940770296093;11851.932563345928 11:37:57 INFO - PROCESS | 12519 | __end_tp_report 11:37:57 INFO - PROCESS | 12519 | __start_cc_report 11:37:57 INFO - PROCESS | 12519 | _x_x_mozilla_cycle_collect,335 11:37:57 INFO - PROCESS | 12519 | __end_cc_report 11:37:57 INFO - PROCESS | 12519 | __startTimestamp1463423877406__endTimestamp 11:37:57 INFO - PROCESS | 12519 | 11:37:57 INFO - PROCESS | 12519 | ------- Summary: start ------- 11:37:57 INFO - PROCESS | 12519 | Number of tests: 6 11:37:57 INFO - PROCESS | 12519 | 11:37:57 INFO - PROCESS | 12519 | [#0] dojo.html Cycles:165 Average:5437.26 Median:5643.55 stddev:632.00 (11.2%) stddev-sans-first:607.35 11:37:57 INFO - PROCESS | 12519 | Values: 3125.1 3150.9 3172.3 3186.6 3203.9 5328.1 5347.1 5378.1 5505.1 5535.8 5305.7 5419.5 5442.9 5490.4 5506.3 4876.7 4890.0 4962.0 5051.6 5093.3 4882.7 5062.0 5113.8 5128.1 5142.4 4902.4 4921.2 4950.7 4955.1 4958.1 4971.4 4975.6 4978.8 4987.7 5047.9 4961.2 4973.3 4976.1 4980.6 5018.7 5185.9 5342.8 5346.8 5391.4 5404.5 5818.2 5818.6 5827.6 5835.7 5852.6 5639.5 5888.6 5890.9 5920.3 5922.7 5293.6 5370.5 5378.3 5386.7 5386.9 5961.3 6034.7 6048.1 6124.1 6148.5 5863.6 5865.6 5868.1 5872.1 5877.3 5651.1 5790.5 5887.1 5973.8 5978.0 5657.6 5736.1 5789.7 5858.3 5923.4 5909.6 5919.9 5921.2 5943.7 5960.6 4258.1 4360.3 4458.0 4460.5 4516.9 3884.7 3923.5 3933.3 3961.8 3971.5 5510.8 5527.9 5565.6 5568.3 5600.8 5843.9 5869.1 5890.2 5904.0 5967.0 5588.6 5608.2 5616.9 5621.2 5625.1 5018.9 5046.3 5051.4 5067.4 5098.3 5849.8 6002.9 6060.5 6078.2 6123.6 5908.9 5936.3 5938.8 5963.2 5964.6 5838.9 6126.7 6133.1 6134.8 6135.5 5707.2 5737.0 5777.5 5809.6 5825.0 5903.2 5907.5 5912.8 5915.0 5918.7 5568.6 5653.0 5709.5 5733.6 5746.0 5523.3 5646.7 5663.0 5761.1 5801.0 5586.5 5617.8 5643.5 5648.0 5648.5 5609.4 5741.8 5744.9 5749.9 5794.9 5602.0 5645.1 5650.5 5678.8 5727.1 11:37:57 INFO - PROCESS | 12519 | 11:37:57 INFO - PROCESS | 12519 | [#1] ext.html Cycles:180 Average:56814.87 Median:41879.89 stddev:110076.29 (262.8%) stddev-sans-first:110304.11 11:37:57 INFO - PROCESS | 12519 | Values: 579.3 611.1 629.0 633.5 660.7 39033.6 43758.3 43760.3 43848.1 43902.1 43879.3 44394.9 44459.6 44608.6 44668.3 8808.5 8859.8 8892.8 8895.3 8926.5 8855.0 8889.0 8930.9 8934.3 8936.9 8895.4 8933.3 8951.8 8981.5 8989.7 8938.0 8963.6 8967.1 8976.6 8983.2 8818.8 8867.3 8904.9 8905.8 8908.4 41719.0 42040.8 42076.6 42098.8 42150.8 3534.6 3727.5 3737.6 3813.4 4051.8 32644.0 32842.8 33042.8 33163.3 34818.8 4437.4 4462.7 4472.0 4477.8 4484.2 351792.0 352618.0 354802.0 359229.0 360658.0 35214.3 35913.0 57442.7 58348.4 58456.7 37850.8 38222.2 38234.8 38249.0 38460.0 15960.9 16070.7 16154.3 16165.8 16181.0 13466.4 13640.1 13651.8 13652.9 13689.5 8552.6 8559.0 8580.5 8607.4 8706.4 3257.3 3301.7 3303.6 3307.0 3328.7 998.9 1039.6 1053.5 1104.4 1197.2 31260.2 31632.6 31812.7 31823.0 32186.0 1115.8 1152.9 1163.2 1236.5 1242.8 17108.9 17140.4 17213.1 17386.7 17722.0 504379.0 508023.0 509963.0 512674.0 515353.0 59901.0 60319.4 60368.4 60445.4 60483.0 1378.2 1402.5 1411.6 1422.2 1426.4 32051.5 32311.4 32333.5 32794.7 32841.2 51696.0 52002.5 52181.0 52257.5 52454.0 362093.0 362094.0 362766.0 363294.0 364645.0 28637.3 29112.0 29495.4 29542.7 29550.4 49518.3 49580.0 50047.5 50094.2 50408.4 41324.4 42217.8 42377.6 42760.8 43668.3 41061.6 42165.6 42543.0 42590.4 42878.1 37859.0 42487.6 43168.4 43777.3 43914.1 36479.5 37499.3 38334.6 38822.8 39028.4 29400.7 29681.4 29740.6 29746.4 30041.2 11:37:57 INFO - PROCESS | 12519 | 11:37:57 INFO - PROCESS | 12519 | [#2] jquery.html Cycles:180 Average:29089.24 Median:2668.34 stddev:84835.53 (3179.3%) stddev-sans-first:85046.13 11:37:57 INFO - PROCESS | 12519 | Values: 383.9 385.7 388.6 396.8 410.0 17309.8 19331.4 20436.9 20448.6 20458.6 17588.0 18164.9 18375.9 18961.3 18975.1 5420.1 5429.6 5588.3 5613.3 5644.0 5560.6 5563.5 5615.3 5617.7 5626.9 5266.8 5571.7 5613.6 5630.9 5637.5 5489.5 5558.4 5579.2 5622.2 5655.6 5593.8 5614.0 5630.0 5634.2 5646.1 12571.3 12846.6 18315.0 23189.5 23219.3 2146.3 2356.5 2382.2 2445.5 2477.7 9049.1 9137.1 9624.9 9697.0 9775.5 1914.6 1949.6 1989.9 2014.8 2029.9 68869.7 69802.7 71728.3 76823.0 86018.1 10710.0 11051.6 11149.7 11223.5 11297.3 15110.5 15173.4 15294.4 15314.6 15381.6 8085.8 8120.5 8125.4 8229.3 8534.9 7885.1 8174.0 8225.0 8350.3 8357.3 4663.7 4680.2 4695.9 4742.5 4851.1 1951.9 1979.1 2011.7 2013.8 2019.6 460.0 972.6 1040.2 1091.4 1107.8 11678.1 12081.3 12206.5 12238.8 12263.1 483.2 485.6 488.2 492.6 512.9 6374.5 6538.1 6602.2 6614.7 6686.3 483167.0 488027.0 510048.0 543501.0 544460.0 91664.5 98975.5 99188.0 99537.5 99813.5 474.6 485.6 486.6 487.2 488.1 10923.4 16403.6 17367.1 17427.6 18677.5 39675.6 41723.2 42619.6 43540.0 43916.6 52249.7 54286.5 55698.7 58739.0 61646.0 12442.8 13067.7 13116.9 13603.7 13689.9 8494.5 9413.2 13047.0 14248.8 14876.3 8405.3 8693.5 8741.5 8841.9 8886.0 8623.6 8733.0 8825.4 8884.5 8994.7 6667.9 8809.5 8946.5 8958.4 8973.4 13289.5 13567.3 13775.9 13779.0 13818.9 12809.9 12871.9 12919.1 12930.1 12984.0 11:37:57 INFO - PROCESS | 12519 | 11:37:57 INFO - PROCESS | 12519 | [#3] mootools.html Cycles:180 Average:5998.09 Median:4894.12 stddev:3502.77 (71.6%) stddev-sans-first:3496.65 11:37:57 INFO - PROCESS | 12519 | Values: 1550.2 1572.6 1747.4 1781.9 1843.7 7860.4 8694.1 8720.7 9285.6 9293.9 8793.1 9002.8 9067.5 9081.5 9091.3 2292.6 2328.5 2335.0 2336.8 2339.9 2287.6 2292.4 2309.3 2312.0 2325.7 2320.6 2324.2 2331.8 2362.3 2363.2 2260.6 2268.5 2291.1 2292.3 2300.9 2268.3 2277.8 2278.8 2285.6 2291.7 8958.4 9080.5 9103.4 9107.2 9146.6 5392.6 5571.4 5571.7 5580.9 5605.3 3404.9 3452.1 3497.6 3655.5 3656.4 1162.4 1182.6 1183.5 1192.4 1208.1 12881.5 13026.8 13073.3 13096.6 13097.9 4804.6 4845.1 4886.9 4892.5 4912.6 10890.0 10899.9 10952.7 10959.2 10981.7 5513.0 5529.5 5540.6 5544.1 5544.1 4397.9 4895.7 5081.9 5088.6 5113.1 4159.7 4185.9 4196.8 4259.8 4341.3 1297.3 1303.4 1304.7 1310.0 1316.0 760.8 837.7 889.2 972.3 977.3 5952.9 5963.5 6101.6 6165.1 6376.4 937.9 970.9 987.2 997.8 1110.6 3605.2 3728.4 3734.9 3744.6 3745.8 11432.2 11607.1 11673.9 11697.6 11817.2 11406.4 11534.1 11670.7 11673.1 11702.8 8442.3 8467.5 8572.1 8617.5 8627.1 5472.6 5557.1 5603.6 5627.8 5653.0 10692.7 10882.4 10884.2 10904.8 10907.3 10649.7 10864.6 10972.6 10984.5 11059.3 7239.5 7842.8 7948.3 8247.9 8686.7 8482.7 8693.0 8768.6 8778.0 8793.3 7698.1 7724.6 7792.3 7843.3 8021.8 7533.5 7586.6 7588.3 7588.5 7735.4 7297.7 7403.4 7451.9 7461.1 7466.7 4938.1 4964.7 5103.5 5128.6 5136.9 5240.2 5282.8 5326.9 5332.8 5406.9 11:37:57 INFO - PROCESS | 12519 | 11:37:57 INFO - PROCESS | 12519 | [#4] prototype.html Cycles:180 Average:4974.53 Median:5706.00 stddev:1467.48 (25.7%) stddev-sans-first:1429.69 11:37:57 INFO - PROCESS | 12519 | Values: 335.1 344.7 346.0 349.3 352.2 5577.3 5657.4 5683.4 5692.3 5716.2 5553.6 5553.6 5575.6 5595.2 5614.6 4164.6 4423.4 4438.0 4443.3 4448.6 4293.8 4366.2 4389.2 4402.5 4405.3 4358.6 4375.7 4400.6 4409.7 4416.5 4299.8 4377.5 4396.6 4424.7 4429.8 3877.4 3877.9 3895.9 3899.0 3915.2 5433.2 5445.2 5454.9 5469.5 5483.8 4827.7 5004.5 5058.6 5075.1 5077.2 5810.2 5810.6 5858.3 5871.8 5925.3 4245.5 4246.0 4257.1 4271.3 4284.8 5874.0 6080.9 6088.9 6113.0 6133.0 4374.3 4380.8 4384.3 4388.3 4425.9 4461.3 4475.5 4486.1 4494.8 4498.1 4668.7 5033.0 5075.4 5090.3 5112.4 5895.4 5912.7 5917.1 5936.8 5945.0 1483.6 1489.9 1491.5 1500.2 1504.3 922.4 938.0 943.3 951.9 966.2 5113.4 5576.5 5730.2 5731.9 5742.5 6084.7 6085.7 6111.6 6125.2 6158.1 5498.6 5633.6 5683.3 5692.4 5744.2 3210.6 3219.9 3251.3 3253.9 3256.3 6166.8 6212.5 6221.2 6304.9 6307.4 5979.9 6168.5 6172.1 6177.8 6235.9 6244.0 6286.6 6289.6 6300.6 6300.7 5751.4 6017.2 6096.9 6097.0 6122.4 6010.5 6014.2 6053.7 6097.5 6116.9 6128.0 6206.3 6315.3 6330.9 6351.6 4181.7 4211.2 4212.8 4214.5 4227.0 6070.2 6072.3 6092.3 6129.8 6154.6 5733.2 5842.8 5856.6 5914.4 5923.5 5901.4 5905.2 5931.7 5936.8 5974.2 5695.8 5789.0 5795.0 5816.2 5825.8 5878.4 5886.8 5936.8 5963.9 5969.9 5727.2 5740.3 5805.9 5837.3 5854.9 11:37:57 INFO - PROCESS | 12519 | 11:37:57 INFO - PROCESS | 12519 | [#5] yui.html Cycles:180 Average:16546.01 Median:25700.59 stddev:19343.73 (75.3%) stddev-sans-first:19361.57 11:37:57 INFO - PROCESS | 12519 | Values: 739.5 755.5 842.5 864.8 889.0 14513.6 15401.9 16082.2 16144.7 16165.4 14630.8 14674.6 14676.6 14712.9 14715.0 682.1 825.1 850.4 850.6 852.4 839.9 842.7 845.1 846.3 847.4 889.8 891.7 892.5 893.0 894.3 880.3 883.7 884.5 884.7 886.3 633.3 636.1 638.0 639.0 642.8 15013.2 15090.2 15091.3 15122.5 15262.6 14782.9 14810.1 14825.9 14912.7 15007.5 12096.4 12246.1 12246.2 12343.7 12409.8 3963.9 3968.7 4001.6 4032.0 4055.7 59212.7 59436.0 59597.4 60791.4 61716.7 11314.9 11824.2 11837.6 11932.7 11976.5 21317.8 21330.6 21342.1 21406.7 21722.1 8663.7 8664.7 8749.6 8815.5 8853.8 4852.4 4906.8 4938.8 4957.6 4968.5 3703.8 3803.4 3824.5 3833.5 3835.3 699.7 699.8 737.4 745.9 785.7 705.3 730.9 770.2 796.5 810.3 10355.5 10597.7 10654.2 10666.3 10825.1 643.5 663.4 832.6 841.3 851.2 4898.4 4932.6 5046.3 5050.2 5097.6 61925.0 63931.4 67942.7 68302.7 69613.7 62387.0 63813.4 65101.0 66104.7 66479.0 58869.7 58975.7 59067.1 59276.0 61874.7 9428.7 9526.7 9589.7 9803.2 9898.2 38345.6 38476.8 38669.8 39100.8 39142.4 46548.8 51912.5 52432.0 52451.0 53236.7 12662.7 12736.6 13069.1 13248.2 13625.6 14458.1 14536.8 14551.3 14779.7 14900.9 14108.6 14657.3 15041.2 15148.9 15395.6 14283.4 14586.3 14888.4 14921.5 15066.1 13648.3 13811.2 14297.2 14327.5 14535.2 11715.5 11841.8 11895.6 11898.9 11946.0 11411.6 11670.4 11679.6 11845.9 11851.9 11:37:57 INFO - PROCESS | 12519 | -------- Summary: end -------- 11:37:57 INFO - PROCESS | 12519 | 11:37:58 INFO - TEST-INFO | 12519: exit 0 11:37:58 INFO - TEST-OK | dromaeo_css | took 1111362ms 11:37:58 INFO - TEST-START | kraken 11:37:58 INFO - operating with platform_type : linux_ 11:37:58 INFO - Initialising browser for kraken test... 11:37:58 INFO - TEST-INFO | started process 12753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8joXvH/profile http://localhost:46833/getInfo.html) 11:38:02 INFO - PROCESS | 12753 | 11:38:02 INFO - PROCESS | 12753 | (process:12819): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:38:02 INFO - PROCESS | 12753 | __metrics Screen width/height:1600/1200 11:38:02 INFO - PROCESS | 12753 | colorDepth:24 11:38:02 INFO - PROCESS | 12753 | Browser inner width/height: 1024/697 11:38:02 INFO - PROCESS | 12753 | __metrics 11:38:03 ERROR - PROCESS | 12753 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:38:04 INFO - TEST-INFO | 12753: exit 0 11:38:04 INFO - Browser initialized. 11:38:04 INFO - Running cycle 1/1 for kraken test... 11:38:04 INFO - TEST-INFO | started process 12870 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8joXvH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:06 INFO - PROCESS | 12870 | 11:38:06 INFO - PROCESS | 12870 | (process:12929): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:38:16 INFO - PROCESS | 12870 | RSS: Main: 163504128 11:38:16 INFO - PROCESS | 12870 | 11:38:18 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46833/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:19 INFO - PROCESS | 12870 | RSS: Main: 168153088 11:38:19 INFO - PROCESS | 12870 | 11:38:22 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46833/tests/kraken/driver.html?testName=audio-dft) 11:38:23 INFO - PROCESS | 12870 | RSS: Main: 168333312 11:38:23 INFO - PROCESS | 12870 | 11:38:25 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46833/tests/kraken/driver.html?testName=audio-fft) 11:38:26 INFO - PROCESS | 12870 | RSS: Main: 163139584 11:38:26 INFO - PROCESS | 12870 | 11:38:28 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46833/tests/kraken/driver.html?testName=audio-oscillator) 11:38:29 INFO - PROCESS | 12870 | RSS: Main: 163164160 11:38:29 INFO - PROCESS | 12870 | 11:38:31 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46833/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:32 INFO - PROCESS | 12870 | RSS: Main: 163344384 11:38:32 INFO - PROCESS | 12870 | 11:38:35 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46833/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:36 INFO - PROCESS | 12870 | RSS: Main: 163340288 11:38:36 INFO - PROCESS | 12870 | 11:38:39 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46833/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:40 INFO - PROCESS | 12870 | RSS: Main: 162234368 11:38:40 INFO - PROCESS | 12870 | 11:38:43 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46833/tests/kraken/driver.html?testName=json-parse-financial) 11:38:43 INFO - PROCESS | 12870 | RSS: Main: 163012608 11:38:43 INFO - PROCESS | 12870 | 11:38:45 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46833/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:45 INFO - PROCESS | 12870 | RSS: Main: 163758080 11:38:45 INFO - PROCESS | 12870 | 11:38:47 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46833/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:48 INFO - PROCESS | 12870 | RSS: Main: 163921920 11:38:48 INFO - PROCESS | 12870 | 11:38:50 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46833/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:51 INFO - PROCESS | 12870 | RSS: Main: 163840000 11:38:51 INFO - PROCESS | 12870 | 11:38:53 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:54 INFO - PROCESS | 12870 | RSS: Main: 163696640 11:38:54 INFO - PROCESS | 12870 | 11:38:57 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:57 INFO - PROCESS | 12870 | RSS: Main: 163921920 11:38:57 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | Cycle 1(1): loaded http://localhost:46833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46833/tests/kraken/driver.html?testName=ai-astar) 11:38:59 INFO - PROCESS | 12870 | RSS: Main: 165142528 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | __start_tp_report 11:38:59 INFO - PROCESS | 12870 | _x_x_mozilla_page_load 11:38:59 INFO - PROCESS | 12870 | _x_x_mozilla_page_load_details 11:38:59 INFO - PROCESS | 12870 | |i|pagename|runs| 11:38:59 INFO - PROCESS | 12870 | |0;ai-astar;108;109;101;110;109;110;104;108;111;109 11:38:59 INFO - PROCESS | 12870 | |1;audio-beat-detection;154;123;156;203;126;152;160;128;195;129 11:38:59 INFO - PROCESS | 12870 | |2;audio-dft;162;163;166;163;166;177;162;166;162;162 11:38:59 INFO - PROCESS | 12870 | |3;audio-fft;75;75;76;156;77;75;75;75;157;76 11:38:59 INFO - PROCESS | 12870 | |4;audio-oscillator;94;92;180;92;92;92;147;91;91;148 11:38:59 INFO - PROCESS | 12870 | |5;imaging-gaussian-blur;116;117;118;116;117;116;117;118;117;118 11:38:59 INFO - PROCESS | 12870 | |6;imaging-darkroom;147;147;147;146;146;146;147;146;148;146 11:38:59 INFO - PROCESS | 12870 | |7;imaging-desaturate;96;96;96;95;96;96;95;96;96;95 11:38:59 INFO - PROCESS | 12870 | |8;json-parse-financial;56;56;56;56;56;56;59;107;55;52 11:38:59 INFO - PROCESS | 12870 | |9;json-stringify-tinderbox;59;64;59;59;60;59;58;60;60;61 11:38:59 INFO - PROCESS | 12870 | |10;stanford-crypto-aes;80;78;79;83;79;79;84;80;84;80 11:38:59 INFO - PROCESS | 12870 | |11;stanford-crypto-ccm;129;128;127;121;124;127;120;130;248;133 11:38:59 INFO - PROCESS | 12870 | |12;stanford-crypto-pbkdf2;163;162;164;163;173;169;163;159;164;163 11:38:59 INFO - PROCESS | 12870 | |13;stanford-crypto-sha256-iterative;67;64;63;65;66;63;62;62;62;64 11:38:59 INFO - PROCESS | 12870 | __end_tp_report 11:38:59 INFO - PROCESS | 12870 | __start_cc_report 11:38:59 INFO - PROCESS | 12870 | _x_x_mozilla_cycle_collect,851 11:38:59 INFO - PROCESS | 12870 | __end_cc_report 11:38:59 INFO - PROCESS | 12870 | __startTimestamp1463423939865__endTimestamp 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | ------- Summary: start ------- 11:38:59 INFO - PROCESS | 12870 | Number of tests: 14 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:3.07 (2.8%) stddev-sans-first:3.26 11:38:59 INFO - PROCESS | 12870 | Values: 108.0 109.0 101.0 110.0 109.0 110.0 104.0 108.0 111.0 109.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:155.00 stddev:28.19 (18.2%) stddev-sans-first:29.90 11:38:59 INFO - PROCESS | 12870 | Values: 154.0 123.0 156.0 203.0 126.0 152.0 160.0 128.0 195.0 129.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:4.61 (2.8%) stddev-sans-first:4.76 11:38:59 INFO - PROCESS | 12870 | Values: 162.0 163.0 166.0 163.0 166.0 177.0 162.0 166.0 162.0 162.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#3] audio-fft Cycles:10 Average:91.70 Median:75.00 stddev:34.16 (45.5%) stddev-sans-first:35.69 11:38:59 INFO - PROCESS | 12870 | Values: 75.0 75.0 76.0 156.0 77.0 75.0 75.0 75.0 157.0 76.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#4] audio-oscillator Cycles:10 Average:111.90 Median:92.00 stddev:33.25 (36.1%) stddev-sans-first:34.63 11:38:59 INFO - PROCESS | 12870 | Values: 94.0 92.0 180.0 92.0 92.0 92.0 147.0 91.0 91.0 148.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 11:38:59 INFO - PROCESS | 12870 | Values: 116.0 117.0 118.0 116.0 117.0 116.0 117.0 118.0 117.0 118.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 11:38:59 INFO - PROCESS | 12870 | Values: 147.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 148.0 146.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:38:59 INFO - PROCESS | 12870 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:56.00 stddev:16.29 (29.1%) stddev-sans-first:17.18 11:38:59 INFO - PROCESS | 12870 | Values: 56.0 56.0 56.0 56.0 56.0 56.0 59.0 107.0 55.0 52.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:1.66 (2.8%) stddev-sans-first:1.73 11:38:59 INFO - PROCESS | 12870 | Values: 59.0 64.0 59.0 59.0 60.0 59.0 58.0 60.0 60.0 61.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:2.22 (2.8%) stddev-sans-first:2.35 11:38:59 INFO - PROCESS | 12870 | Values: 80.0 78.0 79.0 83.0 79.0 79.0 84.0 80.0 84.0 80.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:128.50 stddev:38.61 (30.0%) stddev-sans-first:40.79 11:38:59 INFO - PROCESS | 12870 | Values: 129.0 128.0 127.0 121.0 124.0 127.0 120.0 130.0 248.0 133.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:163.50 stddev:3.92 (2.4%) stddev-sans-first:4.13 11:38:59 INFO - PROCESS | 12870 | Values: 163.0 162.0 164.0 163.0 173.0 169.0 163.0 159.0 164.0 163.0 11:38:59 INFO - PROCESS | 12870 | 11:38:59 INFO - PROCESS | 12870 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.75 (2.7%) stddev-sans-first:1.42 11:38:59 INFO - PROCESS | 12870 | Values: 67.0 64.0 63.0 65.0 66.0 63.0 62.0 62.0 62.0 64.0 11:38:59 INFO - PROCESS | 12870 | -------- Summary: end -------- 11:38:59 INFO - PROCESS | 12870 | 11:39:00 INFO - TEST-INFO | 12870: exit 0 11:39:00 INFO - TEST-OK | kraken | took 62676ms 11:39:00 INFO - SUITE-END | took 1174s 11:39:01 INFO - Completed test suite (00:19:34) 11:39:01 INFO - javascript benchmark 11:39:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7196.918593038152, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.093722820382, 3150.9212269693253, 3172.317951640397, 3186.569813075234, 3203.855826487808, 5328.067588172069, 5347.064263753838, 5378.112611419116, 5505.146702261146, 5535.778568857241, 5305.708186049766, 5419.458054194579, 5442.945570544293, 5490.423505531921, 5506.284183056207, 4876.731779752112, 4889.9511004889855, 4962.0324036812835, 5051.595872330205, 5093.286939828427, 4882.707037577739, 5061.9876024795, 5113.846584602449, 5128.128218202895, 5142.357205349332, 4902.3872015998, 4921.237208232729, 4950.653454258186, 4955.08330958772, 4958.057968985881, 4971.37857767779, 4975.5522003019905, 4978.805086779147, 4987.700737955734, 5047.873803154914, 4961.18140506816, 4973.3286006389035, 4976.0545496355935, 4980.576650984671, 5018.749062546858, 5185.922211166836, 5342.786288548454, 5346.8395948121615, 5391.433899440542, 5404.540614047811, 5818.2145410369485, 5818.5926985111055, 5827.592068555203, 5835.679037652927, 5852.56105792063, 5639.548836093103, 5888.5877988540815, 5890.941090589082, 5920.31916329619, 5922.703864806743, 5293.550048245904, 5370.516653501204, 5378.273933019032, 5386.676799392049, 5386.946130538684, 5961.254843144607, 6034.728437220336, 6048.123022161762, 6124.050772130327, 6148.508119350441, 5863.560232982543, 5865.648061116347, 5868.149118377812, 5872.148538461899, 5877.265341832271, 5651.124075768263, 5790.536757059425, 5887.0580707086665, 5973.820785376446, 5978.0, 5657.632253903483, 5736.139579063174, 5789.710514474259, 5858.2677165354335, 5923.407659234128, 5909.615874968199, 5919.881602367928, 5921.230240068763, 5943.673097979653, 5960.612560183574, 4258.127083947783, 4360.324149756792, 4457.955420445819, 4460.531644177315, 4516.88707782308, 3884.669803066771, 3923.509561304837, 3933.3116704576582, 3961.8217180226957, 3971.543272523639, 5510.834674959758, 5527.917081243784, 5565.610407271533, 5568.303962004749, 5600.803971860965, 5843.935707733429, 5869.090291004901, 5890.204822349014, 5904.0, 5967.045272756338, 5588.636738612058, 5608.186812912105, 5616.85957851057, 5621.241132447068, 5625.071863142617, 5018.924716129261, 5046.318746969186, 5051.419086804991, 5067.442581316052, 5098.337216161875, 5849.824505264849, 6002.909956350658, 6060.515158787286, 6078.240219972504, 6123.601965872115, 5908.852278692895, 5936.28764548257, 5938.762449502145, 5963.194968679173, 5964.582479226413, 5838.912416313844, 6126.693665316628, 6133.080037994337, 6134.754609815557, 6135.509159267337, 5707.172459993195, 5736.971315143564, 5777.480026797609, 5809.622374545641, 5825.009748342707, 5903.2325797646035, 5907.5273978080795, 5912.822615321547, 5915.024021036481, 5918.704064796829, 5568.638038527482, 5653.038983372919, 5709.457601527848, 5733.627314224562, 5745.971270143623, 5523.28197334344, 5646.7458964347525, 5662.971685141548, 5761.078227483583, 5801.042827933513, 5586.525145362527, 5617.775288988558, 5643.548516118619, 5648.0, 5648.491635752802, 5609.354924183771, 5741.770329186786, 5744.885102298014, 5749.8562535936935, 5794.855128621818, 5602.047651899105, 5645.096784514622, 5650.463205995424, 5678.829635110953, 5727.11229759388], "value": 5393.854698086349, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.2527639345245, 611.1443978430198, 628.9968550157251, 633.5280216238901, 660.689475946305, 39033.60966390335, 43758.34362484561, 43760.343594846105, 43848.12303753931, 43902.12195756087, 43879.34180987288, 44394.890127746745, 44459.55540444594, 44608.55391446085, 44668.3299750504, 8808.515531645757, 8859.822803543926, 8892.822143557125, 8895.332850036273, 8926.509042002688, 8855.0, 8888.955555222246, 8930.86603700945, 8934.28525717941, 8936.8659470108, 8895.421797583169, 8933.28533717301, 8951.820963580725, 8981.506017169053, 8989.685361012365, 8937.955310223473, 8963.641454341818, 8967.148120928501, 8976.640934362618, 8983.236424903826, 8818.823623527558, 8867.270882177978, 8904.910950890473, 8905.821883562292, 8908.420952638058, 41719.0, 42040.78979605083, 42076.57923420757, 42098.78950605258, 42150.78924605357, 3534.593521744981, 3727.4967879336214, 3737.626237376268, 3813.4470501777364, 4051.8176682049084, 32644.0, 32842.83578582116, 33042.834785826155, 33163.33673326544, 34818.82590587056, 4437.356583295436, 4462.687611867171, 4472.0, 4477.7984990675495, 4484.1928452878465, 351792.0, 352618.0, 354802.0, 359229.0, 360658.0, 35214.29571408557, 35913.0, 57442.7127864358, 58348.416515835146, 58456.70771646115, 37850.810745946095, 38222.23555528874, 38234.80882595625, 38249.0, 38460.0, 15960.920195398949, 16070.67858642844, 16154.273057712431, 16165.757513637305, 16181.0, 13466.394012269471, 13640.113392629448, 13651.795223071662, 13652.863471365357, 13689.452421903012, 8552.61513231906, 8558.95720521406, 8580.485170889766, 8607.440516366416, 8706.434081784664, 3257.267114899129, 3301.669833016679, 3303.587051618548, 3306.9834650827074, 3328.7170590499595, 998.9400635961865, 1039.594558122333, 1053.5259133390005, 1104.4036220440871, 1197.1978774221293, 31260.218494537363, 31632.55117324014, 31812.681873181435, 31823.0, 32186.0, 1115.8437818705388, 1152.9135314851253, 1163.243891470534, 1236.536298887917, 1242.782513060229, 17108.914455427894, 17140.40008599693, 17213.1393430328, 17386.65226695459, 17722.02528860899, 504379.0, 508023.0, 509963.0, 512674.0, 515353.0, 59901.0, 60319.39680603226, 60368.39631603628, 60445.395546044856, 60483.0, 1378.179982910167, 1402.4923207551922, 1411.6470882279225, 1422.153818478004, 1426.3866537388815, 32051.519227211145, 32311.35377292488, 32333.51499727553, 32794.67205328012, 32841.17897052593, 51696.0, 52002.47997520128, 52181.0, 52257.47742522526, 52454.0, 362093.0, 362094.0, 362766.0, 363294.0, 364645.0, 28637.28406789847, 29112.0, 29495.410091797614, 29542.704572954855, 29550.408991820474, 49518.257226140915, 49580.0, 50047.499525004285, 50094.24858627196, 50408.387418871695, 41324.38013429741, 42217.78891105648, 42377.5762242386, 42760.78619606882, 43668.34497482604, 41061.58938410578, 42165.57834421616, 42543.0, 42590.361144583476, 42878.14243715046, 37859.0, 42487.5751242496, 43168.35247471228, 43777.343339850566, 43914.12171756483, 36479.45280820737, 37499.25001500009, 38334.61665383422, 38822.80588597039, 39028.414573781985, 29400.7059929398, 29681.406371872872, 29740.553891692074, 29746.405071898873, 30041.248968775955], "value": 19183.99950686437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9040239940015, 385.69722767627417, 388.64827331265207, 396.84919730502406, 409.9692523060771, 17309.82690173098, 19331.420057398267, 20436.89781551092, 20448.591028179428, 20458.590828183427, 17588.0, 18164.909175454137, 18375.90812045941, 18961.336353227638, 18975.14611842467, 5420.105682562392, 5429.56563474923, 5588.273524441837, 5613.270274864262, 5643.971780141093, 5560.610757246974, 5563.499285064343, 5615.2700148980775, 5617.691026993513, 5626.943730562703, 5266.7629956652045, 5571.693556854371, 5613.550915926737, 5630.859228519279, 5637.520810731072, 5489.533389661883, 5558.416366281543, 5579.218909352694, 5622.240997465351, 5655.575831812631, 5593.804216852391, 5614.045612245928, 5630.014747419226, 5634.1830434586755, 5646.096624540054, 12571.308578028205, 12846.550370737074, 18315.0, 23189.53620927572, 23219.3034208974, 2146.270268108835, 2356.5286942611547, 2382.1900553811615, 2445.5231229910173, 2477.677901872745, 9049.095090490964, 9137.086291370877, 9624.90375096247, 9697.0, 9775.51122443875, 1914.5787926656253, 1949.6393167264102, 1989.9005049747454, 2014.7985201479735, 2029.8579099463043, 68869.65565172193, 69802.65098674526, 71728.28271717268, 76823.0, 86018.13981860227, 10710.0, 11051.557937682563, 11149.665510034549, 11223.490375582143, 11297.26567773092, 15110.471133510275, 15173.393064277527, 15294.388224470897, 15314.617134571503, 15381.615459613598, 8085.838283234302, 8120.512769233865, 8125.3905957052275, 8229.25936665703, 8534.914650853536, 7885.053793544811, 8174.0, 8225.0, 8350.290225330915, 8357.289630381363, 4663.673542851968, 4680.227762419163, 4695.882602934954, 4742.549457801503, 4851.078295123915, 1951.8731282466595, 1979.0995097230725, 2011.688188330811, 2013.7986201380038, 2019.6061767955107, 459.97700114994115, 972.5866506734751, 1040.1782591752583, 1091.44881834673, 1107.8005958927308, 11678.124140689482, 12081.275123492444, 12206.511739530319, 12238.81641775374, 12263.080268979862, 483.2268370607071, 485.6042325504702, 488.16280079663545, 492.63298842362667, 512.9051125541712, 6374.458171055419, 6538.126632665754, 6602.207735071822, 6614.669266536654, 6686.3313668632745, 483167.0, 488027.0, 510048.0, 543501.0, 544460.0, 91664.54167729118, 98975.50512247393, 99188.0, 99537.50231248942, 99813.50093249488, 474.5776259129378, 485.57754753364094, 486.63502373220086, 487.2180150857893, 488.1481814234184, 10923.399213043358, 16403.589910251863, 17367.13164341803, 17427.56431089233, 18677.533061673566, 39675.60324396719, 41723.1655366897, 42619.57380426156, 43540.0, 43916.56083439253, 52249.73875130752, 54286.45713542972, 55698.72150639221, 58739.0, 61646.0, 12442.81335779946, 13067.738645227233, 13116.868831311565, 13603.659908502366, 13689.931550342184, 8494.53280069602, 9413.199878010446, 13046.956243500686, 14248.786268205778, 14876.330565124379, 8405.327573794204, 8693.521856297964, 8741.475511469333, 8841.911580884109, 8886.0, 8623.568821559022, 8732.956335218283, 8825.382223244567, 8884.511351875708, 8994.730158095268, 6667.899981500378, 8809.471431714117, 8946.507942062988, 8958.372913896226, 8973.37186396972, 13289.468421263042, 13567.321633918462, 13775.931120344334, 13779.0, 13818.86181138216, 12809.935950320189, 12871.871281287067, 12919.095663303478, 12930.094893357375, 12984.0], "value": 8515.577177591264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.2481296571164, 1572.5754046407471, 1747.3884140550801, 1781.9198136083876, 1843.695790194617, 7860.371170306376, 8694.087120852306, 8720.738377848658, 9285.628574857006, 9293.90706092938, 8793.076726943675, 9002.774930626721, 9067.546622668873, 9081.545922703855, 9091.272698184146, 2292.5529521743224, 2328.511012687338, 2334.9649755253686, 2336.8247381446376, 2339.9064037438484, 2287.5653625811124, 2292.381057114578, 2309.3072078376504, 2311.976880231193, 2325.7092863392077, 2320.628699408095, 2324.1981516376823, 2331.7901388875, 2362.2795047510504, 2363.161077817376, 2260.6156953317977, 2268.546290741842, 2291.0721157931066, 2292.3352227853984, 2300.861948283108, 2268.2968279833303, 2277.7608351123226, 2278.8176945844293, 2285.6000199964938, 2291.679164916913, 8958.37291389603, 9080.455172689593, 9103.36276460648, 9107.225885799715, 9146.634134634607, 5392.622516423852, 5571.415001424833, 5571.693556854371, 5580.944190558083, 5605.271314729059, 3404.8638054478038, 3452.1197094740933, 3497.6327485613897, 3655.469956856241, 3656.4149736042373, 1162.3839365136491, 1182.5801840346726, 1183.4556104191995, 1192.4097571701977, 1208.1301462946665, 12881.484740610364, 13026.80459793104, 13073.280969546671, 13096.607101786962, 13097.86902130976, 4804.615630749532, 4845.103655823684, 4886.926696099561, 4892.535209155125, 4912.631552633496, 10890.0, 10899.891001089887, 10952.671419857417, 10959.178061645249, 10981.670549883516, 5513.0, 5529.474699903502, 5540.584456165804, 5544.112941929272, 5544.140658197985, 4397.890052748643, 4895.7062576245535, 5081.898362032813, 5088.592912566985, 5113.105206588906, 4159.729617574848, 4185.874423767292, 4196.769177695256, 4259.807253968894, 4341.261985462479, 1297.280009594684, 1303.4264923433848, 1304.6803533134444, 1309.9869001310055, 1316.0, 760.7717684694569, 837.7026155714756, 889.235257678396, 972.2756546372998, 977.3012296208103, 5952.851178720567, 5963.463288304073, 6101.633901965896, 6165.106059621419, 6376.362363763679, 937.8686983822271, 970.898055704155, 987.1559816357055, 997.8303688372994, 1110.616837191184, 3605.152789094561, 3728.440733889884, 3734.9066273343383, 3744.6068162843053, 3745.7752534847996, 11432.199746017865, 11607.129465290138, 11673.941630291964, 11697.590584329508, 11817.231879927776, 11406.372649504357, 11534.077273818075, 11670.708232294091, 11673.124515661359, 11702.824457633142, 8442.282405995558, 8467.53428561435, 8572.099929507436, 8617.48295102296, 8627.137286271449, 5472.5621950243085, 5557.083081291542, 5603.607747457639, 5627.803026894039, 5653.010723123355, 10692.679219623424, 10882.40146791934, 10884.183686223723, 10904.836427453753, 10907.29102608328, 10649.733756656145, 10864.619738309122, 10972.615958441416, 10984.450777461256, 11059.281146725438, 7239.4932354734665, 7842.764717058498, 7948.324392426708, 8247.917520824714, 8686.739397818075, 8482.745517634481, 8693.04376518595, 8768.649254029768, 8777.956110219407, 8793.252573531066, 7698.0762308523335, 7724.613769311624, 7792.259735325135, 7843.333316668147, 8021.782385590198, 7533.510321829063, 7586.582737949466, 7588.317051465174, 7588.468807183444, 7735.419843511647, 7297.708091676273, 7403.370713489198, 7451.888221676788, 7461.067366579177, 7466.664000120117, 4938.135826230324, 4964.702117872939, 5103.515166059218, 5128.6153538485505, 5136.897262054663, 5240.213967904845, 5282.788688452419, 5326.946730532645, 5332.813351532678, 5406.918896216481], "value": 4758.662277815458, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.08855911919585, 344.70699905080676, 345.9809710465925, 349.33626110390253, 352.218075871565, 5577.330720313563, 5657.405972372903, 5683.431656834319, 5692.260006199188, 5716.22830917826, 5553.583481238903, 5553.611247212697, 5575.637583557066, 5595.21666966624, 5614.635048721841, 4164.583541645841, 4423.380726698265, 4437.977810110945, 4443.311286750559, 4448.555144485558, 4293.785310734466, 4366.214081465335, 4389.188000219953, 4402.4937132229725, 4405.295152775557, 4358.564143585648, 4375.715578487404, 4400.581944715247, 4409.735415875041, 4416.470023597173, 4299.763513006784, 4377.496587892385, 4396.604305612478, 4424.734515929038, 4429.844955426544, 3877.399003154487, 3877.9030524236837, 3895.8831235062994, 3898.966773804944, 3915.197384536163, 5433.239346491494, 5445.237666726622, 5454.91817622736, 5469.468548806341, 5483.8080667176455, 4827.662063655545, 5004.474530174352, 5058.620603454756, 5075.111855425323, 5077.238414237857, 5810.1865738796605, 5810.622309549865, 5858.326292476378, 5871.765129394819, 5925.259342582177, 4245.532991370947, 4245.9787701061605, 4257.127288905767, 4271.252530807096, 4284.764337961411, 5873.970630146822, 6080.908786368208, 6088.878222435571, 6112.969435152796, 6132.95739724248, 4374.256376416017, 4380.846670366522, 4384.298512238027, 4388.319810429389, 4425.867223983286, 4461.260108557665, 4475.507694153641, 4486.102779444124, 4494.797734101973, 4498.145352383037, 4668.673192876466, 5032.993401319751, 5075.416327122428, 5090.338256026767, 5112.437631860493, 5895.41045895407, 5912.704364781744, 5917.082852157922, 5936.762529498858, 5945.0, 1483.6439254578822, 1489.9106053636817, 1491.455618699167, 1500.2498750624688, 1504.255393580163, 922.4050487435701, 937.9531023448936, 943.3349488610513, 951.9381240219363, 966.1980556138388, 5113.411957624847, 5576.525995290364, 5730.226419433407, 5731.8567035824435, 5742.454466825645, 6084.726187321581, 6085.665288409092, 6111.572189946661, 6125.203723516003, 6158.137860699506, 5498.645826046109, 5633.57748168889, 5683.346415162309, 5692.402297758758, 5744.195812586241, 3210.5826242588314, 3219.8712051517678, 3251.2847173621767, 3253.902382928516, 3256.2741746874194, 6166.784162554289, 6212.47193988507, 6221.222347206599, 6304.873902522016, 6307.391615138111, 5979.910301345483, 6168.506519478431, 6172.105044768484, 6177.7837775677635, 6235.906461402992, 6244.0, 6286.591371560834, 6289.622622642564, 6300.621962682254, 6300.653464059429, 5751.424857514383, 6017.18767966319, 6096.878062438637, 6097.0, 6122.387761223842, 6010.497375656086, 6014.188084608521, 6053.727582258721, 6097.506111002833, 6116.938830611815, 6128.0, 6206.348333424925, 6315.3053164152825, 6330.936690633219, 6351.587146835441, 4181.749095054306, 4211.1998720243055, 4212.831486740619, 4214.515330737005, 4226.95773042278, 6070.2412198475195, 6072.33010922, 6092.299385570716, 6129.754809807558, 6154.569180157346, 5733.226014487991, 5842.824715258549, 5856.648601083949, 5914.408559144051, 5923.48951017505, 5901.409859014236, 5905.202797622438, 5931.673757943355, 5936.7922122725495, 5974.163617093697, 5695.772169113189, 5789.0, 5795.0, 5816.1857339973285, 5825.766969321349, 5878.353381127987, 5886.79320739256, 5936.762529498772, 5963.91054134197, 5969.850753731192, 5727.226824378656, 5740.339860916049, 5805.883882322414, 5837.270341207349, 5854.853628659318], "value": 4499.007687457732, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.4971419434783, 755.4673954861823, 842.5155535567047, 864.7794812322859, 889.0220757167112, 14513.564593062212, 15401.922990385046, 16082.195890205501, 16144.677106457893, 16165.43420980266, 14630.780538291907, 14674.559763207095, 14676.633084172901, 14712.926435367835, 14715.0, 682.0689758479676, 825.1130035212141, 850.4387104511025, 850.6087199888059, 852.4288726553224, 839.8992120945464, 842.7387509871928, 845.0619812008665, 846.2933450568783, 847.4195176304221, 889.7686601483629, 891.745852432057, 892.4868200784542, 893.0132203914678, 894.2845723421269, 880.2737741363369, 883.6553744039829, 884.4737381258141, 884.6505630276005, 886.3485338276394, 633.3160186998077, 636.1316802564467, 638.0174531221912, 639.0, 642.8103709405736, 15013.174275414847, 15090.24548772557, 15091.320890559951, 15122.54632361031, 15262.618434539114, 14782.926085369505, 14810.111393316327, 14825.925870370687, 14912.70174596502, 15007.474738384213, 12096.395180240952, 12246.142770006103, 12246.203996740183, 12343.691407714789, 12409.75180496394, 3963.9009024774323, 3968.7420317679257, 4001.6198461146146, 4031.97984010081, 4055.7363771354767, 59212.703936480044, 59436.0, 59597.40402595962, 60791.39208607902, 61716.69141654263, 11314.886851131383, 11824.23142495735, 11837.644870653894, 11932.68639241126, 11976.461059252355, 21317.78682213189, 21330.57338853245, 21342.146314147572, 21406.678899816514, 21722.13111475555, 8663.696770612998, 8664.696735614223, 8749.637597848545, 8815.471071735588, 8853.778655533535, 4852.417709874838, 4906.803727850917, 4938.777755001033, 4957.578605818474, 4968.527989840959, 3703.814809259526, 3803.391457366808, 3824.464574959508, 3833.463315135883, 3835.347990841564, 699.6956323998975, 699.7550857200041, 737.3953358246187, 745.9477836551498, 785.7328508307203, 705.2735682247294, 730.8684436801427, 770.1874522378944, 796.482286513759, 810.3274282345639, 10355.534000969974, 10597.682069537927, 10654.200934929911, 10666.306690065121, 10825.079868211133, 643.5398689936718, 663.4393937123124, 832.592029905342, 841.2680967558141, 851.1913682002123, 4898.387701537308, 4932.580730637936, 5046.26829109777, 5050.191969284897, 5097.566706829887, 61925.0, 63931.36068639254, 67942.66028669824, 68302.65848670725, 69613.65193174002, 62387.0, 63813.36186638167, 65101.0, 66104.66947665327, 66479.0, 58869.70565147147, 58975.705121474115, 59067.113993290135, 59276.0, 61874.69062654658, 9428.717138485856, 9526.666566670134, 9589.729554897785, 9803.2488551441, 9898.208143348658, 38345.61654383421, 38476.80761596174, 38669.806650966566, 39100.80449597734, 39142.412863806494, 46548.767256163504, 51912.48087519076, 52432.0, 52451.0, 53236.73381633067, 12662.746745064864, 12736.60618890729, 13069.085164038426, 13248.20510769357, 13625.591232263048, 14458.06022608527, 14536.781948270573, 14551.27243637835, 14779.704405912036, 14900.925495372454, 14108.647283817576, 14657.340419681354, 15041.172735499653, 15148.924255378653, 15395.61510962235, 14283.357248923616, 14586.322572904252, 14888.404463821325, 14921.477748278758, 15066.09603423798, 13648.317584120952, 13811.240381779098, 14297.213653249171, 14327.498537551135, 14535.200563969083, 11715.472803724024, 11841.763164736485, 11895.583654572049, 11898.881011190124, 11946.0, 11411.60059397917, 11670.358130302915, 11679.591214307458, 11845.940770296093, 11851.932563345928], "value": 7365.234807650004, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 101.0, 110.0, 109.0, 110.0, 104.0, 108.0, 111.0, 109.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 156.0, 203.0, 126.0, 152.0, 160.0, 128.0, 195.0, 129.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 166.0, 163.0, 166.0, 177.0, 162.0, 166.0, 162.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 156.0, 77.0, 75.0, 75.0, 75.0, 157.0, 76.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 180.0, 92.0, 92.0, 92.0, 147.0, 91.0, 91.0, 148.0], "value": 111.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 118.0, 116.0, 117.0, 116.0, 117.0, 118.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 148.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 59.0, 107.0, 55.0, 52.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 59.0, 59.0, 60.0, 59.0, 58.0, 60.0, 60.0, 61.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 83.0, 79.0, 79.0, 84.0, 80.0, 84.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 127.0, 121.0, 124.0, 127.0, 120.0, 130.0, 248.0, 133.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 163.0, 173.0, 169.0, 163.0, 159.0, 164.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 63.0, 65.0, 66.0, 63.0, 62.0, 62.0, 62.0, 64.0], "value": 63.8, "unit": "score"}]}]} 11:39:01 INFO - Return code: 0 11:39:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:39:01 ERROR - # TBPL SUCCESS # 11:39:01 INFO - Running post-action listener: _resource_record_post_action 11:39:01 INFO - ##### 11:39:01 INFO - ##### Finished run-tests step (success) 11:39:01 INFO - ##### 11:39:01 INFO - Running post-run listener: _resource_record_post_run 11:39:01 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 545927168; Read time: 0; Write time: 510644 11:39:01 INFO - TinderboxPrint: CPU usage
13.4% 11:39:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:39:01 INFO - TinderboxPrint: I/O write bytes / time
545,927,168 / 510,644 11:39:01 INFO - TinderboxPrint: CPU idle
8,238.3 (86.6%) 11:39:01 INFO - TinderboxPrint: CPU user
1,214.9 (12.8%) 11:39:01 INFO - TinderboxPrint: Swap in / out
0 / 0 11:39:01 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 256581632; Read time: 0; Write time: 304808 11:39:01 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 287948800; Read time: 0; Write time: 205796 11:39:01 INFO - Running post-run listener: _upload_blobber_files 11:39:01 INFO - Blob upload gear active. 11:39:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:39:01 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 11:39:01 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:39:01 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:39:02 INFO - (blobuploader) - INFO - Open directory for files ... 11:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:03 INFO - (blobuploader) - INFO - Done attempting. 11:39:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:39:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:05 INFO - (blobuploader) - INFO - Done attempting. 11:39:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:39:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:39:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:14 INFO - (blobuploader) - INFO - Done attempting. 11:39:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:14 INFO - Return code: 0 11:39:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:39:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf56e6695c3d2735ef9811ba081f3a275d7eaad4fcb46d4a8ebbcdf54d8e130d718e8ec18543c01f67ff5c272ac784f8c9a8ae447df3588f31d9b57f3009c0c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f26cb66cbade995c4c3fad723930c6c2739ebfff8fcc9812f5a4d3395d3e9db6e0fed986a4bc0fc4810cadddf8ee179bcbb6bb49a791e5f2e9177776bfb7230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05af54dffcd1a6cfbd03ca38cef6360337a5925c3e925eb9034b698b36949988fc1c3586bcca82220515ea48997763b0836cfd008b1ed4d28ceb52ab2b628e64"} 11:39:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:39:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:39:14 INFO - Contents: 11:39:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf56e6695c3d2735ef9811ba081f3a275d7eaad4fcb46d4a8ebbcdf54d8e130d718e8ec18543c01f67ff5c272ac784f8c9a8ae447df3588f31d9b57f3009c0c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f26cb66cbade995c4c3fad723930c6c2739ebfff8fcc9812f5a4d3395d3e9db6e0fed986a4bc0fc4810cadddf8ee179bcbb6bb49a791e5f2e9177776bfb7230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05af54dffcd1a6cfbd03ca38cef6360337a5925c3e925eb9034b698b36949988fc1c3586bcca82220515ea48997763b0836cfd008b1ed4d28ceb52ab2b628e64"} 11:39:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:39:14 INFO - Copying logs to upload dir... 11:39:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:39:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.974331 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-16 11:39:14.731957) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 11:39:14.735939) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311 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/Fx-Team/sha512/bf56e6695c3d2735ef9811ba081f3a275d7eaad4fcb46d4a8ebbcdf54d8e130d718e8ec18543c01f67ff5c272ac784f8c9a8ae447df3588f31d9b57f3009c0c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f26cb66cbade995c4c3fad723930c6c2739ebfff8fcc9812f5a4d3395d3e9db6e0fed986a4bc0fc4810cadddf8ee179bcbb6bb49a791e5f2e9177776bfb7230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05af54dffcd1a6cfbd03ca38cef6360337a5925c3e925eb9034b698b36949988fc1c3586bcca82220515ea48997763b0836cfd008b1ed4d28ceb52ab2b628e64"} build_url:https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/H67eVTFCRjyrwtKgE6ydzA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf56e6695c3d2735ef9811ba081f3a275d7eaad4fcb46d4a8ebbcdf54d8e130d718e8ec18543c01f67ff5c272ac784f8c9a8ae447df3588f31d9b57f3009c0c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f26cb66cbade995c4c3fad723930c6c2739ebfff8fcc9812f5a4d3395d3e9db6e0fed986a4bc0fc4810cadddf8ee179bcbb6bb49a791e5f2e9177776bfb7230", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05af54dffcd1a6cfbd03ca38cef6360337a5925c3e925eb9034b698b36949988fc1c3586bcca82220515ea48997763b0836cfd008b1ed4d28ceb52ab2b628e64"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 11:39:14.765002) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:39:14.765344) ========= 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=c6927cf182745ad25b1d38b9000001fe-1463422454.453248-909181311 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 11:39:14.853746) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 11:39:14.854327) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 11:39:14.854673) ========= ========= Total master_lag: 0.20 =========