builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1466079819.13 results: success (0) buildid: 20160616023026 builduid: 20880d4d9fa746818ed05c53b92a6af8 revision: 6fb65c82c879efbc6bf966a50689b1ba91329949 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.127959) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.128419) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.128725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.144595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.144859) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 05:23:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.0M=0s 2016-06-16 05:23:41 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124560 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.284095) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.284449) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015133 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.336246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.336697) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6fb65c82c879efbc6bf966a50689b1ba91329949 --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 6fb65c82c879efbc6bf966a50689b1ba91329949 --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=e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 05:23:41,755 truncating revision to first 12 chars 2016-06-16 05:23:41,755 Setting DEBUG logging. 2016-06-16 05:23:41,755 attempt 1/10 2016-06-16 05:23:41,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6fb65c82c879?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 05:23:42,080 unpacking tar archive at: fx-team-6fb65c82c879/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633368 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.984829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.985207) ========= script_repo_revision: 6fb65c82c879efbc6bf966a50689b1ba91329949 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.985684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.985970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 05:23:39.996903) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-16 05:23:39.997183) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:23:42 INFO - MultiFileLogger online at 20160616 05:23:42 in /builds/slave/test 05:23:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:23:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:42 INFO - {'append_to_log': False, 05:23:42 INFO - 'base_work_dir': '/builds/slave/test', 05:23:42 INFO - 'blob_upload_branch': 'Fx-Team', 05:23:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:42 INFO - 'branch': 'Fx-Team', 05:23:42 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:42 INFO - 'config_files': ('talos/linux_config.py',), 05:23:42 INFO - 'default_actions': ('clobber', 05:23:42 INFO - 'read-buildbot-config', 05:23:42 INFO - 'download-and-extract', 05:23:42 INFO - 'populate-webroot', 05:23:42 INFO - 'create-virtualenv', 05:23:42 INFO - 'install', 05:23:42 INFO - 'run-tests'), 05:23:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:42 INFO - 'download_minidump_stackwalk': True, 05:23:42 INFO - 'download_symbols': 'ondemand', 05:23:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:42 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:42 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:42 INFO - 'installer_path': 'installer.exe', 05:23:42 INFO - 'log_level': 'info', 05:23:42 INFO - 'log_name': 'talos', 05:23:42 INFO - 'log_to_console': True, 05:23:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:23:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:23:42 INFO - 'opt_config_files': (), 05:23:42 INFO - 'pip_index': False, 05:23:42 INFO - 'sps_profile': False, 05:23:42 INFO - 'sps_profile_interval': 0, 05:23:42 INFO - 'suite': 'dromaeojs', 05:23:42 INFO - 'system_bits': '32', 05:23:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:42 INFO - 'title': 'talos-linux64-ix-067', 05:23:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:42 INFO - 'use_talos_json': True, 05:23:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:42 INFO - 'work_dir': 'build'} 05:23:42 INFO - ##### 05:23:42 INFO - ##### Running clobber step. 05:23:42 INFO - ##### 05:23:42 INFO - Running pre-action listener: _resource_record_pre_action 05:23:42 INFO - Running main action method: clobber 05:23:42 INFO - rmtree: /builds/slave/test/build 05:23:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:43 INFO - Running post-action listener: _resource_record_post_action 05:23:43 INFO - ##### 05:23:43 INFO - ##### Finished clobber step (success) 05:23:43 INFO - ##### 05:23:43 INFO - ##### 05:23:43 INFO - ##### Running read-buildbot-config step. 05:23:43 INFO - ##### 05:23:43 INFO - Running pre-action listener: _resource_record_pre_action 05:23:43 INFO - Running main action method: read_buildbot_config 05:23:43 INFO - Using buildbot properties: 05:23:43 INFO - { 05:23:43 INFO - "project": "", 05:23:43 INFO - "product": "firefox", 05:23:43 INFO - "script_repo_revision": "production", 05:23:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:23:43 INFO - "repository": "", 05:23:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:23:43 INFO - "buildid": "20160616023026", 05:23:43 INFO - "pgo_build": "True", 05:23:43 INFO - "basedir": "/builds/slave/test", 05:23:43 INFO - "buildnumber": 1261, 05:23:43 INFO - "slavename": "talos-linux64-ix-067", 05:23:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:23:43 INFO - "platform": "ubuntu64_hw", 05:23:43 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:23:43 INFO - "branch": "fx-team", 05:23:43 INFO - "repo_path": "integration/fx-team", 05:23:43 INFO - "revision": "6fb65c82c879efbc6bf966a50689b1ba91329949", 05:23:43 INFO - "stage_platform": "linux64-pgo", 05:23:43 INFO - "builduid": "20880d4d9fa746818ed05c53b92a6af8", 05:23:43 INFO - "slavebuilddir": "test" 05:23:43 INFO - } 05:23:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:23:43 INFO - Running post-action listener: _resource_record_post_action 05:23:43 INFO - ##### 05:23:43 INFO - ##### Finished read-buildbot-config step (success) 05:23:43 INFO - ##### 05:23:43 INFO - ##### 05:23:43 INFO - ##### Running download-and-extract step. 05:23:43 INFO - ##### 05:23:43 INFO - Running pre-action listener: _resource_record_pre_action 05:23:43 INFO - Running main action method: download_and_extract 05:23:43 INFO - mkdir: /builds/slave/test/build/tests 05:23: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')]} 05:23:43 INFO - https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:23:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:23:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:23:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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 05:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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 05:23:48 INFO - Downloaded 1361 bytes. 05:23:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:23:48 INFO - Using the following test package requirements: 05:23:48 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:48 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:23:48 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:23:48 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:48 INFO - u'jsshell-linux-x86_64.zip'], 05:23:48 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:23:48 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:48 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:23:48 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:23:48 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:23:48 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:48 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:23:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:23:48 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')]} 05:23:48 INFO - https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:23:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:23:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:23:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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 05:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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 05:23:50 INFO - Downloaded 24220743 bytes. 05:23:50 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'] 05:23:50 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 05:23:51 INFO - Return code: 0 05:23:51 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 05:23: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')]} 05:23:51 INFO - https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:23:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:23:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:23:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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 05:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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 05:23:52 INFO - Downloaded 24220743 bytes. 05:23:52 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'] 05:23:52 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 05:23:54 INFO - Return code: 0 05:23: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')]} 05:23:54 INFO - https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:23:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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 05:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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 05:23:56 INFO - Downloaded 14405384 bytes. 05:23:56 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'] 05:23:56 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 05:23:56 INFO - Return code: 0 05:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:56 INFO - https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:23:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:23:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:23:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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 05:23:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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 05:23:57 INFO - Downloaded 59415070 bytes. 05:23:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:23:57 INFO - mkdir: /builds/slave/test/properties 05:23:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:23:57 INFO - Writing to file /builds/slave/test/properties/build_url 05:23:57 INFO - Contents: 05:23:57 INFO - build_url:https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:23:58 INFO - Running post-action listener: _resource_record_post_action 05:23:58 INFO - Running post-action listener: set_extra_try_arguments 05:23:58 INFO - ##### 05:23:58 INFO - ##### Finished download-and-extract step (success) 05:23:58 INFO - ##### 05:23:58 INFO - ##### 05:23:58 INFO - ##### Running populate-webroot step. 05:23:58 INFO - ##### 05:23:58 INFO - Running pre-action listener: _resource_record_pre_action 05:23:58 INFO - Running main action method: populate_webroot 05:23:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:23:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:23:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:23:58 INFO - '--tppagecycles', 05:23:58 INFO - '7'], 05:23:58 INFO - 'tests': ['tsvgm']}}, 05:23:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:23:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:23:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:23:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:23:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:58 INFO - 'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:58 INFO - 'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['damp', 'tps']}, 05:23:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:58 INFO - 'tests': ['damp', 'tps']}, 05:23:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['dromaeo_dom']}, 05:23:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:23:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['basic_compositor_video']}, 05:23:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:23:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['a11yr', 05:23:58 INFO - 'ts_paint', 05:23:58 INFO - 'tpaint', 05:23:58 INFO - 'sessionrestore', 05:23:58 INFO - 'sessionrestore_no_auto_restore', 05:23:58 INFO - 'tabpaint']}, 05:23:58 INFO - 'other-e10s': {'tests': ['a11yr', 05:23:58 INFO - 'ts_paint', 05:23:58 INFO - 'tpaint', 05:23:58 INFO - 'sessionrestore', 05:23:58 INFO - 'sessionrestore_no_auto_restore', 05:23:58 INFO - 'tabpaint']}, 05:23:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:23:58 INFO - 'ts_paint', 05:23:58 INFO - 'tpaint', 05:23:58 INFO - 'sessionrestore', 05:23:58 INFO - 'sessionrestore_no_auto_restore', 05:23:58 INFO - 'tabpaint']}, 05:23:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:23:58 INFO - 'ts_paint', 05:23:58 INFO - 'tpaint', 05:23:58 INFO - 'sessionrestore', 05:23:58 INFO - 'sessionrestore_no_auto_restore', 05:23:58 INFO - 'tabpaint']}, 05:23:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['a11yr', 05:23:58 INFO - 'ts_paint', 05:23:58 INFO - 'tpaint', 05:23:58 INFO - 'sessionrestore', 05:23:58 INFO - 'sessionrestore_no_auto_restore', 05:23:58 INFO - 'tabpaint']}, 05:23:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['a11yr', 05:23:58 INFO - 'ts_paint', 05:23:58 INFO - 'tpaint', 05:23:58 INFO - 'sessionrestore', 05:23:58 INFO - 'sessionrestore_no_auto_restore', 05:23:58 INFO - 'tabpaint']}, 05:23:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['tsvgx', 05:23:58 INFO - 'tsvgr_opacity', 05:23:58 INFO - 'tart', 05:23:58 INFO - 'tscrollx', 05:23:58 INFO - 'cart']}, 05:23:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:23:58 INFO - 'tsvgr_opacity', 05:23:58 INFO - 'tart', 05:23:58 INFO - 'tscrollx', 05:23:58 INFO - 'cart']}, 05:23:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:58 INFO - 'talos_options': ['--disable-e10s'], 05:23:58 INFO - 'tests': ['tp5o']}, 05:23:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:58 INFO - 'tests': ['tp5o']}, 05:23:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:58 INFO - 'talos_options': ['--disable-e10s', 05:23:58 INFO - '--xperf_path', 05:23:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:58 INFO - 'tests': ['tp5n']}, 05:23:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:58 INFO - 'talos_options': ['--xperf_path', 05:23:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:58 INFO - 'tests': ['tp5n']}}, 05:23:58 INFO - 'talos.zip': {'path': '', 05:23:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:23:58 INFO - Running post-action listener: _resource_record_post_action 05:23:58 INFO - ##### 05:23:58 INFO - ##### Finished populate-webroot step (success) 05:23:58 INFO - ##### 05:23:58 INFO - ##### 05:23:58 INFO - ##### Running create-virtualenv step. 05:23:58 INFO - ##### 05:23:58 INFO - Running pre-action listener: _resource_record_pre_action 05:23:58 INFO - Running main action method: create_virtualenv 05:23:58 INFO - Creating virtualenv /builds/slave/test/build/venv 05:23:58 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 05:23:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:23:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:23:58 INFO - Using real prefix '/usr' 05:23:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:23:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:00 INFO - Installing pip.................done. 05:24:00 INFO - Return code: 0 05:24:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:00 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 0x7fa0b2fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', '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 05:24:00 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 05:24:00 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 05:24:00 INFO - Using env: {'DISPLAY': ':0', 05:24:00 INFO - 'HOME': '/home/cltbld', 05:24:00 INFO - 'LANG': 'en_US.UTF-8', 05:24:00 INFO - 'LANGUAGE': 'en_US:en', 05:24:00 INFO - 'LOGNAME': 'cltbld', 05:24:00 INFO - 'MAIL': '/var/mail/cltbld', 05:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:00 INFO - 'MOZ_NO_REMOTE': '1', 05:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:00 INFO - 'NO_EM_RESTART': '1', 05:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:00 INFO - 'PWD': '/builds/slave/test', 05:24:00 INFO - 'SHELL': '/bin/bash', 05:24:00 INFO - 'SHLVL': '1', 05:24:00 INFO - 'TERM': 'linux', 05:24:00 INFO - 'TMOUT': '86400', 05:24:00 INFO - 'USER': 'cltbld', 05:24:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:00 INFO - '_': '/tools/buildbot/bin/python'} 05:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:01 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 05:24:01 INFO - Cleaning up... 05:24:01 INFO - Return code: 0 05:24:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:24:01 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')]} 05:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:01 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')]} 05:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:01 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 0x7fa0b2fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', '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 05:24:01 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 05:24:01 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 05:24:01 INFO - Using env: {'DISPLAY': ':0', 05:24:01 INFO - 'HOME': '/home/cltbld', 05:24:01 INFO - 'LANG': 'en_US.UTF-8', 05:24:01 INFO - 'LANGUAGE': 'en_US:en', 05:24:01 INFO - 'LOGNAME': 'cltbld', 05:24:01 INFO - 'MAIL': '/var/mail/cltbld', 05:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:01 INFO - 'MOZ_NO_REMOTE': '1', 05:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:01 INFO - 'NO_EM_RESTART': '1', 05:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:01 INFO - 'PWD': '/builds/slave/test', 05:24:01 INFO - 'SHELL': '/bin/bash', 05:24:01 INFO - 'SHLVL': '1', 05:24:01 INFO - 'TERM': 'linux', 05:24:01 INFO - 'TMOUT': '86400', 05:24:01 INFO - 'USER': 'cltbld', 05:24:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:01 INFO - '_': '/tools/buildbot/bin/python'} 05:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:01 INFO - Downloading/unpacking psutil>=3.1.1 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:03 INFO - Installing collected packages: psutil 05:24:03 INFO - Running setup.py install for psutil 05:24:03 INFO - building 'psutil._psutil_linux' extension 05:24:03 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 05:24:03 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 05:24:03 INFO - building 'psutil._psutil_posix' extension 05:24:03 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 05:24:03 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 05:24:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:03 INFO - Successfully installed psutil 05:24:03 INFO - Cleaning up... 05:24:03 INFO - Return code: 0 05:24:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b2fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', '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 05:24:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:24:03 INFO - Using env: {'DISPLAY': ':0', 05:24:03 INFO - 'HOME': '/home/cltbld', 05:24:03 INFO - 'LANG': 'en_US.UTF-8', 05:24:03 INFO - 'LANGUAGE': 'en_US:en', 05:24:03 INFO - 'LOGNAME': 'cltbld', 05:24:03 INFO - 'MAIL': '/var/mail/cltbld', 05:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:03 INFO - 'MOZ_NO_REMOTE': '1', 05:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:03 INFO - 'NO_EM_RESTART': '1', 05:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:03 INFO - 'PWD': '/builds/slave/test', 05:24:03 INFO - 'SHELL': '/bin/bash', 05:24:03 INFO - 'SHLVL': '1', 05:24:03 INFO - 'TERM': 'linux', 05:24:03 INFO - 'TMOUT': '86400', 05:24:03 INFO - 'USER': 'cltbld', 05:24:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:03 INFO - '_': '/tools/buildbot/bin/python'} 05:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:24:04 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 05:24:04 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 05:24:04 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 05:24:04 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 05:24:04 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 05:24:04 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 05:24:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:24:06 INFO - Installing collected packages: mozsystemmonitor 05:24:06 INFO - Running setup.py install for mozsystemmonitor 05:24:06 INFO - Successfully installed mozsystemmonitor 05:24:06 INFO - Cleaning up... 05:24:06 INFO - Return code: 0 05:24:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:24:06 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')]} 05:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:06 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')]} 05:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:06 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 0x7fa0b2fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', '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 05:24:06 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 05:24:06 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 05:24:06 INFO - Using env: {'DISPLAY': ':0', 05:24:06 INFO - 'HOME': '/home/cltbld', 05:24:06 INFO - 'LANG': 'en_US.UTF-8', 05:24:06 INFO - 'LANGUAGE': 'en_US:en', 05:24:06 INFO - 'LOGNAME': 'cltbld', 05:24:06 INFO - 'MAIL': '/var/mail/cltbld', 05:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:06 INFO - 'MOZ_NO_REMOTE': '1', 05:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:06 INFO - 'NO_EM_RESTART': '1', 05:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:06 INFO - 'PWD': '/builds/slave/test', 05:24:06 INFO - 'SHELL': '/bin/bash', 05:24:06 INFO - 'SHLVL': '1', 05:24:06 INFO - 'TERM': 'linux', 05:24:06 INFO - 'TMOUT': '86400', 05:24:06 INFO - 'USER': 'cltbld', 05:24:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:06 INFO - '_': '/tools/buildbot/bin/python'} 05:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:06 INFO - Downloading/unpacking jsonschema==2.5.1 05:24:06 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 05:24:06 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 05:24:06 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 05:24:06 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 05:24:06 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 05:24:06 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 05:24:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:08 INFO - warning: no files found matching '*.txt' 05:24:08 INFO - no previously-included directories found matching 'build' 05:24:08 INFO - no previously-included directories found matching 'dist' 05:24:08 INFO - no previously-included directories found matching '.git*' 05:24:08 INFO - Installing collected packages: jsonschema, functools32 05:24:08 INFO - Running setup.py install for functools32 05:24:08 INFO - warning: no files found matching '*.txt' 05:24:08 INFO - no previously-included directories found matching 'build' 05:24:08 INFO - no previously-included directories found matching 'dist' 05:24:08 INFO - no previously-included directories found matching '.git*' 05:24:08 INFO - Successfully installed jsonschema functools32 05:24:08 INFO - Cleaning up... 05:24:08 INFO - Return code: 0 05:24:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa0b2fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', '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 05:24:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:24:08 INFO - Using env: {'DISPLAY': ':0', 05:24:08 INFO - 'HOME': '/home/cltbld', 05:24:08 INFO - 'LANG': 'en_US.UTF-8', 05:24:08 INFO - 'LANGUAGE': 'en_US:en', 05:24:08 INFO - 'LOGNAME': 'cltbld', 05:24:08 INFO - 'MAIL': '/var/mail/cltbld', 05:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:08 INFO - 'MOZ_NO_REMOTE': '1', 05:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:08 INFO - 'NO_EM_RESTART': '1', 05:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:08 INFO - 'PWD': '/builds/slave/test', 05:24:08 INFO - 'SHELL': '/bin/bash', 05:24:08 INFO - 'SHLVL': '1', 05:24:08 INFO - 'TERM': 'linux', 05:24:08 INFO - 'TMOUT': '86400', 05:24:08 INFO - 'USER': 'cltbld', 05:24:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:08 INFO - '_': '/tools/buildbot/bin/python'} 05:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:08 INFO - Downloading/unpacking blobuploader==1.2.4 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24:11 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 05:24:11 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 05:24:11 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 05:24:11 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 05:24:11 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 05:24:11 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 05:24:11 INFO - Downloading docopt-0.6.1.tar.gz 05:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:11 INFO - Running setup.py install for blobuploader 05:24:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:11 INFO - Running setup.py install for requests 05:24:12 INFO - Running setup.py install for docopt 05:24:12 INFO - Successfully installed blobuploader requests docopt 05:24:12 INFO - Cleaning up... 05:24:12 INFO - Return code: 0 05:24:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:12 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')]} 05:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:12 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')]} 05:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:12 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 0x7fa0b2fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', '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 05:24:12 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 05:24:12 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 05:24:12 INFO - Using env: {'DISPLAY': ':0', 05:24:12 INFO - 'HOME': '/home/cltbld', 05:24:12 INFO - 'LANG': 'en_US.UTF-8', 05:24:12 INFO - 'LANGUAGE': 'en_US:en', 05:24:12 INFO - 'LOGNAME': 'cltbld', 05:24:12 INFO - 'MAIL': '/var/mail/cltbld', 05:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:12 INFO - 'MOZ_NO_REMOTE': '1', 05:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:12 INFO - 'NO_EM_RESTART': '1', 05:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:12 INFO - 'PWD': '/builds/slave/test', 05:24:12 INFO - 'SHELL': '/bin/bash', 05:24:12 INFO - 'SHLVL': '1', 05:24:12 INFO - 'TERM': 'linux', 05:24:12 INFO - 'TMOUT': '86400', 05:24:12 INFO - 'USER': 'cltbld', 05:24:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:12 INFO - '_': '/tools/buildbot/bin/python'} 05:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:12 INFO - Running setup.py (path:/tmp/pip-3BftSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:12 INFO - Running setup.py (path:/tmp/pip-DEjPQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:12 INFO - Running setup.py (path:/tmp/pip-jM9tGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:12 INFO - Running setup.py (path:/tmp/pip-9e9HxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:12 INFO - Running setup.py (path:/tmp/pip-DRMdX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:12 INFO - Running setup.py (path:/tmp/pip-ckujPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:12 INFO - Running setup.py (path:/tmp/pip-_s2uuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:12 INFO - Running setup.py (path:/tmp/pip-LRvLNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:13 INFO - Running setup.py (path:/tmp/pip-uh9N_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:13 INFO - Running setup.py (path:/tmp/pip-0kyDkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:13 INFO - Running setup.py (path:/tmp/pip-kfVMLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:13 INFO - Running setup.py (path:/tmp/pip-K2QZrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:13 INFO - Running setup.py (path:/tmp/pip-cFAQxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:13 INFO - Running setup.py (path:/tmp/pip-HtXZlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:13 INFO - Running setup.py (path:/tmp/pip-roEUu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:13 INFO - Running setup.py (path:/tmp/pip-fKnHb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:13 INFO - Running setup.py (path:/tmp/pip-YmGKOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:13 INFO - Running setup.py install for manifestparser 05:24:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:13 INFO - Running setup.py install for mozcrash 05:24:13 INFO - Running setup.py install for mozdebug 05:24:13 INFO - Running setup.py install for mozdevice 05:24:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Running setup.py install for mozfile 05:24:14 INFO - Running setup.py install for mozhttpd 05:24:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Running setup.py install for mozinfo 05:24:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Running setup.py install for mozInstall 05:24:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Running setup.py install for mozleak 05:24:14 INFO - Running setup.py install for mozlog 05:24:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Running setup.py install for moznetwork 05:24:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Running setup.py install for mozprocess 05:24:14 INFO - Running setup.py install for mozprofile 05:24:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:15 INFO - Running setup.py install for mozrunner 05:24:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:15 INFO - Running setup.py install for mozscreenshot 05:24:15 INFO - Running setup.py install for moztest 05:24:15 INFO - Running setup.py install for mozversion 05:24:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:15 INFO - Cleaning up... 05:24:15 INFO - Return code: 0 05:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:15 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')]} 05:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:15 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')]} 05:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:15 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 0x7fa0b2fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', '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 05:24:15 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 05:24:15 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 05:24:15 INFO - Using env: {'DISPLAY': ':0', 05:24:15 INFO - 'HOME': '/home/cltbld', 05:24:15 INFO - 'LANG': 'en_US.UTF-8', 05:24:15 INFO - 'LANGUAGE': 'en_US:en', 05:24:15 INFO - 'LOGNAME': 'cltbld', 05:24:15 INFO - 'MAIL': '/var/mail/cltbld', 05:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:15 INFO - 'MOZ_NO_REMOTE': '1', 05:24:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:15 INFO - 'NO_EM_RESTART': '1', 05:24:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:15 INFO - 'PWD': '/builds/slave/test', 05:24:15 INFO - 'SHELL': '/bin/bash', 05:24:15 INFO - 'SHLVL': '1', 05:24:15 INFO - 'TERM': 'linux', 05:24:15 INFO - 'TMOUT': '86400', 05:24:15 INFO - 'USER': 'cltbld', 05:24:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:15 INFO - '_': '/tools/buildbot/bin/python'} 05:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:15 INFO - Running setup.py (path:/tmp/pip-N8wbLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:15 INFO - Running setup.py (path:/tmp/pip-UN7BHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:15 INFO - Running setup.py (path:/tmp/pip-QZzRvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:15 INFO - Running setup.py (path:/tmp/pip-pJxTTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:15 INFO - Running setup.py (path:/tmp/pip-NH1Jux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:16 INFO - Running setup.py (path:/tmp/pip-hKG5SS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:16 INFO - Running setup.py (path:/tmp/pip-4T2jol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:16 INFO - Running setup.py (path:/tmp/pip-wg65dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:16 INFO - Running setup.py (path:/tmp/pip-ArGxGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:16 INFO - Running setup.py (path:/tmp/pip-Z4YafI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:16 INFO - Running setup.py (path:/tmp/pip-SFBzH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:16 INFO - Running setup.py (path:/tmp/pip-zN6TPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:16 INFO - Running setup.py (path:/tmp/pip-MM460h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:16 INFO - Running setup.py (path:/tmp/pip-ABmXjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:16 INFO - Running setup.py (path:/tmp/pip-kTBs6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:16 INFO - Running setup.py (path:/tmp/pip-XgvxRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:16 INFO - Running setup.py (path:/tmp/pip-mLZOiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:24:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:18 INFO - Downloading blessings-1.6.tar.gz 05:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:18 INFO - Installing collected packages: blessings 05:24:18 INFO - Running setup.py install for blessings 05:24:18 INFO - Successfully installed blessings 05:24:18 INFO - Cleaning up... 05:24:19 INFO - Return code: 0 05:24:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:19 INFO - Reading from file tmpfile_stdout 05:24:19 INFO - Current package versions: 05:24:19 INFO - argparse == 1.2.1 05:24:19 INFO - blessings == 1.6 05:24:19 INFO - blobuploader == 1.2.4 05:24:19 INFO - docopt == 0.6.1 05:24:19 INFO - functools32 == 3.2.3-2 05:24:19 INFO - jsonschema == 2.5.1 05:24:19 INFO - manifestparser == 1.1 05:24:19 INFO - mozInstall == 1.12 05:24:19 INFO - mozcrash == 0.17 05:24:19 INFO - mozdebug == 0.1 05:24:19 INFO - mozdevice == 0.48 05:24:19 INFO - mozfile == 1.2 05:24:19 INFO - mozhttpd == 0.7 05:24:19 INFO - mozinfo == 0.9 05:24:19 INFO - mozleak == 0.1 05:24:19 INFO - mozlog == 3.2 05:24:19 INFO - moznetwork == 0.27 05:24:19 INFO - mozprocess == 0.22 05:24:19 INFO - mozprofile == 0.28 05:24:19 INFO - mozrunner == 6.11 05:24:19 INFO - mozscreenshot == 0.1 05:24:19 INFO - mozsystemmonitor == 0.3 05:24:19 INFO - moztest == 0.7 05:24:19 INFO - mozversion == 1.4 05:24:19 INFO - psutil == 3.1.1 05:24:19 INFO - requests == 1.2.3 05:24:19 INFO - wsgiref == 0.1.2 05:24:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:19 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')]} 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 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')]} 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 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 0x7fa0b2fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', '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 05:24:19 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 05:24:19 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 05:24:19 INFO - Using env: {'DISPLAY': ':0', 05:24:19 INFO - 'HOME': '/home/cltbld', 05:24:19 INFO - 'LANG': 'en_US.UTF-8', 05:24:19 INFO - 'LANGUAGE': 'en_US:en', 05:24:19 INFO - 'LOGNAME': 'cltbld', 05:24:19 INFO - 'MAIL': '/var/mail/cltbld', 05:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:19 INFO - 'MOZ_NO_REMOTE': '1', 05:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:19 INFO - 'NO_EM_RESTART': '1', 05:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:19 INFO - 'PWD': '/builds/slave/test', 05:24:19 INFO - 'SHELL': '/bin/bash', 05:24:19 INFO - 'SHLVL': '1', 05:24:19 INFO - 'TERM': 'linux', 05:24:19 INFO - 'TMOUT': '86400', 05:24:19 INFO - 'USER': 'cltbld', 05:24:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:19 INFO - '_': '/tools/buildbot/bin/python'} 05:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:19 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)) 05:24:19 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)) 05:24:19 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)) 05:24:19 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)) 05:24:19 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)) 05:24:19 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)) 05:24:19 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)) 05:24:19 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)) 05:24:19 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)) 05:24:19 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)) 05:24:19 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)) 05:24:19 INFO - Cleaning up... 05:24:19 INFO - Return code: 0 05:24:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:24:19 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')]} 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 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')]} 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 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 0x7fa0b2fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', '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 05:24:19 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 05:24:19 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 05:24:19 INFO - Using env: {'DISPLAY': ':0', 05:24:19 INFO - 'HOME': '/home/cltbld', 05:24:19 INFO - 'LANG': 'en_US.UTF-8', 05:24:19 INFO - 'LANGUAGE': 'en_US:en', 05:24:19 INFO - 'LOGNAME': 'cltbld', 05:24:19 INFO - 'MAIL': '/var/mail/cltbld', 05:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:19 INFO - 'MOZ_NO_REMOTE': '1', 05:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:19 INFO - 'NO_EM_RESTART': '1', 05:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:19 INFO - 'PWD': '/builds/slave/test', 05:24:19 INFO - 'SHELL': '/bin/bash', 05:24:19 INFO - 'SHLVL': '1', 05:24:19 INFO - 'TERM': 'linux', 05:24:19 INFO - 'TMOUT': '86400', 05:24:19 INFO - 'USER': 'cltbld', 05:24:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:19 INFO - '_': '/tools/buildbot/bin/python'} 05:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:24:19 INFO - Cleaning up... 05:24:19 INFO - Return code: 0 05:24:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:24:19 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')]} 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 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')]} 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 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 0x7fa0b2fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bbf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', '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 05:24:19 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 05:24:19 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 05:24:19 INFO - Using env: {'DISPLAY': ':0', 05:24:19 INFO - 'HOME': '/home/cltbld', 05:24:19 INFO - 'LANG': 'en_US.UTF-8', 05:24:19 INFO - 'LANGUAGE': 'en_US:en', 05:24:19 INFO - 'LOGNAME': 'cltbld', 05:24:19 INFO - 'MAIL': '/var/mail/cltbld', 05:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:19 INFO - 'MOZ_NO_REMOTE': '1', 05:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:19 INFO - 'NO_EM_RESTART': '1', 05:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:19 INFO - 'PWD': '/builds/slave/test', 05:24:19 INFO - 'SHELL': '/bin/bash', 05:24:19 INFO - 'SHLVL': '1', 05:24:19 INFO - 'TERM': 'linux', 05:24:19 INFO - 'TMOUT': '86400', 05:24:19 INFO - 'USER': 'cltbld', 05:24:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:19 INFO - '_': '/tools/buildbot/bin/python'} 05:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:19 INFO - Downloading/unpacking flake8 05:24:19 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 05:24:19 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 05:24:19 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 05:24:19 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 05:24:19 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 05:24:19 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 05:24:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:24:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:24:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:24:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:24:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:24:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:24:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:24:22 INFO - no previously-included directories found matching 'docs/_build' 05:24:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:24:22 INFO - Running setup.py install for pep8 05:24:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:24:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:24:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:24:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:24:22 INFO - no previously-included directories found matching 'docs/_build' 05:24:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:24:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:24:22 INFO - Cleaning up... 05:24:22 INFO - Return code: 0 05:24:22 INFO - Running post-action listener: _resource_record_post_action 05:24:22 INFO - Running post-action listener: _start_resource_monitoring 05:24:22 INFO - Starting resource monitoring. 05:24:22 INFO - ##### 05:24:22 INFO - ##### Finished create-virtualenv step (success) 05:24:22 INFO - ##### 05:24:22 INFO - ##### 05:24:22 INFO - ##### Running install step. 05:24:22 INFO - ##### 05:24:22 INFO - Running pre-action listener: _resource_record_pre_action 05:24:22 INFO - Running main action method: install 05:24:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:23 INFO - Reading from file tmpfile_stdout 05:24:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:23 INFO - Reading from file tmpfile_stdout 05:24:23 INFO - Output received: 05:24:23 INFO - Usage: mozinstall [options] installer 05:24:23 INFO - Options: 05:24:23 INFO - -h, --help show this help message and exit 05:24:23 INFO - -d DEST, --destination=DEST 05:24:23 INFO - Directory to install application into. [default: 05:24:23 INFO - "/builds/slave/test"] 05:24:23 INFO - --app=APP Application being installed. [default: firefox] 05:24:23 INFO - mkdir: /builds/slave/test/build/application 05:24:23 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'] 05:24:23 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 05:24:39 INFO - Reading from file tmpfile_stdout 05:24:39 INFO - Output received: 05:24:39 INFO - /builds/slave/test/build/application/firefox/firefox 05:24:39 INFO - Running post-action listener: _resource_record_post_action 05:24:39 INFO - ##### 05:24:39 INFO - ##### Finished install step (success) 05:24:39 INFO - ##### 05:24:39 INFO - ##### 05:24:39 INFO - ##### Running run-tests step. 05:24:39 INFO - ##### 05:24:39 INFO - Running pre-action listener: _resource_record_pre_action 05:24:39 INFO - Running main action method: run_tests 05:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:24:39 INFO - Python 2.7.3 05:24:39 INFO - Return code: 0 05:24:39 INFO - grabbing minidump binary from tooltool 05:24:39 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')]} 05:24:39 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 0x1c4e1c0>, '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 0x1c4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c4f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:24:39 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 05:24:39 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 05:24:39 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 05:24:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:24:40 INFO - Return code: 0 05:24:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:24:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:24:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:24:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:24:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:24:40 INFO - Return code: 0 05:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 05:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 05:24:40 INFO - Using env: {'DISPLAY': ':0', 05:24:40 INFO - 'HOME': '/home/cltbld', 05:24:40 INFO - 'LANG': 'en_US.UTF-8', 05:24:40 INFO - 'LANGUAGE': 'en_US:en', 05:24:40 INFO - 'LOGNAME': 'cltbld', 05:24:40 INFO - 'MAIL': '/var/mail/cltbld', 05:24:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:24:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:40 INFO - 'MOZ_NO_REMOTE': '1', 05:24:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:40 INFO - 'NO_EM_RESTART': '1', 05:24:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:40 INFO - 'PWD': '/builds/slave/test', 05:24:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:24:40 INFO - 'SHELL': '/bin/bash', 05:24:40 INFO - 'SHLVL': '1', 05:24:40 INFO - 'TERM': 'linux', 05:24:40 INFO - 'TMOUT': '86400', 05:24:40 INFO - 'USER': 'cltbld', 05:24:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457', 05:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:40 INFO - '_': '/tools/buildbot/bin/python'} 05:24:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 05:24:41 INFO - mozversion application_buildid: 20160616023026 05:24:41 INFO - mozversion application_changeset: 6fb65c82c879efbc6bf966a50689b1ba91329949 05:24:41 INFO - mozversion application_display_name: Nightly 05:24:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:24:41 INFO - mozversion application_name: Firefox 05:24:41 INFO - mozversion application_remotingname: firefox 05:24:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:24:41 INFO - mozversion application_vendor: Mozilla 05:24:41 INFO - mozversion application_version: 50.0a1 05:24:41 INFO - mozversion platform_buildid: 20160616023026 05:24:41 INFO - mozversion platform_changeset: 6fb65c82c879efbc6bf966a50689b1ba91329949 05:24:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:24:41 INFO - mozversion platform_version: 50.0a1 05:24:41 INFO - using testdate: 1466079881 05:24:41 INFO - actual date: 1466079881 05:24:41 INFO - starting webserver on 'localhost:58460' 05:24:41 INFO - SUITE-START | Running 2 tests 05:24:41 INFO - TEST-START | dromaeo_css 05:24:41 INFO - operating with platform_type : linux_ 05:24:41 INFO - Initialising browser for dromaeo_css test... 05:24:41 INFO - TEST-INFO | started process 27833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNhfnJ6/profile http://localhost:58460/getInfo.html) 05:24:44 INFO - PROCESS | 27833 | __metrics Screen width/height:1600/1200 05:24:44 INFO - PROCESS | 27833 | colorDepth:24 05:24:44 INFO - PROCESS | 27833 | Browser inner width/height: 1024/697 05:24:44 INFO - PROCESS | 27833 | __metrics 05:24:44 INFO - PROCESS | 27833 | JavaScript error: resource:///modules/PlacesUIUtils.jsm, line 204: ReferenceError: can't access lexical declaration `innerWindowID' before initialization 05:24:45 INFO - PROCESS | 27833 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:46 INFO - TEST-INFO | 27833: exit 0 05:24:46 INFO - Browser initialized. 05:24:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:24:46 INFO - TEST-INFO | started process 27914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNhfnJ6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:58 INFO - PROCESS | 27914 | RSS: Main: 173883392 05:24:58 INFO - PROCESS | 27914 | 05:25:49 INFO - PROCESS | 27914 | 1466079949400 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] 05:27:58 INFO - PROCESS | 27914 | Cycle 1(1): loaded http://localhost:58460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58460/tests/dromaeo/cssquery-ext.html) 05:27:59 INFO - PROCESS | 27914 | RSS: Main: 308985856 05:27:59 INFO - PROCESS | 27914 | 05:31:02 INFO - PROCESS | 27914 | Cycle 1(1): loaded http://localhost:58460/tests/dromaeo/cssquery-ext.html (next: http://localhost:58460/tests/dromaeo/cssquery-jquery.html) 05:31:02 INFO - PROCESS | 27914 | RSS: Main: 257327104 05:31:02 INFO - PROCESS | 27914 | 05:34:04 INFO - PROCESS | 27914 | Cycle 1(1): loaded http://localhost:58460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58460/tests/dromaeo/cssquery-mootools.html) 05:34:05 INFO - PROCESS | 27914 | RSS: Main: 265326592 05:34:05 INFO - PROCESS | 27914 | 05:37:07 INFO - PROCESS | 27914 | Cycle 1(1): loaded http://localhost:58460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58460/tests/dromaeo/cssquery-prototype.html) 05:37:08 INFO - PROCESS | 27914 | RSS: Main: 260284416 05:37:08 INFO - PROCESS | 27914 | 05:40:11 INFO - PROCESS | 27914 | Cycle 1(1): loaded http://localhost:58460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58460/tests/dromaeo/cssquery-yui.html) 05:40:11 INFO - PROCESS | 27914 | RSS: Main: 224296960 05:40:11 INFO - PROCESS | 27914 | 05:43:14 INFO - PROCESS | 27914 | Cycle 1(1): loaded http://localhost:58460/tests/dromaeo/cssquery-yui.html (next: http://localhost:58460/tests/dromaeo/cssquery-dojo.html) 05:43:14 INFO - PROCESS | 27914 | RSS: Main: 291045376 05:43:14 INFO - PROCESS | 27914 | 05:43:14 INFO - PROCESS | 27914 | __start_tp_report 05:43:14 INFO - PROCESS | 27914 | _x_x_mozilla_page_load 05:43:14 INFO - PROCESS | 27914 | _x_x_mozilla_page_load_details 05:43:14 INFO - PROCESS | 27914 | |i|pagename|runs| 05:43:14 INFO - PROCESS | 27914 | |0;dojo.html;3114.2992826614013;3134.7022032906875;3156.984215078924;3184.108449634103;3203.855826487808;5256.632035757499;5293.470652934705;5408.188771684249;5524;5550.583706222029;5335.653182543142;5450.781968721247;5510.201020851984;5618.522425593819;5619.129034999582;4939.580135688462;4995.425526064513;5001.774920128603;5097.949020509803;5100.413452452978;5036.068327359432;5060.11447996601;5063.46833582474;5101.821436249732;5110.28456016158;4924.556789888891;4945.703257804507;5005.5244751748705;5054.342935418372;5072.74636268187;4879.121758083544;4879.536444037811;4896.559309662148;4940.802367905316;4968.354113965198;4848.248521479177;4889.462159162489;4940.629452791055;4942.406911170647;4969.105560999019;5304.38999515053;5349.625526213166;5426.050441172779;5488.643238189545;5505.421930697299;5725.685087320196;5795.1886735857015;5850.063989761617;5854.7072646367515;5855.355910849803;5833.504152147073;5890.352061273256;5894.941050589482;5895.204147440084;5902.704864756788;5297.947020529784;5345.278387417648;5400.351957765015;5475.06923822951;5490.890182196374;5992.58051936369;5998.820035398858;6001.849953751192;6009.939900601025;6021.217241758543;5756.856078597984;5766.365699773021;5771.797987070432;5773.076307790733;5779.306483222041;5693.202951586698;5752.884942301131;5795.449432303924;5798.130280457881;5855.824325270249;5768.250127483484;5770;5780.046292361713;5791.536677065825;5797;5737.540996720252;5756.625819321815;5778.8266352009505;5804.448577385142;5808.738606762706;4297.333913243452;4312.266914624522;4400.933985990213;4424.535423780521;4430.490493593278;3958.6041395860184;3962.2471730371135;3963.742356746802;4011.8796436106963;4013.1171142348635;5524.06090964537;5557.972210138923;5567.081431563827;5577.3028371453565;5577.637453565505;5682.7442765075675;5816.447437493432;5848.970755146197;5871.706414679249;5888.293404791452;5569.721513924287;5575.303087114111;5576.665400075927;5582.218489411485;5588.580856435784;4920.6309526785635;5079.212722028092;5087.87280317995;5090.10923088458;5130.7178105204575;5899.262592175978;5910;5931.673757943355;6021.608595441282;6028.065649824284;5826.621269617462;5839.3868643793485;5839.445252700986;5843.444872737083;5852.122181672783;5906.497947674324;5997.580169388101;6002.879942401215;6013.9699301503215;6030.276366835832;5736.627119237236;5793.971030144822;5803.419658034163;5817.214676018683;5855.3559108497175;5882.794102206402;5893.998020336468;5928.199693041384;5936.614120082181;5945.227120474484;5446.618736688394;5609.775608975595;5614.5789065821045;5747.942520574741;5759.424057594207;5701.914471283017;5704.600677952503;5711.942880571141;5714.5999780015;5758.366579676149;5605.1872478491205;5634.830955071355;5638.210650509014;5638.5771067170945;5639.295088113986;5598.10430331145;5695.487406133468;5721.628094173865;5740.885182296247;5763.279590051244;5534.584906132137;5554.222408862682;5595.188697638901;5596.4123767003875;5612.410696876769 05:43:14 INFO - PROCESS | 27914 | |1;ext.html;573.3406582430205;623.7972658885864;628.64167424568;636.5893998371048;645.7062036773268;30276.394472110544;34242.315153696974;34260.48609270863;34269.65730342696;34293.65706342936;44133.558664413344;45194.322085168664;45195.77402112993;48996;49048.754756226255;8890.422122562046;9065.95467022664;9073.13805188506;9073.274138068939;9075.546222688872;8185.79535511611;8963.282937364995;9055.864162037575;10469.528871200777;10652;10942.343459392423;11034;11079;11080.168987325942;11096.223264371498;10887;10896.891031089666;10906.236563440561;10942.069924056465;10946.945265273662;8113.837723245502;10529.473526323729;10854.72863178419;10863.728406789814;10865;40739.38890916639;40778;40952.79523602363;44908.55091449109;44994.55005449936;3594.9281014379826;3906.4761847714385;4226.767527785971;4274.401583778274;4354.281543545343;33264.16839579006;33568.16079598005;34023.48964765506;34460.82769586161;35087.4736878947;4413.624841888443;4420.381146639473;4441.289393697025;4451.888702782424;4474.82100715971;365283;368700;369772.9999999973;369979;370351;63716.362836371045;64022.35977640164;64484;64932.350676493574;65074.67462662656;36706;37231.81384093062;37436.625633743315;47472.76263618729;47775.283370749465;16049.438269660506;16157.676846463004;16218.026918384934;16222.756658650129;16243.51269461918;11109.44452777358;12379.133460657848;12475.5009799607;12484.687882803002;12502.687432814253;19890.60218795645;20658.967051647356;20718.896405517877;21540.461488462915;21658.241961531272;7586.506877052974;7629.923700763033;7745.148033716287;7986.960065199637;7996.960015199887;967.8983706710835;1050.3277902142636;1090.3512410115968;1102.415719668577;1123.601121601836;32918.506222406686;33538.161545961055;33669.326613467594;33862.83068584691;34100.14749631279;1078.8166011778017;1152.2683096233784;1164.6622479481025;1171.5313874450287;1173.5540494611994;16461.6707665846;17075;17113.657726845395;17166.57083572896;17377;546960;551956;552138;552142;552350;58611;59065;59123;59520.70239648774;59682;1262.5959692898184;1351.8377794664507;1361.6731984323692;1380.2132784313046;1388.9097208681403;31464.685353146175;33740.49389259114;33780.3243935115;33983.49024764581;34131.347461015794;51437.7428112857;52215.21677174769;52290.47709523008;52334.47665523296;52360.214596780315;412422;417390;417611;417689;418371;25721.228363149134;26230;30218.09345719632;30623.387532249675;30651.54022689617;46991;48032.5196748042;48189.27716084332;48462.27306590333;48780.756096219295;41208.58791412167;41293.793531032155;41591.37612935748;41655.1668966625;42227.788861055495;40498.39252411157;40997;41201.587984119775;41401.792991034854;41605.1678966425;39918.600813991485;40726.38910416287;40998.79500602478;41117;41340;35425.29149417049;36133.63866361303;36846;37273.81363093167;37500;27703.168904932885;27873.721262787112;28036;28068.71931280661;28095.859520702266 05:43:14 INFO - PROCESS | 27914 | |2;jquery.html;383.7659027992926;386.26802209812405;390.5040598439981;393.89758662747676;411.8270326462885;14288.984661935516;17115.82884171158;18041.368552100677;19794.208231670735;19803.801961980374;15344.923275383635;15978.201089945485;18304.908475457603;19066.809331906676;19696.803031969714;5649.604527683054;5819.272590926134;5881.176635271044;5914.733836977346;5918;4223.387608796723;5735.480097774093;5788.507976821954;5791.942080579203;6209.1307216989435;6476.838079048038;6566.507511936624;6571.080048793173;6573.112629794989;6583.177102862142;6366.108744775735;6490.383413575702;6547.508936829757;6557.3442655734525;6564.93435065648;5553.722313884289;5698.059820129673;5736.368999410061;5741.942580574183;5755.884882302373;20503.17987280507;21433.67849482259;22764;22824.08703651852;23113.422164445856;2295.2769877488536;2376.1089591403224;2386.844855084414;2540.4538024324675;2818.210900947738;9745.90254097457;10407.323523970994;10412.32319899204;10511.73720656982;10593.682189534326;1818.2545156485778;1887.4809427407436;1977.0510155125621;2005.649011422995;2028.78697736737;73428.26571734267;79505.20494795036;81927.18072819256;83190;87730.56134719349;10710.571577136827;11226.887731122748;11328.150388720878;11377.829332560019;11649;15366.615834604001;15680.686386272211;15761.29074191664;15805.841941580436;15828.28772705231;8143.837123257502;8438.156184381636;8486.363522735695;8691.478511289342;8696.95651521751;7809.531428114217;7911.683532658744;7968.442209045427;7988.121306656263;8052.919470805334;4391.187630288407;4502.977485112553;4771.284307353924;4851.684640498356;4885.267209918469;1942.9514262143277;2012.5371164632218;2021.1006102284343;2045.457953642286;2081.323569839808;1027.6660085472251;1042.6976176908763;1057.4237040812623;1057.4765491081964;1059.7138772531373;19491.317803876795;19535.925524096026;19867.403977880687;19897.303594374418;20000.29998950059;954.613381580461;985.7338518599938;1009.3439264478149;1017.1049476460668;1030.5826140413144;9472;11246.550137994389;11292.717682058013;11371.431428428545;11375.658730238107;455182;464641;467784;470135;470531;88508;89161;89532.5523372379;91384;91475.54262228646;970.1656575345197;985.113397941858;989.6288891665625;989.9604015839429;1009.9949500252452;17466;17575.736363954296;17968.640627187644;18028.909855450638;18065;40810.38784418296;41233.38149927693;42757.57242427536;43443.782781085894;43687.78156109199;58188;58912.11631825612;59750.402495976225;60367.39632603618;60634.69682651735;8868.290536757173;8945.37382383253;11668.88331116678;12564.246145231315;12856;12909.806352904901;13141.211527308393;14038.227897465737;14103.929480352532;14216.502422415166;11478.770424591294;11580.768384632092;12026.579069732867;12075.698107547381;12193.634190974284;11733.706657333634;11895.464704088165;12012.159148859497;12175.634730958085;12316.81524777147;11460.369679667698;11556.075513959031;12435.93782031084;12467.625971220878;12530.624081277212;11864.881351186377;12231.694207644525;12517.812232816697;12603.432845521791;12986.155899866479;11589.710257243636;11624.709382265512;11624.88375116238;11650.30098194111;11744.823827642764 05:43:14 INFO - PROCESS | 27914 | |3;mootools.html;1309.9803502947452;1454.6799704065106;1510.7356212662785;1611.6212690017844;1736;8531.317494600433;8872.911270887298;8891.377603567746;9262.536873156349;9301.116393942582;8984.326175536844;9184.770380740485;9185.402948808323;9190.310726695508;9192.402493837895;2047.3243829536218;2281.167373908528;2328.6739856420113;2347.835651504395;2368.632861906399;2394.1859767678984;2397.508510755291;2399.2802159352213;2401.1475926046264;2404.1465279825584;2316.9768302317016;2370.502194539149;2372.3476044087843;2374.169040835702;2374.6912901322803;2051.7537895452565;2313.2944451942235;2383.4637206628545;2387.1048356866177;2405.350555350046;2281.4866655002493;2281.8288628352775;2309.4919117794057;2319.4665226997886;2320.512692334612;9254.167124958718;9322.114399132071;9340.71977840666;9342.579583918672;9355.204807591363;5298.443663415363;5453.100238460649;5453.918191227135;5455.563554915597;5456.699881506515;3457.222125021875;3563.055790215595;3604.3151801157696;3623.800690961996;3674.8530058797614;1198.1912209258714;1201.591458903968;1247.8315427417274;1253.0727261826182;1256.3027519726547;12819.294938778363;12840.165389249762;12865.871341286562;12931.806022909665;12991.610251692464;4843.782029808667;4897;4960.801567937242;4996.4503904570465;4997.200447928314;10794.298370605886;10895.07391871684;10949.233553651167;10961.397123158304;10962.287451315638;4820.590249828804;5378.489043540857;5382.703951282639;5387.057264978613;5393.78424863009;4868.780904859219;5024.522670346311;5032.446430892599;5070.112730272188;5108.6168537359845;4056.1684854605323;4095.5699651536756;4159.750414975111;4160.355144952538;4171.645410140111;1283.5250957145915;1315.894728421724;1317.9374279252938;1320.214472388927;1340.1222199459369;916.2761418479326;975.302658599105;991.4398364923795;1018.4551265073151;1025.2720568396373;6369.585976911579;6405.103285540028;6416.00551914454;6423.164988551552;6525.184351956005;457.1200439154614;465.6158669098008;467.85262642267577;1031.9174466042698;1048.7220886465093;4375.649948004152;4481.820727170877;4498.370228168059;4524.615407690318;4552.226121559343;11088.168387370979;11392.772144557062;11450.599229026944;11469.426528673534;11494.597689081009;10859.457027148768;11324.547018119183;11325.773484530264;11333.320000799979;11687.415629218505;8409.453385529921;8509.149085091565;8519.659213631385;8521.147885211552;8531.530765807816;6327.272363678236;6570.737170513317;6645.335466453316;6666.166729158856;6750.898736518858;10326.173906087644;10473.109785668303;10542.631007914686;10646.946765266124;10648.946755266174;10709.98255165758;10719.571217151226;10815.134789217002;10828.837567436653;10850.0777433919;7286.052813134471;7472.850542989218;7488.663010164664;7630.923690763021;7994.5203287802915;8057.879131812911;8374.748757537283;8694.608742606724;8707.08575599553;8993.865092023494;7801.556712008297;8036.638351274323;8059.355251579742;8087.110417854149;8193.631286591999;7813.218678132142;7862.567558784322;7939.28546430824;8062.5968701563515;8090.919090809017;7447.627618618939;7471.514351567131;7525.209852965579;7602.239776022354;7606.885896711443;5273.5781137509675;5375.408705042364;5546.362168350692;5548.500634942875;5644.8306550803545;5576.386597474194;5586.77652893896;5599.860003499945;5620.662760234399;5654.2649455572155 05:43:14 INFO - PROCESS | 27914 | |4;prototype.html;333.55803560282624;334.1179286683155;344.87412094585477;345.1457642335221;346.3730647527973;5414.7834086636485;5426.8371948841495;5443.482869127436;5450.373207081187;5486.862828429286;5344.599155063366;5350.973245133779;5369.838904832861;5393.2719082923795;5407.702576358299;3929.5677475477673;4059.918801623973;4125.793710314488;4134.2144992451485;4167.499900012002;4186.623203911648;4230.4500414946015;4257.254071124123;4267.829286828523;4284.850030248942;4216.7680777557225;4217.135487225111;4221.197972385252;4221.746695198282;4255.616994470497;4011.8796436106963;4153.958460415418;4232.217039847623;4237.40676305316;4275.973766296098;3747.1006958330076;3755.8122093895195;3776.7922764247955;3777.2823163598828;3778.7732736035928;5276.1030624793875;5280.656757310762;5308.097623404031;5319.840404787863;5345.866353341159;4849.3453383793085;4863.927041094386;4875.561199492027;4876.463589005207;4893.730844803535;5614.831555053355;5624.409437009096;5644.6330988486025;5652.802151924663;5662.716864156776;3930.449737036817;4028.710812539988;4032.74984754727;4043.1509383029306;4069.1454794493193;5487.216654587275;5609.467100625434;5768.451997060272;5810.593258471867;5828.1549175369755;4183.895402614898;4187.1625674865145;4193.580641935782;4204.51648060477;4207.389928460418;4191.413202151702;4249.235137675187;4282.700210985201;4282.892927676833;4283.372318518943;4755.667103302805;4796.904061918742;4808.8797780055775;4816.590589799836;4856.854294371175;5559.27729395176;5579.330480342385;5641.12562552805;5680.914786278209;5726.112452569775;1449.2970909109074;1482.5848762346561;1483.7329280729357;1492.3732032546357;1492.4776328285013;924.4222361024359;933.421278807144;941.1623654947102;950.5674917912334;961.4567769210374;4756.595689366373;4766.712987493427;4793.880152996203;4808.447028591687;4835.564799168092;5024.824131155392;5088.956763863399;5097.898042039138;5099.4390617032095;5163.251328557338;4682.367880336179;4764.380630518011;4798.920242945309;4809.206480930678;5226;3102.0228627982565;3102.317490152163;3108;3109.7667674924473;3142.3345626817822;6014.308354539196;6018.067199584071;6027.698615069229;6052.760478622849;6059.666718330446;5799.4780469757925;5868.2664666916635;5947.762089516457;5967.880642387215;5976.701164941735;5914.497267732291;5925.4151238500945;6028.698565071729;6041.8884274599495;6057.545684073712;5392.272043274264;5526.972365138309;5809.157672137601;5858.7070646468355;5863.794767183128;5750.539956803529;5777.91333129995;5778;5784.2769653793275;5795.971020144872;6009;6052.03167493199;6076.756929722762;6081.452669259788;6081.543884208613;3909.4526766253316;4093.713440059167;4141.461609990682;4181.895452613709;4185.267578173746;5774.816162686723;5790.768369265183;5814.389489103583;5820.76716931318;5848.824535263949;5556.194351819045;5621.606487545832;5649.237352957298;5704.286964129484;5719.542436604978;5591.217229587943;5591.30108736408;5593.496585307342;5604.423598519499;5627.240322556566;5452.26394436746;5479.890402192013;5541.584381171348;5542.501174894118;5568.443155684561;5399.514043736082;5656.88686226265;5671.489565939085;5672.404397538364;5751.223584815996;5509.972450137884;5583.106702927512;5589.273394458694;5595.860103497283;5612.877424515195 05:43:14 INFO - PROCESS | 27914 | |5;yui.html;729.9635018249086;743.672783975051;753.3107206905681;802.7471346525844;812.8861959325693;14744.33650485728;14947.775783363231;15017.32422041008;15028.774568381483;15085.472008479705;13617.591472255823;14574.781378279335;14575.489857854951;14589.12465252083;14620.561383158496;656.3862788292937;778.2684276779809;792.9286364227219;805.0902480197369;815.5392203405087;784.7802615267706;803.4857691077715;805.6898094233703;805.730080423056;805.9879101813477;847.2925107535216;849.4393700157897;850.0182289455688;850.2390360627235;850.4387104511025;682.2597481732302;835.5822088955522;849.1466076593015;850.1795767084762;867.9001914779818;591.893459177348;594.895893218685;595.6783336998016;597.1848426897254;600.4055984575239;14875.47935822241;14964.850351496454;14984.775228371584;14989.925050374679;14996.775048374284;14233;14614;14652.706945861022;14799.778003329959;14879.776803347959;12426.254424734545;12547.811782823264;12549.686257843536;12599.93700031503;12680.80978785319;3839.232153569297;3893.240818040483;3983.083890705125;4014.297497937849;4118.341065429517;79352;79447;80623;80837;80947.5952620239;10949.671509854717;11101.555937762561;11151.330920144655;11434.656960291039;11520.711982200512;20092.799072009384;20129.09419076145;20146.093425795876;20202.696959545618;20259.18963241454;7429.85140297191;7937.920620793718;8300.418970671995;8683.392162548562;9072.364934454525;4796.736179510091;4819.228923372244;4843.636727245471;4883.194272944996;5002.774875130628;3708.647678470595;3880.708946828999;3884.3590807517007;3887.688984881203;3889.358255887747;654.9639769812707;657.3328072006917;664.9335066493409;673.1417442760421;673.7468308945357;719.5826420675995;729.8503806719609;735.213321745727;751.2412463411885;760.0840986611121;9780.804383912282;9811.558479868423;9948.154406875352;9953.25350598708;10011.399316041061;721.4300702445114;726.3462883404978;753.0549160803157;753.9283768042027;754.0913199594476;4559.83918157753;4698.436187657503;4975.651704380731;5075.822346217865;5085.694858308513;122571;124506;126542.36728816298;127101;129057;71216.287837122;105380;106067;106619.46690266654;107278.46360768302;60807.39192608017;78922;93920;94330.99999999863;94450.52774736083;9849.95075024649;9989.750256243651;10020.148287395654;10168.89831101709;10178.796424071328;54711.17933230925;55771.44228557825;56685;57063.42936570581;57066.7146664264;79603;82979.58510207411;84141.5792921056;84504;85786;13083.542076027294;13184.864500725562;13191.868081319064;13254.337283135997;13761.587152385444;15557.45548905783;15588.68822623564;15668.68662626764;15967.600809979844;16491.34034638649;14567.198804065454;14648.487302944346;14855.851441485447;14867.479638212611;15509.146996915279;13703.794443083163;13711.862881371457;14159.150450972975;14565.271736412926;15062.477204938012;13925;14334.713305733618;14390.640233994234;14628.561143165722;14745.744118556615;10865.837012444661;11104.389258590854;11311.434428278717;11538.711532211762;11633.127515436207;11749.645228195152;11761.88238117608;11967.521299147937;12025.518979240733;12075 05:43:14 INFO - PROCESS | 27914 | __end_tp_report 05:43:14 INFO - PROCESS | 27914 | __start_cc_report 05:43:14 INFO - PROCESS | 27914 | _x_x_mozilla_cycle_collect,1107 05:43:14 INFO - PROCESS | 27914 | __end_cc_report 05:43:14 INFO - PROCESS | 27914 | __startTimestamp1466080994722__endTimestamp 05:43:14 INFO - PROCESS | 27914 | 05:43:14 INFO - PROCESS | 27914 | ------- Summary: start ------- 05:43:14 INFO - PROCESS | 27914 | Number of tests: 6 05:43:14 INFO - PROCESS | 27914 | 05:43:14 INFO - PROCESS | 27914 | [#0] dojo.html Cycles:165 Average:5417.75 Median:5614.58 stddev:614.06 (10.9%) stddev-sans-first:588.75 05:43:14 INFO - PROCESS | 27914 | Values: 3114.3 3134.7 3157.0 3184.1 3203.9 5256.6 5293.5 5408.2 5524.0 5550.6 5335.7 5450.8 5510.2 5618.5 5619.1 4939.6 4995.4 5001.8 5097.9 5100.4 5036.1 5060.1 5063.5 5101.8 5110.3 4924.6 4945.7 5005.5 5054.3 5072.7 4879.1 4879.5 4896.6 4940.8 4968.4 4848.2 4889.5 4940.6 4942.4 4969.1 5304.4 5349.6 5426.1 5488.6 5505.4 5725.7 5795.2 5850.1 5854.7 5855.4 5833.5 5890.4 5894.9 5895.2 5902.7 5297.9 5345.3 5400.4 5475.1 5490.9 5992.6 5998.8 6001.8 6009.9 6021.2 5756.9 5766.4 5771.8 5773.1 5779.3 5693.2 5752.9 5795.4 5798.1 5855.8 5768.3 5770.0 5780.0 5791.5 5797.0 5737.5 5756.6 5778.8 5804.4 5808.7 4297.3 4312.3 4400.9 4424.5 4430.5 3958.6 3962.2 3963.7 4011.9 4013.1 5524.1 5558.0 5567.1 5577.3 5577.6 5682.7 5816.4 5849.0 5871.7 5888.3 5569.7 5575.3 5576.7 5582.2 5588.6 4920.6 5079.2 5087.9 5090.1 5130.7 5899.3 5910.0 5931.7 6021.6 6028.1 5826.6 5839.4 5839.4 5843.4 5852.1 5906.5 5997.6 6002.9 6014.0 6030.3 5736.6 5794.0 5803.4 5817.2 5855.4 5882.8 5894.0 5928.2 5936.6 5945.2 5446.6 5609.8 5614.6 5747.9 5759.4 5701.9 5704.6 5711.9 5714.6 5758.4 5605.2 5634.8 5638.2 5638.6 5639.3 5598.1 5695.5 5721.6 5740.9 5763.3 5534.6 5554.2 5595.2 5596.4 5612.4 05:43:14 INFO - PROCESS | 27914 | 05:43:14 INFO - PROCESS | 27914 | [#1] ext.html Cycles:180 Average:60547.79 Median:37252.81 stddev:119840.65 (321.7%) stddev-sans-first:120092.23 05:43:14 INFO - PROCESS | 27914 | Values: 573.3 623.8 628.6 636.6 645.7 30276.4 34242.3 34260.5 34269.7 34293.7 44133.6 45194.3 45195.8 48996.0 49048.8 8890.4 9066.0 9073.1 9073.3 9075.5 8185.8 8963.3 9055.9 10469.5 10652.0 10942.3 11034.0 11079.0 11080.2 11096.2 10887.0 10896.9 10906.2 10942.1 10946.9 8113.8 10529.5 10854.7 10863.7 10865.0 40739.4 40778.0 40952.8 44908.6 44994.6 3594.9 3906.5 4226.8 4274.4 4354.3 33264.2 33568.2 34023.5 34460.8 35087.5 4413.6 4420.4 4441.3 4451.9 4474.8 365283.0 368700.0 369773.0 369979.0 370351.0 63716.4 64022.4 64484.0 64932.4 65074.7 36706.0 37231.8 37436.6 47472.8 47775.3 16049.4 16157.7 16218.0 16222.8 16243.5 11109.4 12379.1 12475.5 12484.7 12502.7 19890.6 20659.0 20718.9 21540.5 21658.2 7586.5 7629.9 7745.1 7987.0 7997.0 967.9 1050.3 1090.4 1102.4 1123.6 32918.5 33538.2 33669.3 33862.8 34100.1 1078.8 1152.3 1164.7 1171.5 1173.6 16461.7 17075.0 17113.7 17166.6 17377.0 546960.0 551956.0 552138.0 552142.0 552350.0 58611.0 59065.0 59123.0 59520.7 59682.0 1262.6 1351.8 1361.7 1380.2 1388.9 31464.7 33740.5 33780.3 33983.5 34131.3 51437.7 52215.2 52290.5 52334.5 52360.2 412422.0 417390.0 417611.0 417689.0 418371.0 25721.2 26230.0 30218.1 30623.4 30651.5 46991.0 48032.5 48189.3 48462.3 48780.8 41208.6 41293.8 41591.4 41655.2 42227.8 40498.4 40997.0 41201.6 41401.8 41605.2 39918.6 40726.4 40998.8 41117.0 41340.0 35425.3 36133.6 36846.0 37273.8 37500.0 27703.2 27873.7 28036.0 28068.7 28095.9 05:43:14 INFO - PROCESS | 27914 | 05:43:14 INFO - PROCESS | 27914 | [#2] jquery.html Cycles:180 Average:28557.90 Median:11757.50 stddev:76842.88 (653.6%) stddev-sans-first:77029.33 05:43:14 INFO - PROCESS | 27914 | Values: 383.8 386.3 390.5 393.9 411.8 14289.0 17115.8 18041.4 19794.2 19803.8 15344.9 15978.2 18304.9 19066.8 19696.8 5649.6 5819.3 5881.2 5914.7 5918.0 4223.4 5735.5 5788.5 5791.9 6209.1 6476.8 6566.5 6571.1 6573.1 6583.2 6366.1 6490.4 6547.5 6557.3 6564.9 5553.7 5698.1 5736.4 5741.9 5755.9 20503.2 21433.7 22764.0 22824.1 23113.4 2295.3 2376.1 2386.8 2540.5 2818.2 9745.9 10407.3 10412.3 10511.7 10593.7 1818.3 1887.5 1977.1 2005.6 2028.8 73428.3 79505.2 81927.2 83190.0 87730.6 10710.6 11226.9 11328.2 11377.8 11649.0 15366.6 15680.7 15761.3 15805.8 15828.3 8143.8 8438.2 8486.4 8691.5 8697.0 7809.5 7911.7 7968.4 7988.1 8052.9 4391.2 4503.0 4771.3 4851.7 4885.3 1943.0 2012.5 2021.1 2045.5 2081.3 1027.7 1042.7 1057.4 1057.5 1059.7 19491.3 19535.9 19867.4 19897.3 20000.3 954.6 985.7 1009.3 1017.1 1030.6 9472.0 11246.6 11292.7 11371.4 11375.7 455182.0 464641.0 467784.0 470135.0 470531.0 88508.0 89161.0 89532.6 91384.0 91475.5 970.2 985.1 989.6 990.0 1010.0 17466.0 17575.7 17968.6 18028.9 18065.0 40810.4 41233.4 42757.6 43443.8 43687.8 58188.0 58912.1 59750.4 60367.4 60634.7 8868.3 8945.4 11668.9 12564.2 12856.0 12909.8 13141.2 14038.2 14103.9 14216.5 11478.8 11580.8 12026.6 12075.7 12193.6 11733.7 11895.5 12012.2 12175.6 12316.8 11460.4 11556.1 12435.9 12467.6 12530.6 11864.9 12231.7 12517.8 12603.4 12986.2 11589.7 11624.7 11624.9 11650.3 11744.8 05:43:14 INFO - PROCESS | 27914 | 05:43:14 INFO - PROCESS | 27914 | [#3] mootools.html Cycles:180 Average:6048.87 Median:466.73 stddev:3461.52 (741.6%) stddev-sans-first:3452.91 05:43:14 INFO - PROCESS | 27914 | Values: 1310.0 1454.7 1510.7 1611.6 1736.0 8531.3 8872.9 8891.4 9262.5 9301.1 8984.3 9184.8 9185.4 9190.3 9192.4 2047.3 2281.2 2328.7 2347.8 2368.6 2394.2 2397.5 2399.3 2401.1 2404.1 2317.0 2370.5 2372.3 2374.2 2374.7 2051.8 2313.3 2383.5 2387.1 2405.4 2281.5 2281.8 2309.5 2319.5 2320.5 9254.2 9322.1 9340.7 9342.6 9355.2 5298.4 5453.1 5453.9 5455.6 5456.7 3457.2 3563.1 3604.3 3623.8 3674.9 1198.2 1201.6 1247.8 1253.1 1256.3 12819.3 12840.2 12865.9 12931.8 12991.6 4843.8 4897.0 4960.8 4996.5 4997.2 10794.3 10895.1 10949.2 10961.4 10962.3 4820.6 5378.5 5382.7 5387.1 5393.8 4868.8 5024.5 5032.4 5070.1 5108.6 4056.2 4095.6 4159.8 4160.4 4171.6 1283.5 1315.9 1317.9 1320.2 1340.1 916.3 975.3 991.4 1018.5 1025.3 6369.6 6405.1 6416.0 6423.2 6525.2 457.1 465.6 467.9 1031.9 1048.7 4375.6 4481.8 4498.4 4524.6 4552.2 11088.2 11392.8 11450.6 11469.4 11494.6 10859.5 11324.5 11325.8 11333.3 11687.4 8409.5 8509.1 8519.7 8521.1 8531.5 6327.3 6570.7 6645.3 6666.2 6750.9 10326.2 10473.1 10542.6 10646.9 10648.9 10710.0 10719.6 10815.1 10828.8 10850.1 7286.1 7472.9 7488.7 7630.9 7994.5 8057.9 8374.7 8694.6 8707.1 8993.9 7801.6 8036.6 8059.4 8087.1 8193.6 7813.2 7862.6 7939.3 8062.6 8090.9 7447.6 7471.5 7525.2 7602.2 7606.9 5273.6 5375.4 5546.4 5548.5 5644.8 5576.4 5586.8 5599.9 5620.7 5654.3 05:43:14 INFO - PROCESS | 27914 | 05:43:14 INFO - PROCESS | 27914 | [#4] prototype.html Cycles:180 Average:4714.89 Median:5348.42 stddev:1377.39 (25.8%) stddev-sans-first:1341.42 05:43:14 INFO - PROCESS | 27914 | Values: 333.6 334.1 344.9 345.1 346.4 5414.8 5426.8 5443.5 5450.4 5486.9 5344.6 5351.0 5369.8 5393.3 5407.7 3929.6 4059.9 4125.8 4134.2 4167.5 4186.6 4230.5 4257.3 4267.8 4284.9 4216.8 4217.1 4221.2 4221.7 4255.6 4011.9 4154.0 4232.2 4237.4 4276.0 3747.1 3755.8 3776.8 3777.3 3778.8 5276.1 5280.7 5308.1 5319.8 5345.9 4849.3 4863.9 4875.6 4876.5 4893.7 5614.8 5624.4 5644.6 5652.8 5662.7 3930.4 4028.7 4032.7 4043.2 4069.1 5487.2 5609.5 5768.5 5810.6 5828.2 4183.9 4187.2 4193.6 4204.5 4207.4 4191.4 4249.2 4282.7 4282.9 4283.4 4755.7 4796.9 4808.9 4816.6 4856.9 5559.3 5579.3 5641.1 5680.9 5726.1 1449.3 1482.6 1483.7 1492.4 1492.5 924.4 933.4 941.2 950.6 961.5 4756.6 4766.7 4793.9 4808.4 4835.6 5024.8 5089.0 5097.9 5099.4 5163.3 4682.4 4764.4 4798.9 4809.2 5226.0 3102.0 3102.3 3108.0 3109.8 3142.3 6014.3 6018.1 6027.7 6052.8 6059.7 5799.5 5868.3 5947.8 5967.9 5976.7 5914.5 5925.4 6028.7 6041.9 6057.5 5392.3 5527.0 5809.2 5858.7 5863.8 5750.5 5777.9 5778.0 5784.3 5796.0 6009.0 6052.0 6076.8 6081.5 6081.5 3909.5 4093.7 4141.5 4181.9 4185.3 5774.8 5790.8 5814.4 5820.8 5848.8 5556.2 5621.6 5649.2 5704.3 5719.5 5591.2 5591.3 5593.5 5604.4 5627.2 5452.3 5479.9 5541.6 5542.5 5568.4 5399.5 5656.9 5671.5 5672.4 5751.2 5510.0 5583.1 5589.3 5595.9 5612.9 05:43:14 INFO - PROCESS | 27914 | 05:43:14 INFO - PROCESS | 27914 | [#5] yui.html Cycles:180 Average:21694.70 Median:3998.69 stddev:31758.11 (794.2%) stddev-sans-first:31808.19 05:43:14 INFO - PROCESS | 27914 | Values: 730.0 743.7 753.3 802.7 812.9 14744.3 14947.8 15017.3 15028.8 15085.5 13617.6 14574.8 14575.5 14589.1 14620.6 656.4 778.3 792.9 805.1 815.5 784.8 803.5 805.7 805.7 806.0 847.3 849.4 850.0 850.2 850.4 682.3 835.6 849.1 850.2 867.9 591.9 594.9 595.7 597.2 600.4 14875.5 14964.9 14984.8 14989.9 14996.8 14233.0 14614.0 14652.7 14799.8 14879.8 12426.3 12547.8 12549.7 12599.9 12680.8 3839.2 3893.2 3983.1 4014.3 4118.3 79352.0 79447.0 80623.0 80837.0 80947.6 10949.7 11101.6 11151.3 11434.7 11520.7 20092.8 20129.1 20146.1 20202.7 20259.2 7429.9 7937.9 8300.4 8683.4 9072.4 4796.7 4819.2 4843.6 4883.2 5002.8 3708.6 3880.7 3884.4 3887.7 3889.4 655.0 657.3 664.9 673.1 673.7 719.6 729.9 735.2 751.2 760.1 9780.8 9811.6 9948.2 9953.3 10011.4 721.4 726.3 753.1 753.9 754.1 4559.8 4698.4 4975.7 5075.8 5085.7 122571.0 124506.0 126542.4 127101.0 129057.0 71216.3 105380.0 106067.0 106619.5 107278.5 60807.4 78922.0 93920.0 94331.0 94450.5 9850.0 9989.8 10020.1 10168.9 10178.8 54711.2 55771.4 56685.0 57063.4 57066.7 79603.0 82979.6 84141.6 84504.0 85786.0 13083.5 13184.9 13191.9 13254.3 13761.6 15557.5 15588.7 15668.7 15967.6 16491.3 14567.2 14648.5 14855.9 14867.5 15509.1 13703.8 13711.9 14159.2 14565.3 15062.5 13925.0 14334.7 14390.6 14628.6 14745.7 10865.8 11104.4 11311.4 11538.7 11633.1 11749.6 11761.9 11967.5 12025.5 12075.0 05:43:14 INFO - PROCESS | 27914 | -------- Summary: end -------- 05:43:14 INFO - PROCESS | 27914 | 05:43:15 INFO - TEST-INFO | 27914: exit 0 05:43:15 INFO - TEST-OK | dromaeo_css | took 1114340ms 05:43:15 INFO - TEST-START | kraken 05:43:15 INFO - operating with platform_type : linux_ 05:43:15 INFO - Initialising browser for kraken test... 05:43:15 INFO - TEST-INFO | started process 28100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp44kyG8/profile http://localhost:58460/getInfo.html) 05:43:19 INFO - PROCESS | 28100 | __metrics Screen width/height:1600/1200 05:43:19 INFO - PROCESS | 28100 | colorDepth:24 05:43:19 INFO - PROCESS | 28100 | Browser inner width/height: 1024/697 05:43:19 INFO - PROCESS | 28100 | __metrics 05:43:19 INFO - PROCESS | 28100 | JavaScript error: resource:///modules/PlacesUIUtils.jsm, line 204: ReferenceError: can't access lexical declaration `innerWindowID' before initialization 05:43:20 INFO - PROCESS | 28100 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:43:21 INFO - TEST-INFO | 28100: exit 0 05:43:21 INFO - Browser initialized. 05:43:21 INFO - Running cycle 1/1 for kraken test... 05:43:21 INFO - TEST-INFO | started process 28179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp44kyG8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:33 INFO - PROCESS | 28179 | RSS: Main: 173641728 05:43:33 INFO - PROCESS | 28179 | 05:43:35 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58460/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:36 INFO - PROCESS | 28179 | RSS: Main: 232906752 05:43:36 INFO - PROCESS | 28179 | 05:43:39 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58460/tests/kraken/driver.html?testName=audio-dft) 05:43:39 INFO - PROCESS | 28179 | RSS: Main: 220999680 05:43:39 INFO - PROCESS | 28179 | 05:43:42 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58460/tests/kraken/driver.html?testName=audio-fft) 05:43:43 INFO - PROCESS | 28179 | RSS: Main: 287334400 05:43:43 INFO - PROCESS | 28179 | 05:43:45 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58460/tests/kraken/driver.html?testName=audio-oscillator) 05:43:46 INFO - PROCESS | 28179 | RSS: Main: 198713344 05:43:46 INFO - PROCESS | 28179 | 05:43:48 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:43:48 INFO - PROCESS | 28179 | RSS: Main: 202604544 05:43:48 INFO - PROCESS | 28179 | 05:43:51 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58460/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:52 INFO - PROCESS | 28179 | RSS: Main: 238112768 05:43:52 INFO - PROCESS | 28179 | 05:43:55 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58460/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:56 INFO - PROCESS | 28179 | RSS: Main: 238645248 05:43:56 INFO - PROCESS | 28179 | 05:43:59 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58460/tests/kraken/driver.html?testName=json-parse-financial) 05:43:59 INFO - PROCESS | 28179 | RSS: Main: 238882816 05:43:59 INFO - PROCESS | 28179 | 05:44:01 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:44:02 INFO - PROCESS | 28179 | RSS: Main: 226140160 05:44:02 INFO - PROCESS | 28179 | 05:44:03 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58460/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:44:04 INFO - PROCESS | 28179 | RSS: Main: 229556224 05:44:04 INFO - PROCESS | 28179 | 05:44:06 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:44:07 INFO - PROCESS | 28179 | RSS: Main: 238485504 05:44:07 INFO - PROCESS | 28179 | 05:44:09 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:44:10 INFO - PROCESS | 28179 | RSS: Main: 238845952 05:44:10 INFO - PROCESS | 28179 | 05:44:13 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:44:13 INFO - PROCESS | 28179 | RSS: Main: 235872256 05:44:13 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | Cycle 1(1): loaded http://localhost:58460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58460/tests/kraken/driver.html?testName=ai-astar) 05:44:15 INFO - PROCESS | 28179 | RSS: Main: 278134784 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | __start_tp_report 05:44:15 INFO - PROCESS | 28179 | _x_x_mozilla_page_load 05:44:15 INFO - PROCESS | 28179 | _x_x_mozilla_page_load_details 05:44:15 INFO - PROCESS | 28179 | |i|pagename|runs| 05:44:15 INFO - PROCESS | 28179 | |0;ai-astar;114;105;110;111;111;111;111;111;110;111 05:44:15 INFO - PROCESS | 28179 | |1;audio-beat-detection;153;123;135;188;130;156;149;128;195;132 05:44:15 INFO - PROCESS | 28179 | |2;audio-dft;162;163;164;163;163;164;163;161;161;160 05:44:15 INFO - PROCESS | 28179 | |3;audio-fft;74;76;75;123;75;78;74;78;98;76 05:44:15 INFO - PROCESS | 28179 | |4;audio-oscillator;84;85;127;84;84;85;127;84;84;126 05:44:15 INFO - PROCESS | 28179 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;116;117 05:44:15 INFO - PROCESS | 28179 | |6;imaging-darkroom;145;147;146;145;145;145;145;145;146;146 05:44:15 INFO - PROCESS | 28179 | |7;imaging-desaturate;96;96;94;95;95;94;95;95;95;95 05:44:15 INFO - PROCESS | 28179 | |8;json-parse-financial;52;53;53;56;54;53;55;54;53;54 05:44:15 INFO - PROCESS | 28179 | |9;json-stringify-tinderbox;62;62;62;61;62;62;62;63;63;63 05:44:15 INFO - PROCESS | 28179 | |10;stanford-crypto-aes;80;79;79;79;83;81;87;81;109;80 05:44:15 INFO - PROCESS | 28179 | |11;stanford-crypto-ccm;124;124;132;123;130;136;134;130;128;127 05:44:15 INFO - PROCESS | 28179 | |12;stanford-crypto-pbkdf2;161;165;161;166;166;167;163;160;164;159 05:44:15 INFO - PROCESS | 28179 | |13;stanford-crypto-sha256-iterative;63;62;63;62;63;62;65;63;61;60 05:44:15 INFO - PROCESS | 28179 | __end_tp_report 05:44:15 INFO - PROCESS | 28179 | __start_cc_report 05:44:15 INFO - PROCESS | 28179 | _x_x_mozilla_cycle_collect,1594 05:44:15 INFO - PROCESS | 28179 | __end_cc_report 05:44:15 INFO - PROCESS | 28179 | __startTimestamp1466081055608__endTimestamp 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | ------- Summary: start ------- 05:44:15 INFO - PROCESS | 28179 | Number of tests: 14 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.22 (2.0%) stddev-sans-first:1.96 05:44:15 INFO - PROCESS | 28179 | Values: 114.0 105.0 110.0 111.0 111.0 111.0 111.0 111.0 110.0 111.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:151.00 stddev:25.09 (16.6%) stddev-sans-first:26.57 05:44:15 INFO - PROCESS | 28179 | Values: 153.0 123.0 135.0 188.0 130.0 156.0 149.0 128.0 195.0 132.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 05:44:15 INFO - PROCESS | 28179 | Values: 162.0 163.0 164.0 163.0 163.0 164.0 163.0 161.0 161.0 160.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:15.85 (20.9%) stddev-sans-first:16.50 05:44:15 INFO - PROCESS | 28179 | Values: 74.0 76.0 75.0 123.0 75.0 78.0 74.0 78.0 98.0 76.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:84.00 stddev:20.48 (24.4%) stddev-sans-first:21.17 05:44:15 INFO - PROCESS | 28179 | Values: 84.0 85.0 127.0 84.0 84.0 85.0 127.0 84.0 84.0 126.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:44:15 INFO - PROCESS | 28179 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 05:44:15 INFO - PROCESS | 28179 | Values: 145.0 147.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 05:44:15 INFO - PROCESS | 28179 | Values: 96.0 96.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.16 (2.1%) stddev-sans-first:1.05 05:44:15 INFO - PROCESS | 28179 | Values: 52.0 53.0 53.0 56.0 54.0 53.0 55.0 54.0 53.0 54.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 05:44:15 INFO - PROCESS | 28179 | Values: 62.0 62.0 62.0 61.0 62.0 62.0 62.0 63.0 63.0 63.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:80.50 stddev:9.19 (11.4%) stddev-sans-first:9.64 05:44:15 INFO - PROCESS | 28179 | Values: 80.0 79.0 79.0 79.0 83.0 81.0 87.0 81.0 109.0 80.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:130.00 stddev:4.42 (3.4%) stddev-sans-first:4.33 05:44:15 INFO - PROCESS | 28179 | Values: 124.0 124.0 132.0 123.0 130.0 136.0 134.0 130.0 128.0 127.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:164.50 stddev:2.82 (1.7%) stddev-sans-first:2.88 05:44:15 INFO - PROCESS | 28179 | Values: 161.0 165.0 161.0 166.0 166.0 167.0 163.0 160.0 164.0 159.0 05:44:15 INFO - PROCESS | 28179 | 05:44:15 INFO - PROCESS | 28179 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:1.35 (2.1%) stddev-sans-first:1.41 05:44:15 INFO - PROCESS | 28179 | Values: 63.0 62.0 63.0 62.0 63.0 62.0 65.0 63.0 61.0 60.0 05:44:15 INFO - PROCESS | 28179 | -------- Summary: end -------- 05:44:15 INFO - PROCESS | 28179 | 05:44:16 INFO - TEST-INFO | 28179: exit 0 05:44:16 INFO - TEST-OK | kraken | took 61113ms 05:44:16 INFO - SUITE-END | took 1175s 05:44:16 INFO - Completed test suite (00:19:35) 05:44:16 INFO - javascript benchmark 05:44:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.2992826614013, 3134.7022032906875, 3156.984215078924, 3184.108449634103, 3203.855826487808, 5256.632035757499, 5293.470652934705, 5408.188771684249, 5524.0, 5550.583706222029, 5335.653182543142, 5450.781968721247, 5510.201020851984, 5618.522425593819, 5619.129034999582, 4939.580135688462, 4995.425526064513, 5001.774920128603, 5097.949020509803, 5100.413452452978, 5036.068327359432, 5060.11447996601, 5063.46833582474, 5101.821436249732, 5110.28456016158, 4924.556789888891, 4945.703257804507, 5005.5244751748705, 5054.342935418372, 5072.74636268187, 4879.121758083544, 4879.536444037811, 4896.559309662148, 4940.802367905316, 4968.354113965198, 4848.248521479177, 4889.462159162489, 4940.629452791055, 4942.406911170647, 4969.105560999019, 5304.38999515053, 5349.625526213166, 5426.050441172779, 5488.643238189545, 5505.421930697299, 5725.685087320196, 5795.1886735857015, 5850.063989761617, 5854.7072646367515, 5855.355910849803, 5833.504152147073, 5890.352061273256, 5894.941050589482, 5895.204147440084, 5902.704864756788, 5297.947020529784, 5345.278387417648, 5400.351957765015, 5475.06923822951, 5490.890182196374, 5992.58051936369, 5998.820035398858, 6001.849953751192, 6009.939900601025, 6021.217241758543, 5756.856078597984, 5766.365699773021, 5771.797987070432, 5773.076307790733, 5779.306483222041, 5693.202951586698, 5752.884942301131, 5795.449432303924, 5798.130280457881, 5855.824325270249, 5768.250127483484, 5770.0, 5780.046292361713, 5791.536677065825, 5797.0, 5737.540996720252, 5756.625819321815, 5778.8266352009505, 5804.448577385142, 5808.738606762706, 4297.333913243452, 4312.266914624522, 4400.933985990213, 4424.535423780521, 4430.490493593278, 3958.6041395860184, 3962.2471730371135, 3963.742356746802, 4011.8796436106963, 4013.1171142348635, 5524.06090964537, 5557.972210138923, 5567.081431563827, 5577.3028371453565, 5577.637453565505, 5682.7442765075675, 5816.447437493432, 5848.970755146197, 5871.706414679249, 5888.293404791452, 5569.721513924287, 5575.303087114111, 5576.665400075927, 5582.218489411485, 5588.580856435784, 4920.6309526785635, 5079.212722028092, 5087.87280317995, 5090.10923088458, 5130.7178105204575, 5899.262592175978, 5910.0, 5931.673757943355, 6021.608595441282, 6028.065649824284, 5826.621269617462, 5839.3868643793485, 5839.445252700986, 5843.444872737083, 5852.122181672783, 5906.497947674324, 5997.580169388101, 6002.879942401215, 6013.9699301503215, 6030.276366835832, 5736.627119237236, 5793.971030144822, 5803.419658034163, 5817.214676018683, 5855.3559108497175, 5882.794102206402, 5893.998020336468, 5928.199693041384, 5936.614120082181, 5945.227120474484, 5446.618736688394, 5609.775608975595, 5614.5789065821045, 5747.942520574741, 5759.424057594207, 5701.914471283017, 5704.600677952503, 5711.942880571141, 5714.5999780015, 5758.366579676149, 5605.1872478491205, 5634.830955071355, 5638.210650509014, 5638.5771067170945, 5639.295088113986, 5598.10430331145, 5695.487406133468, 5721.628094173865, 5740.885182296247, 5763.279590051244, 5534.584906132137, 5554.222408862682, 5595.188697638901, 5596.4123767003875, 5612.410696876769], "value": 5376.270242496498, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.3406582430205, 623.7972658885864, 628.64167424568, 636.5893998371048, 645.7062036773268, 30276.394472110544, 34242.315153696974, 34260.48609270863, 34269.65730342696, 34293.65706342936, 44133.558664413344, 45194.322085168664, 45195.77402112993, 48996.0, 49048.754756226255, 8890.422122562046, 9065.95467022664, 9073.13805188506, 9073.274138068939, 9075.546222688872, 8185.79535511611, 8963.282937364995, 9055.864162037575, 10469.528871200777, 10652.0, 10942.343459392423, 11034.0, 11079.0, 11080.168987325942, 11096.223264371498, 10887.0, 10896.891031089666, 10906.236563440561, 10942.069924056465, 10946.945265273662, 8113.837723245502, 10529.473526323729, 10854.72863178419, 10863.728406789814, 10865.0, 40739.38890916639, 40778.0, 40952.79523602363, 44908.55091449109, 44994.55005449936, 3594.9281014379826, 3906.4761847714385, 4226.767527785971, 4274.401583778274, 4354.281543545343, 33264.16839579006, 33568.16079598005, 34023.48964765506, 34460.82769586161, 35087.4736878947, 4413.624841888443, 4420.381146639473, 4441.289393697025, 4451.888702782424, 4474.82100715971, 365283.0, 368700.0, 369772.9999999973, 369979.0, 370351.0, 63716.362836371045, 64022.35977640164, 64484.0, 64932.350676493574, 65074.67462662656, 36706.0, 37231.81384093062, 37436.625633743315, 47472.76263618729, 47775.283370749465, 16049.438269660506, 16157.676846463004, 16218.026918384934, 16222.756658650129, 16243.51269461918, 11109.44452777358, 12379.133460657848, 12475.5009799607, 12484.687882803002, 12502.687432814253, 19890.60218795645, 20658.967051647356, 20718.896405517877, 21540.461488462915, 21658.241961531272, 7586.506877052974, 7629.923700763033, 7745.148033716287, 7986.960065199637, 7996.960015199887, 967.8983706710835, 1050.3277902142636, 1090.3512410115968, 1102.415719668577, 1123.601121601836, 32918.506222406686, 33538.161545961055, 33669.326613467594, 33862.83068584691, 34100.14749631279, 1078.8166011778017, 1152.2683096233784, 1164.6622479481025, 1171.5313874450287, 1173.5540494611994, 16461.6707665846, 17075.0, 17113.657726845395, 17166.57083572896, 17377.0, 546960.0, 551956.0, 552138.0, 552142.0, 552350.0, 58611.0, 59065.0, 59123.0, 59520.70239648774, 59682.0, 1262.5959692898184, 1351.8377794664507, 1361.6731984323692, 1380.2132784313046, 1388.9097208681403, 31464.685353146175, 33740.49389259114, 33780.3243935115, 33983.49024764581, 34131.347461015794, 51437.7428112857, 52215.21677174769, 52290.47709523008, 52334.47665523296, 52360.214596780315, 412422.0, 417390.0, 417611.0, 417689.0, 418371.0, 25721.228363149134, 26230.0, 30218.09345719632, 30623.387532249675, 30651.54022689617, 46991.0, 48032.5196748042, 48189.27716084332, 48462.27306590333, 48780.756096219295, 41208.58791412167, 41293.793531032155, 41591.37612935748, 41655.1668966625, 42227.788861055495, 40498.39252411157, 40997.0, 41201.587984119775, 41401.792991034854, 41605.1678966425, 39918.600813991485, 40726.38910416287, 40998.79500602478, 41117.0, 41340.0, 35425.29149417049, 36133.63866361303, 36846.0, 37273.81363093167, 37500.0, 27703.168904932885, 27873.721262787112, 28036.0, 28068.71931280661, 28095.859520702266], "value": 20565.33157126712, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.7659027992926, 386.26802209812405, 390.5040598439981, 393.89758662747676, 411.8270326462885, 14288.984661935516, 17115.82884171158, 18041.368552100677, 19794.208231670735, 19803.801961980374, 15344.923275383635, 15978.201089945485, 18304.908475457603, 19066.809331906676, 19696.803031969714, 5649.604527683054, 5819.272590926134, 5881.176635271044, 5914.733836977346, 5918.0, 4223.387608796723, 5735.480097774093, 5788.507976821954, 5791.942080579203, 6209.1307216989435, 6476.838079048038, 6566.507511936624, 6571.080048793173, 6573.112629794989, 6583.177102862142, 6366.108744775735, 6490.383413575702, 6547.508936829757, 6557.3442655734525, 6564.93435065648, 5553.722313884289, 5698.059820129673, 5736.368999410061, 5741.942580574183, 5755.884882302373, 20503.17987280507, 21433.67849482259, 22764.0, 22824.08703651852, 23113.422164445856, 2295.2769877488536, 2376.1089591403224, 2386.844855084414, 2540.4538024324675, 2818.210900947738, 9745.90254097457, 10407.323523970994, 10412.32319899204, 10511.73720656982, 10593.682189534326, 1818.2545156485778, 1887.4809427407436, 1977.0510155125621, 2005.649011422995, 2028.78697736737, 73428.26571734267, 79505.20494795036, 81927.18072819256, 83190.0, 87730.56134719349, 10710.571577136827, 11226.887731122748, 11328.150388720878, 11377.829332560019, 11649.0, 15366.615834604001, 15680.686386272211, 15761.29074191664, 15805.841941580436, 15828.28772705231, 8143.837123257502, 8438.156184381636, 8486.363522735695, 8691.478511289342, 8696.95651521751, 7809.531428114217, 7911.683532658744, 7968.442209045427, 7988.121306656263, 8052.919470805334, 4391.187630288407, 4502.977485112553, 4771.284307353924, 4851.684640498356, 4885.267209918469, 1942.9514262143277, 2012.5371164632218, 2021.1006102284343, 2045.457953642286, 2081.323569839808, 1027.6660085472251, 1042.6976176908763, 1057.4237040812623, 1057.4765491081964, 1059.7138772531373, 19491.317803876795, 19535.925524096026, 19867.403977880687, 19897.303594374418, 20000.29998950059, 954.613381580461, 985.7338518599938, 1009.3439264478149, 1017.1049476460668, 1030.5826140413144, 9472.0, 11246.550137994389, 11292.717682058013, 11371.431428428545, 11375.658730238107, 455182.0, 464641.0, 467784.0, 470135.0, 470531.0, 88508.0, 89161.0, 89532.5523372379, 91384.0, 91475.54262228646, 970.1656575345197, 985.113397941858, 989.6288891665625, 989.9604015839429, 1009.9949500252452, 17466.0, 17575.736363954296, 17968.640627187644, 18028.909855450638, 18065.0, 40810.38784418296, 41233.38149927693, 42757.57242427536, 43443.782781085894, 43687.78156109199, 58188.0, 58912.11631825612, 59750.402495976225, 60367.39632603618, 60634.69682651735, 8868.290536757173, 8945.37382383253, 11668.88331116678, 12564.246145231315, 12856.0, 12909.806352904901, 13141.211527308393, 14038.227897465737, 14103.929480352532, 14216.502422415166, 11478.770424591294, 11580.768384632092, 12026.579069732867, 12075.698107547381, 12193.634190974284, 11733.706657333634, 11895.464704088165, 12012.159148859497, 12175.634730958085, 12316.81524777147, 11460.369679667698, 11556.075513959031, 12435.93782031084, 12467.625971220878, 12530.624081277212, 11864.881351186377, 12231.694207644525, 12517.812232816697, 12603.432845521791, 12986.155899866479, 11589.710257243636, 11624.709382265512, 11624.88375116238, 11650.30098194111, 11744.823827642764], "value": 9499.134881627117, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.9803502947452, 1454.6799704065106, 1510.7356212662785, 1611.6212690017844, 1736.0, 8531.317494600433, 8872.911270887298, 8891.377603567746, 9262.536873156349, 9301.116393942582, 8984.326175536844, 9184.770380740485, 9185.402948808323, 9190.310726695508, 9192.402493837895, 2047.3243829536218, 2281.167373908528, 2328.6739856420113, 2347.835651504395, 2368.632861906399, 2394.1859767678984, 2397.508510755291, 2399.2802159352213, 2401.1475926046264, 2404.1465279825584, 2316.9768302317016, 2370.502194539149, 2372.3476044087843, 2374.169040835702, 2374.6912901322803, 2051.7537895452565, 2313.2944451942235, 2383.4637206628545, 2387.1048356866177, 2405.350555350046, 2281.4866655002493, 2281.8288628352775, 2309.4919117794057, 2319.4665226997886, 2320.512692334612, 9254.167124958718, 9322.114399132071, 9340.71977840666, 9342.579583918672, 9355.204807591363, 5298.443663415363, 5453.100238460649, 5453.918191227135, 5455.563554915597, 5456.699881506515, 3457.222125021875, 3563.055790215595, 3604.3151801157696, 3623.800690961996, 3674.8530058797614, 1198.1912209258714, 1201.591458903968, 1247.8315427417274, 1253.0727261826182, 1256.3027519726547, 12819.294938778363, 12840.165389249762, 12865.871341286562, 12931.806022909665, 12991.610251692464, 4843.782029808667, 4897.0, 4960.801567937242, 4996.4503904570465, 4997.200447928314, 10794.298370605886, 10895.07391871684, 10949.233553651167, 10961.397123158304, 10962.287451315638, 4820.590249828804, 5378.489043540857, 5382.703951282639, 5387.057264978613, 5393.78424863009, 4868.780904859219, 5024.522670346311, 5032.446430892599, 5070.112730272188, 5108.6168537359845, 4056.1684854605323, 4095.5699651536756, 4159.750414975111, 4160.355144952538, 4171.645410140111, 1283.5250957145915, 1315.894728421724, 1317.9374279252938, 1320.214472388927, 1340.1222199459369, 916.2761418479326, 975.302658599105, 991.4398364923795, 1018.4551265073151, 1025.2720568396373, 6369.585976911579, 6405.103285540028, 6416.00551914454, 6423.164988551552, 6525.184351956005, 457.1200439154614, 465.6158669098008, 467.85262642267577, 1031.9174466042698, 1048.7220886465093, 4375.649948004152, 4481.820727170877, 4498.370228168059, 4524.615407690318, 4552.226121559343, 11088.168387370979, 11392.772144557062, 11450.599229026944, 11469.426528673534, 11494.597689081009, 10859.457027148768, 11324.547018119183, 11325.773484530264, 11333.320000799979, 11687.415629218505, 8409.453385529921, 8509.149085091565, 8519.659213631385, 8521.147885211552, 8531.530765807816, 6327.272363678236, 6570.737170513317, 6645.335466453316, 6666.166729158856, 6750.898736518858, 10326.173906087644, 10473.109785668303, 10542.631007914686, 10646.946765266124, 10648.946755266174, 10709.98255165758, 10719.571217151226, 10815.134789217002, 10828.837567436653, 10850.0777433919, 7286.052813134471, 7472.850542989218, 7488.663010164664, 7630.923690763021, 7994.5203287802915, 8057.879131812911, 8374.748757537283, 8694.608742606724, 8707.08575599553, 8993.865092023494, 7801.556712008297, 8036.638351274323, 8059.355251579742, 8087.110417854149, 8193.631286591999, 7813.218678132142, 7862.567558784322, 7939.28546430824, 8062.5968701563515, 8090.919090809017, 7447.627618618939, 7471.514351567131, 7525.209852965579, 7602.239776022354, 7606.885896711443, 5273.5781137509675, 5375.408705042364, 5546.362168350692, 5548.500634942875, 5644.8306550803545, 5576.386597474194, 5586.77652893896, 5599.860003499945, 5620.662760234399, 5654.2649455572155], "value": 4784.0123327432275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.55803560282624, 334.1179286683155, 344.87412094585477, 345.1457642335221, 346.3730647527973, 5414.7834086636485, 5426.8371948841495, 5443.482869127436, 5450.373207081187, 5486.862828429286, 5344.599155063366, 5350.973245133779, 5369.838904832861, 5393.2719082923795, 5407.702576358299, 3929.5677475477673, 4059.918801623973, 4125.793710314488, 4134.2144992451485, 4167.499900012002, 4186.623203911648, 4230.4500414946015, 4257.254071124123, 4267.829286828523, 4284.850030248942, 4216.7680777557225, 4217.135487225111, 4221.197972385252, 4221.746695198282, 4255.616994470497, 4011.8796436106963, 4153.958460415418, 4232.217039847623, 4237.40676305316, 4275.973766296098, 3747.1006958330076, 3755.8122093895195, 3776.7922764247955, 3777.2823163598828, 3778.7732736035928, 5276.1030624793875, 5280.656757310762, 5308.097623404031, 5319.840404787863, 5345.866353341159, 4849.3453383793085, 4863.927041094386, 4875.561199492027, 4876.463589005207, 4893.730844803535, 5614.831555053355, 5624.409437009096, 5644.6330988486025, 5652.802151924663, 5662.716864156776, 3930.449737036817, 4028.710812539988, 4032.74984754727, 4043.1509383029306, 4069.1454794493193, 5487.216654587275, 5609.467100625434, 5768.451997060272, 5810.593258471867, 5828.1549175369755, 4183.895402614898, 4187.1625674865145, 4193.580641935782, 4204.51648060477, 4207.389928460418, 4191.413202151702, 4249.235137675187, 4282.700210985201, 4282.892927676833, 4283.372318518943, 4755.667103302805, 4796.904061918742, 4808.8797780055775, 4816.590589799836, 4856.854294371175, 5559.27729395176, 5579.330480342385, 5641.12562552805, 5680.914786278209, 5726.112452569775, 1449.2970909109074, 1482.5848762346561, 1483.7329280729357, 1492.3732032546357, 1492.4776328285013, 924.4222361024359, 933.421278807144, 941.1623654947102, 950.5674917912334, 961.4567769210374, 4756.595689366373, 4766.712987493427, 4793.880152996203, 4808.447028591687, 4835.564799168092, 5024.824131155392, 5088.956763863399, 5097.898042039138, 5099.4390617032095, 5163.251328557338, 4682.367880336179, 4764.380630518011, 4798.920242945309, 4809.206480930678, 5226.0, 3102.0228627982565, 3102.317490152163, 3108.0, 3109.7667674924473, 3142.3345626817822, 6014.308354539196, 6018.067199584071, 6027.698615069229, 6052.760478622849, 6059.666718330446, 5799.4780469757925, 5868.2664666916635, 5947.762089516457, 5967.880642387215, 5976.701164941735, 5914.497267732291, 5925.4151238500945, 6028.698565071729, 6041.8884274599495, 6057.545684073712, 5392.272043274264, 5526.972365138309, 5809.157672137601, 5858.7070646468355, 5863.794767183128, 5750.539956803529, 5777.91333129995, 5778.0, 5784.2769653793275, 5795.971020144872, 6009.0, 6052.03167493199, 6076.756929722762, 6081.452669259788, 6081.543884208613, 3909.4526766253316, 4093.713440059167, 4141.461609990682, 4181.895452613709, 4185.267578173746, 5774.816162686723, 5790.768369265183, 5814.389489103583, 5820.76716931318, 5848.824535263949, 5556.194351819045, 5621.606487545832, 5649.237352957298, 5704.286964129484, 5719.542436604978, 5591.217229587943, 5591.30108736408, 5593.496585307342, 5604.423598519499, 5627.240322556566, 5452.26394436746, 5479.890402192013, 5541.584381171348, 5542.501174894118, 5568.443155684561, 5399.514043736082, 5656.88686226265, 5671.489565939085, 5672.404397538364, 5751.223584815996, 5509.972450137884, 5583.106702927512, 5589.273394458694, 5595.860103497283, 5612.877424515195], "value": 4279.05000413975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.9635018249086, 743.672783975051, 753.3107206905681, 802.7471346525844, 812.8861959325693, 14744.33650485728, 14947.775783363231, 15017.32422041008, 15028.774568381483, 15085.472008479705, 13617.591472255823, 14574.781378279335, 14575.489857854951, 14589.12465252083, 14620.561383158496, 656.3862788292937, 778.2684276779809, 792.9286364227219, 805.0902480197369, 815.5392203405087, 784.7802615267706, 803.4857691077715, 805.6898094233703, 805.730080423056, 805.9879101813477, 847.2925107535216, 849.4393700157897, 850.0182289455688, 850.2390360627235, 850.4387104511025, 682.2597481732302, 835.5822088955522, 849.1466076593015, 850.1795767084762, 867.9001914779818, 591.893459177348, 594.895893218685, 595.6783336998016, 597.1848426897254, 600.4055984575239, 14875.47935822241, 14964.850351496454, 14984.775228371584, 14989.925050374679, 14996.775048374284, 14233.0, 14614.0, 14652.706945861022, 14799.778003329959, 14879.776803347959, 12426.254424734545, 12547.811782823264, 12549.686257843536, 12599.93700031503, 12680.80978785319, 3839.232153569297, 3893.240818040483, 3983.083890705125, 4014.297497937849, 4118.341065429517, 79352.0, 79447.0, 80623.0, 80837.0, 80947.5952620239, 10949.671509854717, 11101.555937762561, 11151.330920144655, 11434.656960291039, 11520.711982200512, 20092.799072009384, 20129.09419076145, 20146.093425795876, 20202.696959545618, 20259.18963241454, 7429.85140297191, 7937.920620793718, 8300.418970671995, 8683.392162548562, 9072.364934454525, 4796.736179510091, 4819.228923372244, 4843.636727245471, 4883.194272944996, 5002.774875130628, 3708.647678470595, 3880.708946828999, 3884.3590807517007, 3887.688984881203, 3889.358255887747, 654.9639769812707, 657.3328072006917, 664.9335066493409, 673.1417442760421, 673.7468308945357, 719.5826420675995, 729.8503806719609, 735.213321745727, 751.2412463411885, 760.0840986611121, 9780.804383912282, 9811.558479868423, 9948.154406875352, 9953.25350598708, 10011.399316041061, 721.4300702445114, 726.3462883404978, 753.0549160803157, 753.9283768042027, 754.0913199594476, 4559.83918157753, 4698.436187657503, 4975.651704380731, 5075.822346217865, 5085.694858308513, 122571.0, 124506.0, 126542.36728816298, 127101.0, 129057.0, 71216.287837122, 105380.0, 106067.0, 106619.46690266654, 107278.46360768302, 60807.39192608017, 78922.0, 93920.0, 94330.99999999863, 94450.52774736083, 9849.95075024649, 9989.750256243651, 10020.148287395654, 10168.89831101709, 10178.796424071328, 54711.17933230925, 55771.44228557825, 56685.0, 57063.42936570581, 57066.7146664264, 79603.0, 82979.58510207411, 84141.5792921056, 84504.0, 85786.0, 13083.542076027294, 13184.864500725562, 13191.868081319064, 13254.337283135997, 13761.587152385444, 15557.45548905783, 15588.68822623564, 15668.68662626764, 15967.600809979844, 16491.34034638649, 14567.198804065454, 14648.487302944346, 14855.851441485447, 14867.479638212611, 15509.146996915279, 13703.794443083163, 13711.862881371457, 14159.150450972975, 14565.271736412926, 15062.477204938012, 13925.0, 14334.713305733618, 14390.640233994234, 14628.561143165722, 14745.744118556615, 10865.837012444661, 11104.389258590854, 11311.434428278717, 11538.711532211762, 11633.127515436207, 11749.645228195152, 11761.88238117608, 11967.521299147937, 12025.518979240733, 12075.0], "value": 7742.268657152224, "unit": "score"}], "name": "dromaeo_css", "value": 7416.953671368987, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 105.0, 110.0, 111.0, 111.0, 111.0, 111.0, 111.0, 110.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 135.0, 188.0, 130.0, 156.0, 149.0, 128.0, 195.0, 132.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 163.0, 164.0, 163.0, 161.0, 161.0, 160.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 123.0, 75.0, 78.0, 74.0, 78.0, 98.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 127.0, 84.0, 84.0, 85.0, 127.0, 84.0, 84.0, 126.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 56.0, 54.0, 53.0, 55.0, 54.0, 53.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 83.0, 81.0, 87.0, 81.0, 109.0, 80.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 132.0, 123.0, 130.0, 136.0, 134.0, 130.0, 128.0, 127.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 161.0, 166.0, 166.0, 167.0, 163.0, 160.0, 164.0, 159.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 63.0, 62.0, 65.0, 63.0, 61.0, 60.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1512.9, "alertThreshold": 2.0}]} 05:44:16 INFO - Return code: 0 05:44:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:44:16 INFO - # TBPL SUCCESS # 05:44:16 INFO - Running post-action listener: _resource_record_post_action 05:44:16 INFO - ##### 05:44:16 INFO - ##### Finished run-tests step (success) 05:44:16 INFO - ##### 05:44:16 INFO - Running post-run listener: _resource_record_post_run 05:44:16 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549847040; Read time: 20; Write time: 403444 05:44:16 INFO - TinderboxPrint: CPU usage
13.2% 05:44:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:44:16 INFO - TinderboxPrint: I/O write bytes / time
549,847,040 / 403,444 05:44:16 INFO - TinderboxPrint: CPU idle
8,268.8 (86.8%) 05:44:16 INFO - TinderboxPrint: CPU user
1,212.6 (12.7%) 05:44:16 INFO - TinderboxPrint: Swap in / out
0 / 0 05:44:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255528960; Read time: 0; Write time: 234428 05:44:16 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294318080; Read time: 20; Write time: 169016 05:44:17 INFO - Running post-run listener: _upload_blobber_files 05:44:17 INFO - Blob upload gear active. 05:44:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:44:17 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 05:44:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:44:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:44:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:44:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:44:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:21 INFO - (blobuploader) - INFO - Done attempting. 05:44:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:44:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:44:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:22 INFO - (blobuploader) - INFO - Done attempting. 05:44:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:44:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:44:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:23 INFO - (blobuploader) - INFO - Done attempting. 05:44:23 INFO - (blobuploader) - INFO - Iteration through files over. 05:44:23 INFO - Return code: 0 05:44:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:44:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:44:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9f7af3bb41f4890a548a074f5a9790899dfbe8c04f3a0a86fd782b01cf862e3405890324970e022bb92005774e4d14aa155742e6e0550e426f21d3008bf2350", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04c5bfea14414cb2e6681994a35485f95a1f708adcf6cfc246c2244f991e475ddccb082f84ec32c58691e507cca294da6c04b64f3429fa6817a11fbe940d78a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1fec9f3cdf667ffff928a8c1eedac2f215acb1d6cc4ad01acb9d73732e0a30414dd6644e12d0a033f1c7652a4a91b8763e9a225c6ae60dabd4feb84c901bbb48"} 05:44:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:44:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:44:23 INFO - Contents: 05:44:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a9f7af3bb41f4890a548a074f5a9790899dfbe8c04f3a0a86fd782b01cf862e3405890324970e022bb92005774e4d14aa155742e6e0550e426f21d3008bf2350", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04c5bfea14414cb2e6681994a35485f95a1f708adcf6cfc246c2244f991e475ddccb082f84ec32c58691e507cca294da6c04b64f3429fa6817a11fbe940d78a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1fec9f3cdf667ffff928a8c1eedac2f215acb1d6cc4ad01acb9d73732e0a30414dd6644e12d0a033f1c7652a4a91b8763e9a225c6ae60dabd4feb84c901bbb48"} 05:44:23 INFO - Running post-run listener: copy_logs_to_upload_dir 05:44:23 INFO - Copying logs to upload dir... 05:44:23 INFO - mkdir: /builds/slave/test/build/upload/logs 05:44:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.792880 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-16 05:44:20.807599) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 05:44:20.811928) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457 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/sha512/a9f7af3bb41f4890a548a074f5a9790899dfbe8c04f3a0a86fd782b01cf862e3405890324970e022bb92005774e4d14aa155742e6e0550e426f21d3008bf2350", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04c5bfea14414cb2e6681994a35485f95a1f708adcf6cfc246c2244f991e475ddccb082f84ec32c58691e507cca294da6c04b64f3429fa6817a11fbe940d78a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1fec9f3cdf667ffff928a8c1eedac2f215acb1d6cc4ad01acb9d73732e0a30414dd6644e12d0a033f1c7652a4a91b8763e9a225c6ae60dabd4feb84c901bbb48"} build_url:https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/KLIyr81pTTqW5wTSdRK8JQ/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/sha512/a9f7af3bb41f4890a548a074f5a9790899dfbe8c04f3a0a86fd782b01cf862e3405890324970e022bb92005774e4d14aa155742e6e0550e426f21d3008bf2350", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04c5bfea14414cb2e6681994a35485f95a1f708adcf6cfc246c2244f991e475ddccb082f84ec32c58691e507cca294da6c04b64f3429fa6817a11fbe940d78a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1fec9f3cdf667ffff928a8c1eedac2f215acb1d6cc4ad01acb9d73732e0a30414dd6644e12d0a033f1c7652a4a91b8763e9a225c6ae60dabd4feb84c901bbb48"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 05:44:20.839837) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:44:20.840178) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1466079339.715780-793528457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:44:20.923390) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 05:44:20.923799) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 05:44:20.924169) ========= ========= Total master_lag: 0.18 =========