builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1466693186.64 results: success (0) buildid: 20160623063425 builduid: f38770dce278412ab80b873968f067d8 revision: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:26.635796) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:26.636302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:26.636623) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:26.651327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:26.651625) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 07:46:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-06-23 07:46:27 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:26.759471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:26.759817) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019043 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:26.809745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:26.810112) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a7e793ef71a31643eddd1bf7cb7a80b580cb8284 --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 a7e793ef71a31643eddd1bf7cb7a80b580cb8284 --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=8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 07:46:27,168 truncating revision to first 12 chars 2016-06-23 07:46:27,168 Setting DEBUG logging. 2016-06-23 07:46:27,168 attempt 1/10 2016-06-23 07:46:27,168 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a7e793ef71a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 07:46:27,640 unpacking tar archive at: fx-team-a7e793ef71a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.793290 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:27.617868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:27.618368) ========= script_repo_revision: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:27.618853) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:27.619246) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 07:46:27.630201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-23 07:46:27.630575) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:46:28 INFO - MultiFileLogger online at 20160623 07:46:28 in /builds/slave/test 07:46:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:46:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:28 INFO - {'append_to_log': False, 07:46:28 INFO - 'base_work_dir': '/builds/slave/test', 07:46:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:46:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:28 INFO - 'branch': 'Fx-Team-Non-PGO', 07:46:28 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:28 INFO - 'config_files': ('talos/linux_config.py',), 07:46:28 INFO - 'default_actions': ('clobber', 07:46:28 INFO - 'read-buildbot-config', 07:46:28 INFO - 'download-and-extract', 07:46:28 INFO - 'populate-webroot', 07:46:28 INFO - 'create-virtualenv', 07:46:28 INFO - 'install', 07:46:28 INFO - 'run-tests'), 07:46:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:28 INFO - 'download_minidump_stackwalk': True, 07:46:28 INFO - 'download_symbols': 'ondemand', 07:46:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:28 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:28 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:28 INFO - 'installer_path': 'installer.exe', 07:46:28 INFO - 'log_level': 'info', 07:46:28 INFO - 'log_name': 'talos', 07:46:28 INFO - 'log_to_console': True, 07:46:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:46:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:46:28 INFO - 'opt_config_files': (), 07:46:28 INFO - 'pip_index': False, 07:46:28 INFO - 'sps_profile': False, 07:46:28 INFO - 'sps_profile_interval': 0, 07:46:28 INFO - 'suite': 'dromaeojs', 07:46:28 INFO - 'system_bits': '32', 07:46:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:28 INFO - 'title': 'talos-linux64-ix-001', 07:46:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:28 INFO - 'use_talos_json': True, 07:46:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:28 INFO - 'work_dir': 'build'} 07:46:28 INFO - ##### 07:46:28 INFO - ##### Running clobber step. 07:46:28 INFO - ##### 07:46:28 INFO - Running pre-action listener: _resource_record_pre_action 07:46:28 INFO - Running main action method: clobber 07:46:28 INFO - rmtree: /builds/slave/test/build 07:46:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:28 INFO - Running post-action listener: _resource_record_post_action 07:46:28 INFO - ##### 07:46:28 INFO - ##### Finished clobber step (success) 07:46:28 INFO - ##### 07:46:28 INFO - ##### 07:46:28 INFO - ##### Running read-buildbot-config step. 07:46:28 INFO - ##### 07:46:28 INFO - Running pre-action listener: _resource_record_pre_action 07:46:28 INFO - Running main action method: read_buildbot_config 07:46:28 INFO - Using buildbot properties: 07:46:28 INFO - { 07:46:28 INFO - "project": "", 07:46:28 INFO - "product": "firefox", 07:46:28 INFO - "script_repo_revision": "production", 07:46:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:46:28 INFO - "repository": "", 07:46:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:46:28 INFO - "buildid": "20160623063425", 07:46:28 INFO - "pgo_build": "False", 07:46:28 INFO - "basedir": "/builds/slave/test", 07:46:28 INFO - "buildnumber": 3110, 07:46:28 INFO - "slavename": "talos-linux64-ix-001", 07:46:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:46:28 INFO - "platform": "ubuntu64_hw", 07:46:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:46:28 INFO - "branch": "fx-team", 07:46:28 INFO - "repo_path": "integration/fx-team", 07:46:28 INFO - "revision": "a7e793ef71a31643eddd1bf7cb7a80b580cb8284", 07:46:28 INFO - "stage_platform": "linux64", 07:46:28 INFO - "builduid": "f38770dce278412ab80b873968f067d8", 07:46:28 INFO - "slavebuilddir": "test" 07:46:28 INFO - } 07:46:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:46:28 INFO - Running post-action listener: _resource_record_post_action 07:46:28 INFO - ##### 07:46:28 INFO - ##### Finished read-buildbot-config step (success) 07:46:28 INFO - ##### 07:46:28 INFO - ##### 07:46:28 INFO - ##### Running download-and-extract step. 07:46:28 INFO - ##### 07:46:28 INFO - Running pre-action listener: _resource_record_pre_action 07:46:28 INFO - Running main action method: download_and_extract 07:46:28 INFO - mkdir: /builds/slave/test/build/tests 07:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:28 INFO - https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:46:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:46:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:46:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/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 07:46:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/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 07:46:29 INFO - Downloaded 1361 bytes. 07:46:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:46:29 INFO - Using the following test package requirements: 07:46:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:46:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:46:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:46:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:29 INFO - u'jsshell-linux-x86_64.zip'], 07:46:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:46:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:46:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:46:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:46:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:46:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:46:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:46:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:46:29 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')]} 07:46:29 INFO - https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/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 07:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/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 07:46:30 INFO - Downloaded 22709646 bytes. 07:46:30 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'] 07:46:30 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 07:46:31 INFO - Return code: 0 07:46:31 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 07:46:31 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')]} 07:46:31 INFO - https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/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 07:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/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 07:46:32 INFO - Downloaded 22709646 bytes. 07:46:32 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'] 07:46:32 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 07:46:34 INFO - Return code: 0 07:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:34 INFO - https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:46:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:46:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/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 07:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/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 07:46:35 INFO - Downloaded 14405384 bytes. 07:46:35 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'] 07:46:35 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 07:46:35 INFO - Return code: 0 07:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:35 INFO - https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/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 07:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/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 07:46:36 INFO - Downloaded 56254806 bytes. 07:46:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:46:36 INFO - mkdir: /builds/slave/test/properties 07:46:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:36 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:36 INFO - Contents: 07:46:36 INFO - build_url:https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:46:37 INFO - Running post-action listener: _resource_record_post_action 07:46:37 INFO - Running post-action listener: set_extra_try_arguments 07:46:37 INFO - ##### 07:46:37 INFO - ##### Finished download-and-extract step (success) 07:46:37 INFO - ##### 07:46:37 INFO - ##### 07:46:37 INFO - ##### Running populate-webroot step. 07:46:37 INFO - ##### 07:46:37 INFO - Running pre-action listener: _resource_record_pre_action 07:46:37 INFO - Running main action method: populate_webroot 07:46:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:37 INFO - '--tppagecycles', 07:46:37 INFO - '7'], 07:46:37 INFO - 'tests': ['tsvgm']}}, 07:46:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:37 INFO - 'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:37 INFO - 'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['damp', 'tps']}, 07:46:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:37 INFO - 'tests': ['damp', 'tps']}, 07:46:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['dromaeo_dom']}, 07:46:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['basic_compositor_video']}, 07:46:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:46:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['a11yr', 07:46:37 INFO - 'ts_paint', 07:46:37 INFO - 'tpaint', 07:46:37 INFO - 'sessionrestore', 07:46:37 INFO - 'sessionrestore_no_auto_restore', 07:46:37 INFO - 'tabpaint']}, 07:46:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:37 INFO - 'ts_paint', 07:46:37 INFO - 'tpaint', 07:46:37 INFO - 'sessionrestore', 07:46:37 INFO - 'sessionrestore_no_auto_restore', 07:46:37 INFO - 'tabpaint']}, 07:46:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:37 INFO - 'ts_paint', 07:46:37 INFO - 'tpaint', 07:46:37 INFO - 'sessionrestore', 07:46:37 INFO - 'sessionrestore_no_auto_restore', 07:46:37 INFO - 'tabpaint']}, 07:46:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:37 INFO - 'ts_paint', 07:46:37 INFO - 'tpaint', 07:46:37 INFO - 'sessionrestore', 07:46:37 INFO - 'sessionrestore_no_auto_restore', 07:46:37 INFO - 'tabpaint']}, 07:46:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['a11yr', 07:46:37 INFO - 'ts_paint', 07:46:37 INFO - 'tpaint', 07:46:37 INFO - 'sessionrestore', 07:46:37 INFO - 'sessionrestore_no_auto_restore', 07:46:37 INFO - 'tabpaint']}, 07:46:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['a11yr', 07:46:37 INFO - 'ts_paint', 07:46:37 INFO - 'tpaint', 07:46:37 INFO - 'sessionrestore', 07:46:37 INFO - 'sessionrestore_no_auto_restore', 07:46:37 INFO - 'tabpaint']}, 07:46:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['tsvgx', 07:46:37 INFO - 'tsvgr_opacity', 07:46:37 INFO - 'tart', 07:46:37 INFO - 'tscrollx', 07:46:37 INFO - 'cart']}, 07:46:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:37 INFO - 'tsvgr_opacity', 07:46:37 INFO - 'tart', 07:46:37 INFO - 'tscrollx', 07:46:37 INFO - 'cart']}, 07:46:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:37 INFO - 'talos_options': ['--disable-e10s'], 07:46:37 INFO - 'tests': ['tp5o']}, 07:46:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:37 INFO - 'tests': ['tp5o']}, 07:46:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:37 INFO - 'talos_options': ['--disable-e10s', 07:46:37 INFO - '--xperf_path', 07:46:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:37 INFO - 'tests': ['tp5n']}, 07:46:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:37 INFO - 'talos_options': ['--xperf_path', 07:46:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:37 INFO - 'tests': ['tp5n']}}, 07:46:37 INFO - 'talos.zip': {'path': '', 07:46:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:37 INFO - Running post-action listener: _resource_record_post_action 07:46:37 INFO - ##### 07:46:37 INFO - ##### Finished populate-webroot step (success) 07:46:37 INFO - ##### 07:46:37 INFO - ##### 07:46:37 INFO - ##### Running create-virtualenv step. 07:46:37 INFO - ##### 07:46:37 INFO - Running pre-action listener: _resource_record_pre_action 07:46:37 INFO - Running main action method: create_virtualenv 07:46:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:37 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 07:46:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:37 INFO - Using real prefix '/usr' 07:46:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:38 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:40 INFO - Installing pip.................done. 07:46:40 INFO - Return code: 0 07:46:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46: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')]} 07:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:40 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 0x7f75ddbddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', '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 07:46:40 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 07:46:40 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 07:46:40 INFO - Using env: {'DISPLAY': ':0', 07:46:40 INFO - 'HOME': '/home/cltbld', 07:46:40 INFO - 'LANG': 'en_US.UTF-8', 07:46:40 INFO - 'LANGUAGE': 'en_US:en', 07:46:40 INFO - 'LOGNAME': 'cltbld', 07:46:40 INFO - 'MAIL': '/var/mail/cltbld', 07:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:40 INFO - 'MOZ_NO_REMOTE': '1', 07:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:40 INFO - 'NO_EM_RESTART': '1', 07:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:40 INFO - 'PWD': '/builds/slave/test', 07:46:40 INFO - 'SHELL': '/bin/bash', 07:46:40 INFO - 'SHLVL': '1', 07:46:40 INFO - 'TERM': 'linux', 07:46:40 INFO - 'TMOUT': '86400', 07:46:40 INFO - 'USER': 'cltbld', 07:46:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:40 INFO - '_': '/tools/buildbot/bin/python'} 07:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:40 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 07:46:40 INFO - Cleaning up... 07:46:40 INFO - Return code: 0 07:46:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:46: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')]} 07:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:40 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 0x7f75ddbddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', '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 07:46:40 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 07:46:40 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 07:46:40 INFO - Using env: {'DISPLAY': ':0', 07:46:40 INFO - 'HOME': '/home/cltbld', 07:46:40 INFO - 'LANG': 'en_US.UTF-8', 07:46:40 INFO - 'LANGUAGE': 'en_US:en', 07:46:40 INFO - 'LOGNAME': 'cltbld', 07:46:40 INFO - 'MAIL': '/var/mail/cltbld', 07:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:40 INFO - 'MOZ_NO_REMOTE': '1', 07:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:40 INFO - 'NO_EM_RESTART': '1', 07:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:40 INFO - 'PWD': '/builds/slave/test', 07:46:40 INFO - 'SHELL': '/bin/bash', 07:46:40 INFO - 'SHLVL': '1', 07:46:40 INFO - 'TERM': 'linux', 07:46:40 INFO - 'TMOUT': '86400', 07:46:40 INFO - 'USER': 'cltbld', 07:46:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:40 INFO - '_': '/tools/buildbot/bin/python'} 07:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:40 INFO - Downloading/unpacking psutil>=3.1.1 07:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:42 INFO - Installing collected packages: psutil 07:46:42 INFO - Running setup.py install for psutil 07:46:42 INFO - building 'psutil._psutil_linux' extension 07:46:42 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 07:46:42 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 07:46:42 INFO - building 'psutil._psutil_posix' extension 07:46:42 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 07:46:42 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 07:46:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:43 INFO - Successfully installed psutil 07:46:43 INFO - Cleaning up... 07:46:43 INFO - Return code: 0 07:46:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:46: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')]} 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:43 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 0x7f75ddbddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', '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 07:46:43 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 07:46:43 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 07:46:43 INFO - Using env: {'DISPLAY': ':0', 07:46:43 INFO - 'HOME': '/home/cltbld', 07:46:43 INFO - 'LANG': 'en_US.UTF-8', 07:46:43 INFO - 'LANGUAGE': 'en_US:en', 07:46:43 INFO - 'LOGNAME': 'cltbld', 07:46:43 INFO - 'MAIL': '/var/mail/cltbld', 07:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:43 INFO - 'MOZ_NO_REMOTE': '1', 07:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:43 INFO - 'NO_EM_RESTART': '1', 07:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:43 INFO - 'PWD': '/builds/slave/test', 07:46:43 INFO - 'SHELL': '/bin/bash', 07:46:43 INFO - 'SHLVL': '1', 07:46:43 INFO - 'TERM': 'linux', 07:46:43 INFO - 'TMOUT': '86400', 07:46:43 INFO - 'USER': 'cltbld', 07:46:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:43 INFO - '_': '/tools/buildbot/bin/python'} 07:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:46:45 INFO - Installing collected packages: mozsystemmonitor 07:46:45 INFO - Running setup.py install for mozsystemmonitor 07:46:45 INFO - Successfully installed mozsystemmonitor 07:46:45 INFO - Cleaning up... 07:46:45 INFO - Return code: 0 07:46:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:46:45 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')]} 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:45 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')]} 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:45 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 0x7f75ddbddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', '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 07:46:45 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 07:46:45 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 07:46:45 INFO - Using env: {'DISPLAY': ':0', 07:46:45 INFO - 'HOME': '/home/cltbld', 07:46:45 INFO - 'LANG': 'en_US.UTF-8', 07:46:45 INFO - 'LANGUAGE': 'en_US:en', 07:46:45 INFO - 'LOGNAME': 'cltbld', 07:46:45 INFO - 'MAIL': '/var/mail/cltbld', 07:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:45 INFO - 'MOZ_NO_REMOTE': '1', 07:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:45 INFO - 'NO_EM_RESTART': '1', 07:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:45 INFO - 'PWD': '/builds/slave/test', 07:46:45 INFO - 'SHELL': '/bin/bash', 07:46:45 INFO - 'SHLVL': '1', 07:46:45 INFO - 'TERM': 'linux', 07:46:45 INFO - 'TMOUT': '86400', 07:46:45 INFO - 'USER': 'cltbld', 07:46:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:45 INFO - '_': '/tools/buildbot/bin/python'} 07:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:45 INFO - Downloading/unpacking jsonschema==2.5.1 07:46:45 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 07:46:45 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 07:46:45 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 07:46:45 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 07:46:45 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 07:46:45 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 07:46:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:47 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:47 INFO - warning: no files found matching '*.txt' 07:46:47 INFO - no previously-included directories found matching 'build' 07:46:47 INFO - no previously-included directories found matching 'dist' 07:46:47 INFO - no previously-included directories found matching '.git*' 07:46:47 INFO - Installing collected packages: jsonschema, functools32 07:46:47 INFO - Running setup.py install for functools32 07:46:47 INFO - warning: no files found matching '*.txt' 07:46:47 INFO - no previously-included directories found matching 'build' 07:46:47 INFO - no previously-included directories found matching 'dist' 07:46:47 INFO - no previously-included directories found matching '.git*' 07:46:47 INFO - Successfully installed jsonschema functools32 07:46:47 INFO - Cleaning up... 07:46:47 INFO - Return code: 0 07:46:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f75ddbddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', '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 07:46:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:46:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:46:47 INFO - Using env: {'DISPLAY': ':0', 07:46:47 INFO - 'HOME': '/home/cltbld', 07:46:47 INFO - 'LANG': 'en_US.UTF-8', 07:46:47 INFO - 'LANGUAGE': 'en_US:en', 07:46:47 INFO - 'LOGNAME': 'cltbld', 07:46:47 INFO - 'MAIL': '/var/mail/cltbld', 07:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:47 INFO - 'MOZ_NO_REMOTE': '1', 07:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:47 INFO - 'NO_EM_RESTART': '1', 07:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:47 INFO - 'PWD': '/builds/slave/test', 07:46:47 INFO - 'SHELL': '/bin/bash', 07:46:47 INFO - 'SHLVL': '1', 07:46:47 INFO - 'TERM': 'linux', 07:46:47 INFO - 'TMOUT': '86400', 07:46:47 INFO - 'USER': 'cltbld', 07:46:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:47 INFO - '_': '/tools/buildbot/bin/python'} 07:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:48 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:48 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 07:46:48 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 07:46:48 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 07:46:48 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 07:46:48 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 07:46:48 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 07:46:50 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:46:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:50 INFO - Downloading docopt-0.6.1.tar.gz 07:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:50 INFO - Running setup.py install for blobuploader 07:46:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:46:50 INFO - Running setup.py install for requests 07:46:51 INFO - Running setup.py install for docopt 07:46:51 INFO - Successfully installed blobuploader requests docopt 07:46:51 INFO - Cleaning up... 07:46:51 INFO - Return code: 0 07:46:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:51 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 0x7f75ddbddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', '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 07:46:51 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 07:46:51 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 07:46:51 INFO - Using env: {'DISPLAY': ':0', 07:46:51 INFO - 'HOME': '/home/cltbld', 07:46:51 INFO - 'LANG': 'en_US.UTF-8', 07:46:51 INFO - 'LANGUAGE': 'en_US:en', 07:46:51 INFO - 'LOGNAME': 'cltbld', 07:46:51 INFO - 'MAIL': '/var/mail/cltbld', 07:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:51 INFO - 'MOZ_NO_REMOTE': '1', 07:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:51 INFO - 'NO_EM_RESTART': '1', 07:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:51 INFO - 'PWD': '/builds/slave/test', 07:46:51 INFO - 'SHELL': '/bin/bash', 07:46:51 INFO - 'SHLVL': '1', 07:46:51 INFO - 'TERM': 'linux', 07:46:51 INFO - 'TMOUT': '86400', 07:46:51 INFO - 'USER': 'cltbld', 07:46:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:51 INFO - '_': '/tools/buildbot/bin/python'} 07:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:51 INFO - Running setup.py (path:/tmp/pip-nt4tK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:51 INFO - Running setup.py (path:/tmp/pip-C8ONda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:51 INFO - Running setup.py (path:/tmp/pip-5RaVGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:51 INFO - Running setup.py (path:/tmp/pip-TCwkgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:51 INFO - Running setup.py (path:/tmp/pip-5nTs_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:52 INFO - Running setup.py (path:/tmp/pip-9VaNMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:52 INFO - Running setup.py (path:/tmp/pip-MBY5HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:52 INFO - Running setup.py (path:/tmp/pip-8N6C03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:52 INFO - Running setup.py (path:/tmp/pip-fLFqcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:52 INFO - Running setup.py (path:/tmp/pip-hxF4ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:52 INFO - Running setup.py (path:/tmp/pip-jhtSEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:52 INFO - Running setup.py (path:/tmp/pip-OseorU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:52 INFO - Running setup.py (path:/tmp/pip-QycgDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:52 INFO - Running setup.py (path:/tmp/pip-UrIKSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:52 INFO - Running setup.py (path:/tmp/pip-z5l8zX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:52 INFO - Running setup.py (path:/tmp/pip-jy6BSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:52 INFO - Running setup.py (path:/tmp/pip-aytqVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:52 INFO - Running setup.py install for manifestparser 07:46:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for mozcrash 07:46:53 INFO - Running setup.py install for mozdebug 07:46:53 INFO - Running setup.py install for mozdevice 07:46:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for mozfile 07:46:53 INFO - Running setup.py install for mozhttpd 07:46:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for mozinfo 07:46:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for mozInstall 07:46:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for mozleak 07:46:53 INFO - Running setup.py install for mozlog 07:46:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for moznetwork 07:46:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Running setup.py install for mozprocess 07:46:54 INFO - Running setup.py install for mozprofile 07:46:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Running setup.py install for mozrunner 07:46:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Running setup.py install for mozscreenshot 07:46:54 INFO - Running setup.py install for moztest 07:46:54 INFO - Running setup.py install for mozversion 07:46:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:54 INFO - Cleaning up... 07:46:54 INFO - Return code: 0 07:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:54 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 0x7f75ddbddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', '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 07:46:54 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 07:46:54 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 07:46:54 INFO - Using env: {'DISPLAY': ':0', 07:46:54 INFO - 'HOME': '/home/cltbld', 07:46:54 INFO - 'LANG': 'en_US.UTF-8', 07:46:54 INFO - 'LANGUAGE': 'en_US:en', 07:46:54 INFO - 'LOGNAME': 'cltbld', 07:46:54 INFO - 'MAIL': '/var/mail/cltbld', 07:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:54 INFO - 'MOZ_NO_REMOTE': '1', 07:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:54 INFO - 'NO_EM_RESTART': '1', 07:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:54 INFO - 'PWD': '/builds/slave/test', 07:46:54 INFO - 'SHELL': '/bin/bash', 07:46:54 INFO - 'SHLVL': '1', 07:46:54 INFO - 'TERM': 'linux', 07:46:54 INFO - 'TMOUT': '86400', 07:46:54 INFO - 'USER': 'cltbld', 07:46:54 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:54 INFO - '_': '/tools/buildbot/bin/python'} 07:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:54 INFO - Running setup.py (path:/tmp/pip-GxNgUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:55 INFO - Running setup.py (path:/tmp/pip-iFkyJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:55 INFO - Running setup.py (path:/tmp/pip-apE8dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:55 INFO - Running setup.py (path:/tmp/pip-YUm9oO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:55 INFO - Running setup.py (path:/tmp/pip-s0jEsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:55 INFO - Running setup.py (path:/tmp/pip-tl3jhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:55 INFO - Running setup.py (path:/tmp/pip-D7f_8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:55 INFO - Running setup.py (path:/tmp/pip-LcossG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:55 INFO - Running setup.py (path:/tmp/pip-CSP3xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:55 INFO - Running setup.py (path:/tmp/pip-NF6WGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:55 INFO - Running setup.py (path:/tmp/pip-fQ2aQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:55 INFO - Running setup.py (path:/tmp/pip-Uz7PLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:55 INFO - Running setup.py (path:/tmp/pip-KwPhsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:55 INFO - Running setup.py (path:/tmp/pip-ZYrVIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:55 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)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:55 INFO - Running setup.py (path:/tmp/pip-hZ0thM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:56 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)) 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:56 INFO - Running setup.py (path:/tmp/pip-uGJwdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:56 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)) 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:56 INFO - Running setup.py (path:/tmp/pip-9GNOuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:56 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)) 07:46:56 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)) 07:46:56 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)) 07:46:56 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)) 07:46:56 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)) 07:46:56 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)) 07:46:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:58 INFO - Downloading blessings-1.6.tar.gz 07:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:46:58 INFO - Installing collected packages: blessings 07:46:58 INFO - Running setup.py install for blessings 07:46:58 INFO - Successfully installed blessings 07:46:58 INFO - Cleaning up... 07:46:58 INFO - Return code: 0 07:46:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:58 INFO - Reading from file tmpfile_stdout 07:46:58 INFO - Current package versions: 07:46:58 INFO - argparse == 1.2.1 07:46:58 INFO - blessings == 1.6 07:46:58 INFO - blobuploader == 1.2.4 07:46:58 INFO - docopt == 0.6.1 07:46:58 INFO - functools32 == 3.2.3-2 07:46:58 INFO - jsonschema == 2.5.1 07:46:58 INFO - manifestparser == 1.1 07:46:58 INFO - mozInstall == 1.12 07:46:58 INFO - mozcrash == 0.17 07:46:58 INFO - mozdebug == 0.1 07:46:58 INFO - mozdevice == 0.48 07:46:58 INFO - mozfile == 1.2 07:46:58 INFO - mozhttpd == 0.7 07:46:58 INFO - mozinfo == 0.9 07:46:58 INFO - mozleak == 0.1 07:46:58 INFO - mozlog == 3.2 07:46:58 INFO - moznetwork == 0.27 07:46:58 INFO - mozprocess == 0.22 07:46:58 INFO - mozprofile == 0.28 07:46:58 INFO - mozrunner == 6.11 07:46:58 INFO - mozscreenshot == 0.1 07:46:58 INFO - mozsystemmonitor == 0.3 07:46:58 INFO - moztest == 0.7 07:46:58 INFO - mozversion == 1.4 07:46:58 INFO - psutil == 3.1.1 07:46:58 INFO - requests == 1.2.3 07:46:58 INFO - wsgiref == 0.1.2 07:46:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:58 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')]} 07:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:58 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')]} 07:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:58 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 0x7f75ddbddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', '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 07:46:58 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 07:46:58 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 07:46:58 INFO - Using env: {'DISPLAY': ':0', 07:46:58 INFO - 'HOME': '/home/cltbld', 07:46:58 INFO - 'LANG': 'en_US.UTF-8', 07:46:58 INFO - 'LANGUAGE': 'en_US:en', 07:46:58 INFO - 'LOGNAME': 'cltbld', 07:46:58 INFO - 'MAIL': '/var/mail/cltbld', 07:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:58 INFO - 'MOZ_NO_REMOTE': '1', 07:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:58 INFO - 'NO_EM_RESTART': '1', 07:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:58 INFO - 'PWD': '/builds/slave/test', 07:46:58 INFO - 'SHELL': '/bin/bash', 07:46:58 INFO - 'SHLVL': '1', 07:46:58 INFO - 'TERM': 'linux', 07:46:58 INFO - 'TMOUT': '86400', 07:46:58 INFO - 'USER': 'cltbld', 07:46:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:58 INFO - '_': '/tools/buildbot/bin/python'} 07:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 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)) 07:46:58 INFO - Cleaning up... 07:46:58 INFO - Return code: 0 07:46:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:46:58 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')]} 07:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:58 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')]} 07:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:58 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 0x7f75ddbddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', '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 07:46:58 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 07:46:58 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 07:46:58 INFO - Using env: {'DISPLAY': ':0', 07:46:58 INFO - 'HOME': '/home/cltbld', 07:46:58 INFO - 'LANG': 'en_US.UTF-8', 07:46:58 INFO - 'LANGUAGE': 'en_US:en', 07:46:58 INFO - 'LOGNAME': 'cltbld', 07:46:58 INFO - 'MAIL': '/var/mail/cltbld', 07:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:58 INFO - 'MOZ_NO_REMOTE': '1', 07:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:58 INFO - 'NO_EM_RESTART': '1', 07:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:58 INFO - 'PWD': '/builds/slave/test', 07:46:58 INFO - 'SHELL': '/bin/bash', 07:46:58 INFO - 'SHLVL': '1', 07:46:58 INFO - 'TERM': 'linux', 07:46:58 INFO - 'TMOUT': '86400', 07:46:58 INFO - 'USER': 'cltbld', 07:46:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:58 INFO - '_': '/tools/buildbot/bin/python'} 07:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:46:58 INFO - Cleaning up... 07:46:58 INFO - Return code: 0 07:46:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:46:58 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')]} 07:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:58 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')]} 07:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:58 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 0x7f75ddbddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c11350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, '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': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', '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 07:46:58 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 07:46:58 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 07:46:58 INFO - Using env: {'DISPLAY': ':0', 07:46:58 INFO - 'HOME': '/home/cltbld', 07:46:58 INFO - 'LANG': 'en_US.UTF-8', 07:46:58 INFO - 'LANGUAGE': 'en_US:en', 07:46:58 INFO - 'LOGNAME': 'cltbld', 07:46:58 INFO - 'MAIL': '/var/mail/cltbld', 07:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:58 INFO - 'MOZ_NO_REMOTE': '1', 07:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:46:58 INFO - 'NO_EM_RESTART': '1', 07:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:58 INFO - 'PWD': '/builds/slave/test', 07:46:58 INFO - 'SHELL': '/bin/bash', 07:46:58 INFO - 'SHLVL': '1', 07:46:58 INFO - 'TERM': 'linux', 07:46:58 INFO - 'TMOUT': '86400', 07:46:58 INFO - 'USER': 'cltbld', 07:46:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:58 INFO - '_': '/tools/buildbot/bin/python'} 07:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:59 INFO - Downloading/unpacking flake8 07:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:47:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:47:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:47:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 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 07:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:47:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:47:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:47:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:47:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:47:01 INFO - no previously-included directories found matching 'docs/_build' 07:47:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:47:01 INFO - Running setup.py install for pep8 07:47:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:47:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:47:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:47:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:47:01 INFO - no previously-included directories found matching 'docs/_build' 07:47:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:47:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:47:01 INFO - Cleaning up... 07:47:02 INFO - Return code: 0 07:47:02 INFO - Running post-action listener: _resource_record_post_action 07:47:02 INFO - Running post-action listener: _start_resource_monitoring 07:47:02 INFO - Starting resource monitoring. 07:47:02 INFO - ##### 07:47:02 INFO - ##### Finished create-virtualenv step (success) 07:47:02 INFO - ##### 07:47:02 INFO - ##### 07:47:02 INFO - ##### Running install step. 07:47:02 INFO - ##### 07:47:02 INFO - Running pre-action listener: _resource_record_pre_action 07:47:02 INFO - Running main action method: install 07:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:02 INFO - Reading from file tmpfile_stdout 07:47:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:02 INFO - Reading from file tmpfile_stdout 07:47:02 INFO - Output received: 07:47:02 INFO - Usage: mozinstall [options] installer 07:47:02 INFO - Options: 07:47:02 INFO - -h, --help show this help message and exit 07:47:02 INFO - -d DEST, --destination=DEST 07:47:02 INFO - Directory to install application into. [default: 07:47:02 INFO - "/builds/slave/test"] 07:47:02 INFO - --app=APP Application being installed. [default: firefox] 07:47:02 INFO - mkdir: /builds/slave/test/build/application 07:47:02 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'] 07:47:02 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 07:47:18 INFO - Reading from file tmpfile_stdout 07:47:18 INFO - Output received: 07:47:18 INFO - /builds/slave/test/build/application/firefox/firefox 07:47:18 INFO - Running post-action listener: _resource_record_post_action 07:47:18 INFO - ##### 07:47:18 INFO - ##### Finished install step (success) 07:47:18 INFO - ##### 07:47:18 INFO - ##### 07:47:18 INFO - ##### Running run-tests step. 07:47:18 INFO - ##### 07:47:18 INFO - Running pre-action listener: _resource_record_pre_action 07:47:18 INFO - Running main action method: run_tests 07:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:18 INFO - Python 2.7.3 07:47:18 INFO - Return code: 0 07:47:18 INFO - grabbing minidump binary from tooltool 07:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:47:18 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 0x2ca01c0>, '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 0x2ca10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:18 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 07:47:18 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 07:47:18 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 07:47:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:18 INFO - Return code: 0 07:47:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:47:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:47:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:47:19 INFO - Return code: 0 07:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:47:19 INFO - Using env: {'DISPLAY': ':0', 07:47:19 INFO - 'HOME': '/home/cltbld', 07:47:19 INFO - 'LANG': 'en_US.UTF-8', 07:47:19 INFO - 'LANGUAGE': 'en_US:en', 07:47:19 INFO - 'LOGNAME': 'cltbld', 07:47:19 INFO - 'MAIL': '/var/mail/cltbld', 07:47:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:19 INFO - 'MOZ_NO_REMOTE': '1', 07:47:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:47:19 INFO - 'NO_EM_RESTART': '1', 07:47:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:19 INFO - 'PWD': '/builds/slave/test', 07:47:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:19 INFO - 'SHELL': '/bin/bash', 07:47:19 INFO - 'SHLVL': '1', 07:47:19 INFO - 'TERM': 'linux', 07:47:19 INFO - 'TMOUT': '86400', 07:47:19 INFO - 'USER': 'cltbld', 07:47:19 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171', 07:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:19 INFO - '_': '/tools/buildbot/bin/python'} 07:47:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:47:19 INFO - mozversion application_buildid: 20160623063425 07:47:19 INFO - mozversion application_changeset: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 07:47:19 INFO - mozversion application_display_name: Nightly 07:47:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:19 INFO - mozversion application_name: Firefox 07:47:19 INFO - mozversion application_remotingname: firefox 07:47:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:47:19 INFO - mozversion application_vendor: Mozilla 07:47:19 INFO - mozversion application_version: 50.0a1 07:47:19 INFO - mozversion platform_buildid: 20160623063425 07:47:19 INFO - mozversion platform_changeset: a7e793ef71a31643eddd1bf7cb7a80b580cb8284 07:47:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:47:19 INFO - mozversion platform_version: 50.0a1 07:47:19 INFO - using testdate: 1466693239 07:47:19 INFO - actual date: 1466693239 07:47:19 INFO - starting webserver on 'localhost:60505' 07:47:19 INFO - SUITE-START | Running 2 tests 07:47:19 INFO - TEST-START | dromaeo_css 07:47:19 INFO - operating with platform_type : linux_ 07:47:19 INFO - Initialising browser for dromaeo_css test... 07:47:19 INFO - TEST-INFO | started process 6344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC1A9V0/profile http://localhost:60505/getInfo.html) 07:47:24 INFO - PROCESS | 6344 | __metrics Screen width/height:1600/1200 07:47:24 INFO - PROCESS | 6344 | colorDepth:24 07:47:24 INFO - PROCESS | 6344 | Browser inner width/height: 1024/697 07:47:24 INFO - PROCESS | 6344 | __metrics 07:47:25 INFO - PROCESS | 6344 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:25 INFO - PROCESS | 6344 | console.error: PushService: 07:47:25 INFO - PROCESS | 6344 | stateChangeProcessEnqueue: Error transitioning state 07:47:25 INFO - PROCESS | 6344 | UnknownError 07:47:26 INFO - TEST-INFO | 6344: exit 0 07:47:26 INFO - Browser initialized. 07:47:26 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:26 INFO - TEST-INFO | started process 6427 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC1A9V0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:38 INFO - PROCESS | 6427 | RSS: Main: 175726592 07:47:38 INFO - PROCESS | 6427 | 07:48:29 INFO - PROCESS | 6427 | 1466693309469 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] 07:50:42 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:60505/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60505/tests/dromaeo/cssquery-ext.html) 07:50:43 INFO - PROCESS | 6427 | RSS: Main: 284921856 07:50:43 INFO - PROCESS | 6427 | 07:53:46 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:60505/tests/dromaeo/cssquery-ext.html (next: http://localhost:60505/tests/dromaeo/cssquery-jquery.html) 07:53:47 INFO - PROCESS | 6427 | RSS: Main: 255778816 07:53:47 INFO - PROCESS | 6427 | 07:56:49 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:60505/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60505/tests/dromaeo/cssquery-mootools.html) 07:56:50 INFO - PROCESS | 6427 | RSS: Main: 256290816 07:56:50 INFO - PROCESS | 6427 | 07:59:52 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:60505/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60505/tests/dromaeo/cssquery-prototype.html) 07:59:52 INFO - PROCESS | 6427 | RSS: Main: 253198336 07:59:52 INFO - PROCESS | 6427 | 08:02:55 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:60505/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60505/tests/dromaeo/cssquery-yui.html) 08:02:56 INFO - PROCESS | 6427 | RSS: Main: 242159616 08:02:56 INFO - PROCESS | 6427 | 08:05:59 INFO - PROCESS | 6427 | Cycle 1(1): loaded http://localhost:60505/tests/dromaeo/cssquery-yui.html (next: http://localhost:60505/tests/dromaeo/cssquery-dojo.html) 08:05:59 INFO - PROCESS | 6427 | RSS: Main: 296095744 08:05:59 INFO - PROCESS | 6427 | 08:05:59 INFO - PROCESS | 6427 | __start_tp_report 08:05:59 INFO - PROCESS | 6427 | _x_x_mozilla_page_load 08:05:59 INFO - PROCESS | 6427 | _x_x_mozilla_page_load_details 08:05:59 INFO - PROCESS | 6427 | |i|pagename|runs| 08:05:59 INFO - PROCESS | 6427 | |0;dojo.html;2599.961000584991;2639.221429678247;2664.493746188224;2679.0623281851354;2684.6241526186327;4605.286180642006;4681.555252251035;4688.765561721917;4814.879628009297;4841.975790121049;4711.434627844664;4740.3600513930605;4752.239641657336;4755.833545825888;4825.975870120645;4344.826206951718;4351.0862718829085;4399.560043995591;4423.469183697961;4439.356293337464;4362.454693163355;4450.287953927373;4475.843345482909;4509.594136527712;4559.908801823962;4466.441694788152;4512.684112112153;4515.638748900113;4521.683482156251;4550.590446859782;4294.377315289265;4334.783260836945;4346.195953748535;4362.781860906942;4368.934465983013;4315.956840431587;4346.15250026245;4396.098799746076;4398.142362239365;4442.311441726538;4847.733374664392;4858.854234372974;4862.44081930579;4862.586680132157;4873.8781530461665;5011.1481048221885;5081.517255860687;5130.948690513122;5138.409082955471;5157.896842063175;5217.843464696065;5226.634135610509;5228.76470558822;5246.317978662788;5251.396089449724;4683.297505374221;4833.564979151823;4835.734034628059;4837.927431088537;4866.02679464105;5172.870678232999;5201.713905735221;5229.346331708536;5241.528262456397;5313.362396512443;5081.161608334657;5091.9236211456855;5092.0579692756955;5092.312537807348;5093.465186155475;5024.196128619404;5105.846824595268;5154.407243167084;5163.509466600667;5182.144946083929;5103.515166059218;5118.769655365518;5143.4085080216255;5143.614228932845;5194.961007798455;5129.12804823181;5141.922871156936;5143.202803565378;5144.639875208774;5197.350331208599;4281.807318670667;4303.63419109373;4361.433013708198;4417.204903117406;4462.754548499799;3758.4550240215017;3764.3412402829395;3769.208466222069;3791.2227993261317;3844.3272427325105;4318.00685842258;4329.848455304049;4333.956660433419;4369.628581570602;4376.387305777193;4978.079055374695;5084.262781896604;5097.413797413345;5123.2827404163445;5128.076946149654;4402.515723270501;4409.33859921008;4435.423394958635;4440.600345968878;4448.199324121624;4647.604953578983;4664.39362882823;4666.300054991711;4674.368960190399;4691.038337140878;4516.841910533116;4772.308015337687;4815.085133824562;4817.108834865561;4827.444843842863;5192.299039629753;5206.375234971828;5226.346706661668;5231.189165679326;5243.8164664236565;4797.904041919072;4817.590504807131;4824.710517368969;4834.758262086812;4877.878053048702;4897.9510204898925;5013.122703526941;5100.107481190851;5117.078925793393;5165.173572228426;5081.314022607048;5130.4100028497205;5131.2303154525625;5131.87170320745;5184.377874655065;4991.376077990251;5010.899782004412;5013.072581572275;5013.147764880052;5066.2400639902835;4803.855884323476;4926.753662316798;4957.900841983068;5001.8499445016705;5012.8496145115705;4909.803607855646;4938.209886418156;4940.802367905244;4963.181075122564;4993.226049962262;5041.798328066836;5041.899162016666;5044.1424957758;5081;5098.643094983464;4811.374521312207;4888.9755551222015;4929.482404347492;4955.008998200302;4974.154393753143 08:05:59 INFO - PROCESS | 6427 | |1;ext.html;566.7081453051678;568.4429259325858;578.1414599320011;583.7927535724817;592.3868795796349;27618;40533.79733101334;41157.17685646289;41315.17369652605;44918.77540612301;42034.36948445768;42512.57487425125;42545.14909701804;42561.57438425615;42615.360769588406;7225.132984041922;7798.181190974937;7937.126916039231;7950.24472675095;7951.72168974086;7455.4781165318445;7692.615369231544;7695.884561731578;9960;10285.794284114314;10307;10374.844377334346;10377.117944974687;10391.636292729756;10393.32443391181;10239.48802559869;10242.078212960794;10277.383356998529;10312.381257124596;10313.484325783718;7413.51812132215;9821.165200957927;10162.491875406275;10173.54219060144;10490.737731556772;38693;38998.61001389978;39032.804835975636;39054.80472597647;39055.8047209765;3047.527633216855;3097.5973123494027;3108.8445577721022;3131.2550783804663;3566.4115420955513;29093.85453072721;29224.561631575543;29517.262068448246;30071.398572028436;30932.536011959837;3304.7686661933676;3316.933661326784;3317.4526203176447;3320.6015278166533;3351.581052368454;257846;258376;258463;259968;261655;31632.525512117336;54866;55438.44561554414;55565.72217138889;55594.16608750872;31953.52069718956;32893.17767055795;32899.50650740241;32943.176420589676;33050.8347458266;13349.666258343424;13481.932590336986;13512.324383780968;13513.391897364641;13515.324233788271;9367.110124538158;10622.203334749925;10656.520456579472;10666.36001839892;10671.466426678635;7643.617819109022;7741.845163096819;7751.3411360035025;7797.259260370256;7978.401619878532;2976.821390716564;3005;3050.8322042287446;3051.52701331294;3074.292912630063;861.6553378648591;910.2808781063019;946.0303189231093;977.6382738386842;988.8467287570438;27185.45629087407;28405.71594284072;28517.857410712815;28919;29263.707362926525;951.6669165791917;961.485605201214;995.7411073120896;1005.9547320370601;1012.6911292055994;14920.552383428514;15062.472813451477;15111;15174;15448.38206471751;410197;415510;415601;416317;417030;50197.24704129441;51356;51419.48580514147;51446.742766285926;51639.74180129151;1075.989240107589;1145.1239801551653;1167.2004676796253;1190.743990042145;1191.5650787462341;28149;28890;29530.409391811612;30054.69945300519;30166.245843854078;43380.34929475997;43904.78047609742;44009.55990440054;44047.77976110099;44079;313588;316721;318539;318623;318888;22732.772672273066;22913.770862291163;22957.96689148959;26534.734652653227;26535.203943881716;41495.58504414917;42203.3669494964;42298.78850605727;42890.142197155255;43649;35965;36136;36182.4572631416;36250;36375.27249455049;36267.45598816073;36281.81859090688;36420.27159456849;36545.817270913474;36640.81679591585;35309.646903530636;35919;36242.8187859059;36560;36683.44974825433;32006;32973.50539741858;33095.66904331022;33387.16532086717;33397.666023340425;24583.877080614482;24828.875855620605;24888.626670599595;25131.87434062818;25575.872120640022 08:05:59 INFO - PROCESS | 6427 | |2;jquery.html;376.7231085152413;380.5870630366053;383.246919802588;385.83216300909106;393.72832745405685;15777.211139443025;15947.36210551578;16856.66286674266;16878.91560542197;16881.324747010105;11946.880531194685;15864.365425383;17138.400155994543;17157.742633860504;17180.570485737862;4702.717836929778;4888.266759986012;4918.2376731606655;4926.9753651231695;4927.630427717935;3413.9146521337043;5335.1197052486295;5611.2144299798065;5627.437256274381;5738.3974682658345;5424.349078110613;5662.575306851982;5696.11710184922;5713.3429655589725;5724.484796368326;5520.171974203861;5550.888982220353;5571.192177134293;5600.915986260209;5607.046802043662;3318.2368055347406;3541.4864844597646;3543.2204914918675;3571.607123216444;5127.589792816566;12180.81728774069;12367.319797411139;12725.427355769012;12729.872701272961;12769.808452873214;1784.634149999247;1991.442396129086;2233.664950257474;2331.6968794056666;2357.1194730210964;8694.17405346491;9569.138777509988;10002.899971000343;13099.279539625317;13622.93188534061;1672.5567724553002;1682.3607029328778;1689.4678176374402;1744.8080711121765;1745.7468667043336;71501.64249178773;71824.28175718228;72446;72520.27479725188;74201.6289918547;9417.434953902788;9615.221184080967;10069.597216111273;10119.494025298853;10263.9486802567;13912.513062042983;13957.162570245819;13993.930030349784;13995.440182392591;14027.509037183854;7392.334689877936;7403.925960740431;7439.958405823081;7490.4382171337365;7562.886556701654;7053.294670533009;7090.92909070913;7168.247334029956;7209.567425954459;7248.311410416002;4367.978160109243;4425.269830478;4427.424434823452;4435.2016637005645;4525.140223357552;1681.3526792184853;1761.4099276742436;1782.6612943540686;1857.903836736332;1890.2911408221917;831.4927893984665;848.4781859156574;881.581248906777;886.8758373827669;936.2884208001967;16153.192340382933;16264.674706505804;16560.917195414186;16764.245608947625;16976.83023169777;841.5161282262724;844.2781421884323;860.6084231674573;874.5364956573027;909.0137201136708;8348.791280217922;9613.567389467491;9690.418574885529;9737.659181928599;9802.803943921082;392257;400507;404535;408726;409301;76964.61517692488;78367.21632783713;78452.60773696096;78487.60756196182;79358;895.2748273898163;898.2589363774912;901.2384535067857;907.8865141857268;916.0427353415697;14796;15215.163166025975;15280.847191527942;15370.846291536942;15670.686586267982;27464;37168.628313716516;37621.81189094037;37772.2445551093;38297;50447.49552504428;50839;51081.48918510916;51794.22308665298;52763.4045744282;7788.260115289038;7798.961005194938;7885.408594355332;8036.799080023046;8077.63650635711;10341.793164136825;11697.356645384585;11708.180427370344;11734.471948762497;11772.117091218022;9893.406395616286;10257.230707697101;10350.18871697465;10394.272400931863;10549.419781912069;9217.308701847522;10481.633142839964;10602.8939710605;10676.46617669129;10719.249652524248;9508.191803696487;9632.9036709632;9725.4650994196;10556.419396933243;10752.516136773707;6686.364795344629;6896.793096207121;7033.577985320897;7114.715411383487;7973.202679732212;7850.685972561034;9590.568424420779;10123.89876101259;10187.592496300065;10610 08:05:59 INFO - PROCESS | 6427 | |3;mootools.html;1198.79021171295;1356.8032635267884;1387.3895485986166;1474.6018574984755;1689.3158270900283;6757.695903684334;7602.3918086553085;7867.960660196705;7883.724069657556;8084.838303233932;7783.221677832214;7928;7954.482958607687;7960.124386317515;7962.323202527792;1880.8495320374407;1963.9312624058161;1965.3219639224517;2169.1323470611765;2197.7802219777973;1966.2921348314596;2171.9782802172012;2244.753077161511;2254.267363106989;2269.1944359752297;2198.86806791593;2226.1651880544796;2234.5866014787234;2235.6311208650554;2235.8099561537288;1776.7956684981264;2158.9136434542597;2173.826093912499;2180.563887222562;2180.672899065145;2044.5399785048394;2124.8406369522195;2128.4040468668795;2140.389988853185;2142.7214462119823;7881.487703299267;7910.367170626394;7915.406344524184;7927.524348539048;7931.444798864082;4575.633949284049;4689.577937985564;4691.7184968901975;4695.5304469552775;4695.765211739399;2730.563109902426;2894.493463643854;2955.7487613552876;2979;2991.4465823822443;890.1943740914483;904.1546154345708;917.5274733512247;931.6692574136151;934.7522906429801;10619.734506637242;10639.734006649818;10669.146468282519;10678.893211067867;10686.679399618024;4139.606737359946;4242.978785106055;4307.556968415616;4318.654507639381;4349.804258808361;8947.597358118901;8988.55057247135;9007.369484136048;9037.954810225907;9048.683296084606;4617.468991066004;4635.8841028973875;4637.39713837199;4642.558956899089;4644.58198762113;3597.874074407383;3673.9816300918324;4321.481422229353;4395.824167033346;4398.912021759547;3619.60184379718;3728.3102626014274;3754.7934863582764;3768.1521657626813;3775.905602359963;1217.3000524698334;1231.205872212418;1235.1539195650828;1237.2885590785154;1254.7051442910908;709.9776322096164;811.8619834628128;829.5561874397168;831.7005877883956;843.9831203376021;4998.350214472168;5150.948490515122;5177.197534382177;5200.401953775364;5226.738663066832;410.9712320137621;426.1796042617948;436.661587269862;439.0910814613719;441.333586284706;3616.222512159898;3622.9637703623152;3647.7993710346186;3718.4050551911564;3730.757500762442;9398.812023759487;9718.854217186748;9737.318387712792;9795.706128816148;9808.754781130528;9679.758006049906;9692.273079519064;9698.224142068617;9701.272404569685;9719.9028009719;6910.376061625514;7108.537945033556;7186.353228209487;7248.891266631004;7265.455090868206;5215.29593504872;5246.422893481637;5309.203619457112;5358.526405238435;5375.3280839895015;8985.326100542356;9069.138431848964;9074.637014519345;9157.175854173156;9183.403078799856;8911.376203665941;9166.908330916605;9216.262698983932;9304.30217733659;9336.766580835261;5892.911606325994;6111.755529778759;6125.724342404514;6568.7372505099265;6641.601503909781;6972.965135174494;7065.611391373318;7190.856182876418;7402.592857392679;7483.139438964588;6495.1556297681;6566.80299591013;6643.701033453603;6746.392824645805;6834.9316506836285;6465.418112369909;6491.415772580491;6685.465162787063;6767.120274364301;6822;5809.24479817621;5830.387809279964;5860.677662728421;5862.472377486047;5867.6772777497645;4505.887352816206;4610.815567377267;4647.883802904955;4710.3170040343275;4717.386739723814;4461.709988850715;4518.706284091523;4557.1797076526545;4620.422447194101;4624.329472226441 08:05:59 INFO - PROCESS | 6427 | |4;prototype.html;299.9880004799808;306.7346745065518;309.4074846668629;315.47473456694604;315.6385938100876;4619.74591397473;4782;4795.424549054114;4847.151748444021;4865.87835304118;4632.768361581924;4792.233242681172;4837.6371772117145;4861.586765124968;4867.902641947159;3827.0815004399024;3827.215420838735;3835.1946091320856;3851.691864650835;3854.672352849997;3670.871519496818;3710.5547334319785;3830.3105441020607;3833.252515759428;3841.5582208046153;3793.184465339951;3829.9234015319817;3831.712621553381;3837.6737977271964;3839;3794.544654641433;3794.886153415402;3817.675497582709;3821.426785982097;3829.942550861739;3385.6106547747077;3400.1159698478327;3401.2517246205794;3403.931921361559;3407.642197569244;4629.444466663988;4754.286856971447;4760.571548560646;4760.833370832004;4768.356271903318;4389.144116897206;4392.253316936129;4405.317175837718;4405.339199120125;4419.0940857124215;5099.694018358873;5114.565261952738;5119.513646203604;5122.386448268783;5124.1801311790305;3558.395072837624;3705.814709264526;3713.2547702580014;3721.4789929409903;3730.253949210142;5232.7122008289525;5279.894402111975;5297.973510132425;5298.947010529922;5320.361556613231;3790.2040571480297;3804.9809750951067;3810.7713537187856;3814.3706288462095;3814.9809250953567;3810.3712887373827;3864.879185036364;3873.2447172801035;3906.199229158016;3907.847185080408;4314.50383205929;4354.976580503642;4355.477342718894;4368.563143685606;4371.431713877239;5004.299398084271;5028.044671512401;5028.069807085701;5039.422010372677;5062.240663900445;1262.5833474953242;1273.6242808371553;1287.7295767888847;1295.941682624284;1303.7457695749426;861.7759382560579;862.3833958719546;874.1870060843477;880.3045593980811;883.4566741454088;3988.32490354052;4006.1386801837743;4010.639042486132;4013.478247827822;4016.8995775105855;4611.308303754464;4617.630589552828;4617.8383756568355;4649.697769644962;4714;3903.477643718952;4008.779517126586;4058.5040200276617;4062.654674352654;4067.471228740304;2323.7095363079616;2473.6147757255635;2478.7273399925994;2486.7761901428958;2488.4649800293023;4311.8490852820005;4332.397013105171;4337.544557821447;4372.3878656988045;4381.627561657295;4684.648651351163;4742.478327383985;4744.478107408182;4766.713997160182;4783.42147091459;4385.868423947287;4439.822407103679;4539.7049191802425;4966.255061740696;4970.801167953241;5216.165413533817;5227.764750586309;5233.6074794389815;5284.9735751320995;5314.627976041795;5148.897022059613;5150.124478838681;5155.9742201288755;5185.9222111669105;5203.245529398292;4717;4946.318251794407;4955.35580374549;4976.377952755905;4977.278294647183;3725.3480640887196;3726.105734623725;3735.1409175889153;3744.045268456526;3749.531308586427;5018.44797072329;5223.7910483580235;5269.657472264291;5281.55106815925;5292.153255479105;4916.557509824133;5117.462666420121;5150.48495150482;5153.788859617912;5198.778287102604;5122.410922743932;5153.922691159711;5159.587233021424;5178.575891629832;5184.922226166535;4851.975740121276;5014.272930424995;5082.085224659597;5093.490650935025;5118.948810511996;5119.667221630582;5120.465369642051;5139.820106296262;5169.844904652867;5178.922316165185;5034.345535080416;5035.446100928968;5061.949380506295;5063.265826455217;5066.746662666926 08:05:59 INFO - PROCESS | 6427 | |5;yui.html;680.8774420604292;682.5870348439195;688.6832057253663;730.8392153726185;739.7299985505289;12189.695257618552;13207.141535800167;13238.53665121721;13247.205167689934;13251.271180085092;13312.667183320398;13948.163110213369;13969.650758731037;14341.78487322691;14350.78473822891;542.2977244468423;768.8500742355243;773.0877564473918;774.7133560582593;775.6897241103547;767.7044337929881;795.6737737527615;798.3573223555036;800.7757827808223;801.2788490358665;821.6138414944967;829.5064436660177;830.211299265697;832.0265289611169;832.2883934236202;651.3356376495994;801.3348920396057;824.8432797768435;825.1583384947351;825.6325934958945;586.9354371019184;589.0633892111563;589.4341432225069;592.2803793391007;592.9021711417611;12498.25010499373;12605.054620903376;12614.369281535886;12623.684407889785;12644.620661380173;13852.584422467342;14286.64283392913;14332.856671433257;14366.784498232535;14424.134551926812;10706.571737130505;10757.731056723565;10879;10928.726781830517;11257.943710281477;3375.8143302118374;3410.1474631342167;3411.846466908995;3412.385770561298;3475.113845969287;65450.67274663644;66602.66698666524;66762;67872.3212767871;68288.3171168287;10445.164386849034;10497.737556561147;10501.89498105009;10625.149988000941;10692.251542392114;20933;21119.577608448053;21153;21221.78778212198;21297.041633126548;6622.569532980341;6856.314368563204;6863.897041544381;7181.712731490787;7495.700171993169;3646.6535679110443;3686.668199862025;3707.8516859325323;3733.701303895682;3919.2553414851086;2801.90193343232;2930.4432157889933;2933.897313594014;2939.4121175764503;2939.4708952388773;494.1821285772053;502.5351549816405;502.83155143027494;517.7281926988361;523.0323900783596;441.39969641287826;463.80056575672785;488.8289098815386;542.1840130603416;603.2489550509644;7406.444516661272;7475.691753943038;7523.247675232433;7677.462577619513;7727.16170613652;557.4007941462944;562.2578196780293;582.3274118393263;585.9326177489557;588.3204898342422;3688.7602305850032;3835.6164383561977;3922.9607703923166;3929.0766669832565;3964.8810535683974;50763.49236507588;77910;81725.59137204276;81780.18219817725;82621.58689206516;46793.532064679595;68771.65614171897;77879.22120778833;78639;81101.18898811055;70949.64525177341;71009;71935.28064719391;72012.63993679998;74420;8316.83366332682;8444.493330400195;8519.659213631385;8524.488530688179;8695.30437565006;40777.796111019255;42465;42801.571984279755;42896;43771.56228437675;35733.64266357407;43364.566354337316;59434.108488373575;61951.6902415485;62917.68541157448;10784.352938823382;11216.943915280372;11330.37682927447;11389.316641001566;11433.714157146138;11616.593419230287;12142.271463712206;12299.569515067287;12329.383530823603;12341;11350;11713.824292635787;11841.407929603312;11948.641540753792;12018;10673.786524269626;11324.433778311217;11685.357305348287;11701.648950531157;12025.518979240733;11379.715507112389;11387.886121139014;11868.881311187122;11877.52489900429;11917.702057448632;9307.674231401868;9411;9608.615655373986;9737.756556086155;9773.853392199266;8854.158854908774;8923.553822308728;8941;9580.616775329188;9757.31698781107 08:05:59 INFO - PROCESS | 6427 | __end_tp_report 08:05:59 INFO - PROCESS | 6427 | __start_cc_report 08:05:59 INFO - PROCESS | 6427 | _x_x_mozilla_cycle_collect,1003 08:05:59 INFO - PROCESS | 6427 | __end_cc_report 08:05:59 INFO - PROCESS | 6427 | __startTimestamp1466694359568__endTimestamp 08:05:59 INFO - PROCESS | 6427 | 08:05:59 INFO - PROCESS | 6427 | ------- Summary: start ------- 08:05:59 INFO - PROCESS | 6427 | Number of tests: 6 08:05:59 INFO - PROCESS | 6427 | 08:05:59 INFO - PROCESS | 6427 | [#0] dojo.html Cycles:165 Average:4743.43 Median:4862.44 stddev:506.70 (10.4%) stddev-sans-first:479.55 08:05:59 INFO - PROCESS | 6427 | Values: 2600.0 2639.2 2664.5 2679.1 2684.6 4605.3 4681.6 4688.8 4814.9 4842.0 4711.4 4740.4 4752.2 4755.8 4826.0 4344.8 4351.1 4399.6 4423.5 4439.4 4362.5 4450.3 4475.8 4509.6 4559.9 4466.4 4512.7 4515.6 4521.7 4550.6 4294.4 4334.8 4346.2 4362.8 4368.9 4316.0 4346.2 4396.1 4398.1 4442.3 4847.7 4858.9 4862.4 4862.6 4873.9 5011.1 5081.5 5130.9 5138.4 5157.9 5217.8 5226.6 5228.8 5246.3 5251.4 4683.3 4833.6 4835.7 4837.9 4866.0 5172.9 5201.7 5229.3 5241.5 5313.4 5081.2 5091.9 5092.1 5092.3 5093.5 5024.2 5105.8 5154.4 5163.5 5182.1 5103.5 5118.8 5143.4 5143.6 5195.0 5129.1 5141.9 5143.2 5144.6 5197.4 4281.8 4303.6 4361.4 4417.2 4462.8 3758.5 3764.3 3769.2 3791.2 3844.3 4318.0 4329.8 4334.0 4369.6 4376.4 4978.1 5084.3 5097.4 5123.3 5128.1 4402.5 4409.3 4435.4 4440.6 4448.2 4647.6 4664.4 4666.3 4674.4 4691.0 4516.8 4772.3 4815.1 4817.1 4827.4 5192.3 5206.4 5226.3 5231.2 5243.8 4797.9 4817.6 4824.7 4834.8 4877.9 4898.0 5013.1 5100.1 5117.1 5165.2 5081.3 5130.4 5131.2 5131.9 5184.4 4991.4 5010.9 5013.1 5013.1 5066.2 4803.9 4926.8 4957.9 5001.8 5012.8 4909.8 4938.2 4940.8 4963.2 4993.2 5041.8 5041.9 5044.1 5081.0 5098.6 4811.4 4889.0 4929.5 4955.0 4974.2 08:05:59 INFO - PROCESS | 6427 | 08:05:59 INFO - PROCESS | 6427 | [#1] ext.html Cycles:180 Average:47729.39 Median:3317.19 stddev:88891.44 (2679.7%) stddev-sans-first:89070.27 08:05:59 INFO - PROCESS | 6427 | Values: 566.7 568.4 578.1 583.8 592.4 27618.0 40533.8 41157.2 41315.2 44918.8 42034.4 42512.6 42545.1 42561.6 42615.4 7225.1 7798.2 7937.1 7950.2 7951.7 7455.5 7692.6 7695.9 9960.0 10285.8 10307.0 10374.8 10377.1 10391.6 10393.3 10239.5 10242.1 10277.4 10312.4 10313.5 7413.5 9821.2 10162.5 10173.5 10490.7 38693.0 38998.6 39032.8 39054.8 39055.8 3047.5 3097.6 3108.8 3131.3 3566.4 29093.9 29224.6 29517.3 30071.4 30932.5 3304.8 3316.9 3317.5 3320.6 3351.6 257846.0 258376.0 258463.0 259968.0 261655.0 31632.5 54866.0 55438.4 55565.7 55594.2 31953.5 32893.2 32899.5 32943.2 33050.8 13349.7 13481.9 13512.3 13513.4 13515.3 9367.1 10622.2 10656.5 10666.4 10671.5 7643.6 7741.8 7751.3 7797.3 7978.4 2976.8 3005.0 3050.8 3051.5 3074.3 861.7 910.3 946.0 977.6 988.8 27185.5 28405.7 28517.9 28919.0 29263.7 951.7 961.5 995.7 1006.0 1012.7 14920.6 15062.5 15111.0 15174.0 15448.4 410197.0 415510.0 415601.0 416317.0 417030.0 50197.2 51356.0 51419.5 51446.7 51639.7 1076.0 1145.1 1167.2 1190.7 1191.6 28149.0 28890.0 29530.4 30054.7 30166.2 43380.3 43904.8 44009.6 44047.8 44079.0 313588.0 316721.0 318539.0 318623.0 318888.0 22732.8 22913.8 22958.0 26534.7 26535.2 41495.6 42203.4 42298.8 42890.1 43649.0 35965.0 36136.0 36182.5 36250.0 36375.3 36267.5 36281.8 36420.3 36545.8 36640.8 35309.6 35919.0 36242.8 36560.0 36683.4 32006.0 32973.5 33095.7 33387.2 33397.7 24583.9 24828.9 24888.6 25131.9 25575.9 08:05:59 INFO - PROCESS | 6427 | 08:05:59 INFO - PROCESS | 6427 | [#2] jquery.html Cycles:180 Average:24487.78 Median:4426.35 stddev:66613.58 (1504.9%) stddev-sans-first:66775.84 08:05:59 INFO - PROCESS | 6427 | Values: 376.7 380.6 383.2 385.8 393.7 15777.2 15947.4 16856.7 16878.9 16881.3 11946.9 15864.4 17138.4 17157.7 17180.6 4702.7 4888.3 4918.2 4927.0 4927.6 3413.9 5335.1 5611.2 5627.4 5738.4 5424.3 5662.6 5696.1 5713.3 5724.5 5520.2 5550.9 5571.2 5600.9 5607.0 3318.2 3541.5 3543.2 3571.6 5127.6 12180.8 12367.3 12725.4 12729.9 12769.8 1784.6 1991.4 2233.7 2331.7 2357.1 8694.2 9569.1 10002.9 13099.3 13622.9 1672.6 1682.4 1689.5 1744.8 1745.7 71501.6 71824.3 72446.0 72520.3 74201.6 9417.4 9615.2 10069.6 10119.5 10263.9 13912.5 13957.2 13993.9 13995.4 14027.5 7392.3 7403.9 7440.0 7490.4 7562.9 7053.3 7090.9 7168.2 7209.6 7248.3 4368.0 4425.3 4427.4 4435.2 4525.1 1681.4 1761.4 1782.7 1857.9 1890.3 831.5 848.5 881.6 886.9 936.3 16153.2 16264.7 16560.9 16764.2 16976.8 841.5 844.3 860.6 874.5 909.0 8348.8 9613.6 9690.4 9737.7 9802.8 392257.0 400507.0 404535.0 408726.0 409301.0 76964.6 78367.2 78452.6 78487.6 79358.0 895.3 898.3 901.2 907.9 916.0 14796.0 15215.2 15280.8 15370.8 15670.7 27464.0 37168.6 37621.8 37772.2 38297.0 50447.5 50839.0 51081.5 51794.2 52763.4 7788.3 7799.0 7885.4 8036.8 8077.6 10341.8 11697.4 11708.2 11734.5 11772.1 9893.4 10257.2 10350.2 10394.3 10549.4 9217.3 10481.6 10602.9 10676.5 10719.2 9508.2 9632.9 9725.5 10556.4 10752.5 6686.4 6896.8 7033.6 7114.7 7973.2 7850.7 9590.6 10123.9 10187.6 10610.0 08:05:59 INFO - PROCESS | 6427 | 08:05:59 INFO - PROCESS | 6427 | [#3] mootools.html Cycles:180 Average:5101.69 Median:5074.65 stddev:2900.66 (57.2%) stddev-sans-first:2893.96 08:05:59 INFO - PROCESS | 6427 | Values: 1198.8 1356.8 1387.4 1474.6 1689.3 6757.7 7602.4 7868.0 7883.7 8084.8 7783.2 7928.0 7954.5 7960.1 7962.3 1880.8 1963.9 1965.3 2169.1 2197.8 1966.3 2172.0 2244.8 2254.3 2269.2 2198.9 2226.2 2234.6 2235.6 2235.8 1776.8 2158.9 2173.8 2180.6 2180.7 2044.5 2124.8 2128.4 2140.4 2142.7 7881.5 7910.4 7915.4 7927.5 7931.4 4575.6 4689.6 4691.7 4695.5 4695.8 2730.6 2894.5 2955.7 2979.0 2991.4 890.2 904.2 917.5 931.7 934.8 10619.7 10639.7 10669.1 10678.9 10686.7 4139.6 4243.0 4307.6 4318.7 4349.8 8947.6 8988.6 9007.4 9038.0 9048.7 4617.5 4635.9 4637.4 4642.6 4644.6 3597.9 3674.0 4321.5 4395.8 4398.9 3619.6 3728.3 3754.8 3768.2 3775.9 1217.3 1231.2 1235.2 1237.3 1254.7 710.0 811.9 829.6 831.7 844.0 4998.4 5150.9 5177.2 5200.4 5226.7 411.0 426.2 436.7 439.1 441.3 3616.2 3623.0 3647.8 3718.4 3730.8 9398.8 9718.9 9737.3 9795.7 9808.8 9679.8 9692.3 9698.2 9701.3 9719.9 6910.4 7108.5 7186.4 7248.9 7265.5 5215.3 5246.4 5309.2 5358.5 5375.3 8985.3 9069.1 9074.6 9157.2 9183.4 8911.4 9166.9 9216.3 9304.3 9336.8 5892.9 6111.8 6125.7 6568.7 6641.6 6973.0 7065.6 7190.9 7402.6 7483.1 6495.2 6566.8 6643.7 6746.4 6834.9 6465.4 6491.4 6685.5 6767.1 6822.0 5809.2 5830.4 5860.7 5862.5 5867.7 4505.9 4610.8 4647.9 4710.3 4717.4 4461.7 4518.7 4557.2 4620.4 4624.3 08:05:59 INFO - PROCESS | 6427 | 08:05:59 INFO - PROCESS | 6427 | [#4] prototype.html Cycles:180 Average:4157.00 Median:4618.79 stddev:1205.72 (26.1%) stddev-sans-first:1173.83 08:05:59 INFO - PROCESS | 6427 | Values: 300.0 306.7 309.4 315.5 315.6 4619.7 4782.0 4795.4 4847.2 4865.9 4632.8 4792.2 4837.6 4861.6 4867.9 3827.1 3827.2 3835.2 3851.7 3854.7 3670.9 3710.6 3830.3 3833.3 3841.6 3793.2 3829.9 3831.7 3837.7 3839.0 3794.5 3794.9 3817.7 3821.4 3829.9 3385.6 3400.1 3401.3 3403.9 3407.6 4629.4 4754.3 4760.6 4760.8 4768.4 4389.1 4392.3 4405.3 4405.3 4419.1 5099.7 5114.6 5119.5 5122.4 5124.2 3558.4 3705.8 3713.3 3721.5 3730.3 5232.7 5279.9 5298.0 5298.9 5320.4 3790.2 3805.0 3810.8 3814.4 3815.0 3810.4 3864.9 3873.2 3906.2 3907.8 4314.5 4355.0 4355.5 4368.6 4371.4 5004.3 5028.0 5028.1 5039.4 5062.2 1262.6 1273.6 1287.7 1295.9 1303.7 861.8 862.4 874.2 880.3 883.5 3988.3 4006.1 4010.6 4013.5 4016.9 4611.3 4617.6 4617.8 4649.7 4714.0 3903.5 4008.8 4058.5 4062.7 4067.5 2323.7 2473.6 2478.7 2486.8 2488.5 4311.8 4332.4 4337.5 4372.4 4381.6 4684.6 4742.5 4744.5 4766.7 4783.4 4385.9 4439.8 4539.7 4966.3 4970.8 5216.2 5227.8 5233.6 5285.0 5314.6 5148.9 5150.1 5156.0 5185.9 5203.2 4717.0 4946.3 4955.4 4976.4 4977.3 3725.3 3726.1 3735.1 3744.0 3749.5 5018.4 5223.8 5269.7 5281.6 5292.2 4916.6 5117.5 5150.5 5153.8 5198.8 5122.4 5153.9 5159.6 5178.6 5184.9 4852.0 5014.3 5082.1 5093.5 5118.9 5119.7 5120.5 5139.8 5169.8 5178.9 5034.3 5035.4 5061.9 5063.3 5066.7 08:05:59 INFO - PROCESS | 6427 | 08:05:59 INFO - PROCESS | 6427 | [#5] yui.html Cycles:180 Average:16568.42 Median:491.51 stddev:22374.27 (4552.2%) stddev-sans-first:22405.24 08:05:59 INFO - PROCESS | 6427 | Values: 680.9 682.6 688.7 730.8 739.7 12189.7 13207.1 13238.5 13247.2 13251.3 13312.7 13948.2 13969.7 14341.8 14350.8 542.3 768.9 773.1 774.7 775.7 767.7 795.7 798.4 800.8 801.3 821.6 829.5 830.2 832.0 832.3 651.3 801.3 824.8 825.2 825.6 586.9 589.1 589.4 592.3 592.9 12498.3 12605.1 12614.4 12623.7 12644.6 13852.6 14286.6 14332.9 14366.8 14424.1 10706.6 10757.7 10879.0 10928.7 11257.9 3375.8 3410.1 3411.8 3412.4 3475.1 65450.7 66602.7 66762.0 67872.3 68288.3 10445.2 10497.7 10501.9 10625.1 10692.3 20933.0 21119.6 21153.0 21221.8 21297.0 6622.6 6856.3 6863.9 7181.7 7495.7 3646.7 3686.7 3707.9 3733.7 3919.3 2801.9 2930.4 2933.9 2939.4 2939.5 494.2 502.5 502.8 517.7 523.0 441.4 463.8 488.8 542.2 603.2 7406.4 7475.7 7523.2 7677.5 7727.2 557.4 562.3 582.3 585.9 588.3 3688.8 3835.6 3923.0 3929.1 3964.9 50763.5 77910.0 81725.6 81780.2 82621.6 46793.5 68771.7 77879.2 78639.0 81101.2 70949.6 71009.0 71935.3 72012.6 74420.0 8316.8 8444.5 8519.7 8524.5 8695.3 40777.8 42465.0 42801.6 42896.0 43771.6 35733.6 43364.6 59434.1 61951.7 62917.7 10784.4 11216.9 11330.4 11389.3 11433.7 11616.6 12142.3 12299.6 12329.4 12341.0 11350.0 11713.8 11841.4 11948.6 12018.0 10673.8 11324.4 11685.4 11701.6 12025.5 11379.7 11387.9 11868.9 11877.5 11917.7 9307.7 9411.0 9608.6 9737.8 9773.9 8854.2 8923.6 8941.0 9580.6 9757.3 08:05:59 INFO - PROCESS | 6427 | -------- Summary: end -------- 08:05:59 INFO - PROCESS | 6427 | 08:06:00 INFO - TEST-INFO | 6427: exit 0 08:06:00 INFO - TEST-OK | dromaeo_css | took 1120607ms 08:06:00 INFO - TEST-START | kraken 08:06:00 INFO - operating with platform_type : linux_ 08:06:00 INFO - Initialising browser for kraken test... 08:06:00 INFO - TEST-INFO | started process 6605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL4XHbL/profile http://localhost:60505/getInfo.html) 08:06:04 INFO - PROCESS | 6605 | __metrics Screen width/height:1600/1200 08:06:04 INFO - PROCESS | 6605 | colorDepth:24 08:06:04 INFO - PROCESS | 6605 | Browser inner width/height: 1024/697 08:06:04 INFO - PROCESS | 6605 | __metrics 08:06:05 INFO - PROCESS | 6605 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:06 INFO - TEST-INFO | 6605: exit 0 08:06:06 INFO - Browser initialized. 08:06:06 INFO - Running cycle 1/1 for kraken test... 08:06:06 INFO - TEST-INFO | started process 6685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL4XHbL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:18 INFO - PROCESS | 6685 | RSS: Main: 175489024 08:06:18 INFO - PROCESS | 6685 | 08:06:21 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60505/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:22 INFO - PROCESS | 6685 | RSS: Main: 233250816 08:06:22 INFO - PROCESS | 6685 | 08:06:25 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60505/tests/kraken/driver.html?testName=audio-dft) 08:06:26 INFO - PROCESS | 6685 | RSS: Main: 222670848 08:06:26 INFO - PROCESS | 6685 | 08:06:29 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60505/tests/kraken/driver.html?testName=audio-fft) 08:06:29 INFO - PROCESS | 6685 | RSS: Main: 289144832 08:06:29 INFO - PROCESS | 6685 | 08:06:32 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60505/tests/kraken/driver.html?testName=audio-oscillator) 08:06:32 INFO - PROCESS | 6685 | RSS: Main: 199049216 08:06:32 INFO - PROCESS | 6685 | 08:06:34 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60505/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:35 INFO - PROCESS | 6685 | RSS: Main: 203595776 08:06:35 INFO - PROCESS | 6685 | 08:06:38 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60505/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:39 INFO - PROCESS | 6685 | RSS: Main: 239427584 08:06:39 INFO - PROCESS | 6685 | 08:06:42 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60505/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:43 INFO - PROCESS | 6685 | RSS: Main: 235065344 08:06:43 INFO - PROCESS | 6685 | 08:06:46 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60505/tests/kraken/driver.html?testName=json-parse-financial) 08:06:46 INFO - PROCESS | 6685 | RSS: Main: 237826048 08:06:46 INFO - PROCESS | 6685 | 08:06:48 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60505/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:49 INFO - PROCESS | 6685 | RSS: Main: 224985088 08:06:49 INFO - PROCESS | 6685 | 08:06:51 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60505/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:51 INFO - PROCESS | 6685 | RSS: Main: 229543936 08:06:51 INFO - PROCESS | 6685 | 08:06:54 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60505/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:54 INFO - PROCESS | 6685 | RSS: Main: 237232128 08:06:54 INFO - PROCESS | 6685 | 08:06:57 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60505/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:58 INFO - PROCESS | 6685 | RSS: Main: 241618944 08:06:58 INFO - PROCESS | 6685 | 08:07:01 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60505/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:01 INFO - PROCESS | 6685 | RSS: Main: 240517120 08:07:01 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | Cycle 1(1): loaded http://localhost:60505/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60505/tests/kraken/driver.html?testName=ai-astar) 08:07:03 INFO - PROCESS | 6685 | RSS: Main: 283672576 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | __start_tp_report 08:07:03 INFO - PROCESS | 6685 | _x_x_mozilla_page_load 08:07:03 INFO - PROCESS | 6685 | _x_x_mozilla_page_load_details 08:07:03 INFO - PROCESS | 6685 | |i|pagename|runs| 08:07:03 INFO - PROCESS | 6685 | |0;ai-astar;105;114;112;113;114;115;113;112;114;113 08:07:03 INFO - PROCESS | 6685 | |1;audio-beat-detection;158;132;132;187;138;131;151;129;166;134 08:07:03 INFO - PROCESS | 6685 | |2;audio-dft;162;161;160;160;162;162;162;163;161;162 08:07:03 INFO - PROCESS | 6685 | |3;audio-fft;75;77;76;106;77;76;77;75;98;76 08:07:03 INFO - PROCESS | 6685 | |4;audio-oscillator;85;86;109;87;88;88;118;86;87;124 08:07:03 INFO - PROCESS | 6685 | |5;imaging-gaussian-blur;117;117;116;116;116;117;116;117;116;117 08:07:03 INFO - PROCESS | 6685 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;145 08:07:03 INFO - PROCESS | 6685 | |7;imaging-desaturate;95;95;94;95;95;94;95;94;99;94 08:07:03 INFO - PROCESS | 6685 | |8;json-parse-financial;65;65;64;65;65;65;65;65;65;72 08:07:03 INFO - PROCESS | 6685 | |9;json-stringify-tinderbox;66;65;64;65;66;66;66;65;65;65 08:07:03 INFO - PROCESS | 6685 | |10;stanford-crypto-aes;89;83;88;82;84;84;89;84;99;88 08:07:03 INFO - PROCESS | 6685 | |11;stanford-crypto-ccm;134;132;130;130;138;149;127;134;157;141 08:07:03 INFO - PROCESS | 6685 | |12;stanford-crypto-pbkdf2;172;179;170;168;171;169;183;176;170;171 08:07:03 INFO - PROCESS | 6685 | |13;stanford-crypto-sha256-iterative;68;68;67;69;68;68;69;68;68;70 08:07:03 INFO - PROCESS | 6685 | __end_tp_report 08:07:03 INFO - PROCESS | 6685 | __start_cc_report 08:07:03 INFO - PROCESS | 6685 | _x_x_mozilla_cycle_collect,1901 08:07:03 INFO - PROCESS | 6685 | __end_cc_report 08:07:03 INFO - PROCESS | 6685 | __startTimestamp1466694423734__endTimestamp 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | ------- Summary: start ------- 08:07:03 INFO - PROCESS | 6685 | Number of tests: 14 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 08:07:03 INFO - PROCESS | 6685 | Values: 105.0 114.0 112.0 113.0 114.0 115.0 113.0 112.0 114.0 113.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:144.50 stddev:19.33 (13.4%) stddev-sans-first:19.99 08:07:03 INFO - PROCESS | 6685 | Values: 158.0 132.0 132.0 187.0 138.0 131.0 151.0 129.0 166.0 134.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:07:03 INFO - PROCESS | 6685 | Values: 162.0 161.0 160.0 160.0 162.0 162.0 162.0 163.0 161.0 162.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.50 stddev:11.10 (14.5%) stddev-sans-first:11.53 08:07:03 INFO - PROCESS | 6685 | Values: 75.0 77.0 76.0 106.0 77.0 76.0 77.0 75.0 98.0 76.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:86.50 stddev:15.08 (17.4%) stddev-sans-first:15.48 08:07:03 INFO - PROCESS | 6685 | Values: 85.0 86.0 109.0 87.0 88.0 88.0 118.0 86.0 87.0 124.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:07:03 INFO - PROCESS | 6685 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:07:03 INFO - PROCESS | 6685 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.49 (1.6%) stddev-sans-first:1.58 08:07:03 INFO - PROCESS | 6685 | Values: 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 99.0 94.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:2.27 (3.5%) stddev-sans-first:2.40 08:07:03 INFO - PROCESS | 6685 | Values: 65.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 72.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 08:07:03 INFO - PROCESS | 6685 | Values: 66.0 65.0 64.0 65.0 66.0 66.0 66.0 65.0 65.0 65.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:88.00 stddev:4.97 (5.6%) stddev-sans-first:5.21 08:07:03 INFO - PROCESS | 6685 | Values: 89.0 83.0 88.0 82.0 84.0 84.0 89.0 84.0 99.0 88.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:136.00 stddev:9.44 (6.9%) stddev-sans-first:9.94 08:07:03 INFO - PROCESS | 6685 | Values: 134.0 132.0 130.0 130.0 138.0 149.0 127.0 134.0 157.0 141.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:171.50 stddev:4.86 (2.8%) stddev-sans-first:5.15 08:07:03 INFO - PROCESS | 6685 | Values: 172.0 179.0 170.0 168.0 171.0 169.0 183.0 176.0 170.0 171.0 08:07:03 INFO - PROCESS | 6685 | 08:07:03 INFO - PROCESS | 6685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 08:07:03 INFO - PROCESS | 6685 | Values: 68.0 68.0 67.0 69.0 68.0 68.0 69.0 68.0 68.0 70.0 08:07:03 INFO - PROCESS | 6685 | -------- Summary: end -------- 08:07:03 INFO - PROCESS | 6685 | 08:07:04 INFO - TEST-INFO | 6685: exit 0 08:07:04 INFO - TEST-OK | kraken | took 64410ms 08:07:04 INFO - SUITE-END | took 1185s 08:07:04 INFO - Completed test suite (00:19:45) 08:07:04 INFO - javascript benchmark 08:07:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.961000584991, 2639.221429678247, 2664.493746188224, 2679.0623281851354, 2684.6241526186327, 4605.286180642006, 4681.555252251035, 4688.765561721917, 4814.879628009297, 4841.975790121049, 4711.434627844664, 4740.3600513930605, 4752.239641657336, 4755.833545825888, 4825.975870120645, 4344.826206951718, 4351.0862718829085, 4399.560043995591, 4423.469183697961, 4439.356293337464, 4362.454693163355, 4450.287953927373, 4475.843345482909, 4509.594136527712, 4559.908801823962, 4466.441694788152, 4512.684112112153, 4515.638748900113, 4521.683482156251, 4550.590446859782, 4294.377315289265, 4334.783260836945, 4346.195953748535, 4362.781860906942, 4368.934465983013, 4315.956840431587, 4346.15250026245, 4396.098799746076, 4398.142362239365, 4442.311441726538, 4847.733374664392, 4858.854234372974, 4862.44081930579, 4862.586680132157, 4873.8781530461665, 5011.1481048221885, 5081.517255860687, 5130.948690513122, 5138.409082955471, 5157.896842063175, 5217.843464696065, 5226.634135610509, 5228.76470558822, 5246.317978662788, 5251.396089449724, 4683.297505374221, 4833.564979151823, 4835.734034628059, 4837.927431088537, 4866.02679464105, 5172.870678232999, 5201.713905735221, 5229.346331708536, 5241.528262456397, 5313.362396512443, 5081.161608334657, 5091.9236211456855, 5092.0579692756955, 5092.312537807348, 5093.465186155475, 5024.196128619404, 5105.846824595268, 5154.407243167084, 5163.509466600667, 5182.144946083929, 5103.515166059218, 5118.769655365518, 5143.4085080216255, 5143.614228932845, 5194.961007798455, 5129.12804823181, 5141.922871156936, 5143.202803565378, 5144.639875208774, 5197.350331208599, 4281.807318670667, 4303.63419109373, 4361.433013708198, 4417.204903117406, 4462.754548499799, 3758.4550240215017, 3764.3412402829395, 3769.208466222069, 3791.2227993261317, 3844.3272427325105, 4318.00685842258, 4329.848455304049, 4333.956660433419, 4369.628581570602, 4376.387305777193, 4978.079055374695, 5084.262781896604, 5097.413797413345, 5123.2827404163445, 5128.076946149654, 4402.515723270501, 4409.33859921008, 4435.423394958635, 4440.600345968878, 4448.199324121624, 4647.604953578983, 4664.39362882823, 4666.300054991711, 4674.368960190399, 4691.038337140878, 4516.841910533116, 4772.308015337687, 4815.085133824562, 4817.108834865561, 4827.444843842863, 5192.299039629753, 5206.375234971828, 5226.346706661668, 5231.189165679326, 5243.8164664236565, 4797.904041919072, 4817.590504807131, 4824.710517368969, 4834.758262086812, 4877.878053048702, 4897.9510204898925, 5013.122703526941, 5100.107481190851, 5117.078925793393, 5165.173572228426, 5081.314022607048, 5130.4100028497205, 5131.2303154525625, 5131.87170320745, 5184.377874655065, 4991.376077990251, 5010.899782004412, 5013.072581572275, 5013.147764880052, 5066.2400639902835, 4803.855884323476, 4926.753662316798, 4957.900841983068, 5001.8499445016705, 5012.8496145115705, 4909.803607855646, 4938.209886418156, 4940.802367905244, 4963.181075122564, 4993.226049962262, 5041.798328066836, 5041.899162016666, 5044.1424957758, 5081.0, 5098.643094983464, 4811.374521312207, 4888.9755551222015, 4929.482404347492, 4955.008998200302, 4974.154393753143], "value": 4710.409853190771, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7081453051678, 568.4429259325858, 578.1414599320011, 583.7927535724817, 592.3868795796349, 27618.0, 40533.79733101334, 41157.17685646289, 41315.17369652605, 44918.77540612301, 42034.36948445768, 42512.57487425125, 42545.14909701804, 42561.57438425615, 42615.360769588406, 7225.132984041922, 7798.181190974937, 7937.126916039231, 7950.24472675095, 7951.72168974086, 7455.4781165318445, 7692.615369231544, 7695.884561731578, 9960.0, 10285.794284114314, 10307.0, 10374.844377334346, 10377.117944974687, 10391.636292729756, 10393.32443391181, 10239.48802559869, 10242.078212960794, 10277.383356998529, 10312.381257124596, 10313.484325783718, 7413.51812132215, 9821.165200957927, 10162.491875406275, 10173.54219060144, 10490.737731556772, 38693.0, 38998.61001389978, 39032.804835975636, 39054.80472597647, 39055.8047209765, 3047.527633216855, 3097.5973123494027, 3108.8445577721022, 3131.2550783804663, 3566.4115420955513, 29093.85453072721, 29224.561631575543, 29517.262068448246, 30071.398572028436, 30932.536011959837, 3304.7686661933676, 3316.933661326784, 3317.4526203176447, 3320.6015278166533, 3351.581052368454, 257846.0, 258376.0, 258463.0, 259968.0, 261655.0, 31632.525512117336, 54866.0, 55438.44561554414, 55565.72217138889, 55594.16608750872, 31953.52069718956, 32893.17767055795, 32899.50650740241, 32943.176420589676, 33050.8347458266, 13349.666258343424, 13481.932590336986, 13512.324383780968, 13513.391897364641, 13515.324233788271, 9367.110124538158, 10622.203334749925, 10656.520456579472, 10666.36001839892, 10671.466426678635, 7643.617819109022, 7741.845163096819, 7751.3411360035025, 7797.259260370256, 7978.401619878532, 2976.821390716564, 3005.0, 3050.8322042287446, 3051.52701331294, 3074.292912630063, 861.6553378648591, 910.2808781063019, 946.0303189231093, 977.6382738386842, 988.8467287570438, 27185.45629087407, 28405.71594284072, 28517.857410712815, 28919.0, 29263.707362926525, 951.6669165791917, 961.485605201214, 995.7411073120896, 1005.9547320370601, 1012.6911292055994, 14920.552383428514, 15062.472813451477, 15111.0, 15174.0, 15448.38206471751, 410197.0, 415510.0, 415601.0, 416317.0, 417030.0, 50197.24704129441, 51356.0, 51419.48580514147, 51446.742766285926, 51639.74180129151, 1075.989240107589, 1145.1239801551653, 1167.2004676796253, 1190.743990042145, 1191.5650787462341, 28149.0, 28890.0, 29530.409391811612, 30054.69945300519, 30166.245843854078, 43380.34929475997, 43904.78047609742, 44009.55990440054, 44047.77976110099, 44079.0, 313588.0, 316721.0, 318539.0, 318623.0, 318888.0, 22732.772672273066, 22913.770862291163, 22957.96689148959, 26534.734652653227, 26535.203943881716, 41495.58504414917, 42203.3669494964, 42298.78850605727, 42890.142197155255, 43649.0, 35965.0, 36136.0, 36182.4572631416, 36250.0, 36375.27249455049, 36267.45598816073, 36281.81859090688, 36420.27159456849, 36545.817270913474, 36640.81679591585, 35309.646903530636, 35919.0, 36242.8187859059, 36560.0, 36683.44974825433, 32006.0, 32973.50539741858, 33095.66904331022, 33387.16532086717, 33397.666023340425, 24583.877080614482, 24828.875855620605, 24888.626670599595, 25131.87434062818, 25575.872120640022], "value": 16974.14479132211, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.7231085152413, 380.5870630366053, 383.246919802588, 385.83216300909106, 393.72832745405685, 15777.211139443025, 15947.36210551578, 16856.66286674266, 16878.91560542197, 16881.324747010105, 11946.880531194685, 15864.365425383, 17138.400155994543, 17157.742633860504, 17180.570485737862, 4702.717836929778, 4888.266759986012, 4918.2376731606655, 4926.9753651231695, 4927.630427717935, 3413.9146521337043, 5335.1197052486295, 5611.2144299798065, 5627.437256274381, 5738.3974682658345, 5424.349078110613, 5662.575306851982, 5696.11710184922, 5713.3429655589725, 5724.484796368326, 5520.171974203861, 5550.888982220353, 5571.192177134293, 5600.915986260209, 5607.046802043662, 3318.2368055347406, 3541.4864844597646, 3543.2204914918675, 3571.607123216444, 5127.589792816566, 12180.81728774069, 12367.319797411139, 12725.427355769012, 12729.872701272961, 12769.808452873214, 1784.634149999247, 1991.442396129086, 2233.664950257474, 2331.6968794056666, 2357.1194730210964, 8694.17405346491, 9569.138777509988, 10002.899971000343, 13099.279539625317, 13622.93188534061, 1672.5567724553002, 1682.3607029328778, 1689.4678176374402, 1744.8080711121765, 1745.7468667043336, 71501.64249178773, 71824.28175718228, 72446.0, 72520.27479725188, 74201.6289918547, 9417.434953902788, 9615.221184080967, 10069.597216111273, 10119.494025298853, 10263.9486802567, 13912.513062042983, 13957.162570245819, 13993.930030349784, 13995.440182392591, 14027.509037183854, 7392.334689877936, 7403.925960740431, 7439.958405823081, 7490.4382171337365, 7562.886556701654, 7053.294670533009, 7090.92909070913, 7168.247334029956, 7209.567425954459, 7248.311410416002, 4367.978160109243, 4425.269830478, 4427.424434823452, 4435.2016637005645, 4525.140223357552, 1681.3526792184853, 1761.4099276742436, 1782.6612943540686, 1857.903836736332, 1890.2911408221917, 831.4927893984665, 848.4781859156574, 881.581248906777, 886.8758373827669, 936.2884208001967, 16153.192340382933, 16264.674706505804, 16560.917195414186, 16764.245608947625, 16976.83023169777, 841.5161282262724, 844.2781421884323, 860.6084231674573, 874.5364956573027, 909.0137201136708, 8348.791280217922, 9613.567389467491, 9690.418574885529, 9737.659181928599, 9802.803943921082, 392257.0, 400507.0, 404535.0, 408726.0, 409301.0, 76964.61517692488, 78367.21632783713, 78452.60773696096, 78487.60756196182, 79358.0, 895.2748273898163, 898.2589363774912, 901.2384535067857, 907.8865141857268, 916.0427353415697, 14796.0, 15215.163166025975, 15280.847191527942, 15370.846291536942, 15670.686586267982, 27464.0, 37168.628313716516, 37621.81189094037, 37772.2445551093, 38297.0, 50447.49552504428, 50839.0, 51081.48918510916, 51794.22308665298, 52763.4045744282, 7788.260115289038, 7798.961005194938, 7885.408594355332, 8036.799080023046, 8077.63650635711, 10341.793164136825, 11697.356645384585, 11708.180427370344, 11734.471948762497, 11772.117091218022, 9893.406395616286, 10257.230707697101, 10350.18871697465, 10394.272400931863, 10549.419781912069, 9217.308701847522, 10481.633142839964, 10602.8939710605, 10676.46617669129, 10719.249652524248, 9508.191803696487, 9632.9036709632, 9725.4650994196, 10556.419396933243, 10752.516136773707, 6686.364795344629, 6896.793096207121, 7033.577985320897, 7114.715411383487, 7973.202679732212, 7850.685972561034, 9590.568424420779, 10123.89876101259, 10187.592496300065, 10610.0], "value": 8053.8360446885945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1198.79021171295, 1356.8032635267884, 1387.3895485986166, 1474.6018574984755, 1689.3158270900283, 6757.695903684334, 7602.3918086553085, 7867.960660196705, 7883.724069657556, 8084.838303233932, 7783.221677832214, 7928.0, 7954.482958607687, 7960.124386317515, 7962.323202527792, 1880.8495320374407, 1963.9312624058161, 1965.3219639224517, 2169.1323470611765, 2197.7802219777973, 1966.2921348314596, 2171.9782802172012, 2244.753077161511, 2254.267363106989, 2269.1944359752297, 2198.86806791593, 2226.1651880544796, 2234.5866014787234, 2235.6311208650554, 2235.8099561537288, 1776.7956684981264, 2158.9136434542597, 2173.826093912499, 2180.563887222562, 2180.672899065145, 2044.5399785048394, 2124.8406369522195, 2128.4040468668795, 2140.389988853185, 2142.7214462119823, 7881.487703299267, 7910.367170626394, 7915.406344524184, 7927.524348539048, 7931.444798864082, 4575.633949284049, 4689.577937985564, 4691.7184968901975, 4695.5304469552775, 4695.765211739399, 2730.563109902426, 2894.493463643854, 2955.7487613552876, 2979.0, 2991.4465823822443, 890.1943740914483, 904.1546154345708, 917.5274733512247, 931.6692574136151, 934.7522906429801, 10619.734506637242, 10639.734006649818, 10669.146468282519, 10678.893211067867, 10686.679399618024, 4139.606737359946, 4242.978785106055, 4307.556968415616, 4318.654507639381, 4349.804258808361, 8947.597358118901, 8988.55057247135, 9007.369484136048, 9037.954810225907, 9048.683296084606, 4617.468991066004, 4635.8841028973875, 4637.39713837199, 4642.558956899089, 4644.58198762113, 3597.874074407383, 3673.9816300918324, 4321.481422229353, 4395.824167033346, 4398.912021759547, 3619.60184379718, 3728.3102626014274, 3754.7934863582764, 3768.1521657626813, 3775.905602359963, 1217.3000524698334, 1231.205872212418, 1235.1539195650828, 1237.2885590785154, 1254.7051442910908, 709.9776322096164, 811.8619834628128, 829.5561874397168, 831.7005877883956, 843.9831203376021, 4998.350214472168, 5150.948490515122, 5177.197534382177, 5200.401953775364, 5226.738663066832, 410.9712320137621, 426.1796042617948, 436.661587269862, 439.0910814613719, 441.333586284706, 3616.222512159898, 3622.9637703623152, 3647.7993710346186, 3718.4050551911564, 3730.757500762442, 9398.812023759487, 9718.854217186748, 9737.318387712792, 9795.706128816148, 9808.754781130528, 9679.758006049906, 9692.273079519064, 9698.224142068617, 9701.272404569685, 9719.9028009719, 6910.376061625514, 7108.537945033556, 7186.353228209487, 7248.891266631004, 7265.455090868206, 5215.29593504872, 5246.422893481637, 5309.203619457112, 5358.526405238435, 5375.3280839895015, 8985.326100542356, 9069.138431848964, 9074.637014519345, 9157.175854173156, 9183.403078799856, 8911.376203665941, 9166.908330916605, 9216.262698983932, 9304.30217733659, 9336.766580835261, 5892.911606325994, 6111.755529778759, 6125.724342404514, 6568.7372505099265, 6641.601503909781, 6972.965135174494, 7065.611391373318, 7190.856182876418, 7402.592857392679, 7483.139438964588, 6495.1556297681, 6566.80299591013, 6643.701033453603, 6746.392824645805, 6834.9316506836285, 6465.418112369909, 6491.415772580491, 6685.465162787063, 6767.120274364301, 6822.0, 5809.24479817621, 5830.387809279964, 5860.677662728421, 5862.472377486047, 5867.6772777497645, 4505.887352816206, 4610.815567377267, 4647.883802904955, 4710.3170040343275, 4717.386739723814, 4461.709988850715, 4518.706284091523, 4557.1797076526545, 4620.422447194101, 4624.329472226441], "value": 4034.165970065704, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.9880004799808, 306.7346745065518, 309.4074846668629, 315.47473456694604, 315.6385938100876, 4619.74591397473, 4782.0, 4795.424549054114, 4847.151748444021, 4865.87835304118, 4632.768361581924, 4792.233242681172, 4837.6371772117145, 4861.586765124968, 4867.902641947159, 3827.0815004399024, 3827.215420838735, 3835.1946091320856, 3851.691864650835, 3854.672352849997, 3670.871519496818, 3710.5547334319785, 3830.3105441020607, 3833.252515759428, 3841.5582208046153, 3793.184465339951, 3829.9234015319817, 3831.712621553381, 3837.6737977271964, 3839.0, 3794.544654641433, 3794.886153415402, 3817.675497582709, 3821.426785982097, 3829.942550861739, 3385.6106547747077, 3400.1159698478327, 3401.2517246205794, 3403.931921361559, 3407.642197569244, 4629.444466663988, 4754.286856971447, 4760.571548560646, 4760.833370832004, 4768.356271903318, 4389.144116897206, 4392.253316936129, 4405.317175837718, 4405.339199120125, 4419.0940857124215, 5099.694018358873, 5114.565261952738, 5119.513646203604, 5122.386448268783, 5124.1801311790305, 3558.395072837624, 3705.814709264526, 3713.2547702580014, 3721.4789929409903, 3730.253949210142, 5232.7122008289525, 5279.894402111975, 5297.973510132425, 5298.947010529922, 5320.361556613231, 3790.2040571480297, 3804.9809750951067, 3810.7713537187856, 3814.3706288462095, 3814.9809250953567, 3810.3712887373827, 3864.879185036364, 3873.2447172801035, 3906.199229158016, 3907.847185080408, 4314.50383205929, 4354.976580503642, 4355.477342718894, 4368.563143685606, 4371.431713877239, 5004.299398084271, 5028.044671512401, 5028.069807085701, 5039.422010372677, 5062.240663900445, 1262.5833474953242, 1273.6242808371553, 1287.7295767888847, 1295.941682624284, 1303.7457695749426, 861.7759382560579, 862.3833958719546, 874.1870060843477, 880.3045593980811, 883.4566741454088, 3988.32490354052, 4006.1386801837743, 4010.639042486132, 4013.478247827822, 4016.8995775105855, 4611.308303754464, 4617.630589552828, 4617.8383756568355, 4649.697769644962, 4714.0, 3903.477643718952, 4008.779517126586, 4058.5040200276617, 4062.654674352654, 4067.471228740304, 2323.7095363079616, 2473.6147757255635, 2478.7273399925994, 2486.7761901428958, 2488.4649800293023, 4311.8490852820005, 4332.397013105171, 4337.544557821447, 4372.3878656988045, 4381.627561657295, 4684.648651351163, 4742.478327383985, 4744.478107408182, 4766.713997160182, 4783.42147091459, 4385.868423947287, 4439.822407103679, 4539.7049191802425, 4966.255061740696, 4970.801167953241, 5216.165413533817, 5227.764750586309, 5233.6074794389815, 5284.9735751320995, 5314.627976041795, 5148.897022059613, 5150.124478838681, 5155.9742201288755, 5185.9222111669105, 5203.245529398292, 4717.0, 4946.318251794407, 4955.35580374549, 4976.377952755905, 4977.278294647183, 3725.3480640887196, 3726.105734623725, 3735.1409175889153, 3744.045268456526, 3749.531308586427, 5018.44797072329, 5223.7910483580235, 5269.657472264291, 5281.55106815925, 5292.153255479105, 4916.557509824133, 5117.462666420121, 5150.48495150482, 5153.788859617912, 5198.778287102604, 5122.410922743932, 5153.922691159711, 5159.587233021424, 5178.575891629832, 5184.922226166535, 4851.975740121276, 5014.272930424995, 5082.085224659597, 5093.490650935025, 5118.948810511996, 5119.667221630582, 5120.465369642051, 5139.820106296262, 5169.844904652867, 5178.922316165185, 5034.345535080416, 5035.446100928968, 5061.949380506295, 5063.265826455217, 5066.746662666926], "value": 3778.7126872029653, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.8774420604292, 682.5870348439195, 688.6832057253663, 730.8392153726185, 739.7299985505289, 12189.695257618552, 13207.141535800167, 13238.53665121721, 13247.205167689934, 13251.271180085092, 13312.667183320398, 13948.163110213369, 13969.650758731037, 14341.78487322691, 14350.78473822891, 542.2977244468423, 768.8500742355243, 773.0877564473918, 774.7133560582593, 775.6897241103547, 767.7044337929881, 795.6737737527615, 798.3573223555036, 800.7757827808223, 801.2788490358665, 821.6138414944967, 829.5064436660177, 830.211299265697, 832.0265289611169, 832.2883934236202, 651.3356376495994, 801.3348920396057, 824.8432797768435, 825.1583384947351, 825.6325934958945, 586.9354371019184, 589.0633892111563, 589.4341432225069, 592.2803793391007, 592.9021711417611, 12498.25010499373, 12605.054620903376, 12614.369281535886, 12623.684407889785, 12644.620661380173, 13852.584422467342, 14286.64283392913, 14332.856671433257, 14366.784498232535, 14424.134551926812, 10706.571737130505, 10757.731056723565, 10879.0, 10928.726781830517, 11257.943710281477, 3375.8143302118374, 3410.1474631342167, 3411.846466908995, 3412.385770561298, 3475.113845969287, 65450.67274663644, 66602.66698666524, 66762.0, 67872.3212767871, 68288.3171168287, 10445.164386849034, 10497.737556561147, 10501.89498105009, 10625.149988000941, 10692.251542392114, 20933.0, 21119.577608448053, 21153.0, 21221.78778212198, 21297.041633126548, 6622.569532980341, 6856.314368563204, 6863.897041544381, 7181.712731490787, 7495.700171993169, 3646.6535679110443, 3686.668199862025, 3707.8516859325323, 3733.701303895682, 3919.2553414851086, 2801.90193343232, 2930.4432157889933, 2933.897313594014, 2939.4121175764503, 2939.4708952388773, 494.1821285772053, 502.5351549816405, 502.83155143027494, 517.7281926988361, 523.0323900783596, 441.39969641287826, 463.80056575672785, 488.8289098815386, 542.1840130603416, 603.2489550509644, 7406.444516661272, 7475.691753943038, 7523.247675232433, 7677.462577619513, 7727.16170613652, 557.4007941462944, 562.2578196780293, 582.3274118393263, 585.9326177489557, 588.3204898342422, 3688.7602305850032, 3835.6164383561977, 3922.9607703923166, 3929.0766669832565, 3964.8810535683974, 50763.49236507588, 77910.0, 81725.59137204276, 81780.18219817725, 82621.58689206516, 46793.532064679595, 68771.65614171897, 77879.22120778833, 78639.0, 81101.18898811055, 70949.64525177341, 71009.0, 71935.28064719391, 72012.63993679998, 74420.0, 8316.83366332682, 8444.493330400195, 8519.659213631385, 8524.488530688179, 8695.30437565006, 40777.796111019255, 42465.0, 42801.571984279755, 42896.0, 43771.56228437675, 35733.64266357407, 43364.566354337316, 59434.108488373575, 61951.6902415485, 62917.68541157448, 10784.352938823382, 11216.943915280372, 11330.37682927447, 11389.316641001566, 11433.714157146138, 11616.593419230287, 12142.271463712206, 12299.569515067287, 12329.383530823603, 12341.0, 11350.0, 11713.824292635787, 11841.407929603312, 11948.641540753792, 12018.0, 10673.786524269626, 11324.433778311217, 11685.357305348287, 11701.648950531157, 12025.518979240733, 11379.715507112389, 11387.886121139014, 11868.881311187122, 11877.52489900429, 11917.702057448632, 9307.674231401868, 9411.0, 9608.615655373986, 9737.756556086155, 9773.853392199266, 8854.158854908774, 8923.553822308728, 8941.0, 9580.616775329188, 9757.31698781107], "value": 6439.37583194756, "unit": "score"}], "name": "dromaeo_css", "value": 6311.606915201974, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 112.0, 113.0, 114.0, 115.0, 113.0, 112.0, 114.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 132.0, 187.0, 138.0, 131.0, 151.0, 129.0, 166.0, 134.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 162.0, 162.0, 162.0, 163.0, 161.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 106.0, 77.0, 76.0, 77.0, 75.0, 98.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 109.0, 87.0, 88.0, 88.0, 118.0, 86.0, 87.0, 124.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 99.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 72.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 88.0, 82.0, 84.0, 84.0, 89.0, 84.0, 99.0, 88.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 130.0, 130.0, 138.0, 149.0, 127.0, 134.0, 157.0, 141.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 179.0, 170.0, 168.0, 171.0, 169.0, 183.0, 176.0, 170.0, 171.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 70.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1550.6000000000001, "alertThreshold": 2.0}]} 08:07:04 INFO - Return code: 0 08:07:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:05 INFO - # TBPL SUCCESS # 08:07:05 INFO - Running post-action listener: _resource_record_post_action 08:07:05 INFO - ##### 08:07:05 INFO - ##### Finished run-tests step (success) 08:07:05 INFO - ##### 08:07:05 INFO - Running post-run listener: _resource_record_post_run 08:07:05 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535224320; Read time: 16; Write time: 434224 08:07:05 INFO - TinderboxPrint: CPU usage
13.2% 08:07:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:07:05 INFO - TinderboxPrint: I/O write bytes / time
535,224,320 / 434,224 08:07:05 INFO - TinderboxPrint: CPU idle
8,323.9 (86.8%) 08:07:05 INFO - TinderboxPrint: CPU user
1,219.9 (12.7%) 08:07:05 INFO - TinderboxPrint: Swap in / out
0 / 0 08:07:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246120448; Read time: 0; Write time: 226944 08:07:05 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288911360; Read time: 16; Write time: 207256 08:07:05 INFO - Running post-run listener: _upload_blobber_files 08:07:05 INFO - Blob upload gear active. 08:07:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:05 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 08:07:05 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:07:05 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:07:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:09 INFO - (blobuploader) - INFO - Done attempting. 08:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:07:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:10 INFO - (blobuploader) - INFO - Done attempting. 08:07:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:07:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:07:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:11 INFO - (blobuploader) - INFO - Done attempting. 08:07:11 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:11 INFO - Return code: 0 08:07:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e86f972d7016cc34384994f6a3cd00395ccbfbba7a1717d673cb1930feb2c93dea63ae01a8ceb6a020b1658d14de20f166ee54a7f45760b610bc809e2dc414ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a9110c29970d65fdd6614148bfe75e453aa0e45b52eacaa84d51d2b1741285aff19ffdd54c38b870d49a8f5bbbae3c9bfde40a660decab83309d81046557d02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce84a231318bb3e79a7413c06d066e97b9812975e5d0108bc42b6d366a294d4a4c23e93d308adacd5f585fd1250332314a1c2efda1837b9d1725fcd6e483ca72"} 08:07:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:11 INFO - Contents: 08:07:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e86f972d7016cc34384994f6a3cd00395ccbfbba7a1717d673cb1930feb2c93dea63ae01a8ceb6a020b1658d14de20f166ee54a7f45760b610bc809e2dc414ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a9110c29970d65fdd6614148bfe75e453aa0e45b52eacaa84d51d2b1741285aff19ffdd54c38b870d49a8f5bbbae3c9bfde40a660decab83309d81046557d02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce84a231318bb3e79a7413c06d066e97b9812975e5d0108bc42b6d366a294d4a4c23e93d308adacd5f585fd1250332314a1c2efda1837b9d1725fcd6e483ca72"} 08:07:11 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:11 INFO - Copying logs to upload dir... 08:07:11 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.428422 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-23 08:07:11.075687) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:07:11.079496) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e86f972d7016cc34384994f6a3cd00395ccbfbba7a1717d673cb1930feb2c93dea63ae01a8ceb6a020b1658d14de20f166ee54a7f45760b610bc809e2dc414ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a9110c29970d65fdd6614148bfe75e453aa0e45b52eacaa84d51d2b1741285aff19ffdd54c38b870d49a8f5bbbae3c9bfde40a660decab83309d81046557d02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce84a231318bb3e79a7413c06d066e97b9812975e5d0108bc42b6d366a294d4a4c23e93d308adacd5f585fd1250332314a1c2efda1837b9d1725fcd6e483ca72"} build_url:https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011333 build_url: 'https://queue.taskcluster.net/v1/task/NNSsAwxQTBiXDiOZCmQSsQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e86f972d7016cc34384994f6a3cd00395ccbfbba7a1717d673cb1930feb2c93dea63ae01a8ceb6a020b1658d14de20f166ee54a7f45760b610bc809e2dc414ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a9110c29970d65fdd6614148bfe75e453aa0e45b52eacaa84d51d2b1741285aff19ffdd54c38b870d49a8f5bbbae3c9bfde40a660decab83309d81046557d02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce84a231318bb3e79a7413c06d066e97b9812975e5d0108bc42b6d366a294d4a4c23e93d308adacd5f585fd1250332314a1c2efda1837b9d1725fcd6e483ca72"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:07:11.106166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:07:11.106482) ========= 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=8887e36bb8e381bfd44124ac000001a8-1466693186.220130-1262343171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:07:11.188945) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:07:11.189269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:07:11.189573) ========= ========= Total master_lag: 0.17 =========