builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1465496794.51 results: success (0) buildid: 20160609083020 builduid: 900b9f59ec48492dacaebcccf9258527 revision: f1c88261bd7310a5837cccffc767df53737fd9ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:34.512638) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:34.513212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:34.513558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:34.528826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:34.529147) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 11:26:35-- 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% 226M=0s 2016-06-09 11:26:35 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105285 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:34.652590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:34.653389) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015811 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:34.707812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 11:26:34.708690) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f1c88261bd7310a5837cccffc767df53737fd9ce --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 f1c88261bd7310a5837cccffc767df53737fd9ce --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=516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 11:26:35,375 truncating revision to first 12 chars 2016-06-09 11:26:35,375 Setting DEBUG logging. 2016-06-09 11:26:35,375 attempt 1/10 2016-06-09 11:26:35,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f1c88261bd73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 11:26:36,278 unpacking tar archive at: fx-team-f1c88261bd73/testing/mozharness/ program finished with exit code 0 elapsedTime=1.260469 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-09 11:26:35.991129) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:35.991548) ========= script_repo_revision: f1c88261bd7310a5837cccffc767df53737fd9ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:35.992034) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:35.992357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 11:26:36.037077) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-09 11:26:36.039087) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:26:36 INFO - MultiFileLogger online at 20160609 11:26:36 in /builds/slave/test 11:26:36 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:26:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:26:36 INFO - {'append_to_log': False, 11:26:36 INFO - 'base_work_dir': '/builds/slave/test', 11:26:36 INFO - 'blob_upload_branch': 'Fx-Team', 11:26:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:26:36 INFO - 'branch': 'Fx-Team', 11:26:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:36 INFO - 'config_files': ('talos/linux_config.py',), 11:26:36 INFO - 'default_actions': ('clobber', 11:26:36 INFO - 'read-buildbot-config', 11:26:36 INFO - 'download-and-extract', 11:26:36 INFO - 'populate-webroot', 11:26:36 INFO - 'create-virtualenv', 11:26:36 INFO - 'install', 11:26:36 INFO - 'run-tests'), 11:26:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:36 INFO - 'download_minidump_stackwalk': True, 11:26:36 INFO - 'download_symbols': 'ondemand', 11:26:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:26:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:26:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:26:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:26:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:36 INFO - 'installer_path': 'installer.exe', 11:26:36 INFO - 'log_level': 'info', 11:26:36 INFO - 'log_name': 'talos', 11:26:36 INFO - 'log_to_console': True, 11:26:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:26:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:26:36 INFO - 'opt_config_files': (), 11:26:36 INFO - 'pip_index': False, 11:26:36 INFO - 'sps_profile': False, 11:26:36 INFO - 'sps_profile_interval': 0, 11:26:36 INFO - 'suite': 'dromaeojs-e10s', 11:26:36 INFO - 'system_bits': '32', 11:26:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:36 INFO - 'title': 'talos-linux64-ix-061', 11:26:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:36 INFO - 'use_talos_json': True, 11:26:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:26:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:36 INFO - 'work_dir': 'build'} 11:26:36 INFO - ##### 11:26:36 INFO - ##### Running clobber step. 11:26:36 INFO - ##### 11:26:36 INFO - Running pre-action listener: _resource_record_pre_action 11:26:36 INFO - Running main action method: clobber 11:26:36 INFO - rmtree: /builds/slave/test/build 11:26:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:37 INFO - Running post-action listener: _resource_record_post_action 11:26:37 INFO - ##### 11:26:37 INFO - ##### Finished clobber step (success) 11:26:37 INFO - ##### 11:26:37 INFO - ##### 11:26:37 INFO - ##### Running read-buildbot-config step. 11:26:37 INFO - ##### 11:26:37 INFO - Running pre-action listener: _resource_record_pre_action 11:26:37 INFO - Running main action method: read_buildbot_config 11:26:37 INFO - Using buildbot properties: 11:26:37 INFO - { 11:26:37 INFO - "project": "", 11:26:37 INFO - "product": "firefox", 11:26:37 INFO - "script_repo_revision": "production", 11:26:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:26:37 INFO - "repository": "", 11:26:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:26:37 INFO - "buildid": "20160609083020", 11:26:37 INFO - "pgo_build": "True", 11:26:37 INFO - "basedir": "/builds/slave/test", 11:26:37 INFO - "buildnumber": 449, 11:26:37 INFO - "slavename": "talos-linux64-ix-061", 11:26:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:26:37 INFO - "platform": "ubuntu64_hw", 11:26:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:26:37 INFO - "branch": "fx-team", 11:26:37 INFO - "repo_path": "integration/fx-team", 11:26:37 INFO - "revision": "f1c88261bd7310a5837cccffc767df53737fd9ce", 11:26:37 INFO - "stage_platform": "linux64-pgo", 11:26:37 INFO - "builduid": "900b9f59ec48492dacaebcccf9258527", 11:26:37 INFO - "slavebuilddir": "test" 11:26:37 INFO - } 11:26:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:26:37 INFO - Running post-action listener: _resource_record_post_action 11:26:37 INFO - ##### 11:26:37 INFO - ##### Finished read-buildbot-config step (success) 11:26:37 INFO - ##### 11:26:37 INFO - ##### 11:26:37 INFO - ##### Running download-and-extract step. 11:26:37 INFO - ##### 11:26:37 INFO - Running pre-action listener: _resource_record_pre_action 11:26:37 INFO - Running main action method: download_and_extract 11:26:37 INFO - mkdir: /builds/slave/test/build/tests 11:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:37 INFO - https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:26:38 INFO - Downloaded 1361 bytes. 11:26:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:26:38 INFO - Using the following test package requirements: 11:26:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:26:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:26:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:26:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:38 INFO - u'jsshell-linux-x86_64.zip'], 11:26:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:26:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:26:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:26:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:26:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:26:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:26:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:26:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:26: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:26:38 INFO - https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:26:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:26:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:26:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:26:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:26:39 INFO - Downloaded 24452281 bytes. 11:26:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:26:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:26:40 INFO - Return code: 0 11:26:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:26: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:26:40 INFO - https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:26:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:26:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:26:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:26:41 INFO - Downloaded 24452281 bytes. 11:26:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:26:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:26:43 INFO - Return code: 0 11:26:43 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:26:43 INFO - https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:26:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:26:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:26:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:26:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:26:44 INFO - Downloaded 10833377 bytes. 11:26:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:26:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:26:44 INFO - Return code: 0 11:26:44 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:26:44 INFO - https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:26:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:26:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:26:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:26:45 INFO - Downloaded 59288651 bytes. 11:26:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:26:45 INFO - mkdir: /builds/slave/test/properties 11:26:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:26:45 INFO - Writing to file /builds/slave/test/properties/build_url 11:26:45 INFO - Contents: 11:26:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:26:46 INFO - Running post-action listener: _resource_record_post_action 11:26:46 INFO - Running post-action listener: set_extra_try_arguments 11:26:46 INFO - ##### 11:26:46 INFO - ##### Finished download-and-extract step (success) 11:26:46 INFO - ##### 11:26:46 INFO - ##### 11:26:46 INFO - ##### Running populate-webroot step. 11:26:46 INFO - ##### 11:26:46 INFO - Running pre-action listener: _resource_record_pre_action 11:26:46 INFO - Running main action method: populate_webroot 11:26:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:26:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:26:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:26:46 INFO - '--tppagecycles', 11:26:46 INFO - '7'], 11:26:46 INFO - 'tests': ['tsvgm']}}, 11:26:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:26:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:26:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:26:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:26:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:26:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:26:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:46 INFO - 'talos_options': ['--disable-e10s'], 11:26:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:46 INFO - 'talos_options': ['--disable-e10s'], 11:26:46 INFO - 'tests': ['damp', 'tps']}, 11:26:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:46 INFO - 'tests': ['damp', 'tps']}, 11:26:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:26:46 INFO - 'tests': ['dromaeo_dom']}, 11:26:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:26:46 INFO - 'tests': ['a11yr', 11:26:46 INFO - 'ts_paint', 11:26:46 INFO - 'tpaint', 11:26:46 INFO - 'sessionrestore', 11:26:46 INFO - 'sessionrestore_no_auto_restore', 11:26:46 INFO - 'tabpaint']}, 11:26:46 INFO - 'other-e10s': {'tests': ['a11yr', 11:26:46 INFO - 'ts_paint', 11:26:46 INFO - 'tpaint', 11:26:46 INFO - 'sessionrestore', 11:26:46 INFO - 'sessionrestore_no_auto_restore', 11:26:46 INFO - 'tabpaint']}, 11:26:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:26:46 INFO - 'ts_paint', 11:26:46 INFO - 'tpaint', 11:26:46 INFO - 'sessionrestore', 11:26:46 INFO - 'sessionrestore_no_auto_restore', 11:26:46 INFO - 'tabpaint']}, 11:26:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:26:46 INFO - 'ts_paint', 11:26:46 INFO - 'tpaint', 11:26:46 INFO - 'sessionrestore', 11:26:46 INFO - 'sessionrestore_no_auto_restore', 11:26:46 INFO - 'tabpaint']}, 11:26:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:26:46 INFO - 'tests': ['a11yr', 11:26:46 INFO - 'ts_paint', 11:26:46 INFO - 'tpaint', 11:26:46 INFO - 'sessionrestore', 11:26:46 INFO - 'sessionrestore_no_auto_restore', 11:26:46 INFO - 'tabpaint']}, 11:26:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:26:46 INFO - 'tests': ['a11yr', 11:26:46 INFO - 'ts_paint', 11:26:46 INFO - 'tpaint', 11:26:46 INFO - 'sessionrestore', 11:26:46 INFO - 'sessionrestore_no_auto_restore', 11:26:46 INFO - 'tabpaint']}, 11:26:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:26:46 INFO - 'tests': ['tsvgx', 11:26:46 INFO - 'tsvgr_opacity', 11:26:46 INFO - 'tart', 11:26:46 INFO - 'tscrollx', 11:26:46 INFO - 'cart']}, 11:26:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:26:46 INFO - 'tsvgr_opacity', 11:26:46 INFO - 'tart', 11:26:46 INFO - 'tscrollx', 11:26:46 INFO - 'cart']}, 11:26:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:46 INFO - 'talos_options': ['--disable-e10s'], 11:26:46 INFO - 'tests': ['tp5o']}, 11:26:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:46 INFO - 'tests': ['tp5o']}, 11:26:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:46 INFO - 'talos_options': ['--disable-e10s', 11:26:46 INFO - '--xperf_path', 11:26:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:46 INFO - 'tests': ['tp5n']}, 11:26:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:26:46 INFO - 'talos_options': ['--xperf_path', 11:26:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:46 INFO - 'tests': ['tp5n']}}, 11:26:46 INFO - 'talos.zip': {'path': '', 11:26:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:26:46 INFO - Running post-action listener: _resource_record_post_action 11:26:46 INFO - ##### 11:26:46 INFO - ##### Finished populate-webroot step (success) 11:26:46 INFO - ##### 11:26:46 INFO - ##### 11:26:46 INFO - ##### Running create-virtualenv step. 11:26:46 INFO - ##### 11:26:46 INFO - Running pre-action listener: _resource_record_pre_action 11:26:46 INFO - Running main action method: create_virtualenv 11:26:46 INFO - Creating virtualenv /builds/slave/test/build/venv 11:26:46 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:26:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:26:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:46 INFO - Using real prefix '/usr' 11:26:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:26:47 INFO - Installing distribute.............................................................................................................................................................................................done. 11:26:49 INFO - Installing pip.................done. 11:26:49 INFO - Return code: 0 11:26:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:26:49 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:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:49 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:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:49 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 0x7fe12a3f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', '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:26:49 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:26:49 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:26:49 INFO - Using env: {'DISPLAY': ':0', 11:26:49 INFO - 'HOME': '/home/cltbld', 11:26:49 INFO - 'LANG': 'en_US.UTF-8', 11:26:49 INFO - 'LANGUAGE': 'en_US:en', 11:26:49 INFO - 'LOGNAME': 'cltbld', 11:26:49 INFO - 'MAIL': '/var/mail/cltbld', 11:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:49 INFO - 'MOZ_NO_REMOTE': '1', 11:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:49 INFO - 'NO_EM_RESTART': '1', 11:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:49 INFO - 'PWD': '/builds/slave/test', 11:26:49 INFO - 'SHELL': '/bin/bash', 11:26:49 INFO - 'SHLVL': '1', 11:26:49 INFO - 'TERM': 'linux', 11:26:49 INFO - 'TMOUT': '86400', 11:26:49 INFO - 'USER': 'cltbld', 11:26:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:49 INFO - '_': '/tools/buildbot/bin/python'} 11:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:49 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:26:49 INFO - Cleaning up... 11:26:49 INFO - Return code: 0 11:26:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:26:49 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:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:49 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:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:49 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 0x7fe12a3f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', '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:26:49 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:26:49 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:26:49 INFO - Using env: {'DISPLAY': ':0', 11:26:49 INFO - 'HOME': '/home/cltbld', 11:26:49 INFO - 'LANG': 'en_US.UTF-8', 11:26:49 INFO - 'LANGUAGE': 'en_US:en', 11:26:49 INFO - 'LOGNAME': 'cltbld', 11:26:49 INFO - 'MAIL': '/var/mail/cltbld', 11:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:49 INFO - 'MOZ_NO_REMOTE': '1', 11:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:49 INFO - 'NO_EM_RESTART': '1', 11:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:49 INFO - 'PWD': '/builds/slave/test', 11:26:49 INFO - 'SHELL': '/bin/bash', 11:26:49 INFO - 'SHLVL': '1', 11:26:49 INFO - 'TERM': 'linux', 11:26:49 INFO - 'TMOUT': '86400', 11:26:49 INFO - 'USER': 'cltbld', 11:26:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:49 INFO - '_': '/tools/buildbot/bin/python'} 11:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:49 INFO - Downloading/unpacking psutil>=3.1.1 11:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:49 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:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:51 INFO - Installing collected packages: psutil 11:26:51 INFO - Running setup.py install for psutil 11:26:51 INFO - building 'psutil._psutil_linux' extension 11:26:51 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:26:51 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:26:51 INFO - building 'psutil._psutil_posix' extension 11:26:51 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:26:52 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:26:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:52 INFO - Successfully installed psutil 11:26:52 INFO - Cleaning up... 11:26:52 INFO - Return code: 0 11:26:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:26: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:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe12a3f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', '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:26: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:26: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 mozsystemmonitor==0.3 11:26:52 INFO - Using env: {'DISPLAY': ':0', 11:26:52 INFO - 'HOME': '/home/cltbld', 11:26:52 INFO - 'LANG': 'en_US.UTF-8', 11:26:52 INFO - 'LANGUAGE': 'en_US:en', 11:26:52 INFO - 'LOGNAME': 'cltbld', 11:26:52 INFO - 'MAIL': '/var/mail/cltbld', 11:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:52 INFO - 'MOZ_NO_REMOTE': '1', 11:26:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:52 INFO - 'NO_EM_RESTART': '1', 11:26:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:52 INFO - 'PWD': '/builds/slave/test', 11:26:52 INFO - 'SHELL': '/bin/bash', 11:26:52 INFO - 'SHLVL': '1', 11:26:52 INFO - 'TERM': 'linux', 11:26:52 INFO - 'TMOUT': '86400', 11:26:52 INFO - 'USER': 'cltbld', 11:26:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:52 INFO - '_': '/tools/buildbot/bin/python'} 11:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:26: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:26: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:26: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:26: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:26: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:26: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:26:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:26:54 INFO - Installing collected packages: mozsystemmonitor 11:26:54 INFO - Running setup.py install for mozsystemmonitor 11:26:54 INFO - Successfully installed mozsystemmonitor 11:26:54 INFO - Cleaning up... 11:26:54 INFO - Return code: 0 11:26:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:54 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe12a3f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', '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:26:54 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==2.5.1'] in /builds/slave/test/build 11:26:54 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==2.5.1 11:26:54 INFO - Using env: {'DISPLAY': ':0', 11:26:54 INFO - 'HOME': '/home/cltbld', 11:26:54 INFO - 'LANG': 'en_US.UTF-8', 11:26:54 INFO - 'LANGUAGE': 'en_US:en', 11:26:54 INFO - 'LOGNAME': 'cltbld', 11:26:54 INFO - 'MAIL': '/var/mail/cltbld', 11:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:54 INFO - 'MOZ_NO_REMOTE': '1', 11:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:54 INFO - 'NO_EM_RESTART': '1', 11:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:54 INFO - 'PWD': '/builds/slave/test', 11:26:54 INFO - 'SHELL': '/bin/bash', 11:26:54 INFO - 'SHLVL': '1', 11:26:54 INFO - 'TERM': 'linux', 11:26:54 INFO - 'TMOUT': '86400', 11:26:54 INFO - 'USER': 'cltbld', 11:26:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:54 INFO - '_': '/tools/buildbot/bin/python'} 11:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:54 INFO - Downloading/unpacking jsonschema==2.5.1 11:26: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:26: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:26: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:26: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:26: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:26: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:26:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:26:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:26:56 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:26:56 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:26:56 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:26:56 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:26:56 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:26:56 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:26:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:26:56 INFO - warning: no files found matching '*.txt' 11:26:56 INFO - no previously-included directories found matching 'build' 11:26:56 INFO - no previously-included directories found matching 'dist' 11:26:56 INFO - no previously-included directories found matching '.git*' 11:26:56 INFO - Installing collected packages: jsonschema, functools32 11:26:56 INFO - Running setup.py install for functools32 11:26:57 INFO - warning: no files found matching '*.txt' 11:26:57 INFO - no previously-included directories found matching 'build' 11:26:57 INFO - no previously-included directories found matching 'dist' 11:26:57 INFO - no previously-included directories found matching '.git*' 11:26:57 INFO - Successfully installed jsonschema functools32 11:26:57 INFO - Cleaning up... 11:26:57 INFO - Return code: 0 11:26:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:26:57 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 0x7fe12a3f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', '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:26:57 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:26:57 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:26:57 INFO - Using env: {'DISPLAY': ':0', 11:26:57 INFO - 'HOME': '/home/cltbld', 11:26:57 INFO - 'LANG': 'en_US.UTF-8', 11:26:57 INFO - 'LANGUAGE': 'en_US:en', 11:26:57 INFO - 'LOGNAME': 'cltbld', 11:26:57 INFO - 'MAIL': '/var/mail/cltbld', 11:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:57 INFO - 'MOZ_NO_REMOTE': '1', 11:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:57 INFO - 'NO_EM_RESTART': '1', 11:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:57 INFO - 'PWD': '/builds/slave/test', 11:26:57 INFO - 'SHELL': '/bin/bash', 11:26:57 INFO - 'SHLVL': '1', 11:26:57 INFO - 'TERM': 'linux', 11:26:57 INFO - 'TMOUT': '86400', 11:26:57 INFO - 'USER': 'cltbld', 11:26:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:57 INFO - '_': '/tools/buildbot/bin/python'} 11:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:26:57 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:26:57 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:26:57 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:26:57 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:26:57 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:26:57 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:26:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:26:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:26:59 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:26:59 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:26:59 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:26:59 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:26:59 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:26:59 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:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:26:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:26:59 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:26:59 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:26:59 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:26:59 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:26:59 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:26:59 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:27:00 INFO - Downloading docopt-0.6.1.tar.gz 11:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:27:00 INFO - Installing collected packages: blobuploader, requests, docopt 11:27:00 INFO - Running setup.py install for blobuploader 11:27:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:27:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:27:00 INFO - Running setup.py install for requests 11:27:00 INFO - Running setup.py install for docopt 11:27:00 INFO - Successfully installed blobuploader requests docopt 11:27:00 INFO - Cleaning up... 11:27:00 INFO - Return code: 0 11:27:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:00 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:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:00 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:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:00 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 0x7fe12a3f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', '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:27:00 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:27:00 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:27:00 INFO - Using env: {'DISPLAY': ':0', 11:27:00 INFO - 'HOME': '/home/cltbld', 11:27:00 INFO - 'LANG': 'en_US.UTF-8', 11:27:00 INFO - 'LANGUAGE': 'en_US:en', 11:27:00 INFO - 'LOGNAME': 'cltbld', 11:27:00 INFO - 'MAIL': '/var/mail/cltbld', 11:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:00 INFO - 'MOZ_NO_REMOTE': '1', 11:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:00 INFO - 'NO_EM_RESTART': '1', 11:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:00 INFO - 'PWD': '/builds/slave/test', 11:27:00 INFO - 'SHELL': '/bin/bash', 11:27:00 INFO - 'SHLVL': '1', 11:27:00 INFO - 'TERM': 'linux', 11:27:00 INFO - 'TMOUT': '86400', 11:27:00 INFO - 'USER': 'cltbld', 11:27:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:00 INFO - '_': '/tools/buildbot/bin/python'} 11:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:00 INFO - Running setup.py (path:/tmp/pip-RV4MX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:01 INFO - Running setup.py (path:/tmp/pip-LGDZaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:01 INFO - Running setup.py (path:/tmp/pip-EozI_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:01 INFO - Running setup.py (path:/tmp/pip-es2YIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:01 INFO - Running setup.py (path:/tmp/pip-1_0JXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:01 INFO - Running setup.py (path:/tmp/pip-5y8OpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:01 INFO - Running setup.py (path:/tmp/pip-c8iTWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:01 INFO - Running setup.py (path:/tmp/pip-REo_2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:01 INFO - Running setup.py (path:/tmp/pip-jvb6B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:01 INFO - Running setup.py (path:/tmp/pip-iO0Vas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:01 INFO - Running setup.py (path:/tmp/pip-UbPDxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:01 INFO - Running setup.py (path:/tmp/pip-5T__ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:01 INFO - Running setup.py (path:/tmp/pip-cAFdCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:01 INFO - Running setup.py (path:/tmp/pip-RgkwwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:02 INFO - Running setup.py (path:/tmp/pip-DKzhIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:02 INFO - Running setup.py (path:/tmp/pip-49T2Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:02 INFO - Running setup.py (path:/tmp/pip-Ci3eah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:27:02 INFO - Running setup.py install for manifestparser 11:27:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:27:02 INFO - Running setup.py install for mozcrash 11:27:02 INFO - Running setup.py install for mozdebug 11:27:02 INFO - Running setup.py install for mozdevice 11:27:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:27:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:27:02 INFO - Running setup.py install for mozfile 11:27:02 INFO - Running setup.py install for mozhttpd 11:27:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:27:02 INFO - Running setup.py install for mozinfo 11:27:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:27:02 INFO - Running setup.py install for mozInstall 11:27:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:27:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:27:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:27:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:27:03 INFO - Running setup.py install for mozleak 11:27:03 INFO - Running setup.py install for mozlog 11:27:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:27:03 INFO - Running setup.py install for moznetwork 11:27:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:27:03 INFO - Running setup.py install for mozprocess 11:27:03 INFO - Running setup.py install for mozprofile 11:27:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:27:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:27:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:27:03 INFO - Running setup.py install for mozrunner 11:27:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:27:03 INFO - Running setup.py install for mozscreenshot 11:27:03 INFO - Running setup.py install for moztest 11:27:03 INFO - Running setup.py install for mozversion 11:27:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:27:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:27:04 INFO - Cleaning up... 11:27:04 INFO - Return code: 0 11:27:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:04 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:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:04 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:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:04 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 0x7fe12a3f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', '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:27:04 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:27:04 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:27:04 INFO - Using env: {'DISPLAY': ':0', 11:27:04 INFO - 'HOME': '/home/cltbld', 11:27:04 INFO - 'LANG': 'en_US.UTF-8', 11:27:04 INFO - 'LANGUAGE': 'en_US:en', 11:27:04 INFO - 'LOGNAME': 'cltbld', 11:27:04 INFO - 'MAIL': '/var/mail/cltbld', 11:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:04 INFO - 'MOZ_NO_REMOTE': '1', 11:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:04 INFO - 'NO_EM_RESTART': '1', 11:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:04 INFO - 'PWD': '/builds/slave/test', 11:27:04 INFO - 'SHELL': '/bin/bash', 11:27:04 INFO - 'SHLVL': '1', 11:27:04 INFO - 'TERM': 'linux', 11:27:04 INFO - 'TMOUT': '86400', 11:27:04 INFO - 'USER': 'cltbld', 11:27:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:04 INFO - '_': '/tools/buildbot/bin/python'} 11:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:04 INFO - Running setup.py (path:/tmp/pip-lCG6zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:04 INFO - Running setup.py (path:/tmp/pip-cfhzCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:04 INFO - Running setup.py (path:/tmp/pip-JnCsT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:04 INFO - Running setup.py (path:/tmp/pip-2idYaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:04 INFO - Running setup.py (path:/tmp/pip-0PqHtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:04 INFO - Running setup.py (path:/tmp/pip-HMjWYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:04 INFO - Running setup.py (path:/tmp/pip-c4WMAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:04 INFO - Running setup.py (path:/tmp/pip-XGW1fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:04 INFO - Running setup.py (path:/tmp/pip-TVPqVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:04 INFO - Running setup.py (path:/tmp/pip-ohX4GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:04 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:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:04 INFO - Running setup.py (path:/tmp/pip-XuAawJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:05 INFO - Running setup.py (path:/tmp/pip-A_jQOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:05 INFO - Running setup.py (path:/tmp/pip-aEel3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:05 INFO - Running setup.py (path:/tmp/pip-ic9N4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:05 INFO - Running setup.py (path:/tmp/pip-vWvrgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:05 INFO - Running setup.py (path:/tmp/pip-iUjlCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:05 INFO - Running setup.py (path:/tmp/pip-9uRJQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:05 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:27:05 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:27:05 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:27:05 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:27:05 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:27:05 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:27:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:27: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:27: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:27: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:27: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:27: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:27: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:27:07 INFO - Downloading blessings-1.6.tar.gz 11:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:27:07 INFO - Installing collected packages: blessings 11:27:07 INFO - Running setup.py install for blessings 11:27:07 INFO - Successfully installed blessings 11:27:07 INFO - Cleaning up... 11:27:07 INFO - Return code: 0 11:27:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:27:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:07 INFO - Reading from file tmpfile_stdout 11:27:07 INFO - Current package versions: 11:27:07 INFO - argparse == 1.2.1 11:27:07 INFO - blessings == 1.6 11:27:07 INFO - blobuploader == 1.2.4 11:27:07 INFO - docopt == 0.6.1 11:27:07 INFO - functools32 == 3.2.3-2 11:27:07 INFO - jsonschema == 2.5.1 11:27:07 INFO - manifestparser == 1.1 11:27:07 INFO - mozInstall == 1.12 11:27:07 INFO - mozcrash == 0.17 11:27:07 INFO - mozdebug == 0.1 11:27:07 INFO - mozdevice == 0.48 11:27:07 INFO - mozfile == 1.2 11:27:07 INFO - mozhttpd == 0.7 11:27:07 INFO - mozinfo == 0.9 11:27:07 INFO - mozleak == 0.1 11:27:07 INFO - mozlog == 3.2 11:27:07 INFO - moznetwork == 0.27 11:27:07 INFO - mozprocess == 0.22 11:27:07 INFO - mozprofile == 0.28 11:27:07 INFO - mozrunner == 6.11 11:27:07 INFO - mozscreenshot == 0.1 11:27:07 INFO - mozsystemmonitor == 0.3 11:27:07 INFO - moztest == 0.7 11:27:07 INFO - mozversion == 1.4 11:27:07 INFO - psutil == 3.1.1 11:27:07 INFO - requests == 1.2.3 11:27:07 INFO - wsgiref == 0.1.2 11:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:07 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 0x7fe12a3f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', '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:27:07 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:27:07 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:27:07 INFO - Using env: {'DISPLAY': ':0', 11:27:07 INFO - 'HOME': '/home/cltbld', 11:27:07 INFO - 'LANG': 'en_US.UTF-8', 11:27:07 INFO - 'LANGUAGE': 'en_US:en', 11:27:07 INFO - 'LOGNAME': 'cltbld', 11:27:07 INFO - 'MAIL': '/var/mail/cltbld', 11:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:07 INFO - 'MOZ_NO_REMOTE': '1', 11:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:07 INFO - 'NO_EM_RESTART': '1', 11:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:07 INFO - 'PWD': '/builds/slave/test', 11:27:07 INFO - 'SHELL': '/bin/bash', 11:27:07 INFO - 'SHLVL': '1', 11:27:07 INFO - 'TERM': 'linux', 11:27:07 INFO - 'TMOUT': '86400', 11:27:07 INFO - 'USER': 'cltbld', 11:27:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:07 INFO - '_': '/tools/buildbot/bin/python'} 11:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:08 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:27:08 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:27:08 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:27:08 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:27:08 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:27:08 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:27:08 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:27:08 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:27:08 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:27:08 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:27:08 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:27:08 INFO - Cleaning up... 11:27:08 INFO - Return code: 0 11:27:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:08 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 0x7fe12a3f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', '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:27:08 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:27:08 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:27:08 INFO - Using env: {'DISPLAY': ':0', 11:27:08 INFO - 'HOME': '/home/cltbld', 11:27:08 INFO - 'LANG': 'en_US.UTF-8', 11:27:08 INFO - 'LANGUAGE': 'en_US:en', 11:27:08 INFO - 'LOGNAME': 'cltbld', 11:27:08 INFO - 'MAIL': '/var/mail/cltbld', 11:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:08 INFO - 'MOZ_NO_REMOTE': '1', 11:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:08 INFO - 'NO_EM_RESTART': '1', 11:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:08 INFO - 'PWD': '/builds/slave/test', 11:27:08 INFO - 'SHELL': '/bin/bash', 11:27:08 INFO - 'SHLVL': '1', 11:27:08 INFO - 'TERM': 'linux', 11:27:08 INFO - 'TMOUT': '86400', 11:27:08 INFO - 'USER': 'cltbld', 11:27:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:08 INFO - '_': '/tools/buildbot/bin/python'} 11:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:27:08 INFO - Cleaning up... 11:27:08 INFO - Return code: 0 11:27:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:08 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 0x7fe12a3f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f1c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', '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:27:08 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:27:08 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:27:08 INFO - Using env: {'DISPLAY': ':0', 11:27:08 INFO - 'HOME': '/home/cltbld', 11:27:08 INFO - 'LANG': 'en_US.UTF-8', 11:27:08 INFO - 'LANGUAGE': 'en_US:en', 11:27:08 INFO - 'LOGNAME': 'cltbld', 11:27:08 INFO - 'MAIL': '/var/mail/cltbld', 11:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:08 INFO - 'MOZ_NO_REMOTE': '1', 11:27:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:08 INFO - 'NO_EM_RESTART': '1', 11:27:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:08 INFO - 'PWD': '/builds/slave/test', 11:27:08 INFO - 'SHELL': '/bin/bash', 11:27:08 INFO - 'SHLVL': '1', 11:27:08 INFO - 'TERM': 'linux', 11:27:08 INFO - 'TMOUT': '86400', 11:27:08 INFO - 'USER': 'cltbld', 11:27:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:08 INFO - '_': '/tools/buildbot/bin/python'} 11:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:08 INFO - Downloading/unpacking flake8 11:27: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:27: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:27: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:27: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:27: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:27: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:27:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:27:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:27:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:27:11 INFO - no previously-included directories found matching 'docs/_build' 11:27:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:27:11 INFO - Running setup.py install for pep8 11:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:27:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:27:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:27:11 INFO - no previously-included directories found matching 'docs/_build' 11:27:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:27:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:27:11 INFO - Cleaning up... 11:27:11 INFO - Return code: 0 11:27:11 INFO - Running post-action listener: _resource_record_post_action 11:27:11 INFO - Running post-action listener: _start_resource_monitoring 11:27:11 INFO - Starting resource monitoring. 11:27:11 INFO - ##### 11:27:11 INFO - ##### Finished create-virtualenv step (success) 11:27:11 INFO - ##### 11:27:11 INFO - ##### 11:27:11 INFO - ##### Running install step. 11:27:11 INFO - ##### 11:27:11 INFO - Running pre-action listener: _resource_record_pre_action 11:27:11 INFO - Running main action method: install 11:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:11 INFO - Reading from file tmpfile_stdout 11:27:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:27:11 INFO - Reading from file tmpfile_stdout 11:27:11 INFO - Output received: 11:27:11 INFO - Usage: mozinstall [options] installer 11:27:11 INFO - Options: 11:27:11 INFO - -h, --help show this help message and exit 11:27:11 INFO - -d DEST, --destination=DEST 11:27:11 INFO - Directory to install application into. [default: 11:27:11 INFO - "/builds/slave/test"] 11:27:11 INFO - --app=APP Application being installed. [default: firefox] 11:27:11 INFO - mkdir: /builds/slave/test/build/application 11:27:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:27:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:27:28 INFO - Reading from file tmpfile_stdout 11:27:28 INFO - Output received: 11:27:28 INFO - /builds/slave/test/build/application/firefox/firefox 11:27:28 INFO - Running post-action listener: _resource_record_post_action 11:27:28 INFO - ##### 11:27:28 INFO - ##### Finished install step (success) 11:27:28 INFO - ##### 11:27:28 INFO - ##### 11:27:28 INFO - ##### Running run-tests step. 11:27:28 INFO - ##### 11:27:28 INFO - Running pre-action listener: _resource_record_pre_action 11:27:28 INFO - Running main action method: run_tests 11:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:27:28 INFO - Python 2.7.3 11:27:28 INFO - Return code: 0 11:27:28 INFO - grabbing minidump binary from tooltool 11:27:28 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:27:28 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 0x1fab1c0>, '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 0x1fac0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:27:28 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:27:28 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:27:28 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:27:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:28 INFO - Return code: 0 11:27:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:27:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:27:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:27:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:27:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:27:29 INFO - Return code: 0 11:27:29 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/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:27:29 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/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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:27:29 INFO - Using env: {'DISPLAY': ':0', 11:27:29 INFO - 'HOME': '/home/cltbld', 11:27:29 INFO - 'LANG': 'en_US.UTF-8', 11:27:29 INFO - 'LANGUAGE': 'en_US:en', 11:27:29 INFO - 'LOGNAME': 'cltbld', 11:27:29 INFO - 'MAIL': '/var/mail/cltbld', 11:27:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:29 INFO - 'MOZ_NO_REMOTE': '1', 11:27:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:29 INFO - 'NO_EM_RESTART': '1', 11:27:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:29 INFO - 'PWD': '/builds/slave/test', 11:27:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:29 INFO - 'SHELL': '/bin/bash', 11:27:29 INFO - 'SHLVL': '1', 11:27:29 INFO - 'TERM': 'linux', 11:27:29 INFO - 'TMOUT': '86400', 11:27:29 INFO - 'USER': 'cltbld', 11:27:29 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403', 11:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:29 INFO - '_': '/tools/buildbot/bin/python'} 11:27:29 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/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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:27:29 INFO - mozversion application_buildid: 20160609083020 11:27:29 INFO - mozversion application_changeset: f1c88261bd7310a5837cccffc767df53737fd9ce 11:27:29 INFO - mozversion application_display_name: Nightly 11:27:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:29 INFO - mozversion application_name: Firefox 11:27:29 INFO - mozversion application_remotingname: firefox 11:27:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:27:29 INFO - mozversion application_vendor: Mozilla 11:27:29 INFO - mozversion application_version: 50.0a1 11:27:29 INFO - mozversion platform_buildid: 20160609083020 11:27:29 INFO - mozversion platform_changeset: f1c88261bd7310a5837cccffc767df53737fd9ce 11:27:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:27:29 INFO - mozversion platform_version: 50.0a1 11:27:29 INFO - using testdate: 1465496849 11:27:29 INFO - actual date: 1465496849 11:27:29 INFO - starting webserver on 'localhost:34365' 11:27:29 INFO - SUITE-START | Running 2 tests 11:27:29 INFO - TEST-START | dromaeo_css 11:27:29 INFO - operating with platform_type : linux_ 11:27:29 INFO - Initialising browser for dromaeo_css test... 11:27:29 INFO - TEST-INFO | started process 11203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXBC4D/profile http://localhost:34365/getInfo.html) 11:27:34 INFO - PROCESS | 11203 | __metrics Screen width/height:1600/1200 11:27:34 INFO - PROCESS | 11203 | colorDepth:24 11:27:34 INFO - PROCESS | 11203 | Browser inner width/height: 1024/697 11:27:34 INFO - PROCESS | 11203 | __metrics 11:27:35 ERROR - PROCESS | 11203 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:27:36 INFO - TEST-INFO | 11203: exit 0 11:27:36 INFO - Browser initialized. 11:27:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:36 INFO - TEST-INFO | started process 11328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHXBC4D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:48 INFO - PROCESS | 11328 | RSS: Main: 184958976 11:27:48 INFO - PROCESS | 11328 | 11:28:38 INFO - PROCESS | 11328 | 1465496918058 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:30:46 INFO - PROCESS | 11328 | Cycle 1(1): loaded http://localhost:34365/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34365/tests/dromaeo/cssquery-ext.html) 11:30:47 INFO - PROCESS | 11328 | RSS: Main: 187977728 11:30:47 INFO - PROCESS | 11328 | 11:33:49 INFO - PROCESS | 11328 | Cycle 1(1): loaded http://localhost:34365/tests/dromaeo/cssquery-ext.html (next: http://localhost:34365/tests/dromaeo/cssquery-jquery.html) 11:33:50 INFO - PROCESS | 11328 | RSS: Main: 186728448 11:33:50 INFO - PROCESS | 11328 | 11:36:52 INFO - PROCESS | 11328 | Cycle 1(1): loaded http://localhost:34365/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34365/tests/dromaeo/cssquery-mootools.html) 11:36:52 INFO - PROCESS | 11328 | RSS: Main: 187772928 11:36:52 INFO - PROCESS | 11328 | 11:39:54 INFO - PROCESS | 11328 | Cycle 1(1): loaded http://localhost:34365/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34365/tests/dromaeo/cssquery-prototype.html) 11:39:55 INFO - PROCESS | 11328 | RSS: Main: 185421824 11:39:55 INFO - PROCESS | 11328 | 11:42:57 INFO - PROCESS | 11328 | Cycle 1(1): loaded http://localhost:34365/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34365/tests/dromaeo/cssquery-yui.html) 11:42:58 INFO - PROCESS | 11328 | RSS: Main: 187514880 11:42:58 INFO - PROCESS | 11328 | 11:46:01 INFO - PROCESS | 11328 | Cycle 1(1): loaded http://localhost:34365/tests/dromaeo/cssquery-yui.html (next: http://localhost:34365/tests/dromaeo/cssquery-dojo.html) 11:46:01 INFO - PROCESS | 11328 | RSS: Main: 188305408 11:46:01 INFO - PROCESS | 11328 | 11:46:01 INFO - PROCESS | 11328 | __start_tp_report 11:46:01 INFO - PROCESS | 11328 | _x_x_mozilla_page_load 11:46:01 INFO - PROCESS | 11328 | _x_x_mozilla_page_load_details 11:46:01 INFO - PROCESS | 11328 | |i|pagename|runs| 11:46:01 INFO - PROCESS | 11328 | |0;dojo.html;3099.3956178545186;3158.447271727447;3179.618445786505;3191.4095892259934;3194.2014496375905;5432.2123292122615;5500.724963751812;5504.889902201953;5529.834104976857;5540.3628582713;5355.384130824957;5371.57027437805;5407.486288802557;5472.370677372103;5489.286392768934;4962.900741985167;4985.975070124662;5038.899222015558;5129.589632829383;5139.922901156486;790.2734274003842;4874.780634871421;4955.900881982358;4960.900781984358;5040.84877453677;4987.077390682735;4996.4503904570465;5023.874403139914;5035.924461133086;5040.59675225981;5034.270030845543;5035.571976382012;5037.773300201499;5038.823641172541;5065.848024559269;4933.925991110136;4984.127777638899;5013.39839219296;5019.14674505335;5031.723255220962;5473.042217611942;5550.58370622205;5568.053430916754;5586.441355864381;5627.803026894039;5656.575756818214;5882.588218824684;5907.970460147715;5918.260217472816;5932.11018347247;5952;5980.222571065777;5993.9400605993815;5994.400559944014;6045.093236014589;5480.451954804527;5495.752691128869;5537.640053396516;5539.778408863681;5558.249636299089;5875.559333050039;6004.369541198112;6018.097285407224;6029.065494848305;6069.211002569726;5591.608587398924;5656.830295091154;5659.26429564154;5664.688442135722;5668.9716551417805;5715.799947001835;5718.971405142947;5732.111522713986;5799.101139323411;5812.59311848175;5724.771009159587;5749.252597162342;5843.970780146072;5863.941360586425;5867.237259156283;5885.234919460443;5891.234139561915;5892.057270836645;5908.084246941731;5917.52659787216;4403.669724770655;4467.754273514923;4469.262571675702;4499.59503644667;4530.637548996073;3905.7851818150275;3960.7227494075137;3978.423128646388;4007.5591684914634;4010.057636455431;5566.2207290979295;5579.163125531121;5626.099824028136;5643.153526970905;5670.347909990322;5794.768209271666;5964.7315870785915;5985.281766188085;5991.430814072656;5998.3701711320555;5614.663120212718;5624.353199382123;5676.602637815313;5682.914756278659;5706.087026075891;4910.656254062182;4932;4961.156603377434;4962.6533746142795;5022.372203474566;5823.126531020296;5968.1942937703725;6132.386761323921;6140.907886381708;6151.630902145886;5828.94171058284;5974.522038237017;5975.25309336333;5975.521958243417;6000.459958603747;6119.602225855305;6125.571210015256;6149.139120523219;6150.384961503813;6164.352742961924;5597;5775.422457754191;5792.797252096157;5872.706364681663;5882.705864706833;5958.165856779968;5959.73181206838;5962.373950735284;5977.820665380045;6001.459868611846;5770.682612456355;5779.162021506774;5806.854828629318;5807.332156802022;5810.302763668386;5643.097104463266;5741.942580574141;5751.194832723339;5800.361960184461;5802.854928626649;5649.830505084854;5720.3707592164;5723.227364305932;5750.223719797774;5751.827445176651;5743.224664670216;5752.050911599539;5819.330776960534;5833.445822646841;5840.2991641003355;5476.561875050066;5572.804951826666;5626.381098079126;5661.858453538694;5708.200851880657 11:46:01 INFO - PROCESS | 11328 | |1;ext.html;561.2114978455269;621.6736213487922;632.7057918068099;642.5437939063266;660.3066779881124;39799.403008954854;40733.388999165036;44067.11865762683;44132.779336103355;44414.33378499325;46030.539694603125;46533;46543;46578.30132548006;46756.298655520106;8905.287576993825;9078.137576930214;9133.497657628828;9150.450972941611;9171.495567743805;8782.560871956408;8925.509096999662;8941.150590693873;8952.597133128993;8959.641614335418;8884.733457996239;8932.776680583005;8936.106389361044;8942.821143577125;8956.507392093432;8810.38327317088;8862.734117976439;8870.822583548324;8874.112588741138;8887.822243555158;8887;8958.910410895873;8959;8964.955175224148;9018.909810901872;41959.16081678349;42693.1461370774;42729.57270427318;42815;42924.14151716948;3026.107298346993;3470.2538954124984;3480.773749706261;3575.535180426554;3620.1311685195365;30795.230119246975;30944.535831962537;31135.37729245425;31481.37037259265;31497.8425107873;4155.4182414462;4181.9784660796195;4195.349720793282;4204.138151678929;4313.547077556874;132899;134076;134205;134283;134517.3274133623;33797.49303760446;34542;34656;34671;34863.65136348655;34759.652403476146;36656.633433665855;36812.63187368146;36892.89321320365;36942.815285923396;15064.246787660573;15169;15228.238588070551;15269.389224431121;15297.235138243042;12534.435950382254;12547.3098979557;12663.873361266269;12670.36648167588;12747.49010039588;8274.958625206835;8319.66721331152;8328.33373330132;8331.791705207297;8407.45351552147;3257.820819854931;3271.1495011297234;3281.9343613127603;3314.436545787222;3315.370079684852;1000.3847633705219;1022.5551884930079;1043.8081617654368;1087.7280679830042;1097.846301517788;32125;32455.51316730251;32492;32555.18612034718;32861.67138328634;1071.2982996137541;1080.065743132185;1132.9603463878889;1150.286822170243;1161.2451906260828;16028.679426411407;17021.91489042547;17804.287828486715;17994.190261438267;18974.14616342268;564393;567963;568245;568371;572098;60037.699811500665;60591;60603.393966059775;60624.39375606187;60680;1326.6285440076795;1385.5427708856053;1395.1768456610446;1397.2594524901817;1412.004536801573;32425.351492969538;33249.501257480675;33661;33862.83068584641;33922.66077339195;56802;56834.71582642226;57426;57576;57723.42276577181;538290;541173;543039;544687;548252;43210.13579728451;44882.77558612186;45475.77262113668;45944.54055459536;46003.079938401715;49403;50078;50551.74724126503;50575.74712126416;51239.48760512496;41651.16697665969;41862;41980.370294445;43012.78493607637;43379.349309759746;41715.79142104391;41883;42137.57862421337;42178.7891060555;42238.788806055774;41623;42582;42663.3600495999;42982;43022.35466468068;36101;38088.238235235694;38549.42175867308;38698.61301387063;38836.41745373765;28115;28732.70029791842;28880.844766209117;28896.71103289024;28899.566506502 11:46:01 INFO - PROCESS | 11328 | |2;jquery.html;381.26796550622817;383.55124504329933;385.0570500134378;395.81594558530287;411.84555791578157;14327.498537551188;17400.39098631548;17571;18911.95984220869;18979.905100474494;17509.824901750977;18106;18522.722159167624;19147;19169.52076198096;5193.376794784622;5228.503292187255;5336.30628018359;5372.516473517383;5381.0045141648725;5272.762725677335;5281.419043905186;5314.256004159421;5321.866953326159;5324.973375133119;5181.818636347729;5273.920891186635;5313.335833020872;5335.466453354672;5337.572994160458;5217.895642087156;5246.81636142737;5261.263423120766;5263.605229607757;5322.068637988336;4813.7593120343845;5082.009008243394;5152.562032227265;5152.690838549699;5208.427073021964;13059.869401306056;13416.12795168311;13488.932555337258;13508.932455337661;13594.796078058836;2260.389694782416;2317;2368.9170879019152;2446.7063952325657;2828.6747024092288;9540.618375264981;9664.806703865954;9694.903050969471;9718.076782705632;10073.24450666203;1907.1131923655428;1936.4287535177157;1953.4139758072522;1958.0894883879064;1961.4115765270506;77139.61430192813;77880.61059694723;78187.60906195432;79243.60378198072;82243;10477.37135771856;10864.78270434587;11156;11428.25716328436;11803.40982950849;11524.827127593093;12215.26708397499;14665.56003319902;14814.62963425923;14886;6065.54508411862;6285.779997700059;7194.64026798658;7874.21257874208;7956.846257292776;7912.525248485109;7965.601719914097;7999.440039197317;8018.077921039038;8035.758927232192;4050.7569545827346;4064.1871625674985;4068.2270368629866;4072.6945479089186;4089.1617218470737;1964.3321270768008;1970.7384279018247;1971.250924648653;1989.3634037108277;2028.3103744726864;885.3094586222757;966.4539535162611;1003.5233264199447;1017.2828156149897;1064.6699523147695;18463;18626.90686546586;18927.62144757097;18952.62094758097;19272.22911083569;976.3117002513211;981.2395393569898;985.2462865907586;1002.734275417015;1016.8322226832638;10254.384736915808;10733.731656708489;10770.623028194132;10822.729431764268;10838.295510791773;462683;475076;487802;488979;489141;60590.39409605935;62635.6868215656;72248;78512.60743696245;94184;981.7349315684725;1013.5337744637402;1035.6478797208833;1063.287597309789;1063.6862125672944;16756.481138960466;16886.324547018474;16966.745498817774;17047.31810727557;17464.21411036481;41028.58971410367;41255.381169283086;41982.370264445446;42197.367039493816;42856.35715464208;56306.43693563012;56560;58151;58595.414045859;58722.4127758734;8197.426180167331;8338.791530211793;8477.78805529842;8526.531040792815;8550.57247137653;12643.367831608566;12725.490980360682;12730;12911.22532648044;13084.28036458004;10806.297590656583;10927.235093543375;11114.610988615359;11381.601643942422;11541.711457213636;11131.72170695739;11160.609378671708;11265.493052812806;11436.599719010128;11439.542418303176;11459.19785614999;11545.36500492481;11555.88444115548;11652.766944660889;11883.76232475363;7177.28227177299;7663.846723065619;7857.607119644109;7893.526388416713;8000.079990801132;10076.810442621909;11731.296122232694;11994.520219191483;12026.15816892809;12038.337891415706 11:46:01 INFO - PROCESS | 11328 | |3;mootools.html;1447.8552144785522;1483.4807817263957;1562.8749700024;1721.517974967008;1737.6524695060991;7484.476086673935;8120.837583248332;8285.130061343554;8879.689210877621;8891.422057566253;8152.225538573841;8297.502149871012;8388.790280242982;8462.4076314658;8468.280196183316;2278.54429114177;2318.675385446039;2321;2325.837191396603;2327.2785436514737;2291.472961218921;2307.077169132344;2312.606856834334;2313.2944451942153;2332.9533409331802;2268.9546209075806;2292.793648571628;2323.4191452136965;2346.2843832631124;2366.160013195317;2265.0826415301663;2278.7037685100913;2283.566122436732;2292.7363353214428;2292.7707229277107;2222.75549689534;2223.955520889573;2233.4304752288226;2235.3405745305013;2246.213825161197;8517.872231916526;8657.350698697623;8660.610272537751;8661.870071948926;8664.176903194186;5063.240513922904;5173.611979101544;5175.767090480937;5180.818671346522;5193.610479214074;3250;3301.3067255876294;3473.6526347365316;3478.513008178857;3488.686018258369;1070.2775626452114;1078.8759292681364;1109.2678831970861;1116.8827273136285;1125.2573301620973;11717.472713727902;11845.94077029618;11985.460654270579;11995.520179192821;12073.818892716616;4597.632189424838;4640.86077417678;4716.434027916604;4730.290456431563;4737.95262047382;10226.488675566192;10293.794124117476;10307.278490505743;10315.484225788681;10325.380477171393;5262.71055091966;5267.1309233976735;5298.364196296469;5301.0723123453245;5303.946960530422;4153.501579810442;4533.863984080417;4639.466461356919;4642.326862604903;4766.308885211694;3911.902202444962;3934.488516492838;3986.760794352348;4014.598540145962;4138.255114079495;1279.181323952671;1326.7545504081775;1326.8739469750358;1332.247280286635;1341.3293353323338;977.2621670638622;979.118793086228;985.4579981010415;997.8403455447094;1005.8843233028149;5895;5902.586818922634;5952.255968003999;6055.545834062463;6160.075988601656;436.3236982676838;438.110635410118;442.31882900333767;1028.2493779540978;1051.3429106808244;4088.591140885947;4112.074783173762;4133.4626498555;4201.45381100455;4227.365895115758;10438.217133715001;10748.516316765765;10802.189835762349;10803.189760767973;10820.783584328427;10611.575536978435;10646.095081917969;10667.51996160159;10668.14654827612;10683.038526532493;8019.959900200462;8047.517148970964;8057.879131813028;8060.355171586376;8071.192880711882;5977.22296101504;6035.094735789667;6100.481459076028;6138.938610613836;6237.75048998035;9701.514924253901;9863.753406164904;9965.651202207888;10055.095041446304;10100.747481313027;10010.64962726301;10019.248556358449;10147.086762191439;10209.132223761064;10249.077583017564;6720.428763555153;7260.346568808833;7272.418206543358;7435.107787065586;7475.626218689153;8385.413021088465;8421.284190843848;8502.957485212535;8635.654573817228;8640.308775298086;7359.190489046094;7372.63136843145;7503.737369192052;7545.471816972759;7551.320381165721;7251.637418128967;7410.703571857065;7555.9244407555225;7586.6206689664195;7693.038370203724;6933.861322773415;6978.127734033246;7013.614251216232;7042.753503627348;7045.788626341218;5007.198848184273;5119.360079990001;5235.214717792362;5264.394594621667;5314.441983591667;5206.687598744087;5219.947800521946;5291.126964050888;5391.191321301836;5424.349078110652 11:46:01 INFO - PROCESS | 11328 | |4;prototype.html;310.51714583822155;311.86901501369425;312.498440003794;321.22424345206315;324.77752739373545;5671.291088613923;5688.573356998226;5690.406686127881;5715.456212311212;5721.799737009201;5547.362053363864;5579.995600791855;5584.755585754825;5601.719914004294;5603.579731520132;4099.118689481761;4159.916801663965;4261;4267.978660106695;4286.657067434613;4262.744235345874;4287.121140166259;4287.970886987132;4305.095929854719;4330.133973205356;4269.978650106745;4294.849680261192;4310.116426132651;4310.97844510777;4318.466944234799;4075.4090656854887;4225.852095176685;4272.700910936236;4293.892652683708;4317.71934824237;3618.185908170667;3630.6369363063745;3663.5786884508357;3671.247394284192;3680.6319368063246;5422.776661568777;5441.347038355383;5449.455054494559;5493.340799104093;5513.58648101394;4561.885952851172;4826.493218212107;4880.633952453544;4892.9510704892855;4926.75366231687;5804.187413762077;5816.651000939957;5823.767049318022;5831.241938547962;5835.416458354173;4029.4560234368573;4038.899027524306;4057.472528571296;4062.634362907323;4064.6748260139416;6003;6037.245344331958;6049.909251361233;6140.815775526741;6142.938570614281;4119.814608342632;4123.628873401408;4130.896727581834;4135.152293779828;4141.254574176677;4164.271827191682;4200.600942910419;4210.947263184204;4215.388768628532;4220.345846393814;4734.455537613218;4882.609391248691;4886.975565122151;4910.533499317559;4937.7531123444405;5840.591158618856;5849.590528663038;5869.647821130746;5883.705814709333;5886.175935369051;1432.8782053525358;1450.514077783933;1452.6998336488784;1453.8182727159106;1469.4636457692866;900.8873890763655;906.7053207707521;921.9950254222929;936.5691781780321;956.9617215311449;5594.860128496739;5606.85982850432;5611.971940140274;5658.688772117491;5669.659820410789;5985.491233245223;5996.580239383288;5997.370276121032;6012.699365031731;6037.577369584087;5366.651167674088;5550.9945696791965;5597.328320601554;5607.925067724967;5618.634788738719;3176.0313104502884;3214.614246290413;3223.2747631782663;3255.5116732490314;3260.2990357072867;5823.505002074871;6098.420650038239;6099.9085013724825;6227.96886015567;6238.532110091671;6211.9068213975925;6230.470410015199;6262.4990000800735;6282.528810339243;6283.5287353448675;6159.84600384985;6286.8428289292215;6298.1812364392335;6307.180066591405;6310;6080.300765412034;6081.39186081406;6081.604695694766;6084.726187321669;6091.451769340781;5996.5502587305255;6024.337322894566;6024.759009639565;6029.457348838626;6114.349125735937;6061.787837425669;6240.689455214456;6253.499720022296;6265.96867015662;6340.144080549251;4151.647109995563;4190.434291370748;4210.347396153601;4221;4256.936145957875;6040.516758659384;6170.876582468415;6187.597806142767;6210.378962103753;6219.906701399573;5767.423257674199;5931.258592675916;5952.851178720567;5969.3732158122775;5971.373005834499;5865.442782935615;5881.588548695015;5896.498797602252;5935.525157987265;5965.791197308074;5246.501582349671;5769.30768307789;5781.884362312814;5816.796412125555;5859.794907178229;5914.733836977261;5926.703664816656;5935;5946;5988.502874281429;5552.472515111058;5754.583075108548;5761.913571296518;5765.164051212467;5797.4782269595935 11:46:01 INFO - PROCESS | 11328 | |5;yui.html;778.6457161991291;794.1343935110729;802.5418798573921;816.2368185746324;854.7136709202415;15444.845551544482;16373.75439368409;16671.1664416779;16729.581760455996;16729.74905376419;14076.929615351908;14945.17801520916;14947.925260373682;14949.327280272386;14970.625734356647;789.644659903043;803.6142651527285;808.5350923219144;816.5386556595535;816.5835423933806;812.4962523235573;818.8485130250892;819.1644522586957;819.3854609043218;819.4632515702225;858.1675774498726;865.7965378136133;865.9913400866005;866.0343716755804;866.1728049712509;851.3487182305541;854.0562678240548;856.9700060497853;859.1966511311912;860.6557377049168;633.3476519185247;633.8130251575797;633.9302676705558;634.0869148426298;634.4480302137171;15702.136382498958;15752.369905203777;15762.684746305124;15785.210739463097;15864.52406427809;14663.120212787268;14681.412743490248;14755.852441475556;14836.554903352917;15131.54605361841;12631.168480570357;12641.87358126416;12689.171713742207;12775.29735864527;13045.543405980745;3785.166240409218;3794.69811750492;3880.5343358797127;3947.3092208863336;4002.939955900664;86073;86177.56911215467;86413;87213.56393217994;88804.5559772197;11243.606473773541;11308.660740177807;11417.48621312043;11457.14071444645;11706.88293117058;21928.342149735534;21936.341909742732;21960.89019554892;21964.121435142733;22037.449063773533;8466.957665211634;8618.482891026433;8673.783155421164;8757.179639532555;8792.296616270683;4596.264597664424;4652.209124448784;4658.953410465852;4673.626109911267;4750.358701575312;3426.4517677171534;3506.63180366063;3552.982235088808;3560.127768696634;3587.210813620999;592.0615823919136;603.2670305578743;607.9726412311456;616.2358675242667;621.0808004153878;662.3872917551246;668.4919461209515;674.3122015544118;705.1925545250762;716.5378330976491;10347.49264290602;10484.735736978819;10524.158067354594;10528.315659482108;10745.570177192982;594.5184400635499;595.425414475025;603.7766026570109;692.2731132311053;733.4352548537596;4559.38448309474;4569.200389931749;4788;4804.855854324376;4848.80604775805;74116.62941685256;75053;75752.62123689457;75986.62006690042;123175.3841230806;67814.66092669505;69941.65029174821;83268.58365708133;91311;105505.47247263868;84438.57780711057;86098.56950715206;86325.56837215774;87315.56342218249;89088.10911890928;9921.421386528842;10143.543540540546;10221.131203847755;10279.17766578657;10383.94808025955;43098;44405.555944440144;48460;51188.74405628097;52290.47709523008;68732;69742;70871;70938.29061709523;73228.6338568325;12936.611901642966;12957.935210323889;13069;13193.40629671648;13363.933180334036;13757.38091785852;14315.355808988412;14347.784783228051;14552;15162.090274583561;13557.25435101079;13755.931220343835;14209.715805684034;14232.857671423153;14488.782668259773;13749.793753093913;13829.930850345683;13845.930770346084;14042.78935815984;14545.200013998909;11067.280626759235;12470;12915.35423228816;12959.416826242654;13833.239171845646;11159.330440173615;11198.44007799623;11213.775724485628;11282.887171128184;11830.645080647595;11627.12796540246;11731.765364692828;11890.643280701594;11906.76186476283;11947.402629868298 11:46:01 INFO - PROCESS | 11328 | __end_tp_report 11:46:01 INFO - PROCESS | 11328 | __start_cc_report 11:46:01 INFO - PROCESS | 11328 | _x_x_mozilla_cycle_collect,339 11:46:01 INFO - PROCESS | 11328 | __end_cc_report 11:46:01 INFO - PROCESS | 11328 | __startTimestamp1465497961352__endTimestamp 11:46:01 INFO - PROCESS | 11328 | 11:46:01 INFO - PROCESS | 11328 | ------- Summary: start ------- 11:46:01 INFO - PROCESS | 11328 | Number of tests: 6 11:46:01 INFO - PROCESS | 11328 | 11:46:01 INFO - PROCESS | 11328 | [#0] dojo.html Cycles:165 Average:5441.07 Median:5668.97 stddev:728.59 (12.9%) stddev-sans-first:707.28 11:46:01 INFO - PROCESS | 11328 | Values: 3099.4 3158.4 3179.6 3191.4 3194.2 5432.2 5500.7 5504.9 5529.8 5540.4 5355.4 5371.6 5407.5 5472.4 5489.3 4962.9 4986.0 5038.9 5129.6 5139.9 790.3 4874.8 4955.9 4960.9 5040.8 4987.1 4996.5 5023.9 5035.9 5040.6 5034.3 5035.6 5037.8 5038.8 5065.8 4933.9 4984.1 5013.4 5019.1 5031.7 5473.0 5550.6 5568.1 5586.4 5627.8 5656.6 5882.6 5908.0 5918.3 5932.1 5952.0 5980.2 5993.9 5994.4 6045.1 5480.5 5495.8 5537.6 5539.8 5558.2 5875.6 6004.4 6018.1 6029.1 6069.2 5591.6 5656.8 5659.3 5664.7 5669.0 5715.8 5719.0 5732.1 5799.1 5812.6 5724.8 5749.3 5844.0 5863.9 5867.2 5885.2 5891.2 5892.1 5908.1 5917.5 4403.7 4467.8 4469.3 4499.6 4530.6 3905.8 3960.7 3978.4 4007.6 4010.1 5566.2 5579.2 5626.1 5643.2 5670.3 5794.8 5964.7 5985.3 5991.4 5998.4 5614.7 5624.4 5676.6 5682.9 5706.1 4910.7 4932.0 4961.2 4962.7 5022.4 5823.1 5968.2 6132.4 6140.9 6151.6 5828.9 5974.5 5975.3 5975.5 6000.5 6119.6 6125.6 6149.1 6150.4 6164.4 5597.0 5775.4 5792.8 5872.7 5882.7 5958.2 5959.7 5962.4 5977.8 6001.5 5770.7 5779.2 5806.9 5807.3 5810.3 5643.1 5741.9 5751.2 5800.4 5802.9 5649.8 5720.4 5723.2 5750.2 5751.8 5743.2 5752.1 5819.3 5833.4 5840.3 5476.6 5572.8 5626.4 5661.9 5708.2 11:46:01 INFO - PROCESS | 11328 | 11:46:01 INFO - PROCESS | 11328 | [#1] ext.html Cycles:180 Average:57378.92 Median:41969.77 stddev:123846.71 (295.1%) stddev-sans-first:124120.67 11:46:01 INFO - PROCESS | 11328 | Values: 561.2 621.7 632.7 642.5 660.3 39799.4 40733.4 44067.1 44132.8 44414.3 46030.5 46533.0 46543.0 46578.3 46756.3 8905.3 9078.1 9133.5 9150.5 9171.5 8782.6 8925.5 8941.2 8952.6 8959.6 8884.7 8932.8 8936.1 8942.8 8956.5 8810.4 8862.7 8870.8 8874.1 8887.8 8887.0 8958.9 8959.0 8965.0 9018.9 41959.2 42693.1 42729.6 42815.0 42924.1 3026.1 3470.3 3480.8 3575.5 3620.1 30795.2 30944.5 31135.4 31481.4 31497.8 4155.4 4182.0 4195.3 4204.1 4313.5 132899.0 134076.0 134205.0 134283.0 134517.3 33797.5 34542.0 34656.0 34671.0 34863.7 34759.7 36656.6 36812.6 36892.9 36942.8 15064.2 15169.0 15228.2 15269.4 15297.2 12534.4 12547.3 12663.9 12670.4 12747.5 8275.0 8319.7 8328.3 8331.8 8407.5 3257.8 3271.1 3281.9 3314.4 3315.4 1000.4 1022.6 1043.8 1087.7 1097.8 32125.0 32455.5 32492.0 32555.2 32861.7 1071.3 1080.1 1133.0 1150.3 1161.2 16028.7 17021.9 17804.3 17994.2 18974.1 564393.0 567963.0 568245.0 568371.0 572098.0 60037.7 60591.0 60603.4 60624.4 60680.0 1326.6 1385.5 1395.2 1397.3 1412.0 32425.4 33249.5 33661.0 33862.8 33922.7 56802.0 56834.7 57426.0 57576.0 57723.4 538290.0 541173.0 543039.0 544687.0 548252.0 43210.1 44882.8 45475.8 45944.5 46003.1 49403.0 50078.0 50551.7 50575.7 51239.5 41651.2 41862.0 41980.4 43012.8 43379.3 41715.8 41883.0 42137.6 42178.8 42238.8 41623.0 42582.0 42663.4 42982.0 43022.4 36101.0 38088.2 38549.4 38698.6 38836.4 28115.0 28732.7 28880.8 28896.7 28899.6 11:46:01 INFO - PROCESS | 11328 | 11:46:01 INFO - PROCESS | 11328 | [#2] jquery.html Cycles:180 Average:27582.75 Median:382.41 stddev:79067.37 (20676.1%) stddev-sans-first:79262.79 11:46:01 INFO - PROCESS | 11328 | Values: 381.3 383.6 385.1 395.8 411.8 14327.5 17400.4 17571.0 18912.0 18979.9 17509.8 18106.0 18522.7 19147.0 19169.5 5193.4 5228.5 5336.3 5372.5 5381.0 5272.8 5281.4 5314.3 5321.9 5325.0 5181.8 5273.9 5313.3 5335.5 5337.6 5217.9 5246.8 5261.3 5263.6 5322.1 4813.8 5082.0 5152.6 5152.7 5208.4 13059.9 13416.1 13488.9 13508.9 13594.8 2260.4 2317.0 2368.9 2446.7 2828.7 9540.6 9664.8 9694.9 9718.1 10073.2 1907.1 1936.4 1953.4 1958.1 1961.4 77139.6 77880.6 78187.6 79243.6 82243.0 10477.4 10864.8 11156.0 11428.3 11803.4 11524.8 12215.3 14665.6 14814.6 14886.0 6065.5 6285.8 7194.6 7874.2 7956.8 7912.5 7965.6 7999.4 8018.1 8035.8 4050.8 4064.2 4068.2 4072.7 4089.2 1964.3 1970.7 1971.3 1989.4 2028.3 885.3 966.5 1003.5 1017.3 1064.7 18463.0 18626.9 18927.6 18952.6 19272.2 976.3 981.2 985.2 1002.7 1016.8 10254.4 10733.7 10770.6 10822.7 10838.3 462683.0 475076.0 487802.0 488979.0 489141.0 60590.4 62635.7 72248.0 78512.6 94184.0 981.7 1013.5 1035.6 1063.3 1063.7 16756.5 16886.3 16966.7 17047.3 17464.2 41028.6 41255.4 41982.4 42197.4 42856.4 56306.4 56560.0 58151.0 58595.4 58722.4 8197.4 8338.8 8477.8 8526.5 8550.6 12643.4 12725.5 12730.0 12911.2 13084.3 10806.3 10927.2 11114.6 11381.6 11541.7 11131.7 11160.6 11265.5 11436.6 11439.5 11459.2 11545.4 11555.9 11652.8 11883.8 7177.3 7663.8 7857.6 7893.5 8000.1 10076.8 11731.3 11994.5 12026.2 12038.3 11:46:01 INFO - PROCESS | 11328 | 11:46:01 INFO - PROCESS | 11328 | [#3] mootools.html Cycles:180 Average:5713.85 Median:4618.55 stddev:3219.48 (69.7%) stddev-sans-first:3212.54 11:46:01 INFO - PROCESS | 11328 | Values: 1447.9 1483.5 1562.9 1721.5 1737.7 7484.5 8120.8 8285.1 8879.7 8891.4 8152.2 8297.5 8388.8 8462.4 8468.3 2278.5 2318.7 2321.0 2325.8 2327.3 2291.5 2307.1 2312.6 2313.3 2333.0 2269.0 2292.8 2323.4 2346.3 2366.2 2265.1 2278.7 2283.6 2292.7 2292.8 2222.8 2224.0 2233.4 2235.3 2246.2 8517.9 8657.4 8660.6 8661.9 8664.2 5063.2 5173.6 5175.8 5180.8 5193.6 3250.0 3301.3 3473.7 3478.5 3488.7 1070.3 1078.9 1109.3 1116.9 1125.3 11717.5 11845.9 11985.5 11995.5 12073.8 4597.6 4640.9 4716.4 4730.3 4738.0 10226.5 10293.8 10307.3 10315.5 10325.4 5262.7 5267.1 5298.4 5301.1 5303.9 4153.5 4533.9 4639.5 4642.3 4766.3 3911.9 3934.5 3986.8 4014.6 4138.3 1279.2 1326.8 1326.9 1332.2 1341.3 977.3 979.1 985.5 997.8 1005.9 5895.0 5902.6 5952.3 6055.5 6160.1 436.3 438.1 442.3 1028.2 1051.3 4088.6 4112.1 4133.5 4201.5 4227.4 10438.2 10748.5 10802.2 10803.2 10820.8 10611.6 10646.1 10667.5 10668.1 10683.0 8020.0 8047.5 8057.9 8060.4 8071.2 5977.2 6035.1 6100.5 6138.9 6237.8 9701.5 9863.8 9965.7 10055.1 10100.7 10010.6 10019.2 10147.1 10209.1 10249.1 6720.4 7260.3 7272.4 7435.1 7475.6 8385.4 8421.3 8503.0 8635.7 8640.3 7359.2 7372.6 7503.7 7545.5 7551.3 7251.6 7410.7 7555.9 7586.6 7693.0 6933.9 6978.1 7013.6 7042.8 7045.8 5007.2 5119.4 5235.2 5264.4 5314.4 5206.7 5219.9 5291.1 5391.2 5424.3 11:46:01 INFO - PROCESS | 11328 | 11:46:01 INFO - PROCESS | 11328 | [#4] prototype.html Cycles:180 Average:4914.51 Median:5664.17 stddev:1490.97 (26.3%) stddev-sans-first:1454.56 11:46:01 INFO - PROCESS | 11328 | Values: 310.5 311.9 312.5 321.2 324.8 5671.3 5688.6 5690.4 5715.5 5721.8 5547.4 5580.0 5584.8 5601.7 5603.6 4099.1 4159.9 4261.0 4268.0 4286.7 4262.7 4287.1 4288.0 4305.1 4330.1 4270.0 4294.8 4310.1 4311.0 4318.5 4075.4 4225.9 4272.7 4293.9 4317.7 3618.2 3630.6 3663.6 3671.2 3680.6 5422.8 5441.3 5449.5 5493.3 5513.6 4561.9 4826.5 4880.6 4893.0 4926.8 5804.2 5816.7 5823.8 5831.2 5835.4 4029.5 4038.9 4057.5 4062.6 4064.7 6003.0 6037.2 6049.9 6140.8 6142.9 4119.8 4123.6 4130.9 4135.2 4141.3 4164.3 4200.6 4210.9 4215.4 4220.3 4734.5 4882.6 4887.0 4910.5 4937.8 5840.6 5849.6 5869.6 5883.7 5886.2 1432.9 1450.5 1452.7 1453.8 1469.5 900.9 906.7 922.0 936.6 957.0 5594.9 5606.9 5612.0 5658.7 5669.7 5985.5 5996.6 5997.4 6012.7 6037.6 5366.7 5551.0 5597.3 5607.9 5618.6 3176.0 3214.6 3223.3 3255.5 3260.3 5823.5 6098.4 6099.9 6228.0 6238.5 6211.9 6230.5 6262.5 6282.5 6283.5 6159.8 6286.8 6298.2 6307.2 6310.0 6080.3 6081.4 6081.6 6084.7 6091.5 5996.6 6024.3 6024.8 6029.5 6114.3 6061.8 6240.7 6253.5 6266.0 6340.1 4151.6 4190.4 4210.3 4221.0 4256.9 6040.5 6170.9 6187.6 6210.4 6219.9 5767.4 5931.3 5952.9 5969.4 5971.4 5865.4 5881.6 5896.5 5935.5 5965.8 5246.5 5769.3 5781.9 5816.8 5859.8 5914.7 5926.7 5935.0 5946.0 5988.5 5552.5 5754.6 5761.9 5765.2 5797.5 11:46:01 INFO - PROCESS | 11328 | 11:46:01 INFO - PROCESS | 11328 | [#5] yui.html Cycles:180 Average:19798.67 Median:23550.47 stddev:27108.13 (115.1%) stddev-sans-first:27146.56 11:46:01 INFO - PROCESS | 11328 | Values: 778.6 794.1 802.5 816.2 854.7 15444.8 16373.8 16671.2 16729.6 16729.7 14076.9 14945.2 14947.9 14949.3 14970.6 789.6 803.6 808.5 816.5 816.6 812.5 818.8 819.2 819.4 819.5 858.2 865.8 866.0 866.0 866.2 851.3 854.1 857.0 859.2 860.7 633.3 633.8 633.9 634.1 634.4 15702.1 15752.4 15762.7 15785.2 15864.5 14663.1 14681.4 14755.9 14836.6 15131.5 12631.2 12641.9 12689.2 12775.3 13045.5 3785.2 3794.7 3880.5 3947.3 4002.9 86073.0 86177.6 86413.0 87213.6 88804.6 11243.6 11308.7 11417.5 11457.1 11706.9 21928.3 21936.3 21960.9 21964.1 22037.4 8467.0 8618.5 8673.8 8757.2 8792.3 4596.3 4652.2 4659.0 4673.6 4750.4 3426.5 3506.6 3553.0 3560.1 3587.2 592.1 603.3 608.0 616.2 621.1 662.4 668.5 674.3 705.2 716.5 10347.5 10484.7 10524.2 10528.3 10745.6 594.5 595.4 603.8 692.3 733.4 4559.4 4569.2 4788.0 4804.9 4848.8 74116.6 75053.0 75752.6 75986.6 123175.4 67814.7 69941.7 83268.6 91311.0 105505.5 84438.6 86098.6 86325.6 87315.6 89088.1 9921.4 10143.5 10221.1 10279.2 10383.9 43098.0 44405.6 48460.0 51188.7 52290.5 68732.0 69742.0 70871.0 70938.3 73228.6 12936.6 12957.9 13069.0 13193.4 13363.9 13757.4 14315.4 14347.8 14552.0 15162.1 13557.3 13755.9 14209.7 14232.9 14488.8 13749.8 13829.9 13845.9 14042.8 14545.2 11067.3 12470.0 12915.4 12959.4 13833.2 11159.3 11198.4 11213.8 11282.9 11830.6 11627.1 11731.8 11890.6 11906.8 11947.4 11:46:01 INFO - PROCESS | 11328 | -------- Summary: end -------- 11:46:01 INFO - PROCESS | 11328 | 11:46:02 INFO - TEST-INFO | 11328: exit 0 11:46:02 INFO - TEST-OK | dromaeo_css | took 1112409ms 11:46:02 INFO - TEST-START | kraken 11:46:02 INFO - operating with platform_type : linux_ 11:46:02 INFO - Initialising browser for kraken test... 11:46:02 INFO - TEST-INFO | started process 11560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4MWovQ/profile http://localhost:34365/getInfo.html) 11:46:07 INFO - PROCESS | 11560 | __metrics Screen width/height:1600/1200 11:46:07 INFO - PROCESS | 11560 | colorDepth:24 11:46:07 INFO - PROCESS | 11560 | Browser inner width/height: 1024/697 11:46:07 INFO - PROCESS | 11560 | __metrics 11:46:08 ERROR - PROCESS | 11560 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:46:08 INFO - TEST-INFO | 11560: exit 0 11:46:08 INFO - Browser initialized. 11:46:08 INFO - Running cycle 1/1 for kraken test... 11:46:08 INFO - TEST-INFO | started process 11683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4MWovQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:46:20 INFO - PROCESS | 11683 | RSS: Main: 184913920 11:46:20 INFO - PROCESS | 11683 | 11:46:23 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34365/tests/kraken/driver.html?testName=audio-beat-detection) 11:46:24 INFO - PROCESS | 11683 | RSS: Main: 190435328 11:46:24 INFO - PROCESS | 11683 | 11:46:27 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34365/tests/kraken/driver.html?testName=audio-dft) 11:46:27 INFO - PROCESS | 11683 | RSS: Main: 189734912 11:46:27 INFO - PROCESS | 11683 | 11:46:30 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34365/tests/kraken/driver.html?testName=audio-fft) 11:46:31 INFO - PROCESS | 11683 | RSS: Main: 184426496 11:46:31 INFO - PROCESS | 11683 | 11:46:33 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34365/tests/kraken/driver.html?testName=audio-oscillator) 11:46:34 INFO - PROCESS | 11683 | RSS: Main: 185630720 11:46:34 INFO - PROCESS | 11683 | 11:46:36 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34365/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:37 INFO - PROCESS | 11683 | RSS: Main: 185937920 11:46:37 INFO - PROCESS | 11683 | 11:46:40 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34365/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:40 INFO - PROCESS | 11683 | RSS: Main: 185782272 11:46:40 INFO - PROCESS | 11683 | 11:46:44 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34365/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:44 INFO - PROCESS | 11683 | RSS: Main: 183336960 11:46:44 INFO - PROCESS | 11683 | 11:46:47 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34365/tests/kraken/driver.html?testName=json-parse-financial) 11:46:48 INFO - PROCESS | 11683 | RSS: Main: 184487936 11:46:48 INFO - PROCESS | 11683 | 11:46:49 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34365/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:50 INFO - PROCESS | 11683 | RSS: Main: 184946688 11:46:50 INFO - PROCESS | 11683 | 11:46:52 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34365/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:52 INFO - PROCESS | 11683 | RSS: Main: 185249792 11:46:52 INFO - PROCESS | 11683 | 11:46:55 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34365/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:55 INFO - PROCESS | 11683 | RSS: Main: 186200064 11:46:55 INFO - PROCESS | 11683 | 11:46:58 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:58 INFO - PROCESS | 11683 | RSS: Main: 185741312 11:46:58 INFO - PROCESS | 11683 | 11:47:01 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:47:02 INFO - PROCESS | 11683 | RSS: Main: 185430016 11:47:02 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | Cycle 1(1): loaded http://localhost:34365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34365/tests/kraken/driver.html?testName=ai-astar) 11:47:04 INFO - PROCESS | 11683 | RSS: Main: 186425344 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | __start_tp_report 11:47:04 INFO - PROCESS | 11683 | _x_x_mozilla_page_load 11:47:04 INFO - PROCESS | 11683 | _x_x_mozilla_page_load_details 11:47:04 INFO - PROCESS | 11683 | |i|pagename|runs| 11:47:04 INFO - PROCESS | 11683 | |0;ai-astar;112;108;113;113;112;113;113;109;110;111 11:47:04 INFO - PROCESS | 11683 | |1;audio-beat-detection;157;140;160;174;139;170;155;131;186;134 11:47:04 INFO - PROCESS | 11683 | |2;audio-dft;166;164;162;163;163;176;164;162;161;163 11:47:04 INFO - PROCESS | 11683 | |3;audio-fft;76;75;76;157;75;76;75;74;160;77 11:47:04 INFO - PROCESS | 11683 | |4;audio-oscillator;86;84;152;86;85;84;147;86;87;146 11:47:04 INFO - PROCESS | 11683 | |5;imaging-gaussian-blur;117;118;117;117;117;117;119;117;117;118 11:47:04 INFO - PROCESS | 11683 | |6;imaging-darkroom;149;147;147;148;148;148;149;149;147;147 11:47:04 INFO - PROCESS | 11683 | |7;imaging-desaturate;95;97;97;96;96;95;96;97;95;96 11:47:04 INFO - PROCESS | 11683 | |8;json-parse-financial;56;55;60;59;56;58;62;57;57;66 11:47:04 INFO - PROCESS | 11683 | |9;json-stringify-tinderbox;64;66;64;66;65;64;65;65;66;66 11:47:04 INFO - PROCESS | 11683 | |10;stanford-crypto-aes;79;79;85;82;81;81;81;81;103;88 11:47:04 INFO - PROCESS | 11683 | |11;stanford-crypto-ccm;125;130;124;125;121;139;124;125;128;124 11:47:04 INFO - PROCESS | 11683 | |12;stanford-crypto-pbkdf2;169;161;161;163;166;166;161;160;163;169 11:47:04 INFO - PROCESS | 11683 | |13;stanford-crypto-sha256-iterative;63;64;64;63;64;69;63;63;64;63 11:47:04 INFO - PROCESS | 11683 | __end_tp_report 11:47:04 INFO - PROCESS | 11683 | __start_cc_report 11:47:04 INFO - PROCESS | 11683 | _x_x_mozilla_cycle_collect,865 11:47:04 INFO - PROCESS | 11683 | __end_cc_report 11:47:04 INFO - PROCESS | 11683 | __startTimestamp1465498024290__endTimestamp 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | ------- Summary: start ------- 11:47:04 INFO - PROCESS | 11683 | Number of tests: 14 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:1.84 (1.6%) stddev-sans-first:1.94 11:47:04 INFO - PROCESS | 11683 | Values: 112.0 108.0 113.0 113.0 112.0 113.0 113.0 109.0 110.0 111.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:158.50 stddev:18.48 (11.7%) stddev-sans-first:19.58 11:47:04 INFO - PROCESS | 11683 | Values: 157.0 140.0 160.0 174.0 139.0 170.0 155.0 131.0 186.0 134.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:4.30 (2.6%) stddev-sans-first:4.52 11:47:04 INFO - PROCESS | 11683 | Values: 166.0 164.0 162.0 163.0 163.0 176.0 164.0 162.0 161.0 163.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#3] audio-fft Cycles:10 Average:92.10 Median:75.50 stddev:35.01 (46.4%) stddev-sans-first:36.65 11:47:04 INFO - PROCESS | 11683 | Values: 76.0 75.0 76.0 157.0 75.0 76.0 75.0 74.0 160.0 77.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:85.50 stddev:30.44 (35.6%) stddev-sans-first:31.56 11:47:04 INFO - PROCESS | 11683 | Values: 86.0 84.0 152.0 86.0 85.0 84.0 147.0 86.0 87.0 146.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 11:47:04 INFO - PROCESS | 11683 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 119.0 117.0 117.0 118.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 11:47:04 INFO - PROCESS | 11683 | Values: 149.0 147.0 147.0 148.0 148.0 148.0 149.0 149.0 147.0 147.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 11:47:04 INFO - PROCESS | 11683 | Values: 95.0 97.0 97.0 96.0 96.0 95.0 96.0 97.0 95.0 96.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.50 stddev:3.34 (5.7%) stddev-sans-first:3.41 11:47:04 INFO - PROCESS | 11683 | Values: 56.0 55.0 60.0 59.0 56.0 58.0 62.0 57.0 57.0 66.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.50 stddev:0.88 (1.3%) stddev-sans-first:0.83 11:47:04 INFO - PROCESS | 11683 | Values: 64.0 66.0 64.0 66.0 65.0 64.0 65.0 65.0 66.0 66.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:81.00 stddev:7.21 (8.9%) stddev-sans-first:7.42 11:47:04 INFO - PROCESS | 11683 | Values: 79.0 79.0 85.0 82.0 81.0 81.0 81.0 81.0 103.0 88.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:125.00 stddev:5.02 (4.0%) stddev-sans-first:5.29 11:47:04 INFO - PROCESS | 11683 | Values: 125.0 130.0 124.0 125.0 121.0 139.0 124.0 125.0 128.0 124.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.50 stddev:3.38 (2.1%) stddev-sans-first:3.04 11:47:04 INFO - PROCESS | 11683 | Values: 169.0 161.0 161.0 163.0 166.0 166.0 161.0 160.0 163.0 169.0 11:47:04 INFO - PROCESS | 11683 | 11:47:04 INFO - PROCESS | 11683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.83 (2.9%) stddev-sans-first:1.90 11:47:04 INFO - PROCESS | 11683 | Values: 63.0 64.0 64.0 63.0 64.0 69.0 63.0 63.0 64.0 63.0 11:47:04 INFO - PROCESS | 11683 | -------- Summary: end -------- 11:47:04 INFO - PROCESS | 11683 | 11:47:05 INFO - TEST-INFO | 11683: exit 0 11:47:05 INFO - TEST-OK | kraken | took 63200ms 11:47:05 INFO - SUITE-END | took 1175s 11:47:05 INFO - Completed test suite (00:19:35) 11:47:05 INFO - javascript benchmark 11:47:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7159.378788881645, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.3956178545186, 3158.447271727447, 3179.618445786505, 3191.4095892259934, 3194.2014496375905, 5432.2123292122615, 5500.724963751812, 5504.889902201953, 5529.834104976857, 5540.3628582713, 5355.384130824957, 5371.57027437805, 5407.486288802557, 5472.370677372103, 5489.286392768934, 4962.900741985167, 4985.975070124662, 5038.899222015558, 5129.589632829383, 5139.922901156486, 790.2734274003842, 4874.780634871421, 4955.900881982358, 4960.900781984358, 5040.84877453677, 4987.077390682735, 4996.4503904570465, 5023.874403139914, 5035.924461133086, 5040.59675225981, 5034.270030845543, 5035.571976382012, 5037.773300201499, 5038.823641172541, 5065.848024559269, 4933.925991110136, 4984.127777638899, 5013.39839219296, 5019.14674505335, 5031.723255220962, 5473.042217611942, 5550.58370622205, 5568.053430916754, 5586.441355864381, 5627.803026894039, 5656.575756818214, 5882.588218824684, 5907.970460147715, 5918.260217472816, 5932.11018347247, 5952.0, 5980.222571065777, 5993.9400605993815, 5994.400559944014, 6045.093236014589, 5480.451954804527, 5495.752691128869, 5537.640053396516, 5539.778408863681, 5558.249636299089, 5875.559333050039, 6004.369541198112, 6018.097285407224, 6029.065494848305, 6069.211002569726, 5591.608587398924, 5656.830295091154, 5659.26429564154, 5664.688442135722, 5668.9716551417805, 5715.799947001835, 5718.971405142947, 5732.111522713986, 5799.101139323411, 5812.59311848175, 5724.771009159587, 5749.252597162342, 5843.970780146072, 5863.941360586425, 5867.237259156283, 5885.234919460443, 5891.234139561915, 5892.057270836645, 5908.084246941731, 5917.52659787216, 4403.669724770655, 4467.754273514923, 4469.262571675702, 4499.59503644667, 4530.637548996073, 3905.7851818150275, 3960.7227494075137, 3978.423128646388, 4007.5591684914634, 4010.057636455431, 5566.2207290979295, 5579.163125531121, 5626.099824028136, 5643.153526970905, 5670.347909990322, 5794.768209271666, 5964.7315870785915, 5985.281766188085, 5991.430814072656, 5998.3701711320555, 5614.663120212718, 5624.353199382123, 5676.602637815313, 5682.914756278659, 5706.087026075891, 4910.656254062182, 4932.0, 4961.156603377434, 4962.6533746142795, 5022.372203474566, 5823.126531020296, 5968.1942937703725, 6132.386761323921, 6140.907886381708, 6151.630902145886, 5828.94171058284, 5974.522038237017, 5975.25309336333, 5975.521958243417, 6000.459958603747, 6119.602225855305, 6125.571210015256, 6149.139120523219, 6150.384961503813, 6164.352742961924, 5597.0, 5775.422457754191, 5792.797252096157, 5872.706364681663, 5882.705864706833, 5958.165856779968, 5959.73181206838, 5962.373950735284, 5977.820665380045, 6001.459868611846, 5770.682612456355, 5779.162021506774, 5806.854828629318, 5807.332156802022, 5810.302763668386, 5643.097104463266, 5741.942580574141, 5751.194832723339, 5800.361960184461, 5802.854928626649, 5649.830505084854, 5720.3707592164, 5723.227364305932, 5750.223719797774, 5751.827445176651, 5743.224664670216, 5752.050911599539, 5819.330776960534, 5833.445822646841, 5840.2991641003355, 5476.561875050066, 5572.804951826666, 5626.381098079126, 5661.858453538694, 5708.200851880657], "value": 5392.634025865361, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.2114978455269, 621.6736213487922, 632.7057918068099, 642.5437939063266, 660.3066779881124, 39799.403008954854, 40733.388999165036, 44067.11865762683, 44132.779336103355, 44414.33378499325, 46030.539694603125, 46533.0, 46543.0, 46578.30132548006, 46756.298655520106, 8905.287576993825, 9078.137576930214, 9133.497657628828, 9150.450972941611, 9171.495567743805, 8782.560871956408, 8925.509096999662, 8941.150590693873, 8952.597133128993, 8959.641614335418, 8884.733457996239, 8932.776680583005, 8936.106389361044, 8942.821143577125, 8956.507392093432, 8810.38327317088, 8862.734117976439, 8870.822583548324, 8874.112588741138, 8887.822243555158, 8887.0, 8958.910410895873, 8959.0, 8964.955175224148, 9018.909810901872, 41959.16081678349, 42693.1461370774, 42729.57270427318, 42815.0, 42924.14151716948, 3026.107298346993, 3470.2538954124984, 3480.773749706261, 3575.535180426554, 3620.1311685195365, 30795.230119246975, 30944.535831962537, 31135.37729245425, 31481.37037259265, 31497.8425107873, 4155.4182414462, 4181.9784660796195, 4195.349720793282, 4204.138151678929, 4313.547077556874, 132899.0, 134076.0, 134205.0, 134283.0, 134517.3274133623, 33797.49303760446, 34542.0, 34656.0, 34671.0, 34863.65136348655, 34759.652403476146, 36656.633433665855, 36812.63187368146, 36892.89321320365, 36942.815285923396, 15064.246787660573, 15169.0, 15228.238588070551, 15269.389224431121, 15297.235138243042, 12534.435950382254, 12547.3098979557, 12663.873361266269, 12670.36648167588, 12747.49010039588, 8274.958625206835, 8319.66721331152, 8328.33373330132, 8331.791705207297, 8407.45351552147, 3257.820819854931, 3271.1495011297234, 3281.9343613127603, 3314.436545787222, 3315.370079684852, 1000.3847633705219, 1022.5551884930079, 1043.8081617654368, 1087.7280679830042, 1097.846301517788, 32125.0, 32455.51316730251, 32492.0, 32555.18612034718, 32861.67138328634, 1071.2982996137541, 1080.065743132185, 1132.9603463878889, 1150.286822170243, 1161.2451906260828, 16028.679426411407, 17021.91489042547, 17804.287828486715, 17994.190261438267, 18974.14616342268, 564393.0, 567963.0, 568245.0, 568371.0, 572098.0, 60037.699811500665, 60591.0, 60603.393966059775, 60624.39375606187, 60680.0, 1326.6285440076795, 1385.5427708856053, 1395.1768456610446, 1397.2594524901817, 1412.004536801573, 32425.351492969538, 33249.501257480675, 33661.0, 33862.83068584641, 33922.66077339195, 56802.0, 56834.71582642226, 57426.0, 57576.0, 57723.42276577181, 538290.0, 541173.0, 543039.0, 544687.0, 548252.0, 43210.13579728451, 44882.77558612186, 45475.77262113668, 45944.54055459536, 46003.079938401715, 49403.0, 50078.0, 50551.74724126503, 50575.74712126416, 51239.48760512496, 41651.16697665969, 41862.0, 41980.370294445, 43012.78493607637, 43379.349309759746, 41715.79142104391, 41883.0, 42137.57862421337, 42178.7891060555, 42238.788806055774, 41623.0, 42582.0, 42663.3600495999, 42982.0, 43022.35466468068, 36101.0, 38088.238235235694, 38549.42175867308, 38698.61301387063, 38836.41745373765, 28115.0, 28732.70029791842, 28880.844766209117, 28896.71103289024, 28899.566506502], "value": 18811.77053011046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.26796550622817, 383.55124504329933, 385.0570500134378, 395.81594558530287, 411.84555791578157, 14327.498537551188, 17400.39098631548, 17571.0, 18911.95984220869, 18979.905100474494, 17509.824901750977, 18106.0, 18522.722159167624, 19147.0, 19169.52076198096, 5193.376794784622, 5228.503292187255, 5336.30628018359, 5372.516473517383, 5381.0045141648725, 5272.762725677335, 5281.419043905186, 5314.256004159421, 5321.866953326159, 5324.973375133119, 5181.818636347729, 5273.920891186635, 5313.335833020872, 5335.466453354672, 5337.572994160458, 5217.895642087156, 5246.81636142737, 5261.263423120766, 5263.605229607757, 5322.068637988336, 4813.7593120343845, 5082.009008243394, 5152.562032227265, 5152.690838549699, 5208.427073021964, 13059.869401306056, 13416.12795168311, 13488.932555337258, 13508.932455337661, 13594.796078058836, 2260.389694782416, 2317.0, 2368.9170879019152, 2446.7063952325657, 2828.6747024092288, 9540.618375264981, 9664.806703865954, 9694.903050969471, 9718.076782705632, 10073.24450666203, 1907.1131923655428, 1936.4287535177157, 1953.4139758072522, 1958.0894883879064, 1961.4115765270506, 77139.61430192813, 77880.61059694723, 78187.60906195432, 79243.60378198072, 82243.0, 10477.37135771856, 10864.78270434587, 11156.0, 11428.25716328436, 11803.40982950849, 11524.827127593093, 12215.26708397499, 14665.56003319902, 14814.62963425923, 14886.0, 6065.54508411862, 6285.779997700059, 7194.64026798658, 7874.21257874208, 7956.846257292776, 7912.525248485109, 7965.601719914097, 7999.440039197317, 8018.077921039038, 8035.758927232192, 4050.7569545827346, 4064.1871625674985, 4068.2270368629866, 4072.6945479089186, 4089.1617218470737, 1964.3321270768008, 1970.7384279018247, 1971.250924648653, 1989.3634037108277, 2028.3103744726864, 885.3094586222757, 966.4539535162611, 1003.5233264199447, 1017.2828156149897, 1064.6699523147695, 18463.0, 18626.90686546586, 18927.62144757097, 18952.62094758097, 19272.22911083569, 976.3117002513211, 981.2395393569898, 985.2462865907586, 1002.734275417015, 1016.8322226832638, 10254.384736915808, 10733.731656708489, 10770.623028194132, 10822.729431764268, 10838.295510791773, 462683.0, 475076.0, 487802.0, 488979.0, 489141.0, 60590.39409605935, 62635.6868215656, 72248.0, 78512.60743696245, 94184.0, 981.7349315684725, 1013.5337744637402, 1035.6478797208833, 1063.287597309789, 1063.6862125672944, 16756.481138960466, 16886.324547018474, 16966.745498817774, 17047.31810727557, 17464.21411036481, 41028.58971410367, 41255.381169283086, 41982.370264445446, 42197.367039493816, 42856.35715464208, 56306.43693563012, 56560.0, 58151.0, 58595.414045859, 58722.4127758734, 8197.426180167331, 8338.791530211793, 8477.78805529842, 8526.531040792815, 8550.57247137653, 12643.367831608566, 12725.490980360682, 12730.0, 12911.22532648044, 13084.28036458004, 10806.297590656583, 10927.235093543375, 11114.610988615359, 11381.601643942422, 11541.711457213636, 11131.72170695739, 11160.609378671708, 11265.493052812806, 11436.599719010128, 11439.542418303176, 11459.19785614999, 11545.36500492481, 11555.88444115548, 11652.766944660889, 11883.76232475363, 7177.28227177299, 7663.846723065619, 7857.607119644109, 7893.526388416713, 8000.079990801132, 10076.810442621909, 11731.296122232694, 11994.520219191483, 12026.15816892809, 12038.337891415706], "value": 8717.821333926839, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.8552144785522, 1483.4807817263957, 1562.8749700024, 1721.517974967008, 1737.6524695060991, 7484.476086673935, 8120.837583248332, 8285.130061343554, 8879.689210877621, 8891.422057566253, 8152.225538573841, 8297.502149871012, 8388.790280242982, 8462.4076314658, 8468.280196183316, 2278.54429114177, 2318.675385446039, 2321.0, 2325.837191396603, 2327.2785436514737, 2291.472961218921, 2307.077169132344, 2312.606856834334, 2313.2944451942153, 2332.9533409331802, 2268.9546209075806, 2292.793648571628, 2323.4191452136965, 2346.2843832631124, 2366.160013195317, 2265.0826415301663, 2278.7037685100913, 2283.566122436732, 2292.7363353214428, 2292.7707229277107, 2222.75549689534, 2223.955520889573, 2233.4304752288226, 2235.3405745305013, 2246.213825161197, 8517.872231916526, 8657.350698697623, 8660.610272537751, 8661.870071948926, 8664.176903194186, 5063.240513922904, 5173.611979101544, 5175.767090480937, 5180.818671346522, 5193.610479214074, 3250.0, 3301.3067255876294, 3473.6526347365316, 3478.513008178857, 3488.686018258369, 1070.2775626452114, 1078.8759292681364, 1109.2678831970861, 1116.8827273136285, 1125.2573301620973, 11717.472713727902, 11845.94077029618, 11985.460654270579, 11995.520179192821, 12073.818892716616, 4597.632189424838, 4640.86077417678, 4716.434027916604, 4730.290456431563, 4737.95262047382, 10226.488675566192, 10293.794124117476, 10307.278490505743, 10315.484225788681, 10325.380477171393, 5262.71055091966, 5267.1309233976735, 5298.364196296469, 5301.0723123453245, 5303.946960530422, 4153.501579810442, 4533.863984080417, 4639.466461356919, 4642.326862604903, 4766.308885211694, 3911.902202444962, 3934.488516492838, 3986.760794352348, 4014.598540145962, 4138.255114079495, 1279.181323952671, 1326.7545504081775, 1326.8739469750358, 1332.247280286635, 1341.3293353323338, 977.2621670638622, 979.118793086228, 985.4579981010415, 997.8403455447094, 1005.8843233028149, 5895.0, 5902.586818922634, 5952.255968003999, 6055.545834062463, 6160.075988601656, 436.3236982676838, 438.110635410118, 442.31882900333767, 1028.2493779540978, 1051.3429106808244, 4088.591140885947, 4112.074783173762, 4133.4626498555, 4201.45381100455, 4227.365895115758, 10438.217133715001, 10748.516316765765, 10802.189835762349, 10803.189760767973, 10820.783584328427, 10611.575536978435, 10646.095081917969, 10667.51996160159, 10668.14654827612, 10683.038526532493, 8019.959900200462, 8047.517148970964, 8057.879131813028, 8060.355171586376, 8071.192880711882, 5977.22296101504, 6035.094735789667, 6100.481459076028, 6138.938610613836, 6237.75048998035, 9701.514924253901, 9863.753406164904, 9965.651202207888, 10055.095041446304, 10100.747481313027, 10010.64962726301, 10019.248556358449, 10147.086762191439, 10209.132223761064, 10249.077583017564, 6720.428763555153, 7260.346568808833, 7272.418206543358, 7435.107787065586, 7475.626218689153, 8385.413021088465, 8421.284190843848, 8502.957485212535, 8635.654573817228, 8640.308775298086, 7359.190489046094, 7372.63136843145, 7503.737369192052, 7545.471816972759, 7551.320381165721, 7251.637418128967, 7410.703571857065, 7555.9244407555225, 7586.6206689664195, 7693.038370203724, 6933.861322773415, 6978.127734033246, 7013.614251216232, 7042.753503627348, 7045.788626341218, 5007.198848184273, 5119.360079990001, 5235.214717792362, 5264.394594621667, 5314.441983591667, 5206.687598744087, 5219.947800521946, 5291.126964050888, 5391.191321301836, 5424.349078110652], "value": 4561.781679625443, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.51714583822155, 311.86901501369425, 312.498440003794, 321.22424345206315, 324.77752739373545, 5671.291088613923, 5688.573356998226, 5690.406686127881, 5715.456212311212, 5721.799737009201, 5547.362053363864, 5579.995600791855, 5584.755585754825, 5601.719914004294, 5603.579731520132, 4099.118689481761, 4159.916801663965, 4261.0, 4267.978660106695, 4286.657067434613, 4262.744235345874, 4287.121140166259, 4287.970886987132, 4305.095929854719, 4330.133973205356, 4269.978650106745, 4294.849680261192, 4310.116426132651, 4310.97844510777, 4318.466944234799, 4075.4090656854887, 4225.852095176685, 4272.700910936236, 4293.892652683708, 4317.71934824237, 3618.185908170667, 3630.6369363063745, 3663.5786884508357, 3671.247394284192, 3680.6319368063246, 5422.776661568777, 5441.347038355383, 5449.455054494559, 5493.340799104093, 5513.58648101394, 4561.885952851172, 4826.493218212107, 4880.633952453544, 4892.9510704892855, 4926.75366231687, 5804.187413762077, 5816.651000939957, 5823.767049318022, 5831.241938547962, 5835.416458354173, 4029.4560234368573, 4038.899027524306, 4057.472528571296, 4062.634362907323, 4064.6748260139416, 6003.0, 6037.245344331958, 6049.909251361233, 6140.815775526741, 6142.938570614281, 4119.814608342632, 4123.628873401408, 4130.896727581834, 4135.152293779828, 4141.254574176677, 4164.271827191682, 4200.600942910419, 4210.947263184204, 4215.388768628532, 4220.345846393814, 4734.455537613218, 4882.609391248691, 4886.975565122151, 4910.533499317559, 4937.7531123444405, 5840.591158618856, 5849.590528663038, 5869.647821130746, 5883.705814709333, 5886.175935369051, 1432.8782053525358, 1450.514077783933, 1452.6998336488784, 1453.8182727159106, 1469.4636457692866, 900.8873890763655, 906.7053207707521, 921.9950254222929, 936.5691781780321, 956.9617215311449, 5594.860128496739, 5606.85982850432, 5611.971940140274, 5658.688772117491, 5669.659820410789, 5985.491233245223, 5996.580239383288, 5997.370276121032, 6012.699365031731, 6037.577369584087, 5366.651167674088, 5550.9945696791965, 5597.328320601554, 5607.925067724967, 5618.634788738719, 3176.0313104502884, 3214.614246290413, 3223.2747631782663, 3255.5116732490314, 3260.2990357072867, 5823.505002074871, 6098.420650038239, 6099.9085013724825, 6227.96886015567, 6238.532110091671, 6211.9068213975925, 6230.470410015199, 6262.4990000800735, 6282.528810339243, 6283.5287353448675, 6159.84600384985, 6286.8428289292215, 6298.1812364392335, 6307.180066591405, 6310.0, 6080.300765412034, 6081.39186081406, 6081.604695694766, 6084.726187321669, 6091.451769340781, 5996.5502587305255, 6024.337322894566, 6024.759009639565, 6029.457348838626, 6114.349125735937, 6061.787837425669, 6240.689455214456, 6253.499720022296, 6265.96867015662, 6340.144080549251, 4151.647109995563, 4190.434291370748, 4210.347396153601, 4221.0, 4256.936145957875, 6040.516758659384, 6170.876582468415, 6187.597806142767, 6210.378962103753, 6219.906701399573, 5767.423257674199, 5931.258592675916, 5952.851178720567, 5969.3732158122775, 5971.373005834499, 5865.442782935615, 5881.588548695015, 5896.498797602252, 5935.525157987265, 5965.791197308074, 5246.501582349671, 5769.30768307789, 5781.884362312814, 5816.796412125555, 5859.794907178229, 5914.733836977261, 5926.703664816656, 5935.0, 5946.0, 5988.502874281429, 5552.472515111058, 5754.583075108548, 5761.913571296518, 5765.164051212467, 5797.4782269595935], "value": 4424.141037575286, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.6457161991291, 794.1343935110729, 802.5418798573921, 816.2368185746324, 854.7136709202415, 15444.845551544482, 16373.75439368409, 16671.1664416779, 16729.581760455996, 16729.74905376419, 14076.929615351908, 14945.17801520916, 14947.925260373682, 14949.327280272386, 14970.625734356647, 789.644659903043, 803.6142651527285, 808.5350923219144, 816.5386556595535, 816.5835423933806, 812.4962523235573, 818.8485130250892, 819.1644522586957, 819.3854609043218, 819.4632515702225, 858.1675774498726, 865.7965378136133, 865.9913400866005, 866.0343716755804, 866.1728049712509, 851.3487182305541, 854.0562678240548, 856.9700060497853, 859.1966511311912, 860.6557377049168, 633.3476519185247, 633.8130251575797, 633.9302676705558, 634.0869148426298, 634.4480302137171, 15702.136382498958, 15752.369905203777, 15762.684746305124, 15785.210739463097, 15864.52406427809, 14663.120212787268, 14681.412743490248, 14755.852441475556, 14836.554903352917, 15131.54605361841, 12631.168480570357, 12641.87358126416, 12689.171713742207, 12775.29735864527, 13045.543405980745, 3785.166240409218, 3794.69811750492, 3880.5343358797127, 3947.3092208863336, 4002.939955900664, 86073.0, 86177.56911215467, 86413.0, 87213.56393217994, 88804.5559772197, 11243.606473773541, 11308.660740177807, 11417.48621312043, 11457.14071444645, 11706.88293117058, 21928.342149735534, 21936.341909742732, 21960.89019554892, 21964.121435142733, 22037.449063773533, 8466.957665211634, 8618.482891026433, 8673.783155421164, 8757.179639532555, 8792.296616270683, 4596.264597664424, 4652.209124448784, 4658.953410465852, 4673.626109911267, 4750.358701575312, 3426.4517677171534, 3506.63180366063, 3552.982235088808, 3560.127768696634, 3587.210813620999, 592.0615823919136, 603.2670305578743, 607.9726412311456, 616.2358675242667, 621.0808004153878, 662.3872917551246, 668.4919461209515, 674.3122015544118, 705.1925545250762, 716.5378330976491, 10347.49264290602, 10484.735736978819, 10524.158067354594, 10528.315659482108, 10745.570177192982, 594.5184400635499, 595.425414475025, 603.7766026570109, 692.2731132311053, 733.4352548537596, 4559.38448309474, 4569.200389931749, 4788.0, 4804.855854324376, 4848.80604775805, 74116.62941685256, 75053.0, 75752.62123689457, 75986.62006690042, 123175.3841230806, 67814.66092669505, 69941.65029174821, 83268.58365708133, 91311.0, 105505.47247263868, 84438.57780711057, 86098.56950715206, 86325.56837215774, 87315.56342218249, 89088.10911890928, 9921.421386528842, 10143.543540540546, 10221.131203847755, 10279.17766578657, 10383.94808025955, 43098.0, 44405.555944440144, 48460.0, 51188.74405628097, 52290.47709523008, 68732.0, 69742.0, 70871.0, 70938.29061709523, 73228.6338568325, 12936.611901642966, 12957.935210323889, 13069.0, 13193.40629671648, 13363.933180334036, 13757.38091785852, 14315.355808988412, 14347.784783228051, 14552.0, 15162.090274583561, 13557.25435101079, 13755.931220343835, 14209.715805684034, 14232.857671423153, 14488.782668259773, 13749.793753093913, 13829.930850345683, 13845.930770346084, 14042.78935815984, 14545.200013998909, 11067.280626759235, 12470.0, 12915.35423228816, 12959.416826242654, 13833.239171845646, 11159.330440173615, 11198.44007799623, 11213.775724485628, 11282.887171128184, 11830.645080647595, 11627.12796540246, 11731.765364692828, 11890.643280701594, 11906.76186476283, 11947.402629868298], "value": 7544.137642992414, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 113.0, 113.0, 112.0, 113.0, 113.0, 109.0, 110.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 140.0, 160.0, 174.0, 139.0, 170.0, 155.0, 131.0, 186.0, 134.0], "value": 154.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 162.0, 163.0, 163.0, 176.0, 164.0, 162.0, 161.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 157.0, 75.0, 76.0, 75.0, 74.0, 160.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 152.0, 86.0, 85.0, 84.0, 147.0, 86.0, 87.0, 146.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 148.0, 148.0, 148.0, 149.0, 149.0, 147.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 97.0, 96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 60.0, 59.0, 56.0, 58.0, 62.0, 57.0, 57.0, 66.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 66.0, 65.0, 64.0, 65.0, 65.0, 66.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 85.0, 82.0, 81.0, 81.0, 81.0, 81.0, 103.0, 88.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 124.0, 125.0, 121.0, 139.0, 124.0, 125.0, 128.0, 124.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 161.0, 161.0, 163.0, 166.0, 166.0, 161.0, 160.0, 163.0, 169.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 69.0, 63.0, 63.0, 64.0, 63.0], "value": 64.0, "unit": "score"}]}]} 11:47:05 INFO - Return code: 0 11:47:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:47:05 ERROR - # TBPL SUCCESS # 11:47:05 INFO - Running post-action listener: _resource_record_post_action 11:47:05 INFO - ##### 11:47:05 INFO - ##### Finished run-tests step (success) 11:47:05 INFO - ##### 11:47:05 INFO - Running post-run listener: _resource_record_post_run 11:47:05 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 541556736; Read time: 0; Write time: 339400 11:47:05 INFO - TinderboxPrint: CPU usage
13.4% 11:47:05 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:47:05 INFO - TinderboxPrint: I/O write bytes / time
541,556,736 / 339,400 11:47:05 INFO - TinderboxPrint: CPU idle
8,243.1 (86.5%) 11:47:05 INFO - TinderboxPrint: CPU user
1,224.4 (12.9%) 11:47:05 INFO - TinderboxPrint: Swap in / out
0 / 0 11:47:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 248532992; Read time: 0; Write time: 187072 11:47:05 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 293023744; Read time: 0; Write time: 152328 11:47:06 INFO - Running post-run listener: _upload_blobber_files 11:47:06 INFO - Blob upload gear active. 11:47:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:47:06 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:47:06 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:47:06 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:47:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:47:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:47:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:47:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:07 INFO - (blobuploader) - INFO - Done attempting. 11:47:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:47:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:47:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:11 INFO - (blobuploader) - INFO - Done attempting. 11:47:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:47:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:47:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:12 INFO - (blobuploader) - INFO - Done attempting. 11:47:12 INFO - (blobuploader) - INFO - Iteration through files over. 11:47:12 INFO - Return code: 0 11:47:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:47:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:47:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee169c3db6c79729ccdf72fe02253e7d0604b1eedfc43763880ce2e44f4356d3292884e5d61261517943d54a78b7c77e128c8b3b26266a5909c0d3a9ea0f36ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a72bf692b9fe778b5d7a011a7e6e0099b7935d2ec854e3db6c9c0cbb38759ebececb23dd82b0822f7e1b883056fd2e533cc123490cc4faf4fd22c88ba765aa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe8b5b09df1349fd6abf91c406b73dc7921284be352406e0c8d760235cf6a2abb1c103cc6bdd0d3310a67e7df0e08420cb54d2568719a45c2089dec34c82e571"} 11:47:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:47:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:47:12 INFO - Contents: 11:47:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee169c3db6c79729ccdf72fe02253e7d0604b1eedfc43763880ce2e44f4356d3292884e5d61261517943d54a78b7c77e128c8b3b26266a5909c0d3a9ea0f36ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a72bf692b9fe778b5d7a011a7e6e0099b7935d2ec854e3db6c9c0cbb38759ebececb23dd82b0822f7e1b883056fd2e533cc123490cc4faf4fd22c88ba765aa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe8b5b09df1349fd6abf91c406b73dc7921284be352406e0c8d760235cf6a2abb1c103cc6bdd0d3310a67e7df0e08420cb54d2568719a45c2089dec34c82e571"} 11:47:12 INFO - Running post-run listener: copy_logs_to_upload_dir 11:47:12 INFO - Copying logs to upload dir... 11:47:12 INFO - mkdir: /builds/slave/test/build/upload/logs 11:47:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.174054 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-09 11:47:12.220815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 11:47:12.223979) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403 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/ee169c3db6c79729ccdf72fe02253e7d0604b1eedfc43763880ce2e44f4356d3292884e5d61261517943d54a78b7c77e128c8b3b26266a5909c0d3a9ea0f36ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a72bf692b9fe778b5d7a011a7e6e0099b7935d2ec854e3db6c9c0cbb38759ebececb23dd82b0822f7e1b883056fd2e533cc123490cc4faf4fd22c88ba765aa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe8b5b09df1349fd6abf91c406b73dc7921284be352406e0c8d760235cf6a2abb1c103cc6bdd0d3310a67e7df0e08420cb54d2568719a45c2089dec34c82e571"} build_url:https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/Qn35WWrTT8aaguVLgs-l8w/artifacts/public/build/firefox-50.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/ee169c3db6c79729ccdf72fe02253e7d0604b1eedfc43763880ce2e44f4356d3292884e5d61261517943d54a78b7c77e128c8b3b26266a5909c0d3a9ea0f36ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a72bf692b9fe778b5d7a011a7e6e0099b7935d2ec854e3db6c9c0cbb38759ebececb23dd82b0822f7e1b883056fd2e533cc123490cc4faf4fd22c88ba765aa9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe8b5b09df1349fd6abf91c406b73dc7921284be352406e0c8d760235cf6a2abb1c103cc6bdd0d3310a67e7df0e08420cb54d2568719a45c2089dec34c82e571"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 11:47:12.249844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:47:12.250240) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465496794.407070-242633403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 11:47:12.334349) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 11:47:12.334672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 11:47:12.334965) ========= ========= Total master_lag: 0.18 =========