builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1466533117.04 results: success (0) buildid: 20160621083052 builduid: 52f218857c63453c9ab390f632936197 revision: ecd3562339dcd51a604e82efbcb347de8b823aee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:37.042835) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:37.043365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:37.043709) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:37.060586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:37.061052) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 11:18:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2016-06-21 11:18:37 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152273 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:37.227467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:37.227820) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019531 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:37.278117) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 11:18:37.278492) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ecd3562339dcd51a604e82efbcb347de8b823aee --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 ecd3562339dcd51a604e82efbcb347de8b823aee --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=2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 11:18:37,453 truncating revision to first 12 chars 2016-06-21 11:18:37,453 Setting DEBUG logging. 2016-06-21 11:18:37,453 attempt 1/10 2016-06-21 11:18:37,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ecd3562339dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 11:18:38,561 unpacking tar archive at: fx-team-ecd3562339dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.432670 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 11:18:38.728247) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:38.728903) ========= script_repo_revision: ecd3562339dcd51a604e82efbcb347de8b823aee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:38.729845) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:38.731156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 11:18:38.741546) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-21 11:18:38.742188) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:18:39 INFO - MultiFileLogger online at 20160621 11:18:39 in /builds/slave/test 11:18:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:18:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:39 INFO - {'append_to_log': False, 11:18:39 INFO - 'base_work_dir': '/builds/slave/test', 11:18:39 INFO - 'blob_upload_branch': 'Fx-Team', 11:18:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:39 INFO - 'branch': 'Fx-Team', 11:18:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:39 INFO - 'config_files': ('talos/linux_config.py',), 11:18:39 INFO - 'default_actions': ('clobber', 11:18:39 INFO - 'read-buildbot-config', 11:18:39 INFO - 'download-and-extract', 11:18:39 INFO - 'populate-webroot', 11:18:39 INFO - 'create-virtualenv', 11:18:39 INFO - 'install', 11:18:39 INFO - 'run-tests'), 11:18:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:39 INFO - 'download_minidump_stackwalk': True, 11:18:39 INFO - 'download_symbols': 'ondemand', 11:18:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:39 INFO - 'installer_path': 'installer.exe', 11:18:39 INFO - 'log_level': 'info', 11:18:39 INFO - 'log_name': 'talos', 11:18:39 INFO - 'log_to_console': True, 11:18:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:18:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:18:39 INFO - 'opt_config_files': (), 11:18:39 INFO - 'pip_index': False, 11:18:39 INFO - 'sps_profile': False, 11:18:39 INFO - 'sps_profile_interval': 0, 11:18:39 INFO - 'suite': 'dromaeojs-e10s', 11:18:39 INFO - 'system_bits': '32', 11:18:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:39 INFO - 'title': 'talos-linux64-ix-012', 11:18:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:39 INFO - 'use_talos_json': True, 11:18:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:39 INFO - 'work_dir': 'build'} 11:18:39 INFO - ##### 11:18:39 INFO - ##### Running clobber step. 11:18:39 INFO - ##### 11:18:39 INFO - Running pre-action listener: _resource_record_pre_action 11:18:39 INFO - Running main action method: clobber 11:18:39 INFO - rmtree: /builds/slave/test/build 11:18:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:40 INFO - Running post-action listener: _resource_record_post_action 11:18:40 INFO - ##### 11:18:40 INFO - ##### Finished clobber step (success) 11:18:40 INFO - ##### 11:18:40 INFO - ##### 11:18:40 INFO - ##### Running read-buildbot-config step. 11:18:40 INFO - ##### 11:18:40 INFO - Running pre-action listener: _resource_record_pre_action 11:18:40 INFO - Running main action method: read_buildbot_config 11:18:40 INFO - Using buildbot properties: 11:18:40 INFO - { 11:18:40 INFO - "project": "", 11:18:40 INFO - "product": "firefox", 11:18:40 INFO - "script_repo_revision": "production", 11:18:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:18:40 INFO - "repository": "", 11:18:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:18:40 INFO - "buildid": "20160621083052", 11:18:40 INFO - "pgo_build": "True", 11:18:40 INFO - "basedir": "/builds/slave/test", 11:18:40 INFO - "buildnumber": 849, 11:18:40 INFO - "slavename": "talos-linux64-ix-012", 11:18:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:18:40 INFO - "platform": "ubuntu64_hw", 11:18:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:18:40 INFO - "branch": "fx-team", 11:18:40 INFO - "repo_path": "integration/fx-team", 11:18:40 INFO - "revision": "ecd3562339dcd51a604e82efbcb347de8b823aee", 11:18:40 INFO - "stage_platform": "linux64-pgo", 11:18:40 INFO - "builduid": "52f218857c63453c9ab390f632936197", 11:18:40 INFO - "slavebuilddir": "test" 11:18:40 INFO - } 11:18:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:18:40 INFO - Running post-action listener: _resource_record_post_action 11:18:40 INFO - ##### 11:18:40 INFO - ##### Finished read-buildbot-config step (success) 11:18:40 INFO - ##### 11:18:40 INFO - ##### 11:18:40 INFO - ##### Running download-and-extract step. 11:18:40 INFO - ##### 11:18:40 INFO - Running pre-action listener: _resource_record_pre_action 11:18:40 INFO - Running main action method: download_and_extract 11:18:40 INFO - mkdir: /builds/slave/test/build/tests 11:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:40 INFO - https://queue.taskcluster.net/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/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:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/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:18:40 INFO - Downloaded 1361 bytes. 11:18:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:18:40 INFO - Using the following test package requirements: 11:18:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:18:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:18:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:40 INFO - u'jsshell-linux-x86_64.zip'], 11:18:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:18:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:18:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:18:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:18:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:18:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:18:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:40 INFO - https://queue.taskcluster.net/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/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:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/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:18:42 INFO - Downloaded 24225158 bytes. 11:18:42 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:18:42 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:18:43 INFO - Return code: 0 11:18:43 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:18: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:18:43 INFO - https://queue.taskcluster.net/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/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:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/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:18:49 INFO - Downloaded 24225158 bytes. 11:18:49 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:18:49 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:18:50 INFO - Return code: 0 11:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:50 INFO - https://queue.taskcluster.net/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/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:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/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:18:57 INFO - Downloaded 14405384 bytes. 11:18:57 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:18:57 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:18:57 INFO - Return code: 0 11:18: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:18:57 INFO - https://queue.taskcluster.net/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:18:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/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:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aMV7shOCS1eptfHjzLhAxA/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:18:58 INFO - Downloaded 60130839 bytes. 11:18:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:58 INFO - mkdir: /builds/slave/test/properties 11:18:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:58 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:58 INFO - Contents: 11:18:58 INFO - build_url:https://queue.taskcluster.net/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:18:59 INFO - Running post-action listener: _resource_record_post_action 11:18:59 INFO - Running post-action listener: set_extra_try_arguments 11:18:59 INFO - ##### 11:18:59 INFO - ##### Finished download-and-extract step (success) 11:18:59 INFO - ##### 11:18:59 INFO - ##### 11:18:59 INFO - ##### Running populate-webroot step. 11:18:59 INFO - ##### 11:18:59 INFO - Running pre-action listener: _resource_record_pre_action 11:18:59 INFO - Running main action method: populate_webroot 11:18:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:59 INFO - '--tppagecycles', 11:18:59 INFO - '7'], 11:18:59 INFO - 'tests': ['tsvgm']}}, 11:18:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:59 INFO - 'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:59 INFO - 'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['damp', 'tps']}, 11:18:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:59 INFO - 'tests': ['damp', 'tps']}, 11:18:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['dromaeo_dom']}, 11:18:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['basic_compositor_video']}, 11:18:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:18:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['a11yr', 11:18:59 INFO - 'ts_paint', 11:18:59 INFO - 'tpaint', 11:18:59 INFO - 'sessionrestore', 11:18:59 INFO - 'sessionrestore_no_auto_restore', 11:18:59 INFO - 'tabpaint']}, 11:18:59 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:59 INFO - 'ts_paint', 11:18:59 INFO - 'tpaint', 11:18:59 INFO - 'sessionrestore', 11:18:59 INFO - 'sessionrestore_no_auto_restore', 11:18:59 INFO - 'tabpaint']}, 11:18:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:59 INFO - 'ts_paint', 11:18:59 INFO - 'tpaint', 11:18:59 INFO - 'sessionrestore', 11:18:59 INFO - 'sessionrestore_no_auto_restore', 11:18:59 INFO - 'tabpaint']}, 11:18:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:59 INFO - 'ts_paint', 11:18:59 INFO - 'tpaint', 11:18:59 INFO - 'sessionrestore', 11:18:59 INFO - 'sessionrestore_no_auto_restore', 11:18:59 INFO - 'tabpaint']}, 11:18:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['a11yr', 11:18:59 INFO - 'ts_paint', 11:18:59 INFO - 'tpaint', 11:18:59 INFO - 'sessionrestore', 11:18:59 INFO - 'sessionrestore_no_auto_restore', 11:18:59 INFO - 'tabpaint']}, 11:18:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['a11yr', 11:18:59 INFO - 'ts_paint', 11:18:59 INFO - 'tpaint', 11:18:59 INFO - 'sessionrestore', 11:18:59 INFO - 'sessionrestore_no_auto_restore', 11:18:59 INFO - 'tabpaint']}, 11:18:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['tsvgx', 11:18:59 INFO - 'tsvgr_opacity', 11:18:59 INFO - 'tart', 11:18:59 INFO - 'tscrollx', 11:18:59 INFO - 'cart']}, 11:18:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:59 INFO - 'tsvgr_opacity', 11:18:59 INFO - 'tart', 11:18:59 INFO - 'tscrollx', 11:18:59 INFO - 'cart']}, 11:18:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:59 INFO - 'talos_options': ['--disable-e10s'], 11:18:59 INFO - 'tests': ['tp5o']}, 11:18:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:59 INFO - 'tests': ['tp5o']}, 11:18:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:59 INFO - 'talos_options': ['--disable-e10s', 11:18:59 INFO - '--xperf_path', 11:18:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:59 INFO - 'tests': ['tp5n']}, 11:18:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:59 INFO - 'talos_options': ['--xperf_path', 11:18:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:59 INFO - 'tests': ['tp5n']}}, 11:18:59 INFO - 'talos.zip': {'path': '', 11:18:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:59 INFO - Running post-action listener: _resource_record_post_action 11:18:59 INFO - ##### 11:18:59 INFO - ##### Finished populate-webroot step (success) 11:18:59 INFO - ##### 11:18:59 INFO - ##### 11:18:59 INFO - ##### Running create-virtualenv step. 11:18:59 INFO - ##### 11:18:59 INFO - Running pre-action listener: _resource_record_pre_action 11:18:59 INFO - Running main action method: create_virtualenv 11:18:59 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:18:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:59 INFO - Using real prefix '/usr' 11:18:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:19:00 INFO - Installing distribute.............................................................................................................................................................................................done. 11:19:02 INFO - Installing pip.................done. 11:19:02 INFO - Return code: 0 11:19:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x7f72d8b80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:19:02 INFO - Using env: {'DISPLAY': ':0', 11:19:02 INFO - 'HOME': '/home/cltbld', 11:19:02 INFO - 'LANG': 'en_US.UTF-8', 11:19:02 INFO - 'LANGUAGE': 'en_US:en', 11:19:02 INFO - 'LOGNAME': 'cltbld', 11:19:02 INFO - 'MAIL': '/var/mail/cltbld', 11:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:02 INFO - 'MOZ_NO_REMOTE': '1', 11:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:02 INFO - 'NO_EM_RESTART': '1', 11:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:02 INFO - 'PWD': '/builds/slave/test', 11:19:02 INFO - 'SHELL': '/bin/bash', 11:19:02 INFO - 'SHLVL': '1', 11:19:02 INFO - 'TERM': 'linux', 11:19:02 INFO - 'TMOUT': '86400', 11:19:02 INFO - 'USER': 'cltbld', 11:19:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:02 INFO - '_': '/tools/buildbot/bin/python'} 11:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:19:02 INFO - Cleaning up... 11:19:02 INFO - Return code: 0 11:19:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x7f72d8b80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:19:02 INFO - Using env: {'DISPLAY': ':0', 11:19:02 INFO - 'HOME': '/home/cltbld', 11:19:02 INFO - 'LANG': 'en_US.UTF-8', 11:19:02 INFO - 'LANGUAGE': 'en_US:en', 11:19:02 INFO - 'LOGNAME': 'cltbld', 11:19:02 INFO - 'MAIL': '/var/mail/cltbld', 11:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:02 INFO - 'MOZ_NO_REMOTE': '1', 11:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:02 INFO - 'NO_EM_RESTART': '1', 11:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:02 INFO - 'PWD': '/builds/slave/test', 11:19:02 INFO - 'SHELL': '/bin/bash', 11:19:02 INFO - 'SHLVL': '1', 11:19:02 INFO - 'TERM': 'linux', 11:19:02 INFO - 'TMOUT': '86400', 11:19:02 INFO - 'USER': 'cltbld', 11:19:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:02 INFO - '_': '/tools/buildbot/bin/python'} 11:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:02 INFO - Downloading/unpacking psutil>=3.1.1 11:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:19:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:04 INFO - Installing collected packages: psutil 11:19:04 INFO - Running setup.py install for psutil 11:19:04 INFO - building 'psutil._psutil_linux' extension 11:19:04 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:19:04 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:19:04 INFO - building 'psutil._psutil_posix' extension 11:19:04 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:19:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:19:05 INFO - Successfully installed psutil 11:19:05 INFO - Cleaning up... 11:19:05 INFO - Return code: 0 11:19:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72d8b80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:19:05 INFO - Using env: {'DISPLAY': ':0', 11:19:05 INFO - 'HOME': '/home/cltbld', 11:19:05 INFO - 'LANG': 'en_US.UTF-8', 11:19:05 INFO - 'LANGUAGE': 'en_US:en', 11:19:05 INFO - 'LOGNAME': 'cltbld', 11:19:05 INFO - 'MAIL': '/var/mail/cltbld', 11:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:05 INFO - 'MOZ_NO_REMOTE': '1', 11:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:05 INFO - 'NO_EM_RESTART': '1', 11:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:05 INFO - 'PWD': '/builds/slave/test', 11:19:05 INFO - 'SHELL': '/bin/bash', 11:19:05 INFO - 'SHLVL': '1', 11:19:05 INFO - 'TERM': 'linux', 11:19:05 INFO - 'TMOUT': '86400', 11:19:05 INFO - 'USER': 'cltbld', 11:19:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:05 INFO - '_': '/tools/buildbot/bin/python'} 11:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:19:07 INFO - Installing collected packages: mozsystemmonitor 11:19:07 INFO - Running setup.py install for mozsystemmonitor 11:19:07 INFO - Successfully installed mozsystemmonitor 11:19:07 INFO - Cleaning up... 11:19:07 INFO - Return code: 0 11:19:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:19: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:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19: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:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f72d8b80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:19:07 INFO - Using env: {'DISPLAY': ':0', 11:19:07 INFO - 'HOME': '/home/cltbld', 11:19:07 INFO - 'LANG': 'en_US.UTF-8', 11:19:07 INFO - 'LANGUAGE': 'en_US:en', 11:19:07 INFO - 'LOGNAME': 'cltbld', 11:19:07 INFO - 'MAIL': '/var/mail/cltbld', 11:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:07 INFO - 'MOZ_NO_REMOTE': '1', 11:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:07 INFO - 'NO_EM_RESTART': '1', 11:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:07 INFO - 'PWD': '/builds/slave/test', 11:19:07 INFO - 'SHELL': '/bin/bash', 11:19:07 INFO - 'SHLVL': '1', 11:19:07 INFO - 'TERM': 'linux', 11:19:07 INFO - 'TMOUT': '86400', 11:19:07 INFO - 'USER': 'cltbld', 11:19:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:07 INFO - '_': '/tools/buildbot/bin/python'} 11:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:07 INFO - Downloading/unpacking jsonschema==2.5.1 11:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:19:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:09 INFO - Downloading functools32-3.2.3-2.tar.gz 11:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:19:09 INFO - warning: no files found matching '*.txt' 11:19:09 INFO - no previously-included directories found matching 'build' 11:19:09 INFO - no previously-included directories found matching 'dist' 11:19:09 INFO - no previously-included directories found matching '.git*' 11:19:09 INFO - Installing collected packages: jsonschema, functools32 11:19:10 INFO - Running setup.py install for functools32 11:19:10 INFO - warning: no files found matching '*.txt' 11:19:10 INFO - no previously-included directories found matching 'build' 11:19:10 INFO - no previously-included directories found matching 'dist' 11:19:10 INFO - no previously-included directories found matching '.git*' 11:19:10 INFO - Successfully installed jsonschema functools32 11:19:10 INFO - Cleaning up... 11:19:10 INFO - Return code: 0 11:19:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:10 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 0x7f72d8b80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:10 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:19:10 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:19:10 INFO - Using env: {'DISPLAY': ':0', 11:19:10 INFO - 'HOME': '/home/cltbld', 11:19:10 INFO - 'LANG': 'en_US.UTF-8', 11:19:10 INFO - 'LANGUAGE': 'en_US:en', 11:19:10 INFO - 'LOGNAME': 'cltbld', 11:19:10 INFO - 'MAIL': '/var/mail/cltbld', 11:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:10 INFO - 'MOZ_NO_REMOTE': '1', 11:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:10 INFO - 'NO_EM_RESTART': '1', 11:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:10 INFO - 'PWD': '/builds/slave/test', 11:19:10 INFO - 'SHELL': '/bin/bash', 11:19:10 INFO - 'SHLVL': '1', 11:19:10 INFO - 'TERM': 'linux', 11:19:10 INFO - 'TMOUT': '86400', 11:19:10 INFO - 'USER': 'cltbld', 11:19:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:10 INFO - '_': '/tools/buildbot/bin/python'} 11:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:10 INFO - Downloading/unpacking blobuploader==1.2.4 11:19: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:19: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:19: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:19: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:19: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:19: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:19:12 INFO - Downloading blobuploader-1.2.4.tar.gz 11:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:19:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:19:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:12 INFO - Downloading docopt-0.6.1.tar.gz 11:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:19:13 INFO - Installing collected packages: blobuploader, requests, docopt 11:19:13 INFO - Running setup.py install for blobuploader 11:19:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:19:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:19:13 INFO - Running setup.py install for requests 11:19:13 INFO - Running setup.py install for docopt 11:19:13 INFO - Successfully installed blobuploader requests docopt 11:19:13 INFO - Cleaning up... 11:19:13 INFO - Return code: 0 11:19:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:13 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 0x7f72d8b80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:13 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:19:13 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:19:13 INFO - Using env: {'DISPLAY': ':0', 11:19:13 INFO - 'HOME': '/home/cltbld', 11:19:13 INFO - 'LANG': 'en_US.UTF-8', 11:19:13 INFO - 'LANGUAGE': 'en_US:en', 11:19:13 INFO - 'LOGNAME': 'cltbld', 11:19:13 INFO - 'MAIL': '/var/mail/cltbld', 11:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:13 INFO - 'MOZ_NO_REMOTE': '1', 11:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:13 INFO - 'NO_EM_RESTART': '1', 11:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:13 INFO - 'PWD': '/builds/slave/test', 11:19:13 INFO - 'SHELL': '/bin/bash', 11:19:13 INFO - 'SHLVL': '1', 11:19:13 INFO - 'TERM': 'linux', 11:19:13 INFO - 'TMOUT': '86400', 11:19:13 INFO - 'USER': 'cltbld', 11:19:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:13 INFO - '_': '/tools/buildbot/bin/python'} 11:19:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:13 INFO - Running setup.py (path:/tmp/pip-0KYYMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:13 INFO - Running setup.py (path:/tmp/pip-rlAngD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:14 INFO - Running setup.py (path:/tmp/pip-Tszgpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:14 INFO - Running setup.py (path:/tmp/pip-jo7lVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:14 INFO - Running setup.py (path:/tmp/pip-iAc2Ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:14 INFO - Running setup.py (path:/tmp/pip-SIIXDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:14 INFO - Running setup.py (path:/tmp/pip-G7Q7qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:14 INFO - Running setup.py (path:/tmp/pip-_om7md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:14 INFO - Running setup.py (path:/tmp/pip-zP85R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:14 INFO - Running setup.py (path:/tmp/pip-Npupyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:14 INFO - Running setup.py (path:/tmp/pip-dBU4RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:14 INFO - Running setup.py (path:/tmp/pip-CgKz5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:14 INFO - Running setup.py (path:/tmp/pip-CaCmjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:14 INFO - Running setup.py (path:/tmp/pip-2N6Eai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:14 INFO - Running setup.py (path:/tmp/pip-wSRvo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:14 INFO - Running setup.py (path:/tmp/pip-lUnCdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:15 INFO - Running setup.py (path:/tmp/pip-fQ1ov3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:19:15 INFO - Running setup.py install for manifestparser 11:19:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:19:15 INFO - Running setup.py install for mozcrash 11:19:15 INFO - Running setup.py install for mozdebug 11:19:15 INFO - Running setup.py install for mozdevice 11:19:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:19:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:19:15 INFO - Running setup.py install for mozfile 11:19:15 INFO - Running setup.py install for mozhttpd 11:19:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:19:15 INFO - Running setup.py install for mozinfo 11:19:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:19:15 INFO - Running setup.py install for mozInstall 11:19:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:19:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:19:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:19:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:19:15 INFO - Running setup.py install for mozleak 11:19:16 INFO - Running setup.py install for mozlog 11:19:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:19:16 INFO - Running setup.py install for moznetwork 11:19:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:19:16 INFO - Running setup.py install for mozprocess 11:19:16 INFO - Running setup.py install for mozprofile 11:19:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:19:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:19:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:19:16 INFO - Running setup.py install for mozrunner 11:19:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:19:16 INFO - Running setup.py install for mozscreenshot 11:19:16 INFO - Running setup.py install for moztest 11:19:16 INFO - Running setup.py install for mozversion 11:19:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:19:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:19:16 INFO - Cleaning up... 11:19:16 INFO - Return code: 0 11:19:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:16 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 0x7f72d8b80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:16 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:19:16 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:19:16 INFO - Using env: {'DISPLAY': ':0', 11:19:16 INFO - 'HOME': '/home/cltbld', 11:19:16 INFO - 'LANG': 'en_US.UTF-8', 11:19:16 INFO - 'LANGUAGE': 'en_US:en', 11:19:16 INFO - 'LOGNAME': 'cltbld', 11:19:16 INFO - 'MAIL': '/var/mail/cltbld', 11:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:16 INFO - 'MOZ_NO_REMOTE': '1', 11:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:16 INFO - 'NO_EM_RESTART': '1', 11:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:16 INFO - 'PWD': '/builds/slave/test', 11:19:16 INFO - 'SHELL': '/bin/bash', 11:19:16 INFO - 'SHLVL': '1', 11:19:16 INFO - 'TERM': 'linux', 11:19:16 INFO - 'TMOUT': '86400', 11:19:16 INFO - 'USER': 'cltbld', 11:19:16 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:16 INFO - '_': '/tools/buildbot/bin/python'} 11:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:19:17 INFO - Running setup.py (path:/tmp/pip-jKFKGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:19:17 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:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:19:17 INFO - Running setup.py (path:/tmp/pip-rQP0u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:19:17 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:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:19:17 INFO - Running setup.py (path:/tmp/pip-v0WC4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:19:17 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:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:19:17 INFO - Running setup.py (path:/tmp/pip-6fI_3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:19:17 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:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:19:17 INFO - Running setup.py (path:/tmp/pip-LTuAF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:19:17 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:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:19:17 INFO - Running setup.py (path:/tmp/pip-pTCmTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:19:17 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:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:19:17 INFO - Running setup.py (path:/tmp/pip-t1LO_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:19:17 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:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:19:17 INFO - Running setup.py (path:/tmp/pip-DB7dte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:19:17 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:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:19:17 INFO - Running setup.py (path:/tmp/pip-ML4VwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:19:17 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:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:19:17 INFO - Running setup.py (path:/tmp/pip-lZWWvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:19:17 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:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:19:17 INFO - Running setup.py (path:/tmp/pip-hcNWkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:19:17 INFO - Running setup.py (path:/tmp/pip-xUjFXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:19:18 INFO - Running setup.py (path:/tmp/pip-8y1QA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:19:18 INFO - Running setup.py (path:/tmp/pip-Vo5qo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:18 INFO - Running setup.py (path:/tmp/pip-TyYmAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:19:18 INFO - Running setup.py (path:/tmp/pip-eBVvr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:19:18 INFO - Running setup.py (path:/tmp/pip-G4lZAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:19:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:19:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:20 INFO - Downloading blessings-1.6.tar.gz 11:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:19:20 INFO - Installing collected packages: blessings 11:19:20 INFO - Running setup.py install for blessings 11:19:20 INFO - Successfully installed blessings 11:19:20 INFO - Cleaning up... 11:19:20 INFO - Return code: 0 11:19:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:20 INFO - Reading from file tmpfile_stdout 11:19:20 INFO - Current package versions: 11:19:20 INFO - argparse == 1.2.1 11:19:20 INFO - blessings == 1.6 11:19:20 INFO - blobuploader == 1.2.4 11:19:20 INFO - docopt == 0.6.1 11:19:20 INFO - functools32 == 3.2.3-2 11:19:20 INFO - jsonschema == 2.5.1 11:19:20 INFO - manifestparser == 1.1 11:19:20 INFO - mozInstall == 1.12 11:19:20 INFO - mozcrash == 0.17 11:19:20 INFO - mozdebug == 0.1 11:19:20 INFO - mozdevice == 0.48 11:19:20 INFO - mozfile == 1.2 11:19:20 INFO - mozhttpd == 0.7 11:19:20 INFO - mozinfo == 0.9 11:19:20 INFO - mozleak == 0.1 11:19:20 INFO - mozlog == 3.2 11:19:20 INFO - moznetwork == 0.27 11:19:20 INFO - mozprocess == 0.22 11:19:20 INFO - mozprofile == 0.28 11:19:20 INFO - mozrunner == 6.11 11:19:20 INFO - mozscreenshot == 0.1 11:19:20 INFO - mozsystemmonitor == 0.3 11:19:20 INFO - moztest == 0.7 11:19:20 INFO - mozversion == 1.4 11:19:20 INFO - psutil == 3.1.1 11:19:20 INFO - requests == 1.2.3 11:19:20 INFO - wsgiref == 0.1.2 11:19:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:20 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 0x7f72d8b80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:19:20 INFO - Using env: {'DISPLAY': ':0', 11:19:20 INFO - 'HOME': '/home/cltbld', 11:19:20 INFO - 'LANG': 'en_US.UTF-8', 11:19:20 INFO - 'LANGUAGE': 'en_US:en', 11:19:20 INFO - 'LOGNAME': 'cltbld', 11:19:20 INFO - 'MAIL': '/var/mail/cltbld', 11:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:20 INFO - 'MOZ_NO_REMOTE': '1', 11:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:20 INFO - 'NO_EM_RESTART': '1', 11:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:20 INFO - 'PWD': '/builds/slave/test', 11:19:20 INFO - 'SHELL': '/bin/bash', 11:19:20 INFO - 'SHLVL': '1', 11:19:20 INFO - 'TERM': 'linux', 11:19:20 INFO - 'TMOUT': '86400', 11:19:20 INFO - 'USER': 'cltbld', 11:19:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:20 INFO - '_': '/tools/buildbot/bin/python'} 11:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:19:20 INFO - Cleaning up... 11:19:20 INFO - Return code: 0 11:19:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:20 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 0x7f72d8b80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:19:20 INFO - Using env: {'DISPLAY': ':0', 11:19:20 INFO - 'HOME': '/home/cltbld', 11:19:20 INFO - 'LANG': 'en_US.UTF-8', 11:19:20 INFO - 'LANGUAGE': 'en_US:en', 11:19:20 INFO - 'LOGNAME': 'cltbld', 11:19:20 INFO - 'MAIL': '/var/mail/cltbld', 11:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:20 INFO - 'MOZ_NO_REMOTE': '1', 11:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:20 INFO - 'NO_EM_RESTART': '1', 11:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:20 INFO - 'PWD': '/builds/slave/test', 11:19:20 INFO - 'SHELL': '/bin/bash', 11:19:20 INFO - 'SHLVL': '1', 11:19:20 INFO - 'TERM': 'linux', 11:19:20 INFO - 'TMOUT': '86400', 11:19:20 INFO - 'USER': 'cltbld', 11:19:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:20 INFO - '_': '/tools/buildbot/bin/python'} 11:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:19:21 INFO - Cleaning up... 11:19:21 INFO - Return code: 0 11:19:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72d8b80f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:19:21 INFO - Using env: {'DISPLAY': ':0', 11:19:21 INFO - 'HOME': '/home/cltbld', 11:19:21 INFO - 'LANG': 'en_US.UTF-8', 11:19:21 INFO - 'LANGUAGE': 'en_US:en', 11:19:21 INFO - 'LOGNAME': 'cltbld', 11:19:21 INFO - 'MAIL': '/var/mail/cltbld', 11:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:21 INFO - 'MOZ_NO_REMOTE': '1', 11:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:21 INFO - 'NO_EM_RESTART': '1', 11:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:21 INFO - 'PWD': '/builds/slave/test', 11:19:21 INFO - 'SHELL': '/bin/bash', 11:19:21 INFO - 'SHLVL': '1', 11:19:21 INFO - 'TERM': 'linux', 11:19:21 INFO - 'TMOUT': '86400', 11:19:21 INFO - 'USER': 'cltbld', 11:19:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:21 INFO - '_': '/tools/buildbot/bin/python'} 11:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:19:21 INFO - Downloading/unpacking flake8 11:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:19:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:19:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:19:24 INFO - no previously-included directories found matching 'docs/_build' 11:19:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:19:24 INFO - Running setup.py install for pep8 11:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:19:24 INFO - no previously-included directories found matching 'docs/_build' 11:19:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:19:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:19:24 INFO - Cleaning up... 11:19:24 INFO - Return code: 0 11:19:24 INFO - Running post-action listener: _resource_record_post_action 11:19:24 INFO - Running post-action listener: _start_resource_monitoring 11:19:24 INFO - Starting resource monitoring. 11:19:24 INFO - ##### 11:19:24 INFO - ##### Finished create-virtualenv step (success) 11:19:24 INFO - ##### 11:19:24 INFO - ##### 11:19:24 INFO - ##### Running install step. 11:19:24 INFO - ##### 11:19:24 INFO - Running pre-action listener: _resource_record_pre_action 11:19:24 INFO - Running main action method: install 11:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:24 INFO - Reading from file tmpfile_stdout 11:19:24 INFO - Detecting whether we're running mozinstall >=1.0... 11:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:19:24 INFO - Reading from file tmpfile_stdout 11:19:24 INFO - Output received: 11:19:24 INFO - Usage: mozinstall [options] installer 11:19:24 INFO - Options: 11:19:24 INFO - -h, --help show this help message and exit 11:19:24 INFO - -d DEST, --destination=DEST 11:19:24 INFO - Directory to install application into. [default: 11:19:24 INFO - "/builds/slave/test"] 11:19:24 INFO - --app=APP Application being installed. [default: firefox] 11:19:24 INFO - mkdir: /builds/slave/test/build/application 11:19:24 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:19:24 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:19:41 INFO - Reading from file tmpfile_stdout 11:19:41 INFO - Output received: 11:19:41 INFO - /builds/slave/test/build/application/firefox/firefox 11:19:41 INFO - Running post-action listener: _resource_record_post_action 11:19:41 INFO - ##### 11:19:41 INFO - ##### Finished install step (success) 11:19:41 INFO - ##### 11:19:41 INFO - ##### 11:19:41 INFO - ##### Running run-tests step. 11:19:41 INFO - ##### 11:19:41 INFO - Running pre-action listener: _resource_record_pre_action 11:19:41 INFO - Running main action method: run_tests 11:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:41 INFO - Python 2.7.3 11:19:41 INFO - Return code: 0 11:19:41 INFO - grabbing minidump binary from tooltool 11:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:41 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 0x16bc110>, '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 0x1628230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16286c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:19:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:19:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:19:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:41 INFO - Return code: 0 11:19:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:19:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:19:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:19:42 INFO - Return code: 0 11:19:42 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/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:19:42 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/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:19:42 INFO - Using env: {'DISPLAY': ':0', 11:19:42 INFO - 'HOME': '/home/cltbld', 11:19:42 INFO - 'LANG': 'en_US.UTF-8', 11:19:42 INFO - 'LANGUAGE': 'en_US:en', 11:19:42 INFO - 'LOGNAME': 'cltbld', 11:19:42 INFO - 'MAIL': '/var/mail/cltbld', 11:19:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:42 INFO - 'MOZ_NO_REMOTE': '1', 11:19:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:42 INFO - 'NO_EM_RESTART': '1', 11:19:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:42 INFO - 'PWD': '/builds/slave/test', 11:19:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:42 INFO - 'SHELL': '/bin/bash', 11:19:42 INFO - 'SHLVL': '1', 11:19:42 INFO - 'TERM': 'linux', 11:19:42 INFO - 'TMOUT': '86400', 11:19:42 INFO - 'USER': 'cltbld', 11:19:42 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493', 11:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:42 INFO - '_': '/tools/buildbot/bin/python'} 11:19:42 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/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:19:42 INFO - mozversion application_buildid: 20160621083052 11:19:42 INFO - mozversion application_changeset: ecd3562339dcd51a604e82efbcb347de8b823aee 11:19:42 INFO - mozversion application_display_name: Nightly 11:19:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:42 INFO - mozversion application_name: Firefox 11:19:42 INFO - mozversion application_remotingname: firefox 11:19:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:19:42 INFO - mozversion application_vendor: Mozilla 11:19:42 INFO - mozversion application_version: 50.0a1 11:19:42 INFO - mozversion platform_buildid: 20160621083052 11:19:42 INFO - mozversion platform_changeset: ecd3562339dcd51a604e82efbcb347de8b823aee 11:19:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:19:42 INFO - mozversion platform_version: 50.0a1 11:19:42 INFO - using testdate: 1466533182 11:19:42 INFO - actual date: 1466533182 11:19:42 INFO - starting webserver on 'localhost:34937' 11:19:42 INFO - SUITE-START | Running 2 tests 11:19:42 INFO - TEST-START | dromaeo_css 11:19:42 INFO - operating with platform_type : linux_ 11:19:42 INFO - Initialising browser for dromaeo_css test... 11:19:42 INFO - TEST-INFO | started process 31081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Q7gnm/profile http://localhost:34937/getInfo.html) 11:19:47 INFO - PROCESS | 31081 | __metrics Screen width/height:1600/1200 11:19:47 INFO - PROCESS | 31081 | colorDepth:24 11:19:47 INFO - PROCESS | 31081 | Browser inner width/height: 1024/697 11:19:47 INFO - PROCESS | 31081 | __metrics 11:19:47 ERROR - PROCESS | 31081 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:19:48 INFO - TEST-INFO | 31081: exit 0 11:19:48 INFO - Browser initialized. 11:19:48 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:48 INFO - TEST-INFO | started process 31204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Q7gnm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:00 INFO - PROCESS | 31204 | RSS: Main: 185221120 11:20:00 INFO - PROCESS | 31204 | 11:20:49 INFO - PROCESS | 31204 | 1466533249868 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:22:58 INFO - PROCESS | 31204 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34937/tests/dromaeo/cssquery-ext.html) 11:22:59 INFO - PROCESS | 31204 | RSS: Main: 189554688 11:22:59 INFO - PROCESS | 31204 | 11:26:01 INFO - PROCESS | 31204 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-ext.html (next: http://localhost:34937/tests/dromaeo/cssquery-jquery.html) 11:26:01 INFO - PROCESS | 31204 | RSS: Main: 187449344 11:26:01 INFO - PROCESS | 31204 | 11:29:03 INFO - PROCESS | 31204 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34937/tests/dromaeo/cssquery-mootools.html) 11:29:04 INFO - PROCESS | 31204 | RSS: Main: 189464576 11:29:04 INFO - PROCESS | 31204 | 11:32:06 INFO - PROCESS | 31204 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34937/tests/dromaeo/cssquery-prototype.html) 11:32:06 INFO - PROCESS | 31204 | RSS: Main: 185782272 11:32:06 INFO - PROCESS | 31204 | 11:35:09 INFO - PROCESS | 31204 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34937/tests/dromaeo/cssquery-yui.html) 11:35:09 INFO - PROCESS | 31204 | RSS: Main: 187875328 11:35:09 INFO - PROCESS | 31204 | 11:38:12 INFO - PROCESS | 31204 | Cycle 1(1): loaded http://localhost:34937/tests/dromaeo/cssquery-yui.html (next: http://localhost:34937/tests/dromaeo/cssquery-dojo.html) 11:38:12 INFO - PROCESS | 31204 | RSS: Main: 188874752 11:38:12 INFO - PROCESS | 31204 | 11:38:12 INFO - PROCESS | 31204 | __start_tp_report 11:38:12 INFO - PROCESS | 31204 | _x_x_mozilla_page_load 11:38:12 INFO - PROCESS | 31204 | _x_x_mozilla_page_load_details 11:38:12 INFO - PROCESS | 31204 | |i|pagename|runs| 11:38:12 INFO - PROCESS | 31204 | |0;dojo.html;3097.705717956794;3134.717875391216;3138.623365196177;3141.073383351911;3165.9999999999986;5386.2997810284705;5396.784128634855;5411.567074634029;5420.5392541633955;5492.368377636573;5325.174597937326;5387.78448862046;5443.945560544394;5453.509184173424;5472.616916815825;4905.975470122653;4951.0592987332475;5054.974725126369;5093.286939828427;5136.152534831748;520.4912994895863;4880.341153944208;4914.213725803872;4950.727709975949;5006.624503162259;4987.526185012418;5018.5985121190215;5021.723805190713;5039.647224694273;5044.798208071673;5047.49525047496;5049.924251136236;5059.064073146443;5061.822836200752;5062.139436295838;4907.190313598252;4929.383827021622;4934.25986102084;4951.960088381445;4978.9751051244875;5371.301730775013;5443.646162999393;5457.508824205801;5472.699001554913;5518.751656175442;5608.6073974821775;5819.243498345188;5892;5900.409959004108;5923;5924;5926.199963004982;5961.433663801932;5994.940050599482;6040.879182416371;5414.972925135388;5479.643823151482;5484.369297530795;5495.203195536625;5565.721713914329;5769.048107062287;5937.376575459601;5945.256842894638;6056.878862422727;6064.302605200371;5797.826065218051;5799.4780469757925;5803.970980145156;5820;5836.970815145897;5873.882522349614;5875.9118613220835;5879.353271140171;5882.441168089024;5902.3507414184405;5746.597738158289;5758.913616295759;5775.133729940542;5806.1000544915605;5863.296404431496;5742.425757424224;5770.440722653338;5797.855053623609;5807.622504537191;5852.7658893643775;4453.487848897354;4456.5766252205985;4466.2407390743;4466.330050492452;4489.6408287336935;3882.6893848492055;3962.9405558916637;3966.861159859391;3972.781497017634;4029.7985100744845;5657.4908258256955;5662.292213473316;5680.715964201773;5682.403347648437;5711.457411545896;5929.347771745104;5934.495567876693;5949.613275137102;5950.375210602911;5955.672438015864;5563.248961390242;5600.551955843523;5623.915641265385;5655.745491452894;5661.886762264731;5076.416212135578;5103.464136265713;5105.387353517602;5109;5111.131107711698;6102.633841969496;6148.538859585549;6151.138840562325;6156.6921653918025;6174.8147555573405;5751.85620359486;5830.183774271521;5860.326062502867;5890.970545147418;5909.852253693692;6012.3386427493815;6069.423404776539;6081.087836824335;6085.969570152298;6100.389961003864;5648.830535083954;5781.364049954585;5790.1893734877995;5792.247007889116;5808.5353171747;5866.149408335682;5900.940990590211;5914.940850591439;5948.702564871825;5951.940480595312;5744.626599271034;5780.306363236438;5783.132530120515;5789.884202316014;5791.855203619774;5556.555475561864;5682.431756824284;5770.451807078321;5782.45066718661;5791.8552036199435;5550.750216240198;5620.1569764534015;5625.746841392229;5687.8862422752145;5711.343195532567;5752.942470575241;5781.364049954417;5791.478766910998;5820.534357251495;5820.73806678692;5489.752961116679;5589.664620122806;5592.412796656293;5602.775888964396;5604.495595396434 11:38:12 INFO - PROCESS | 31204 | |1;ext.html;588.4351023017903;620.4571000374672;630.8801327747731;636.6784773689286;640.1486023588627;41724.165516689645;42567.14865702692;43137.78431107844;43218;46191;43015.35476967848;44030.779846100726;44227.33658995118;44423.77788111063;44579.77710111445;8772.210501054904;8988.280937524982;8993.10068993102;9028.819423611523;9032.322575806807;8886.377953543255;8949.149830766068;9006.86489702655;9017.278617710568;9032.819343613124;9030.051844556292;9042.367034307601;9058.592363343665;9059.229965452945;9065.32010099242;8914.108589141098;8986.14631609996;8995.64017439305;9010.189082982497;9021.097890210993;8873;8937.374383793072;8942.73171804847;8946.59740311681;8950.06024367445;41973.79013104915;42028.36957445641;42117.57882421198;42143.367849481976;42373.78813105945;3309.7683162178655;3535.8762443314617;3553.822308884571;3692.9076773080888;3711.164987877733;30378.69621303781;31527.84236078828;31844.363112737847;32293.6770632293;33625.159371015674;4134.64855487284;4234.5765423457715;4248.214080395106;4273;4306.224879521685;339169.0415479216;339923;341547;342826.9999999975;343478;55974;56079;56124.719376402856;56145;56613.433865660816;34173.316533669684;34808.12979675478;54920.17619735707;55318.72340638351;55689.16466253009;14473.92763036178;14495.347709353104;14518.782218266524;14541.491047813488;14552.054116482395;12274.447649855778;12355.876441235472;12361.134720569653;12454.128211025141;12510.18683785551;18458.077096145138;18516;18745.53136171579;18782.530436738918;18805.717914231296;6834.897476537856;7113.7154513819905;7167.605781681953;7261.41908647307;7299.89050164248;962.4417837654144;1078.7572796120967;1135.4095870147478;1178.116412690482;1186.3119390753343;33355;36006.75939165488;36099.81950090285;36308.81845590755;36446.63553364432;980.6028558433845;992.8709267795141;1012.2559918459926;1037.190991026985;1057.7302787789217;16858.157092145342;16905;16933.745993810102;17022.233999470052;17379;548521;554276;557511;558514;559783;55210.723946380815;55966.72016639891;56266;56277;57058.429415706145;1306.1705816806395;1308.6989992301633;1335.9265240411676;1362.734266817961;1368.6852024034529;31075.37849243048;31875.840620797677;32247.193820154684;32272.677273226967;32576.674233257363;48760.51239487559;49389.25916111333;49637;49805;50061.24908126454;488288;488357.23285534803;491396;491689;492918;27625.309367265978;27653.30866728348;27662;27829;27909;44647;46144.30783538183;47733.5226647743;48140.27789583229;48420.5157948416;39002.6099738999;40215.396769049075;40683.59316406916;40978.59021409748;41409.1718165641;37844.24311513699;37950.77418419355;38488;39566.2086758269;40453.59546404616;37882.81058594689;38905;39148;39204.252960044534;39529;33805;34839.825800870836;34906.47640285449;35298.97071175444;35788;27848.303792404542;28082.71917280801;28105.43789124165;28386.43227135487;28494.147880387707 11:38:12 INFO - PROCESS | 31204 | |2;jquery.html;376.9962300376996;378.76895093992664;381.1709531768403;385.3949299599628;394.63496265954024;16791.076490793002;18104.09479526022;18187.454376368714;18848.5287867803;18889.905550472246;16252.51242462725;17473.650526989484;17512.124393780323;17785.82214177861;17818.554536136602;5570.6657600543995;5793.826185214451;5795.1886735857015;5822.767089316422;5825.417458254183;4201.7478951262865;6462.579932304385;6471.223453185625;6478.902816457757;6515;6220.004799232123;6314.179156709644;6493.577917435376;6498.025296205584;6557.245916719567;6253;6257;6281.7173227204885;6304.243490781089;6318.936810631903;5535;5539.750711218005;5568.52667523261;5574.358948720908;5604.495595396434;22406.775932240795;22466.101355945906;22910.083596656114;23106.884465577732;23149.652755208685;2241.9775802241934;2278.612635851909;2322.674825524428;2969.8663560139844;2976.895808646687;14210.502632407919;14255.786163207456;14271;14279.78580321296;14974.550763477004;1938.1181562389079;1952.9218831246733;1960.7454793923675;1982.3656429942423;2021.9890054972514;76200;79667.60166199131;80818.19181808166;81089.59455202686;82289.58855205686;9961.252906031932;9975.25185611082;10257.897421025844;10312.123469505175;10527.473626318653;14224.644383890485;14252.857471425154;14286.571402857931;14295.213763242913;14336.641583960485;7482.738104166328;7755.844883102306;7785;7989.800254993555;7990.4007199460275;7685.116211635622;7689.346405555479;7900.723474678359;7935.444518883738;8015.7595272141925;6017.849553761191;6037.396260374016;6100.816975490742;6189.164462797555;6319.33646967071;1844.2807305151002;1846.2944929149257;1866.178881292227;1883.1902282018864;1895.9620807584047;985.9605615775432;1005.7535903703639;1037.9896201038043;1042.4735508568124;1069.0912724184536;19456.805431945784;19656.410307690792;19719.30982415637;19903;19968.50078748043;936.733328377075;965.2953344058736;977.0620204603518;989.1641562879355;1057.7038429239826;10292.330998485075;11347.489362978686;11551.537938482366;11584.362860042778;11596.072314214842;385230;389649;498627;552778;561660;61331.386686132566;61550;83236.58381708052;93926.53036734773;101423.4928825366;939.9295052871062;967.2455484721928;977.628501169551;985.0641890204191;1050.669039252633;17216.920299200592;17321.480355589352;17739.645207096044;17745.290188392835;17757.73363399576;40770.38844417396;41639.16721665489;42213.366799498646;42512.57487425086;43124.56875431206;59782.701086494286;60257;61113.388866112546;61766.382336176066;62106.689466554184;8191;8335.374846886387;8529.232369086812;8572.228499435081;8604.182602652738;11691.649250522498;12808.679783005127;13075.934620326838;13361.866381336062;13419.329033548478;11421.200515963803;11505.309681419141;11506.252093613888;11556.075513958695;12149.69625759363;11418.543258269576;11522.884771152181;11596.072314215011;11763.470643820878;11922.523099076287;11206.943965280121;11549.42252887369;11657.941710291394;11844.111691623335;11991.340476273888;7011.579305241702;7595.392368610608;7733.419993500623;7989.600519974094;8627.95686021566;9954.25343099256;11058.557657693602;11369.2609980351;11803.055755539364;12061.457234424648 11:38:12 INFO - PROCESS | 31204 | |3;mootools.html;1277.5847849448926;1292.5411478924982;1351.3310911099002;1707.7182264926287;1709.982900170998;7696.268854458832;8186.836263274731;8401.957990210056;8688.826223475535;8698.608562614681;8538.359623028282;8595.91404085959;8596.3122950164;8673;8683.088275731036;2279.988600057006;2295.047555264563;2298.7241531016302;2323.3030090972725;2323.9419014524688;2264.501809601885;2270.920517781878;2323.721153461587;2350.6239001759723;2356.2460012795914;2293.5183611441616;2299.1952816514254;2305.3775480620225;2307.4116100394376;2339.0526836631193;2228.7882651148116;2243.9663405048773;2253.1550668499394;2256.616375216217;2259.6271615183473;2245.517213799025;2251.898664560099;2254.3237028891267;2260.242818655736;2270.591293567157;8773.166549177819;8808.867866982;8816.382853200279;8888.822223555493;8889.644414223423;4927.236278376858;5027.99440111979;5033.370828646419;5044.974775126101;5067.442581316052;3156.9842150789327;3191.3457741163006;3394.2871996880685;3409.5567576214935;3439.518467414564;1078.8219943709278;1105.657246253664;1110.272771334777;1114.0808832713044;1132.943352832355;12187.146899717023;12256.08079394049;12256.264624122581;12277.69305767354;12285.815712764315;4388.078503514298;4407.9338809917235;4487.259602165672;4519.231730605805;4539.909201815945;10206.234532410099;10209.591616335263;10259.846102308471;10305.072543471124;10310.639127630497;4968.30443737877;4970.030843985461;4974.825881094144;4993.80024799004;4997.425296090996;4198.349255865346;4417.1386579616665;4556.794944227518;4583.129205450954;4613.515580864028;3771.2268984858038;3784.9432258516144;3834.9808250958567;3835.463035175078;4020.4170395292517;1215.0947544079718;1229.1887354346088;1230.6615680687883;1237.1154624443566;1248.5754843353122;963.604921981984;970.8058388322364;972.941623502578;1000.7498125468633;1016.1413605503337;6007.068904319837;6013.248343957005;6027.246594175728;6038.094285857156;6199.318075011745;447.94848592411637;448.09932036606654;451.9276915693539;458.3239721410892;466.1562571745152;4065.329220678555;4269.7224680395675;4272.5086615039045;4276.5723427656985;4290.2706539888295;10386.42874641887;10591.099756520782;10613.734656633645;10626.256162068736;10653.73365665849;9859.753506162404;10497.2127090467;10531.52608132636;10582.470876456146;10608.681739547827;8053.234942680436;8178.5092894426525;8208.630611622491;8225.79435514105;8283.917160828436;6011.519078473799;6199.814005579839;6253.562250642593;6291.748330066746;6319.431251187415;9996.500174991366;10014.39913605186;10122.038406351385;10168.084872361524;10168.745781355525;9941.204703623549;9987.201023918215;10379.11777498921;10503.264771465923;10535.42055186972;6934.826629334307;7212.8918066228;7365.8158546036775;7535.171131175457;7607.35337496319;8411.45325553837;8435.325173985944;8439;8470.15298470148;8525.95737021311;7313.195548489555;7563.205863384485;7579.317861392501;7713.884291735516;7725.961370193113;7271;7303.488755787044;7406.370458511087;7434.59109748969;7442.590657513889;7032.964835175791;7034.261402552658;7051.858962820817;7057.258987806206;7141.64291785419;5203.947960520346;5364.275822763877;5425.810096646598;5513.7794488221625;5522.6134170609275;5321.414644389191;5365.710563867027;5383.81156659515;5535.584831137761;5556.305461817273 11:38:12 INFO - PROCESS | 31204 | |4;prototype.html;306.63204155013983;308.08191589064575;310.5248969077311;320.7337909535086;325.4776084384563;5468.7578092981885;5476.479734425233;5564.276644036279;5688.03303438416;5693.772249110036;5519.641223320491;5569.610127291091;5586.497215250627;5587.580931430139;5602.7758889644465;4234.153169366124;4255.382969469425;4261.169072030955;4274.615284624383;4283.764392958394;4170.77060761658;4288.828446862121;4299.4195783569285;4319.114581510783;4337.978310108445;4241.939515121219;4244.299690551071;4261.8082186301535;4262.339337402707;4284.378765079062;4240.300350442173;4257.106007738379;4266.424032755569;4314.309710446313;4323.200207961537;3632.20091579852;3756.211195648917;3781.111438811877;3803.9429408558894;3816.4084566892175;5426.8371948841595;5453.590980676426;5454.154606036071;5474.671519708831;5475.561955043587;4843.07981483517;4860.562549370574;4864.173090574575;4874.634402419832;4897.1146108748035;5532.612717109804;5779.537636989031;5808;5830.32951210612;5853.414658534155;4007.8998025049314;4019.8995025124605;4035.1122752994293;4043.8070769122887;4046.046386138136;6120.234970628671;6125.509959203253;6126.693665316717;6144.38556144382;6145.877082458371;3948.763074215556;4025.154717509356;4031.4355990161403;4046.473958385391;4160.355144952538;4172.457580514514;4202.2646036943415;4205.327147656421;4216.494020717533;4238.686007337735;4837.516248375135;4847.8365192353585;4877;4882.902341953141;4890.1931181355385;5247.947520524822;5869.530437564985;5918.970405147947;5925.911111333334;5945.078512830518;1421.5664222412056;1447.4065633090383;1450.180647933935;1453.0772959171002;1453.8328092269312;839.1650307943635;881.8721285413708;895.3911340288666;909.0409617853096;915.5788337364887;5025.4974502550185;5025.572826309732;5027.673201241908;5079.847604571869;5103.70333349994;5296.563580752897;5349.946500535023;5383.353997520323;5440.891182176413;5441.428649991773;5032.0690672225755;5075.390953085654;5079.339685840817;5288.391834938954;5747.741351639186;3183.4906414973493;3238.6599407061917;3246.0361481303944;3251.902442926716;3258.576385069926;6042.577019608585;6234.657093859791;6310.6213627182515;6351.809445716636;6379.202599675041;6136.7852125175405;6152.2002139722445;6205.937940620626;6217.409346112112;6227.221597300338;6181.258249010058;6248.75004999804;6283.528735344776;6319.715612797435;6338.30278669346;5736.71316434185;6040.275166979991;6049.153118563493;6060.2424696912885;6083.847903802441;6021.578489505692;6030.698465076641;6042.577019608585;6042.848928776816;6073.210482637229;5969.522438204846;6258.155149055002;6267.122602835516;6311.400416960381;6369.45859601939;4103.692223083341;4137.97931010355;4142.6892983027;4150.771707556113;4175.352820312856;5860.977962602895;5900.29196496406;6156.415140561639;6157.291911430243;6163.599366041193;5842.649441033382;5890.882182356243;5900.527957763455;5914.290285165807;5920.79277225295;5858.882822343615;5868.530517558671;5908.3500814911185;5917.1715959766525;5927.199828023162;5571.220029195997;5777.595568310178;5815.82552523425;5821.417858214145;5844.707764611838;5869.148973398918;5951.345352011362;5996.790112346047;6027.969860150672;6030.969845150922;5725.914111288251;5728.112142617901;5802.5357971361345;5811.27359080115;5869.911951320819 11:38:12 INFO - PROCESS | 31204 | |5;yui.html;646.5409559212959;664.2129077043707;764.6100488750736;774.9573773442462;817.1052697296462;13791.724165516684;14434.350454229545;14443.566692999213;15229.086254824719;15426.84573154268;13691.041627086108;13857.4457021719;13961.44154233832;13965.650858728537;13982.650433739162;652.3867564489365;728.5373787644858;768.3776141325516;787.9212078792132;791.0902462168494;759.3014426727397;762.904636920385;763.0881097088981;766.7278116268728;769.1116760142045;827.7723626002837;829.7676650537829;833.170994860112;833.6415341403194;833.6623667414707;822.62159406673;823.5799742131496;826.0954255090696;827.584829940799;830.2403300979596;598.377687205306;599.0355527600559;602.2141105856855;604.2446941323345;604.9001914684072;14431.567052988426;14436.855631443656;14478.203698796668;14521;14603.050801697857;13740.725185496334;13793.862061379357;13920.234387108705;14025.368858401396;14141.29293535319;12038.518459261619;12044.21712588679;12111.212771169845;12153.270803751802;12778.808317875239;3866;3879.4180872869297;3906.3163946309282;3915.3148199065336;3980.024893900984;77755;78559.60720196362;79699;79769;79986.60006699988;9999.35004224723;10219.795604087876;10242.231832612584;10926.836097458545;11065.668029959113;19929.402117936486;20177.899110504353;20196;20219.494512637302;20350.79649203489;7896.881546776803;7902.881456778153;7941.0470743509995;7971.641276142472;8312.750617481484;4506.504284528699;4537.296719008559;4640.350350950869;4712.434507859079;4750.928736068961;3323.9667603323655;3383.7293016558615;3394.6775056369606;3415;3421.127612458807;579.5218944370911;597.9282486101608;601.3325209017986;619.4084649160042;638.2532437048665;543.5271313956882;545.0244063127037;615.6767696959042;616.5203709018161;617.962922224668;9322.813543729088;9532.666356677482;9722.805543889224;9925;9934.701958941243;595.8957182493133;632.1907957814005;660.4353277947382;663.1743479368121;678.7556479667315;4440.666949978765;4725.952740472551;4770;4859.878503037452;4869.561739443397;68097.65951170311;68323.3167668327;68443;68655;109874.45062774795;91362.54318728363;93265;93645.5317723407;94077;94459.52770236105;67050.32949670538;85452.57273713716;87438.12561874428;87484.5625771867;87690.56154719186;8665.740027799176;8706.521141337287;8759.255463285692;8784.209421152127;9112.51980982562;49630.50369496259;50913.745431272604;50937;51201.487985119675;51767;48923;62698.05952910619;69591;71379.28620713727;75673;12585.87414125847;12915.289659068842;12951.611451656465;13184.73630527365;13317.267550284827;14415.78376324335;14484.85515144835;14567.90740694431;14743.410263589336;15184.392624294904;14038.859611403755;14624.268786560842;14809.333579989141;15056.473023444127;15064.548063558112;13897.791533127214;14732.813043694303;14749.705005899606;14871.256437178314;14889;13311.201327920357;14059.22674252885;14069.874410047376;14097.154170749787;14448.855511445172;10917.727056823644;10968.667376386442;11370.658880233606;11658.12564057716;11688.123390745897;10924.890751092387;11054.668359949215;11152.55389784432;11291.096712263163;11322.773544529227 11:38:12 INFO - PROCESS | 31204 | __end_tp_report 11:38:12 INFO - PROCESS | 31204 | __start_cc_report 11:38:12 INFO - PROCESS | 31204 | _x_x_mozilla_cycle_collect,372 11:38:12 INFO - PROCESS | 31204 | __end_cc_report 11:38:12 INFO - PROCESS | 31204 | __startTimestamp1466534292600__endTimestamp 11:38:12 INFO - PROCESS | 31204 | 11:38:12 INFO - PROCESS | 31204 | ------- Summary: start ------- 11:38:12 INFO - PROCESS | 31204 | Number of tests: 6 11:38:12 INFO - PROCESS | 31204 | 11:38:12 INFO - PROCESS | 31204 | [#0] dojo.html Cycles:165 Average:5426.40 Median:5662.29 stddev:736.73 (13.0%) stddev-sans-first:715.98 11:38:12 INFO - PROCESS | 31204 | Values: 3097.7 3134.7 3138.6 3141.1 3166.0 5386.3 5396.8 5411.6 5420.5 5492.4 5325.2 5387.8 5443.9 5453.5 5472.6 4906.0 4951.1 5055.0 5093.3 5136.2 520.5 4880.3 4914.2 4950.7 5006.6 4987.5 5018.6 5021.7 5039.6 5044.8 5047.5 5049.9 5059.1 5061.8 5062.1 4907.2 4929.4 4934.3 4952.0 4979.0 5371.3 5443.6 5457.5 5472.7 5518.8 5608.6 5819.2 5892.0 5900.4 5923.0 5924.0 5926.2 5961.4 5994.9 6040.9 5415.0 5479.6 5484.4 5495.2 5565.7 5769.0 5937.4 5945.3 6056.9 6064.3 5797.8 5799.5 5804.0 5820.0 5837.0 5873.9 5875.9 5879.4 5882.4 5902.4 5746.6 5758.9 5775.1 5806.1 5863.3 5742.4 5770.4 5797.9 5807.6 5852.8 4453.5 4456.6 4466.2 4466.3 4489.6 3882.7 3962.9 3966.9 3972.8 4029.8 5657.5 5662.3 5680.7 5682.4 5711.5 5929.3 5934.5 5949.6 5950.4 5955.7 5563.2 5600.6 5623.9 5655.7 5661.9 5076.4 5103.5 5105.4 5109.0 5111.1 6102.6 6148.5 6151.1 6156.7 6174.8 5751.9 5830.2 5860.3 5891.0 5909.9 6012.3 6069.4 6081.1 6086.0 6100.4 5648.8 5781.4 5790.2 5792.2 5808.5 5866.1 5900.9 5914.9 5948.7 5951.9 5744.6 5780.3 5783.1 5789.9 5791.9 5556.6 5682.4 5770.5 5782.5 5791.9 5550.8 5620.2 5625.7 5687.9 5711.3 5752.9 5781.4 5791.5 5820.5 5820.7 5489.8 5589.7 5592.4 5602.8 5604.5 11:38:12 INFO - PROCESS | 31204 | 11:38:12 INFO - PROCESS | 31204 | [#1] ext.html Cycles:180 Average:61340.69 Median:41848.98 stddev:125259.84 (299.3%) stddev-sans-first:125528.17 11:38:12 INFO - PROCESS | 31204 | Values: 588.4 620.5 630.9 636.7 640.1 41724.2 42567.1 43137.8 43218.0 46191.0 43015.4 44030.8 44227.3 44423.8 44579.8 8772.2 8988.3 8993.1 9028.8 9032.3 8886.4 8949.1 9006.9 9017.3 9032.8 9030.1 9042.4 9058.6 9059.2 9065.3 8914.1 8986.1 8995.6 9010.2 9021.1 8873.0 8937.4 8942.7 8946.6 8950.1 41973.8 42028.4 42117.6 42143.4 42373.8 3309.8 3535.9 3553.8 3692.9 3711.2 30378.7 31527.8 31844.4 32293.7 33625.2 4134.6 4234.6 4248.2 4273.0 4306.2 339169.0 339923.0 341547.0 342827.0 343478.0 55974.0 56079.0 56124.7 56145.0 56613.4 34173.3 34808.1 54920.2 55318.7 55689.2 14473.9 14495.3 14518.8 14541.5 14552.1 12274.4 12355.9 12361.1 12454.1 12510.2 18458.1 18516.0 18745.5 18782.5 18805.7 6834.9 7113.7 7167.6 7261.4 7299.9 962.4 1078.8 1135.4 1178.1 1186.3 33355.0 36006.8 36099.8 36308.8 36446.6 980.6 992.9 1012.3 1037.2 1057.7 16858.2 16905.0 16933.7 17022.2 17379.0 548521.0 554276.0 557511.0 558514.0 559783.0 55210.7 55966.7 56266.0 56277.0 57058.4 1306.2 1308.7 1335.9 1362.7 1368.7 31075.4 31875.8 32247.2 32272.7 32576.7 48760.5 49389.3 49637.0 49805.0 50061.2 488288.0 488357.2 491396.0 491689.0 492918.0 27625.3 27653.3 27662.0 27829.0 27909.0 44647.0 46144.3 47733.5 48140.3 48420.5 39002.6 40215.4 40683.6 40978.6 41409.2 37844.2 37950.8 38488.0 39566.2 40453.6 37882.8 38905.0 39148.0 39204.3 39529.0 33805.0 34839.8 34906.5 35299.0 35788.0 27848.3 28082.7 28105.4 28386.4 28494.1 11:38:12 INFO - PROCESS | 31204 | 11:38:12 INFO - PROCESS | 31204 | [#2] jquery.html Cycles:180 Average:28434.39 Median:379.97 stddev:79658.92 (20964.5%) stddev-sans-first:79854.53 11:38:12 INFO - PROCESS | 31204 | Values: 377.0 378.8 381.2 385.4 394.6 16791.1 18104.1 18187.5 18848.5 18889.9 16252.5 17473.7 17512.1 17785.8 17818.6 5570.7 5793.8 5795.2 5822.8 5825.4 4201.7 6462.6 6471.2 6478.9 6515.0 6220.0 6314.2 6493.6 6498.0 6557.2 6253.0 6257.0 6281.7 6304.2 6318.9 5535.0 5539.8 5568.5 5574.4 5604.5 22406.8 22466.1 22910.1 23106.9 23149.7 2242.0 2278.6 2322.7 2969.9 2976.9 14210.5 14255.8 14271.0 14279.8 14974.6 1938.1 1952.9 1960.7 1982.4 2022.0 76200.0 79667.6 80818.2 81089.6 82289.6 9961.3 9975.3 10257.9 10312.1 10527.5 14224.6 14252.9 14286.6 14295.2 14336.6 7482.7 7755.8 7785.0 7989.8 7990.4 7685.1 7689.3 7900.7 7935.4 8015.8 6017.8 6037.4 6100.8 6189.2 6319.3 1844.3 1846.3 1866.2 1883.2 1896.0 986.0 1005.8 1038.0 1042.5 1069.1 19456.8 19656.4 19719.3 19903.0 19968.5 936.7 965.3 977.1 989.2 1057.7 10292.3 11347.5 11551.5 11584.4 11596.1 385230.0 389649.0 498627.0 552778.0 561660.0 61331.4 61550.0 83236.6 93926.5 101423.5 939.9 967.2 977.6 985.1 1050.7 17216.9 17321.5 17739.6 17745.3 17757.7 40770.4 41639.2 42213.4 42512.6 43124.6 59782.7 60257.0 61113.4 61766.4 62106.7 8191.0 8335.4 8529.2 8572.2 8604.2 11691.6 12808.7 13075.9 13361.9 13419.3 11421.2 11505.3 11506.3 11556.1 12149.7 11418.5 11522.9 11596.1 11763.5 11922.5 11206.9 11549.4 11657.9 11844.1 11991.3 7011.6 7595.4 7733.4 7989.6 8628.0 9954.3 11058.6 11369.3 11803.1 12061.5 11:38:12 INFO - PROCESS | 31204 | 11:38:12 INFO - PROCESS | 31204 | [#3] mootools.html Cycles:180 Average:5716.09 Median:2485.58 stddev:3271.36 (131.6%) stddev-sans-first:3263.53 11:38:12 INFO - PROCESS | 31204 | Values: 1277.6 1292.5 1351.3 1707.7 1710.0 7696.3 8186.8 8402.0 8688.8 8698.6 8538.4 8595.9 8596.3 8673.0 8683.1 2280.0 2295.0 2298.7 2323.3 2323.9 2264.5 2270.9 2323.7 2350.6 2356.2 2293.5 2299.2 2305.4 2307.4 2339.1 2228.8 2244.0 2253.2 2256.6 2259.6 2245.5 2251.9 2254.3 2260.2 2270.6 8773.2 8808.9 8816.4 8888.8 8889.6 4927.2 5028.0 5033.4 5045.0 5067.4 3157.0 3191.3 3394.3 3409.6 3439.5 1078.8 1105.7 1110.3 1114.1 1132.9 12187.1 12256.1 12256.3 12277.7 12285.8 4388.1 4407.9 4487.3 4519.2 4539.9 10206.2 10209.6 10259.8 10305.1 10310.6 4968.3 4970.0 4974.8 4993.8 4997.4 4198.3 4417.1 4556.8 4583.1 4613.5 3771.2 3784.9 3835.0 3835.5 4020.4 1215.1 1229.2 1230.7 1237.1 1248.6 963.6 970.8 972.9 1000.7 1016.1 6007.1 6013.2 6027.2 6038.1 6199.3 447.9 448.1 451.9 458.3 466.2 4065.3 4269.7 4272.5 4276.6 4290.3 10386.4 10591.1 10613.7 10626.3 10653.7 9859.8 10497.2 10531.5 10582.5 10608.7 8053.2 8178.5 8208.6 8225.8 8283.9 6011.5 6199.8 6253.6 6291.7 6319.4 9996.5 10014.4 10122.0 10168.1 10168.7 9941.2 9987.2 10379.1 10503.3 10535.4 6934.8 7212.9 7365.8 7535.2 7607.4 8411.5 8435.3 8439.0 8470.2 8526.0 7313.2 7563.2 7579.3 7713.9 7726.0 7271.0 7303.5 7406.4 7434.6 7442.6 7033.0 7034.3 7051.9 7057.3 7141.6 5203.9 5364.3 5425.8 5513.8 5522.6 5321.4 5365.7 5383.8 5535.6 5556.3 11:38:12 INFO - PROCESS | 31204 | 11:38:12 INFO - PROCESS | 31204 | [#4] prototype.html Cycles:180 Average:4866.93 Median:5476.02 stddev:1474.39 (26.9%) stddev-sans-first:1438.25 11:38:12 INFO - PROCESS | 31204 | Values: 306.6 308.1 310.5 320.7 325.5 5468.8 5476.5 5564.3 5688.0 5693.8 5519.6 5569.6 5586.5 5587.6 5602.8 4234.2 4255.4 4261.2 4274.6 4283.8 4170.8 4288.8 4299.4 4319.1 4338.0 4241.9 4244.3 4261.8 4262.3 4284.4 4240.3 4257.1 4266.4 4314.3 4323.2 3632.2 3756.2 3781.1 3803.9 3816.4 5426.8 5453.6 5454.2 5474.7 5475.6 4843.1 4860.6 4864.2 4874.6 4897.1 5532.6 5779.5 5808.0 5830.3 5853.4 4007.9 4019.9 4035.1 4043.8 4046.0 6120.2 6125.5 6126.7 6144.4 6145.9 3948.8 4025.2 4031.4 4046.5 4160.4 4172.5 4202.3 4205.3 4216.5 4238.7 4837.5 4847.8 4877.0 4882.9 4890.2 5247.9 5869.5 5919.0 5925.9 5945.1 1421.6 1447.4 1450.2 1453.1 1453.8 839.2 881.9 895.4 909.0 915.6 5025.5 5025.6 5027.7 5079.8 5103.7 5296.6 5349.9 5383.4 5440.9 5441.4 5032.1 5075.4 5079.3 5288.4 5747.7 3183.5 3238.7 3246.0 3251.9 3258.6 6042.6 6234.7 6310.6 6351.8 6379.2 6136.8 6152.2 6205.9 6217.4 6227.2 6181.3 6248.8 6283.5 6319.7 6338.3 5736.7 6040.3 6049.2 6060.2 6083.8 6021.6 6030.7 6042.6 6042.8 6073.2 5969.5 6258.2 6267.1 6311.4 6369.5 4103.7 4138.0 4142.7 4150.8 4175.4 5861.0 5900.3 6156.4 6157.3 6163.6 5842.6 5890.9 5900.5 5914.3 5920.8 5858.9 5868.5 5908.4 5917.2 5927.2 5571.2 5777.6 5815.8 5821.4 5844.7 5869.1 5951.3 5996.8 6028.0 6031.0 5725.9 5728.1 5802.5 5811.3 5869.9 11:38:12 INFO - PROCESS | 31204 | 11:38:12 INFO - PROCESS | 31204 | [#5] yui.html Cycles:180 Average:19211.46 Median:49276.75 stddev:26347.05 (53.5%) stddev-sans-first:26384.08 11:38:12 INFO - PROCESS | 31204 | Values: 646.5 664.2 764.6 775.0 817.1 13791.7 14434.4 14443.6 15229.1 15426.8 13691.0 13857.4 13961.4 13965.7 13982.7 652.4 728.5 768.4 787.9 791.1 759.3 762.9 763.1 766.7 769.1 827.8 829.8 833.2 833.6 833.7 822.6 823.6 826.1 827.6 830.2 598.4 599.0 602.2 604.2 604.9 14431.6 14436.9 14478.2 14521.0 14603.1 13740.7 13793.9 13920.2 14025.4 14141.3 12038.5 12044.2 12111.2 12153.3 12778.8 3866.0 3879.4 3906.3 3915.3 3980.0 77755.0 78559.6 79699.0 79769.0 79986.6 9999.4 10219.8 10242.2 10926.8 11065.7 19929.4 20177.9 20196.0 20219.5 20350.8 7896.9 7902.9 7941.0 7971.6 8312.8 4506.5 4537.3 4640.4 4712.4 4750.9 3324.0 3383.7 3394.7 3415.0 3421.1 579.5 597.9 601.3 619.4 638.3 543.5 545.0 615.7 616.5 618.0 9322.8 9532.7 9722.8 9925.0 9934.7 595.9 632.2 660.4 663.2 678.8 4440.7 4726.0 4770.0 4859.9 4869.6 68097.7 68323.3 68443.0 68655.0 109874.5 91362.5 93265.0 93645.5 94077.0 94459.5 67050.3 85452.6 87438.1 87484.6 87690.6 8665.7 8706.5 8759.3 8784.2 9112.5 49630.5 50913.7 50937.0 51201.5 51767.0 48923.0 62698.1 69591.0 71379.3 75673.0 12585.9 12915.3 12951.6 13184.7 13317.3 14415.8 14484.9 14567.9 14743.4 15184.4 14038.9 14624.3 14809.3 15056.5 15064.5 13897.8 14732.8 14749.7 14871.3 14889.0 13311.2 14059.2 14069.9 14097.2 14448.9 10917.7 10968.7 11370.7 11658.1 11688.1 10924.9 11054.7 11152.6 11291.1 11322.8 11:38:12 INFO - PROCESS | 31204 | -------- Summary: end -------- 11:38:12 INFO - PROCESS | 31204 | 11:38:13 INFO - TEST-INFO | 31204: exit 0 11:38:13 INFO - TEST-OK | dromaeo_css | took 1110461ms 11:38:13 INFO - TEST-START | kraken 11:38:13 INFO - operating with platform_type : linux_ 11:38:13 INFO - Initialising browser for kraken test... 11:38:13 INFO - TEST-INFO | started process 31437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yG4TC/profile http://localhost:34937/getInfo.html) 11:38:17 INFO - PROCESS | 31437 | __metrics Screen width/height:1600/1200 11:38:17 INFO - PROCESS | 31437 | colorDepth:24 11:38:17 INFO - PROCESS | 31437 | Browser inner width/height: 1024/697 11:38:17 INFO - PROCESS | 31437 | __metrics 11:38:17 ERROR - PROCESS | 31437 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:38:18 INFO - TEST-INFO | 31437: exit 0 11:38:18 INFO - Browser initialized. 11:38:18 INFO - Running cycle 1/1 for kraken test... 11:38:18 INFO - TEST-INFO | started process 31557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4yG4TC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:30 INFO - PROCESS | 31557 | RSS: Main: 184377344 11:38:30 INFO - PROCESS | 31557 | 11:38:33 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34937/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:34 INFO - PROCESS | 31557 | RSS: Main: 190324736 11:38:34 INFO - PROCESS | 31557 | 11:38:36 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34937/tests/kraken/driver.html?testName=audio-dft) 11:38:37 INFO - PROCESS | 31557 | RSS: Main: 189169664 11:38:37 INFO - PROCESS | 31557 | 11:38:40 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34937/tests/kraken/driver.html?testName=audio-fft) 11:38:41 INFO - PROCESS | 31557 | RSS: Main: 184864768 11:38:41 INFO - PROCESS | 31557 | 11:38:43 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34937/tests/kraken/driver.html?testName=audio-oscillator) 11:38:43 INFO - PROCESS | 31557 | RSS: Main: 185655296 11:38:43 INFO - PROCESS | 31557 | 11:38:45 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34937/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:46 INFO - PROCESS | 31557 | RSS: Main: 186064896 11:38:46 INFO - PROCESS | 31557 | 11:38:49 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34937/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:50 INFO - PROCESS | 31557 | RSS: Main: 185675776 11:38:50 INFO - PROCESS | 31557 | 11:38:53 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34937/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:54 INFO - PROCESS | 31557 | RSS: Main: 184057856 11:38:54 INFO - PROCESS | 31557 | 11:38:57 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34937/tests/kraken/driver.html?testName=json-parse-financial) 11:38:57 INFO - PROCESS | 31557 | RSS: Main: 184995840 11:38:57 INFO - PROCESS | 31557 | 11:38:59 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34937/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:39:00 INFO - PROCESS | 31557 | RSS: Main: 185831424 11:39:00 INFO - PROCESS | 31557 | 11:39:01 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:39:02 INFO - PROCESS | 31557 | RSS: Main: 185798656 11:39:02 INFO - PROCESS | 31557 | 11:39:04 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:39:05 INFO - PROCESS | 31557 | RSS: Main: 185733120 11:39:05 INFO - PROCESS | 31557 | 11:39:07 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:39:08 INFO - PROCESS | 31557 | RSS: Main: 185184256 11:39:08 INFO - PROCESS | 31557 | 11:39:11 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:39:11 INFO - PROCESS | 31557 | RSS: Main: 185663488 11:39:11 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | Cycle 1(1): loaded http://localhost:34937/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34937/tests/kraken/driver.html?testName=ai-astar) 11:39:13 INFO - PROCESS | 31557 | RSS: Main: 186613760 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | __start_tp_report 11:39:13 INFO - PROCESS | 31557 | _x_x_mozilla_page_load 11:39:13 INFO - PROCESS | 31557 | _x_x_mozilla_page_load_details 11:39:13 INFO - PROCESS | 31557 | |i|pagename|runs| 11:39:13 INFO - PROCESS | 31557 | |0;ai-astar;113;107;111;111;114;115;111;112;111;114 11:39:13 INFO - PROCESS | 31557 | |1;audio-beat-detection;153;128;163;167;127;156;153;130;197;142 11:39:13 INFO - PROCESS | 31557 | |2;audio-dft;166;169;164;162;166;171;162;163;162;162 11:39:13 INFO - PROCESS | 31557 | |3;audio-fft;76;77;77;157;77;76;76;75;177;76 11:39:13 INFO - PROCESS | 31557 | |4;audio-oscillator;86;86;160;85;86;86;138;86;85;139 11:39:13 INFO - PROCESS | 31557 | |5;imaging-gaussian-blur;119;118;118;118;118;117;117;118;118;117 11:39:13 INFO - PROCESS | 31557 | |6;imaging-darkroom;149;147;147;147;148;149;148;148;147;147 11:39:13 INFO - PROCESS | 31557 | |7;imaging-desaturate;96;96;96;96;95;96;96;97;96;95 11:39:13 INFO - PROCESS | 31557 | |8;json-parse-financial;52;56;53;53;54;53;56;54;54;53 11:39:13 INFO - PROCESS | 31557 | |9;json-stringify-tinderbox;68;61;63;62;63;62;62;61;61;62 11:39:13 INFO - PROCESS | 31557 | |10;stanford-crypto-aes;81;80;81;80;82;81;86;88;108;81 11:39:13 INFO - PROCESS | 31557 | |11;stanford-crypto-ccm;137;135;127;121;134;124;134;124;143;134 11:39:13 INFO - PROCESS | 31557 | |12;stanford-crypto-pbkdf2;163;163;163;164;167;166;163;161;163;165 11:39:13 INFO - PROCESS | 31557 | |13;stanford-crypto-sha256-iterative;66;65;64;66;65;65;65;64;65;66 11:39:13 INFO - PROCESS | 31557 | __end_tp_report 11:39:13 INFO - PROCESS | 31557 | __start_cc_report 11:39:13 INFO - PROCESS | 31557 | _x_x_mozilla_cycle_collect,891 11:39:13 INFO - PROCESS | 31557 | __end_cc_report 11:39:13 INFO - PROCESS | 31557 | __startTimestamp1466534353835__endTimestamp 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | ------- Summary: start ------- 11:39:13 INFO - PROCESS | 31557 | Number of tests: 14 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:2.28 (2.0%) stddev-sans-first:2.39 11:39:13 INFO - PROCESS | 31557 | Values: 113.0 107.0 111.0 111.0 114.0 115.0 111.0 112.0 111.0 114.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:154.50 stddev:21.53 (13.9%) stddev-sans-first:22.83 11:39:13 INFO - PROCESS | 31557 | Values: 153.0 128.0 163.0 167.0 127.0 156.0 153.0 130.0 197.0 142.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:3.23 (2.0%) stddev-sans-first:3.40 11:39:13 INFO - PROCESS | 31557 | Values: 166.0 169.0 164.0 162.0 166.0 171.0 162.0 163.0 162.0 162.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:38.56 (50.7%) stddev-sans-first:40.32 11:39:13 INFO - PROCESS | 31557 | Values: 76.0 77.0 77.0 157.0 77.0 76.0 76.0 75.0 177.0 76.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:86.00 stddev:29.55 (34.4%) stddev-sans-first:30.64 11:39:13 INFO - PROCESS | 31557 | Values: 86.0 86.0 160.0 85.0 86.0 86.0 138.0 86.0 85.0 139.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 11:39:13 INFO - PROCESS | 31557 | Values: 119.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 11:39:13 INFO - PROCESS | 31557 | Values: 149.0 147.0 147.0 147.0 148.0 149.0 148.0 148.0 147.0 147.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 11:39:13 INFO - PROCESS | 31557 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 95.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.32 (2.4%) stddev-sans-first:1.22 11:39:13 INFO - PROCESS | 31557 | Values: 52.0 56.0 53.0 53.0 54.0 53.0 56.0 54.0 54.0 53.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:2.07 (3.3%) stddev-sans-first:0.78 11:39:13 INFO - PROCESS | 31557 | Values: 68.0 61.0 63.0 62.0 63.0 62.0 62.0 61.0 61.0 62.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:81.00 stddev:8.57 (10.6%) stddev-sans-first:8.98 11:39:13 INFO - PROCESS | 31557 | Values: 81.0 80.0 81.0 80.0 82.0 81.0 86.0 88.0 108.0 81.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:134.00 stddev:6.96 (5.2%) stddev-sans-first:7.07 11:39:13 INFO - PROCESS | 31557 | Values: 137.0 135.0 127.0 121.0 134.0 124.0 134.0 124.0 143.0 134.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:163.50 stddev:1.75 (1.1%) stddev-sans-first:1.83 11:39:13 INFO - PROCESS | 31557 | Values: 163.0 163.0 163.0 164.0 167.0 166.0 163.0 161.0 163.0 165.0 11:39:13 INFO - PROCESS | 31557 | 11:39:13 INFO - PROCESS | 31557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 11:39:13 INFO - PROCESS | 31557 | Values: 66.0 65.0 64.0 66.0 65.0 65.0 65.0 64.0 65.0 66.0 11:39:13 INFO - PROCESS | 31557 | -------- Summary: end -------- 11:39:13 INFO - PROCESS | 31557 | 11:39:14 INFO - TEST-INFO | 31557: exit 0 11:39:14 INFO - TEST-OK | kraken | took 61463ms 11:39:14 INFO - SUITE-END | took 1171s 11:39:14 INFO - Completed test suite (00:19:32) 11:39:14 INFO - javascript benchmark 11:39:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7221.868276056413, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.705717956794, 3134.717875391216, 3138.623365196177, 3141.073383351911, 3165.9999999999986, 5386.2997810284705, 5396.784128634855, 5411.567074634029, 5420.5392541633955, 5492.368377636573, 5325.174597937326, 5387.78448862046, 5443.945560544394, 5453.509184173424, 5472.616916815825, 4905.975470122653, 4951.0592987332475, 5054.974725126369, 5093.286939828427, 5136.152534831748, 520.4912994895863, 4880.341153944208, 4914.213725803872, 4950.727709975949, 5006.624503162259, 4987.526185012418, 5018.5985121190215, 5021.723805190713, 5039.647224694273, 5044.798208071673, 5047.49525047496, 5049.924251136236, 5059.064073146443, 5061.822836200752, 5062.139436295838, 4907.190313598252, 4929.383827021622, 4934.25986102084, 4951.960088381445, 4978.9751051244875, 5371.301730775013, 5443.646162999393, 5457.508824205801, 5472.699001554913, 5518.751656175442, 5608.6073974821775, 5819.243498345188, 5892.0, 5900.409959004108, 5923.0, 5924.0, 5926.199963004982, 5961.433663801932, 5994.940050599482, 6040.879182416371, 5414.972925135388, 5479.643823151482, 5484.369297530795, 5495.203195536625, 5565.721713914329, 5769.048107062287, 5937.376575459601, 5945.256842894638, 6056.878862422727, 6064.302605200371, 5797.826065218051, 5799.4780469757925, 5803.970980145156, 5820.0, 5836.970815145897, 5873.882522349614, 5875.9118613220835, 5879.353271140171, 5882.441168089024, 5902.3507414184405, 5746.597738158289, 5758.913616295759, 5775.133729940542, 5806.1000544915605, 5863.296404431496, 5742.425757424224, 5770.440722653338, 5797.855053623609, 5807.622504537191, 5852.7658893643775, 4453.487848897354, 4456.5766252205985, 4466.2407390743, 4466.330050492452, 4489.6408287336935, 3882.6893848492055, 3962.9405558916637, 3966.861159859391, 3972.781497017634, 4029.7985100744845, 5657.4908258256955, 5662.292213473316, 5680.715964201773, 5682.403347648437, 5711.457411545896, 5929.347771745104, 5934.495567876693, 5949.613275137102, 5950.375210602911, 5955.672438015864, 5563.248961390242, 5600.551955843523, 5623.915641265385, 5655.745491452894, 5661.886762264731, 5076.416212135578, 5103.464136265713, 5105.387353517602, 5109.0, 5111.131107711698, 6102.633841969496, 6148.538859585549, 6151.138840562325, 6156.6921653918025, 6174.8147555573405, 5751.85620359486, 5830.183774271521, 5860.326062502867, 5890.970545147418, 5909.852253693692, 6012.3386427493815, 6069.423404776539, 6081.087836824335, 6085.969570152298, 6100.389961003864, 5648.830535083954, 5781.364049954585, 5790.1893734877995, 5792.247007889116, 5808.5353171747, 5866.149408335682, 5900.940990590211, 5914.940850591439, 5948.702564871825, 5951.940480595312, 5744.626599271034, 5780.306363236438, 5783.132530120515, 5789.884202316014, 5791.855203619774, 5556.555475561864, 5682.431756824284, 5770.451807078321, 5782.45066718661, 5791.8552036199435, 5550.750216240198, 5620.1569764534015, 5625.746841392229, 5687.8862422752145, 5711.343195532567, 5752.942470575241, 5781.364049954417, 5791.478766910998, 5820.534357251495, 5820.73806678692, 5489.752961116679, 5589.664620122806, 5592.412796656293, 5602.775888964396, 5604.495595396434], "value": 5377.390973417428, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.4351023017903, 620.4571000374672, 630.8801327747731, 636.6784773689286, 640.1486023588627, 41724.165516689645, 42567.14865702692, 43137.78431107844, 43218.0, 46191.0, 43015.35476967848, 44030.779846100726, 44227.33658995118, 44423.77788111063, 44579.77710111445, 8772.210501054904, 8988.280937524982, 8993.10068993102, 9028.819423611523, 9032.322575806807, 8886.377953543255, 8949.149830766068, 9006.86489702655, 9017.278617710568, 9032.819343613124, 9030.051844556292, 9042.367034307601, 9058.592363343665, 9059.229965452945, 9065.32010099242, 8914.108589141098, 8986.14631609996, 8995.64017439305, 9010.189082982497, 9021.097890210993, 8873.0, 8937.374383793072, 8942.73171804847, 8946.59740311681, 8950.06024367445, 41973.79013104915, 42028.36957445641, 42117.57882421198, 42143.367849481976, 42373.78813105945, 3309.7683162178655, 3535.8762443314617, 3553.822308884571, 3692.9076773080888, 3711.164987877733, 30378.69621303781, 31527.84236078828, 31844.363112737847, 32293.6770632293, 33625.159371015674, 4134.64855487284, 4234.5765423457715, 4248.214080395106, 4273.0, 4306.224879521685, 339169.0415479216, 339923.0, 341547.0, 342826.9999999975, 343478.0, 55974.0, 56079.0, 56124.719376402856, 56145.0, 56613.433865660816, 34173.316533669684, 34808.12979675478, 54920.17619735707, 55318.72340638351, 55689.16466253009, 14473.92763036178, 14495.347709353104, 14518.782218266524, 14541.491047813488, 14552.054116482395, 12274.447649855778, 12355.876441235472, 12361.134720569653, 12454.128211025141, 12510.18683785551, 18458.077096145138, 18516.0, 18745.53136171579, 18782.530436738918, 18805.717914231296, 6834.897476537856, 7113.7154513819905, 7167.605781681953, 7261.41908647307, 7299.89050164248, 962.4417837654144, 1078.7572796120967, 1135.4095870147478, 1178.116412690482, 1186.3119390753343, 33355.0, 36006.75939165488, 36099.81950090285, 36308.81845590755, 36446.63553364432, 980.6028558433845, 992.8709267795141, 1012.2559918459926, 1037.190991026985, 1057.7302787789217, 16858.157092145342, 16905.0, 16933.745993810102, 17022.233999470052, 17379.0, 548521.0, 554276.0, 557511.0, 558514.0, 559783.0, 55210.723946380815, 55966.72016639891, 56266.0, 56277.0, 57058.429415706145, 1306.1705816806395, 1308.6989992301633, 1335.9265240411676, 1362.734266817961, 1368.6852024034529, 31075.37849243048, 31875.840620797677, 32247.193820154684, 32272.677273226967, 32576.674233257363, 48760.51239487559, 49389.25916111333, 49637.0, 49805.0, 50061.24908126454, 488288.0, 488357.23285534803, 491396.0, 491689.0, 492918.0, 27625.309367265978, 27653.30866728348, 27662.0, 27829.0, 27909.0, 44647.0, 46144.30783538183, 47733.5226647743, 48140.27789583229, 48420.5157948416, 39002.6099738999, 40215.396769049075, 40683.59316406916, 40978.59021409748, 41409.1718165641, 37844.24311513699, 37950.77418419355, 38488.0, 39566.2086758269, 40453.59546404616, 37882.81058594689, 38905.0, 39148.0, 39204.252960044534, 39529.0, 33805.0, 34839.825800870836, 34906.47640285449, 35298.97071175444, 35788.0, 27848.303792404542, 28082.71917280801, 28105.43789124165, 28386.43227135487, 28494.147880387707], "value": 19859.847749207118, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.9962300376996, 378.76895093992664, 381.1709531768403, 385.3949299599628, 394.63496265954024, 16791.076490793002, 18104.09479526022, 18187.454376368714, 18848.5287867803, 18889.905550472246, 16252.51242462725, 17473.650526989484, 17512.124393780323, 17785.82214177861, 17818.554536136602, 5570.6657600543995, 5793.826185214451, 5795.1886735857015, 5822.767089316422, 5825.417458254183, 4201.7478951262865, 6462.579932304385, 6471.223453185625, 6478.902816457757, 6515.0, 6220.004799232123, 6314.179156709644, 6493.577917435376, 6498.025296205584, 6557.245916719567, 6253.0, 6257.0, 6281.7173227204885, 6304.243490781089, 6318.936810631903, 5535.0, 5539.750711218005, 5568.52667523261, 5574.358948720908, 5604.495595396434, 22406.775932240795, 22466.101355945906, 22910.083596656114, 23106.884465577732, 23149.652755208685, 2241.9775802241934, 2278.612635851909, 2322.674825524428, 2969.8663560139844, 2976.895808646687, 14210.502632407919, 14255.786163207456, 14271.0, 14279.78580321296, 14974.550763477004, 1938.1181562389079, 1952.9218831246733, 1960.7454793923675, 1982.3656429942423, 2021.9890054972514, 76200.0, 79667.60166199131, 80818.19181808166, 81089.59455202686, 82289.58855205686, 9961.252906031932, 9975.25185611082, 10257.897421025844, 10312.123469505175, 10527.473626318653, 14224.644383890485, 14252.857471425154, 14286.571402857931, 14295.213763242913, 14336.641583960485, 7482.738104166328, 7755.844883102306, 7785.0, 7989.800254993555, 7990.4007199460275, 7685.116211635622, 7689.346405555479, 7900.723474678359, 7935.444518883738, 8015.7595272141925, 6017.849553761191, 6037.396260374016, 6100.816975490742, 6189.164462797555, 6319.33646967071, 1844.2807305151002, 1846.2944929149257, 1866.178881292227, 1883.1902282018864, 1895.9620807584047, 985.9605615775432, 1005.7535903703639, 1037.9896201038043, 1042.4735508568124, 1069.0912724184536, 19456.805431945784, 19656.410307690792, 19719.30982415637, 19903.0, 19968.50078748043, 936.733328377075, 965.2953344058736, 977.0620204603518, 989.1641562879355, 1057.7038429239826, 10292.330998485075, 11347.489362978686, 11551.537938482366, 11584.362860042778, 11596.072314214842, 385230.0, 389649.0, 498627.0, 552778.0, 561660.0, 61331.386686132566, 61550.0, 83236.58381708052, 93926.53036734773, 101423.4928825366, 939.9295052871062, 967.2455484721928, 977.628501169551, 985.0641890204191, 1050.669039252633, 17216.920299200592, 17321.480355589352, 17739.645207096044, 17745.290188392835, 17757.73363399576, 40770.38844417396, 41639.16721665489, 42213.366799498646, 42512.57487425086, 43124.56875431206, 59782.701086494286, 60257.0, 61113.388866112546, 61766.382336176066, 62106.689466554184, 8191.0, 8335.374846886387, 8529.232369086812, 8572.228499435081, 8604.182602652738, 11691.649250522498, 12808.679783005127, 13075.934620326838, 13361.866381336062, 13419.329033548478, 11421.200515963803, 11505.309681419141, 11506.252093613888, 11556.075513958695, 12149.69625759363, 11418.543258269576, 11522.884771152181, 11596.072314215011, 11763.470643820878, 11922.523099076287, 11206.943965280121, 11549.42252887369, 11657.941710291394, 11844.111691623335, 11991.340476273888, 7011.579305241702, 7595.392368610608, 7733.419993500623, 7989.600519974094, 8627.95686021566, 9954.25343099256, 11058.557657693602, 11369.2609980351, 11803.055755539364, 12061.457234424648], "value": 9301.79461838919, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.5847849448926, 1292.5411478924982, 1351.3310911099002, 1707.7182264926287, 1709.982900170998, 7696.268854458832, 8186.836263274731, 8401.957990210056, 8688.826223475535, 8698.608562614681, 8538.359623028282, 8595.91404085959, 8596.3122950164, 8673.0, 8683.088275731036, 2279.988600057006, 2295.047555264563, 2298.7241531016302, 2323.3030090972725, 2323.9419014524688, 2264.501809601885, 2270.920517781878, 2323.721153461587, 2350.6239001759723, 2356.2460012795914, 2293.5183611441616, 2299.1952816514254, 2305.3775480620225, 2307.4116100394376, 2339.0526836631193, 2228.7882651148116, 2243.9663405048773, 2253.1550668499394, 2256.616375216217, 2259.6271615183473, 2245.517213799025, 2251.898664560099, 2254.3237028891267, 2260.242818655736, 2270.591293567157, 8773.166549177819, 8808.867866982, 8816.382853200279, 8888.822223555493, 8889.644414223423, 4927.236278376858, 5027.99440111979, 5033.370828646419, 5044.974775126101, 5067.442581316052, 3156.9842150789327, 3191.3457741163006, 3394.2871996880685, 3409.5567576214935, 3439.518467414564, 1078.8219943709278, 1105.657246253664, 1110.272771334777, 1114.0808832713044, 1132.943352832355, 12187.146899717023, 12256.08079394049, 12256.264624122581, 12277.69305767354, 12285.815712764315, 4388.078503514298, 4407.9338809917235, 4487.259602165672, 4519.231730605805, 4539.909201815945, 10206.234532410099, 10209.591616335263, 10259.846102308471, 10305.072543471124, 10310.639127630497, 4968.30443737877, 4970.030843985461, 4974.825881094144, 4993.80024799004, 4997.425296090996, 4198.349255865346, 4417.1386579616665, 4556.794944227518, 4583.129205450954, 4613.515580864028, 3771.2268984858038, 3784.9432258516144, 3834.9808250958567, 3835.463035175078, 4020.4170395292517, 1215.0947544079718, 1229.1887354346088, 1230.6615680687883, 1237.1154624443566, 1248.5754843353122, 963.604921981984, 970.8058388322364, 972.941623502578, 1000.7498125468633, 1016.1413605503337, 6007.068904319837, 6013.248343957005, 6027.246594175728, 6038.094285857156, 6199.318075011745, 447.94848592411637, 448.09932036606654, 451.9276915693539, 458.3239721410892, 466.1562571745152, 4065.329220678555, 4269.7224680395675, 4272.5086615039045, 4276.5723427656985, 4290.2706539888295, 10386.42874641887, 10591.099756520782, 10613.734656633645, 10626.256162068736, 10653.73365665849, 9859.753506162404, 10497.2127090467, 10531.52608132636, 10582.470876456146, 10608.681739547827, 8053.234942680436, 8178.5092894426525, 8208.630611622491, 8225.79435514105, 8283.917160828436, 6011.519078473799, 6199.814005579839, 6253.562250642593, 6291.748330066746, 6319.431251187415, 9996.500174991366, 10014.39913605186, 10122.038406351385, 10168.084872361524, 10168.745781355525, 9941.204703623549, 9987.201023918215, 10379.11777498921, 10503.264771465923, 10535.42055186972, 6934.826629334307, 7212.8918066228, 7365.8158546036775, 7535.171131175457, 7607.35337496319, 8411.45325553837, 8435.325173985944, 8439.0, 8470.15298470148, 8525.95737021311, 7313.195548489555, 7563.205863384485, 7579.317861392501, 7713.884291735516, 7725.961370193113, 7271.0, 7303.488755787044, 7406.370458511087, 7434.59109748969, 7442.590657513889, 7032.964835175791, 7034.261402552658, 7051.858962820817, 7057.258987806206, 7141.64291785419, 5203.947960520346, 5364.275822763877, 5425.810096646598, 5513.7794488221625, 5522.6134170609275, 5321.414644389191, 5365.710563867027, 5383.81156659515, 5535.584831137761, 5556.305461817273], "value": 4491.7101764962545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.63204155013983, 308.08191589064575, 310.5248969077311, 320.7337909535086, 325.4776084384563, 5468.7578092981885, 5476.479734425233, 5564.276644036279, 5688.03303438416, 5693.772249110036, 5519.641223320491, 5569.610127291091, 5586.497215250627, 5587.580931430139, 5602.7758889644465, 4234.153169366124, 4255.382969469425, 4261.169072030955, 4274.615284624383, 4283.764392958394, 4170.77060761658, 4288.828446862121, 4299.4195783569285, 4319.114581510783, 4337.978310108445, 4241.939515121219, 4244.299690551071, 4261.8082186301535, 4262.339337402707, 4284.378765079062, 4240.300350442173, 4257.106007738379, 4266.424032755569, 4314.309710446313, 4323.200207961537, 3632.20091579852, 3756.211195648917, 3781.111438811877, 3803.9429408558894, 3816.4084566892175, 5426.8371948841595, 5453.590980676426, 5454.154606036071, 5474.671519708831, 5475.561955043587, 4843.07981483517, 4860.562549370574, 4864.173090574575, 4874.634402419832, 4897.1146108748035, 5532.612717109804, 5779.537636989031, 5808.0, 5830.32951210612, 5853.414658534155, 4007.8998025049314, 4019.8995025124605, 4035.1122752994293, 4043.8070769122887, 4046.046386138136, 6120.234970628671, 6125.509959203253, 6126.693665316717, 6144.38556144382, 6145.877082458371, 3948.763074215556, 4025.154717509356, 4031.4355990161403, 4046.473958385391, 4160.355144952538, 4172.457580514514, 4202.2646036943415, 4205.327147656421, 4216.494020717533, 4238.686007337735, 4837.516248375135, 4847.8365192353585, 4877.0, 4882.902341953141, 4890.1931181355385, 5247.947520524822, 5869.530437564985, 5918.970405147947, 5925.911111333334, 5945.078512830518, 1421.5664222412056, 1447.4065633090383, 1450.180647933935, 1453.0772959171002, 1453.8328092269312, 839.1650307943635, 881.8721285413708, 895.3911340288666, 909.0409617853096, 915.5788337364887, 5025.4974502550185, 5025.572826309732, 5027.673201241908, 5079.847604571869, 5103.70333349994, 5296.563580752897, 5349.946500535023, 5383.353997520323, 5440.891182176413, 5441.428649991773, 5032.0690672225755, 5075.390953085654, 5079.339685840817, 5288.391834938954, 5747.741351639186, 3183.4906414973493, 3238.6599407061917, 3246.0361481303944, 3251.902442926716, 3258.576385069926, 6042.577019608585, 6234.657093859791, 6310.6213627182515, 6351.809445716636, 6379.202599675041, 6136.7852125175405, 6152.2002139722445, 6205.937940620626, 6217.409346112112, 6227.221597300338, 6181.258249010058, 6248.75004999804, 6283.528735344776, 6319.715612797435, 6338.30278669346, 5736.71316434185, 6040.275166979991, 6049.153118563493, 6060.2424696912885, 6083.847903802441, 6021.578489505692, 6030.698465076641, 6042.577019608585, 6042.848928776816, 6073.210482637229, 5969.522438204846, 6258.155149055002, 6267.122602835516, 6311.400416960381, 6369.45859601939, 4103.692223083341, 4137.97931010355, 4142.6892983027, 4150.771707556113, 4175.352820312856, 5860.977962602895, 5900.29196496406, 6156.415140561639, 6157.291911430243, 6163.599366041193, 5842.649441033382, 5890.882182356243, 5900.527957763455, 5914.290285165807, 5920.79277225295, 5858.882822343615, 5868.530517558671, 5908.3500814911185, 5917.1715959766525, 5927.199828023162, 5571.220029195997, 5777.595568310178, 5815.82552523425, 5821.417858214145, 5844.707764611838, 5869.148973398918, 5951.345352011362, 5996.790112346047, 6027.969860150672, 6030.969845150922, 5725.914111288251, 5728.112142617901, 5802.5357971361345, 5811.27359080115, 5869.911951320819], "value": 4381.37970097547, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.5409559212959, 664.2129077043707, 764.6100488750736, 774.9573773442462, 817.1052697296462, 13791.724165516684, 14434.350454229545, 14443.566692999213, 15229.086254824719, 15426.84573154268, 13691.041627086108, 13857.4457021719, 13961.44154233832, 13965.650858728537, 13982.650433739162, 652.3867564489365, 728.5373787644858, 768.3776141325516, 787.9212078792132, 791.0902462168494, 759.3014426727397, 762.904636920385, 763.0881097088981, 766.7278116268728, 769.1116760142045, 827.7723626002837, 829.7676650537829, 833.170994860112, 833.6415341403194, 833.6623667414707, 822.62159406673, 823.5799742131496, 826.0954255090696, 827.584829940799, 830.2403300979596, 598.377687205306, 599.0355527600559, 602.2141105856855, 604.2446941323345, 604.9001914684072, 14431.567052988426, 14436.855631443656, 14478.203698796668, 14521.0, 14603.050801697857, 13740.725185496334, 13793.862061379357, 13920.234387108705, 14025.368858401396, 14141.29293535319, 12038.518459261619, 12044.21712588679, 12111.212771169845, 12153.270803751802, 12778.808317875239, 3866.0, 3879.4180872869297, 3906.3163946309282, 3915.3148199065336, 3980.024893900984, 77755.0, 78559.60720196362, 79699.0, 79769.0, 79986.60006699988, 9999.35004224723, 10219.795604087876, 10242.231832612584, 10926.836097458545, 11065.668029959113, 19929.402117936486, 20177.899110504353, 20196.0, 20219.494512637302, 20350.79649203489, 7896.881546776803, 7902.881456778153, 7941.0470743509995, 7971.641276142472, 8312.750617481484, 4506.504284528699, 4537.296719008559, 4640.350350950869, 4712.434507859079, 4750.928736068961, 3323.9667603323655, 3383.7293016558615, 3394.6775056369606, 3415.0, 3421.127612458807, 579.5218944370911, 597.9282486101608, 601.3325209017986, 619.4084649160042, 638.2532437048665, 543.5271313956882, 545.0244063127037, 615.6767696959042, 616.5203709018161, 617.962922224668, 9322.813543729088, 9532.666356677482, 9722.805543889224, 9925.0, 9934.701958941243, 595.8957182493133, 632.1907957814005, 660.4353277947382, 663.1743479368121, 678.7556479667315, 4440.666949978765, 4725.952740472551, 4770.0, 4859.878503037452, 4869.561739443397, 68097.65951170311, 68323.3167668327, 68443.0, 68655.0, 109874.45062774795, 91362.54318728363, 93265.0, 93645.5317723407, 94077.0, 94459.52770236105, 67050.32949670538, 85452.57273713716, 87438.12561874428, 87484.5625771867, 87690.56154719186, 8665.740027799176, 8706.521141337287, 8759.255463285692, 8784.209421152127, 9112.51980982562, 49630.50369496259, 50913.745431272604, 50937.0, 51201.487985119675, 51767.0, 48923.0, 62698.05952910619, 69591.0, 71379.28620713727, 75673.0, 12585.87414125847, 12915.289659068842, 12951.611451656465, 13184.73630527365, 13317.267550284827, 14415.78376324335, 14484.85515144835, 14567.90740694431, 14743.410263589336, 15184.392624294904, 14038.859611403755, 14624.268786560842, 14809.333579989141, 15056.473023444127, 15064.548063558112, 13897.791533127214, 14732.813043694303, 14749.705005899606, 14871.256437178314, 14889.0, 13311.201327920357, 14059.22674252885, 14069.874410047376, 14097.154170749787, 14448.855511445172, 10917.727056823644, 10968.667376386442, 11370.658880233606, 11658.12564057716, 11688.123390745897, 10924.890751092387, 11054.668359949215, 11152.55389784432, 11291.096712263163, 11322.773544529227], "value": 7256.318395000051, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 111.0, 111.0, 114.0, 115.0, 111.0, 112.0, 111.0, 114.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 163.0, 167.0, 127.0, 156.0, 153.0, 130.0, 197.0, 142.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 164.0, 162.0, 166.0, 171.0, 162.0, 163.0, 162.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 157.0, 77.0, 76.0, 76.0, 75.0, 177.0, 76.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 160.0, 85.0, 86.0, 86.0, 138.0, 86.0, 85.0, 139.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 149.0, 148.0, 148.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 56.0, 53.0, 53.0, 54.0, 53.0, 56.0, 54.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 61.0, 63.0, 62.0, 63.0, 62.0, 62.0, 61.0, 61.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 81.0, 80.0, 82.0, 81.0, 86.0, 88.0, 108.0, 81.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 127.0, 121.0, 134.0, 124.0, 134.0, 124.0, 143.0, 134.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 164.0, 167.0, 166.0, 163.0, 161.0, 163.0, 165.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 66.0], "value": 65.1, "unit": "score"}]}]} 11:39:15 INFO - Return code: 0 11:39:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:39:15 ERROR - # TBPL SUCCESS # 11:39:15 INFO - Running post-action listener: _resource_record_post_action 11:39:15 INFO - ##### 11:39:15 INFO - ##### Finished run-tests step (success) 11:39:15 INFO - ##### 11:39:15 INFO - Running post-run listener: _resource_record_post_run 11:39:15 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 422023168; Read time: 16; Write time: 278352 11:39:15 INFO - TinderboxPrint: CPU usage
13.4% 11:39:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:39:15 INFO - TinderboxPrint: I/O write bytes / time
422,023,168 / 278,352 11:39:15 INFO - TinderboxPrint: CPU idle
8,214.1 (86.5%) 11:39:15 INFO - TinderboxPrint: CPU user
1,224.6 (12.9%) 11:39:15 INFO - TinderboxPrint: Swap in / out
0 / 0 11:39:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 123666432; Read time: 0; Write time: 78972 11:39:15 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298356736; Read time: 16; Write time: 199380 11:39:15 INFO - Running post-run listener: _upload_blobber_files 11:39:15 INFO - Blob upload gear active. 11:39:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:39:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:39:16 INFO - (blobuploader) - INFO - Open directory for files ... 11:39:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:39:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:39:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:17 INFO - (blobuploader) - INFO - Done attempting. 11:39:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:39:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:22 INFO - (blobuploader) - INFO - Done attempting. 11:39:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:39:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:39:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:23 INFO - (blobuploader) - INFO - Done attempting. 11:39:23 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:23 INFO - Return code: 0 11:39:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:39:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f0fba41f6c1bdc932675c16ac32f417f57c95813ae2f572d74d58b1d5468f87c81ec82546cc4ff56ee3cb5a60c96f216a784cd8fc89d88dd7633b1beae14027", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4740acb67a9b7a05cfdb9403330704032f329e6f3ba1722f5c00934f55c694e0963fa703f6682e2928b0a6cd770bf6d7adeb059a9a2805c26c2272d6d1907dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b988a1c2859896c4be7fa3969829a75dea8bf5f3346c849561d9a5bed1683950be388d4094425297779dd468ba0732cf14945f6f6dcb16656c8d10a5e2587275"} 11:39:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:39:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:39:23 INFO - Contents: 11:39:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f0fba41f6c1bdc932675c16ac32f417f57c95813ae2f572d74d58b1d5468f87c81ec82546cc4ff56ee3cb5a60c96f216a784cd8fc89d88dd7633b1beae14027", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4740acb67a9b7a05cfdb9403330704032f329e6f3ba1722f5c00934f55c694e0963fa703f6682e2928b0a6cd770bf6d7adeb059a9a2805c26c2272d6d1907dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b988a1c2859896c4be7fa3969829a75dea8bf5f3346c849561d9a5bed1683950be388d4094425297779dd468ba0732cf14945f6f6dcb16656c8d10a5e2587275"} 11:39:23 INFO - Running post-run listener: copy_logs_to_upload_dir 11:39:23 INFO - Copying logs to upload dir... 11:39:23 INFO - mkdir: /builds/slave/test/build/upload/logs 11:39:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.500951 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-21 11:39:23.264662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 11:39:23.268747) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493 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/8f0fba41f6c1bdc932675c16ac32f417f57c95813ae2f572d74d58b1d5468f87c81ec82546cc4ff56ee3cb5a60c96f216a784cd8fc89d88dd7633b1beae14027", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4740acb67a9b7a05cfdb9403330704032f329e6f3ba1722f5c00934f55c694e0963fa703f6682e2928b0a6cd770bf6d7adeb059a9a2805c26c2272d6d1907dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b988a1c2859896c4be7fa3969829a75dea8bf5f3346c849561d9a5bed1683950be388d4094425297779dd468ba0732cf14945f6f6dcb16656c8d10a5e2587275"} build_url:https://queue.taskcluster.net/v1/task/aMV7shOCS1eptfHjzLhAxA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/aMV7shOCS1eptfHjzLhAxA/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/8f0fba41f6c1bdc932675c16ac32f417f57c95813ae2f572d74d58b1d5468f87c81ec82546cc4ff56ee3cb5a60c96f216a784cd8fc89d88dd7633b1beae14027", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4740acb67a9b7a05cfdb9403330704032f329e6f3ba1722f5c00934f55c694e0963fa703f6682e2928b0a6cd770bf6d7adeb059a9a2805c26c2272d6d1907dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b988a1c2859896c4be7fa3969829a75dea8bf5f3346c849561d9a5bed1683950be388d4094425297779dd468ba0732cf14945f6f6dcb16656c8d10a5e2587275"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 11:39:23.296056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:39:23.296657) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1466532844.932328-1095348493 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-21 11:39:23.379397) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 11:39:23.379846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 11:39:23.380299) ========= ========= Total master_lag: 0.18 =========