builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1466080817.02 results: success (0) buildid: 20160616051126 builduid: e113fd4e0e884f0dab216dccb788ba94 revision: 61b7d2351dd2ed50789df8aed472ee0af1e06829 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.020128) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.021782) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.022108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.047252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.047885) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 05:40:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-06-16 05:40:17 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108499 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.177034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.177384) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018086 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.246826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.247210) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 61b7d2351dd2ed50789df8aed472ee0af1e06829 --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 61b7d2351dd2ed50789df8aed472ee0af1e06829 --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=e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 05:40:17,288 truncating revision to first 12 chars 2016-06-16 05:40:17,288 Setting DEBUG logging. 2016-06-16 05:40:17,288 attempt 1/10 2016-06-16 05:40:17,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/61b7d2351dd2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 05:40:17,617 unpacking tar archive at: fx-team-61b7d2351dd2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701810 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.965669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.966078) ========= script_repo_revision: 61b7d2351dd2ed50789df8aed472ee0af1e06829 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.966540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.966855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 05:40:17.984601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-16 05:40:17.984919) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:40:18 INFO - MultiFileLogger online at 20160616 05:40:18 in /builds/slave/test 05:40:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:40:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:40:18 INFO - {'append_to_log': False, 05:40:18 INFO - 'base_work_dir': '/builds/slave/test', 05:40:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:40:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:40:18 INFO - 'branch': 'Fx-Team-Non-PGO', 05:40:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:40:18 INFO - 'config_files': ('talos/linux_config.py',), 05:40:18 INFO - 'default_actions': ('clobber', 05:40:18 INFO - 'read-buildbot-config', 05:40:18 INFO - 'download-and-extract', 05:40:18 INFO - 'populate-webroot', 05:40:18 INFO - 'create-virtualenv', 05:40:18 INFO - 'install', 05:40:18 INFO - 'run-tests'), 05:40:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:40:18 INFO - 'download_minidump_stackwalk': True, 05:40:18 INFO - 'download_symbols': 'ondemand', 05:40:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:40:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:40:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:40:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:40:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:40:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:40:18 INFO - 'installer_path': 'installer.exe', 05:40:18 INFO - 'log_level': 'info', 05:40:18 INFO - 'log_name': 'talos', 05:40:18 INFO - 'log_to_console': True, 05:40:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:40:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:40:18 INFO - 'opt_config_files': (), 05:40:18 INFO - 'pip_index': False, 05:40:18 INFO - 'sps_profile': False, 05:40:18 INFO - 'sps_profile_interval': 0, 05:40:18 INFO - 'suite': 'dromaeojs', 05:40:18 INFO - 'system_bits': '32', 05:40:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:40:18 INFO - 'title': 'talos-linux64-ix-006', 05:40:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:40:18 INFO - 'use_talos_json': True, 05:40:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:40:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:40:18 INFO - 'work_dir': 'build'} 05:40:18 INFO - ##### 05:40:18 INFO - ##### Running clobber step. 05:40:18 INFO - ##### 05:40:18 INFO - Running pre-action listener: _resource_record_pre_action 05:40:18 INFO - Running main action method: clobber 05:40:18 INFO - rmtree: /builds/slave/test/build 05:40:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:40:18 INFO - Running post-action listener: _resource_record_post_action 05:40:18 INFO - ##### 05:40:18 INFO - ##### Finished clobber step (success) 05:40:18 INFO - ##### 05:40:18 INFO - ##### 05:40:18 INFO - ##### Running read-buildbot-config step. 05:40:18 INFO - ##### 05:40:18 INFO - Running pre-action listener: _resource_record_pre_action 05:40:18 INFO - Running main action method: read_buildbot_config 05:40:18 INFO - Using buildbot properties: 05:40:18 INFO - { 05:40:18 INFO - "project": "", 05:40:18 INFO - "product": "firefox", 05:40:18 INFO - "script_repo_revision": "production", 05:40:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:40:18 INFO - "repository": "", 05:40:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:40:18 INFO - "buildid": "20160616051126", 05:40:18 INFO - "pgo_build": "False", 05:40:18 INFO - "basedir": "/builds/slave/test", 05:40:18 INFO - "buildnumber": 1868, 05:40:18 INFO - "slavename": "talos-linux64-ix-006", 05:40:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:40:18 INFO - "platform": "ubuntu64_hw", 05:40:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:40:18 INFO - "branch": "fx-team", 05:40:18 INFO - "repo_path": "integration/fx-team", 05:40:18 INFO - "revision": "61b7d2351dd2ed50789df8aed472ee0af1e06829", 05:40:18 INFO - "stage_platform": "linux64", 05:40:18 INFO - "builduid": "e113fd4e0e884f0dab216dccb788ba94", 05:40:18 INFO - "slavebuilddir": "test" 05:40:18 INFO - } 05:40:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:40:18 INFO - Running post-action listener: _resource_record_post_action 05:40:18 INFO - ##### 05:40:18 INFO - ##### Finished read-buildbot-config step (success) 05:40:18 INFO - ##### 05:40:18 INFO - ##### 05:40:18 INFO - ##### Running download-and-extract step. 05:40:18 INFO - ##### 05:40:18 INFO - Running pre-action listener: _resource_record_pre_action 05:40:18 INFO - Running main action method: download_and_extract 05:40:18 INFO - mkdir: /builds/slave/test/build/tests 05:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:18 INFO - https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:40:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/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:40:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/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:40:24 INFO - Downloaded 1361 bytes. 05:40:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:40:24 INFO - Using the following test package requirements: 05:40:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:40:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:40:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:24 INFO - u'jsshell-linux-x86_64.zip'], 05:40:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:40:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:40:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:40:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:40:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:40:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:40:24 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:40:24 INFO - https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/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:40:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/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:40:26 INFO - Downloaded 22654315 bytes. 05:40:26 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:40:26 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:40:28 INFO - Return code: 0 05:40:28 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:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:28 INFO - https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:40:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/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:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/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:40:29 INFO - Downloaded 22654315 bytes. 05:40:29 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:40:29 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:40:30 INFO - Return code: 0 05:40:30 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:40:30 INFO - https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:40:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/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:40:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/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:40:33 INFO - Downloaded 14405384 bytes. 05:40:33 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:40:33 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:40:33 INFO - Return code: 0 05:40:33 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:40:33 INFO - https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:40:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/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:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PP_y5hEoQ52kEEqMilp7rA/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:40:35 INFO - Downloaded 55443727 bytes. 05:40:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:35 INFO - mkdir: /builds/slave/test/properties 05:40:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:40:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:40:35 INFO - Contents: 05:40:35 INFO - build_url:https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:40:36 INFO - Running post-action listener: _resource_record_post_action 05:40:36 INFO - Running post-action listener: set_extra_try_arguments 05:40:36 INFO - ##### 05:40:36 INFO - ##### Finished download-and-extract step (success) 05:40:36 INFO - ##### 05:40:36 INFO - ##### 05:40:36 INFO - ##### Running populate-webroot step. 05:40:36 INFO - ##### 05:40:36 INFO - Running pre-action listener: _resource_record_pre_action 05:40:36 INFO - Running main action method: populate_webroot 05:40:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:36 INFO - '--tppagecycles', 05:40:36 INFO - '7'], 05:40:36 INFO - 'tests': ['tsvgm']}}, 05:40:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:40:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:40:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:40:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:36 INFO - 'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:36 INFO - 'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['damp', 'tps']}, 05:40:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:36 INFO - 'tests': ['damp', 'tps']}, 05:40:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['dromaeo_dom']}, 05:40:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['basic_compositor_video']}, 05:40:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:40:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['a11yr', 05:40:36 INFO - 'ts_paint', 05:40:36 INFO - 'tpaint', 05:40:36 INFO - 'sessionrestore', 05:40:36 INFO - 'sessionrestore_no_auto_restore', 05:40:36 INFO - 'tabpaint']}, 05:40:36 INFO - 'other-e10s': {'tests': ['a11yr', 05:40:36 INFO - 'ts_paint', 05:40:36 INFO - 'tpaint', 05:40:36 INFO - 'sessionrestore', 05:40:36 INFO - 'sessionrestore_no_auto_restore', 05:40:36 INFO - 'tabpaint']}, 05:40:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:40:36 INFO - 'ts_paint', 05:40:36 INFO - 'tpaint', 05:40:36 INFO - 'sessionrestore', 05:40:36 INFO - 'sessionrestore_no_auto_restore', 05:40:36 INFO - 'tabpaint']}, 05:40:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:40:36 INFO - 'ts_paint', 05:40:36 INFO - 'tpaint', 05:40:36 INFO - 'sessionrestore', 05:40:36 INFO - 'sessionrestore_no_auto_restore', 05:40:36 INFO - 'tabpaint']}, 05:40:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['a11yr', 05:40:36 INFO - 'ts_paint', 05:40:36 INFO - 'tpaint', 05:40:36 INFO - 'sessionrestore', 05:40:36 INFO - 'sessionrestore_no_auto_restore', 05:40:36 INFO - 'tabpaint']}, 05:40:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['a11yr', 05:40:36 INFO - 'ts_paint', 05:40:36 INFO - 'tpaint', 05:40:36 INFO - 'sessionrestore', 05:40:36 INFO - 'sessionrestore_no_auto_restore', 05:40:36 INFO - 'tabpaint']}, 05:40:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['tsvgx', 05:40:36 INFO - 'tsvgr_opacity', 05:40:36 INFO - 'tart', 05:40:36 INFO - 'tscrollx', 05:40:36 INFO - 'cart']}, 05:40:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:40:36 INFO - 'tsvgr_opacity', 05:40:36 INFO - 'tart', 05:40:36 INFO - 'tscrollx', 05:40:36 INFO - 'cart']}, 05:40:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:36 INFO - 'talos_options': ['--disable-e10s'], 05:40:36 INFO - 'tests': ['tp5o']}, 05:40:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:36 INFO - 'tests': ['tp5o']}, 05:40:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:36 INFO - 'talos_options': ['--disable-e10s', 05:40:36 INFO - '--xperf_path', 05:40:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:36 INFO - 'tests': ['tp5n']}, 05:40:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:36 INFO - 'talos_options': ['--xperf_path', 05:40:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:36 INFO - 'tests': ['tp5n']}}, 05:40:36 INFO - 'talos.zip': {'path': '', 05:40:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:36 INFO - Running post-action listener: _resource_record_post_action 05:40:36 INFO - ##### 05:40:36 INFO - ##### Finished populate-webroot step (success) 05:40:36 INFO - ##### 05:40:36 INFO - ##### 05:40:36 INFO - ##### Running create-virtualenv step. 05:40:36 INFO - ##### 05:40:36 INFO - Running pre-action listener: _resource_record_pre_action 05:40:36 INFO - Running main action method: create_virtualenv 05:40:36 INFO - Creating virtualenv /builds/slave/test/build/venv 05:40:36 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:40:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:40:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:36 INFO - Using real prefix '/usr' 05:40:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:40:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:39 INFO - Installing pip.................done. 05:40:39 INFO - Return code: 0 05:40:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:40: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:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 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 0x7f0bbdd0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', '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:40:39 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:40:39 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:40:39 INFO - Using env: {'DISPLAY': ':0', 05:40:39 INFO - 'HOME': '/home/cltbld', 05:40:39 INFO - 'LANG': 'en_US.UTF-8', 05:40:39 INFO - 'LANGUAGE': 'en_US:en', 05:40:39 INFO - 'LOGNAME': 'cltbld', 05:40:39 INFO - 'MAIL': '/var/mail/cltbld', 05:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:39 INFO - 'MOZ_NO_REMOTE': '1', 05:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:39 INFO - 'NO_EM_RESTART': '1', 05:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:39 INFO - 'PWD': '/builds/slave/test', 05:40:39 INFO - 'SHELL': '/bin/bash', 05:40:39 INFO - 'SHLVL': '1', 05:40:39 INFO - 'TERM': 'linux', 05:40:39 INFO - 'TMOUT': '86400', 05:40:39 INFO - 'USER': 'cltbld', 05:40:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:39 INFO - '_': '/tools/buildbot/bin/python'} 05:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:39 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:40:39 INFO - Cleaning up... 05:40:39 INFO - Return code: 0 05:40:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:40: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:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 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 0x7f0bbdd0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', '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:40:39 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:40:39 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:40:39 INFO - Using env: {'DISPLAY': ':0', 05:40:39 INFO - 'HOME': '/home/cltbld', 05:40:39 INFO - 'LANG': 'en_US.UTF-8', 05:40:39 INFO - 'LANGUAGE': 'en_US:en', 05:40:39 INFO - 'LOGNAME': 'cltbld', 05:40:39 INFO - 'MAIL': '/var/mail/cltbld', 05:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:39 INFO - 'MOZ_NO_REMOTE': '1', 05:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:39 INFO - 'NO_EM_RESTART': '1', 05:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:39 INFO - 'PWD': '/builds/slave/test', 05:40:39 INFO - 'SHELL': '/bin/bash', 05:40:39 INFO - 'SHLVL': '1', 05:40:39 INFO - 'TERM': 'linux', 05:40:39 INFO - 'TMOUT': '86400', 05:40:39 INFO - 'USER': 'cltbld', 05:40:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:39 INFO - '_': '/tools/buildbot/bin/python'} 05:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:39 INFO - Downloading/unpacking psutil>=3.1.1 05:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:39 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:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:41 INFO - Installing collected packages: psutil 05:40:41 INFO - Running setup.py install for psutil 05:40:41 INFO - building 'psutil._psutil_linux' extension 05:40:41 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:40:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:40:42 INFO - building 'psutil._psutil_posix' extension 05:40:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:40:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:40:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:42 INFO - Successfully installed psutil 05:40:42 INFO - Cleaning up... 05:40:42 INFO - Return code: 0 05:40:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:40:42 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:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:42 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:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:42 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 0x7f0bbdd0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', '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:40:42 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:40:42 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:40:42 INFO - Using env: {'DISPLAY': ':0', 05:40:42 INFO - 'HOME': '/home/cltbld', 05:40:42 INFO - 'LANG': 'en_US.UTF-8', 05:40:42 INFO - 'LANGUAGE': 'en_US:en', 05:40:42 INFO - 'LOGNAME': 'cltbld', 05:40:42 INFO - 'MAIL': '/var/mail/cltbld', 05:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:42 INFO - 'MOZ_NO_REMOTE': '1', 05:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:42 INFO - 'NO_EM_RESTART': '1', 05:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:42 INFO - 'PWD': '/builds/slave/test', 05:40:42 INFO - 'SHELL': '/bin/bash', 05:40:42 INFO - 'SHLVL': '1', 05:40:42 INFO - 'TERM': 'linux', 05:40:42 INFO - 'TMOUT': '86400', 05:40:42 INFO - 'USER': 'cltbld', 05:40:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:42 INFO - '_': '/tools/buildbot/bin/python'} 05:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:40:42 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:40:42 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:40:42 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:40:42 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:40:42 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:40:42 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:40:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:40:44 INFO - Installing collected packages: mozsystemmonitor 05:40:44 INFO - Running setup.py install for mozsystemmonitor 05:40:44 INFO - Successfully installed mozsystemmonitor 05:40:44 INFO - Cleaning up... 05:40:44 INFO - Return code: 0 05:40:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:44 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 0x7f0bbdd0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', '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:40:44 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:40:44 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:40:44 INFO - Using env: {'DISPLAY': ':0', 05:40:44 INFO - 'HOME': '/home/cltbld', 05:40:44 INFO - 'LANG': 'en_US.UTF-8', 05:40:44 INFO - 'LANGUAGE': 'en_US:en', 05:40:44 INFO - 'LOGNAME': 'cltbld', 05:40:44 INFO - 'MAIL': '/var/mail/cltbld', 05:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:44 INFO - 'MOZ_NO_REMOTE': '1', 05:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:44 INFO - 'NO_EM_RESTART': '1', 05:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:44 INFO - 'PWD': '/builds/slave/test', 05:40:44 INFO - 'SHELL': '/bin/bash', 05:40:44 INFO - 'SHLVL': '1', 05:40:44 INFO - 'TERM': 'linux', 05:40:44 INFO - 'TMOUT': '86400', 05:40:44 INFO - 'USER': 'cltbld', 05:40:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:44 INFO - '_': '/tools/buildbot/bin/python'} 05:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:40:44 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:40:44 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:40:44 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:40:44 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:40:44 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:40:44 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:40:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:40:46 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:40:46 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:40:46 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:40:46 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:40:46 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:40:46 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:40:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:46 INFO - warning: no files found matching '*.txt' 05:40:46 INFO - no previously-included directories found matching 'build' 05:40:46 INFO - no previously-included directories found matching 'dist' 05:40:46 INFO - no previously-included directories found matching '.git*' 05:40:46 INFO - Installing collected packages: jsonschema, functools32 05:40:47 INFO - Running setup.py install for functools32 05:40:47 INFO - warning: no files found matching '*.txt' 05:40:47 INFO - no previously-included directories found matching 'build' 05:40:47 INFO - no previously-included directories found matching 'dist' 05:40:47 INFO - no previously-included directories found matching '.git*' 05:40:47 INFO - Successfully installed jsonschema functools32 05:40:47 INFO - Cleaning up... 05:40:47 INFO - Return code: 0 05:40:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0bbdd0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', '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:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:40:47 INFO - Using env: {'DISPLAY': ':0', 05:40:47 INFO - 'HOME': '/home/cltbld', 05:40:47 INFO - 'LANG': 'en_US.UTF-8', 05:40:47 INFO - 'LANGUAGE': 'en_US:en', 05:40:47 INFO - 'LOGNAME': 'cltbld', 05:40:47 INFO - 'MAIL': '/var/mail/cltbld', 05:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:47 INFO - 'MOZ_NO_REMOTE': '1', 05:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:47 INFO - 'NO_EM_RESTART': '1', 05:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:47 INFO - 'PWD': '/builds/slave/test', 05:40:47 INFO - 'SHELL': '/bin/bash', 05:40:47 INFO - 'SHLVL': '1', 05:40:47 INFO - 'TERM': 'linux', 05:40:47 INFO - 'TMOUT': '86400', 05:40:47 INFO - 'USER': 'cltbld', 05:40:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:47 INFO - '_': '/tools/buildbot/bin/python'} 05:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:40:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:49 INFO - Downloading docopt-0.6.1.tar.gz 05:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:50 INFO - Running setup.py install for blobuploader 05:40:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:40:50 INFO - Running setup.py install for requests 05:40:50 INFO - Running setup.py install for docopt 05:40:50 INFO - Successfully installed blobuploader requests docopt 05:40:50 INFO - Cleaning up... 05:40:50 INFO - Return code: 0 05:40:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:50 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 0x7f0bbdd0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', '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:40:50 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:40:50 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:40:50 INFO - Using env: {'DISPLAY': ':0', 05:40:50 INFO - 'HOME': '/home/cltbld', 05:40:50 INFO - 'LANG': 'en_US.UTF-8', 05:40:50 INFO - 'LANGUAGE': 'en_US:en', 05:40:50 INFO - 'LOGNAME': 'cltbld', 05:40:50 INFO - 'MAIL': '/var/mail/cltbld', 05:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:50 INFO - 'MOZ_NO_REMOTE': '1', 05:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:50 INFO - 'NO_EM_RESTART': '1', 05:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:50 INFO - 'PWD': '/builds/slave/test', 05:40:50 INFO - 'SHELL': '/bin/bash', 05:40:50 INFO - 'SHLVL': '1', 05:40:50 INFO - 'TERM': 'linux', 05:40:50 INFO - 'TMOUT': '86400', 05:40:50 INFO - 'USER': 'cltbld', 05:40:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:50 INFO - '_': '/tools/buildbot/bin/python'} 05:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:50 INFO - Running setup.py (path:/tmp/pip-Gfavji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:50 INFO - Running setup.py (path:/tmp/pip-7O_ciA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:51 INFO - Running setup.py (path:/tmp/pip-6OZ8AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:51 INFO - Running setup.py (path:/tmp/pip-CZtY56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:51 INFO - Running setup.py (path:/tmp/pip-d3l7lF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:51 INFO - Running setup.py (path:/tmp/pip-rjXnQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:51 INFO - Running setup.py (path:/tmp/pip-wrUE2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:51 INFO - Running setup.py (path:/tmp/pip-WG5lhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:51 INFO - Running setup.py (path:/tmp/pip-XeVwUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:51 INFO - Running setup.py (path:/tmp/pip-9oxOOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:51 INFO - Running setup.py (path:/tmp/pip-cdpRJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:51 INFO - Running setup.py (path:/tmp/pip-tJPUaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:51 INFO - Running setup.py (path:/tmp/pip-LhZkKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:51 INFO - Running setup.py (path:/tmp/pip-GxOKor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:51 INFO - Running setup.py (path:/tmp/pip-_U0eV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:51 INFO - Running setup.py (path:/tmp/pip-NmlNWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:52 INFO - Running setup.py (path:/tmp/pip-APrAh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:52 INFO - Running setup.py install for manifestparser 05:40:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:40:52 INFO - Running setup.py install for mozcrash 05:40:52 INFO - Running setup.py install for mozdebug 05:40:52 INFO - Running setup.py install for mozdevice 05:40:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:40:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:40:52 INFO - Running setup.py install for mozfile 05:40:52 INFO - Running setup.py install for mozhttpd 05:40:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:40:52 INFO - Running setup.py install for mozinfo 05:40:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:40:52 INFO - Running setup.py install for mozInstall 05:40:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:40:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:40:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:40:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:40:52 INFO - Running setup.py install for mozleak 05:40:52 INFO - Running setup.py install for mozlog 05:40:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:40:53 INFO - Running setup.py install for moznetwork 05:40:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:40:53 INFO - Running setup.py install for mozprocess 05:40:53 INFO - Running setup.py install for mozprofile 05:40:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:40:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:40:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:40:53 INFO - Running setup.py install for mozrunner 05:40:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:40:53 INFO - Running setup.py install for mozscreenshot 05:40:53 INFO - Running setup.py install for moztest 05:40:53 INFO - Running setup.py install for mozversion 05:40:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:40:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:53 INFO - Cleaning up... 05:40:53 INFO - Return code: 0 05:40:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:53 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:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:53 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:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:53 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 0x7f0bbdd0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', '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:40:53 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:40:53 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:40:53 INFO - Using env: {'DISPLAY': ':0', 05:40:53 INFO - 'HOME': '/home/cltbld', 05:40:53 INFO - 'LANG': 'en_US.UTF-8', 05:40:53 INFO - 'LANGUAGE': 'en_US:en', 05:40:53 INFO - 'LOGNAME': 'cltbld', 05:40:53 INFO - 'MAIL': '/var/mail/cltbld', 05:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:53 INFO - 'MOZ_NO_REMOTE': '1', 05:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:53 INFO - 'NO_EM_RESTART': '1', 05:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:53 INFO - 'PWD': '/builds/slave/test', 05:40:53 INFO - 'SHELL': '/bin/bash', 05:40:53 INFO - 'SHLVL': '1', 05:40:53 INFO - 'TERM': 'linux', 05:40:53 INFO - 'TMOUT': '86400', 05:40:53 INFO - 'USER': 'cltbld', 05:40:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:53 INFO - '_': '/tools/buildbot/bin/python'} 05:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:54 INFO - Running setup.py (path:/tmp/pip-JCDuKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:54 INFO - Running setup.py (path:/tmp/pip-fSEL3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:54 INFO - Running setup.py (path:/tmp/pip-at95On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:54 INFO - Running setup.py (path:/tmp/pip-BeYxxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:54 INFO - Running setup.py (path:/tmp/pip-fUF_sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:54 INFO - Running setup.py (path:/tmp/pip-87LpYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:54 INFO - Running setup.py (path:/tmp/pip-VxLiqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:54 INFO - Running setup.py (path:/tmp/pip-QHpoBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:54 INFO - Running setup.py (path:/tmp/pip-XCWX73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:54 INFO - Running setup.py (path:/tmp/pip-oUWnM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:54 INFO - Running setup.py (path:/tmp/pip-EWGPrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:54 INFO - Running setup.py (path:/tmp/pip-36aUdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:54 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:40:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:54 INFO - Running setup.py (path:/tmp/pip-tLDNrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:55 INFO - Running setup.py (path:/tmp/pip-40QzAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:55 INFO - Running setup.py (path:/tmp/pip-4PjWy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:55 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:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:55 INFO - Running setup.py (path:/tmp/pip-NoahSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:55 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:40:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:55 INFO - Running setup.py (path:/tmp/pip-HbCRm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:55 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:40:57 INFO - Downloading blessings-1.6.tar.gz 05:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:57 INFO - Installing collected packages: blessings 05:40:57 INFO - Running setup.py install for blessings 05:40:57 INFO - Successfully installed blessings 05:40:57 INFO - Cleaning up... 05:40:57 INFO - Return code: 0 05:40:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:40:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:57 INFO - Reading from file tmpfile_stdout 05:40:57 INFO - Current package versions: 05:40:57 INFO - argparse == 1.2.1 05:40:57 INFO - blessings == 1.6 05:40:57 INFO - blobuploader == 1.2.4 05:40:57 INFO - docopt == 0.6.1 05:40:57 INFO - functools32 == 3.2.3-2 05:40:57 INFO - jsonschema == 2.5.1 05:40:57 INFO - manifestparser == 1.1 05:40:57 INFO - mozInstall == 1.12 05:40:57 INFO - mozcrash == 0.17 05:40:57 INFO - mozdebug == 0.1 05:40:57 INFO - mozdevice == 0.48 05:40:57 INFO - mozfile == 1.2 05:40:57 INFO - mozhttpd == 0.7 05:40:57 INFO - mozinfo == 0.9 05:40:57 INFO - mozleak == 0.1 05:40:57 INFO - mozlog == 3.2 05:40:57 INFO - moznetwork == 0.27 05:40:57 INFO - mozprocess == 0.22 05:40:57 INFO - mozprofile == 0.28 05:40:57 INFO - mozrunner == 6.11 05:40:57 INFO - mozscreenshot == 0.1 05:40:57 INFO - mozsystemmonitor == 0.3 05:40:57 INFO - moztest == 0.7 05:40:57 INFO - mozversion == 1.4 05:40:57 INFO - psutil == 3.1.1 05:40:57 INFO - requests == 1.2.3 05:40:57 INFO - wsgiref == 0.1.2 05:40:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:57 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 0x7f0bbdd0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', '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:40:57 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:40:57 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:40:57 INFO - Using env: {'DISPLAY': ':0', 05:40:57 INFO - 'HOME': '/home/cltbld', 05:40:57 INFO - 'LANG': 'en_US.UTF-8', 05:40:57 INFO - 'LANGUAGE': 'en_US:en', 05:40:57 INFO - 'LOGNAME': 'cltbld', 05:40:57 INFO - 'MAIL': '/var/mail/cltbld', 05:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:57 INFO - 'MOZ_NO_REMOTE': '1', 05:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:57 INFO - 'NO_EM_RESTART': '1', 05:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:57 INFO - 'PWD': '/builds/slave/test', 05:40:57 INFO - 'SHELL': '/bin/bash', 05:40:57 INFO - 'SHLVL': '1', 05:40:57 INFO - 'TERM': 'linux', 05:40:57 INFO - 'TMOUT': '86400', 05:40:57 INFO - 'USER': 'cltbld', 05:40:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:57 INFO - '_': '/tools/buildbot/bin/python'} 05:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 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:40:57 INFO - Cleaning up... 05:40:57 INFO - Return code: 0 05:40:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0bbdd0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', '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:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:40:57 INFO - Using env: {'DISPLAY': ':0', 05:40:57 INFO - 'HOME': '/home/cltbld', 05:40:57 INFO - 'LANG': 'en_US.UTF-8', 05:40:57 INFO - 'LANGUAGE': 'en_US:en', 05:40:57 INFO - 'LOGNAME': 'cltbld', 05:40:57 INFO - 'MAIL': '/var/mail/cltbld', 05:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:57 INFO - 'MOZ_NO_REMOTE': '1', 05:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:57 INFO - 'NO_EM_RESTART': '1', 05:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:57 INFO - 'PWD': '/builds/slave/test', 05:40:57 INFO - 'SHELL': '/bin/bash', 05:40:57 INFO - 'SHLVL': '1', 05:40:57 INFO - 'TERM': 'linux', 05:40:57 INFO - 'TMOUT': '86400', 05:40:57 INFO - 'USER': 'cltbld', 05:40:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:57 INFO - '_': '/tools/buildbot/bin/python'} 05:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:40:58 INFO - Cleaning up... 05:40:58 INFO - Return code: 0 05:40:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0bbdd0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', '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:40:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:40:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:40:58 INFO - Using env: {'DISPLAY': ':0', 05:40:58 INFO - 'HOME': '/home/cltbld', 05:40:58 INFO - 'LANG': 'en_US.UTF-8', 05:40:58 INFO - 'LANGUAGE': 'en_US:en', 05:40:58 INFO - 'LOGNAME': 'cltbld', 05:40:58 INFO - 'MAIL': '/var/mail/cltbld', 05:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:58 INFO - 'MOZ_NO_REMOTE': '1', 05:40:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:58 INFO - 'NO_EM_RESTART': '1', 05:40:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:58 INFO - 'PWD': '/builds/slave/test', 05:40:58 INFO - 'SHELL': '/bin/bash', 05:40:58 INFO - 'SHLVL': '1', 05:40:58 INFO - 'TERM': 'linux', 05:40:58 INFO - 'TMOUT': '86400', 05:40:58 INFO - 'USER': 'cltbld', 05:40:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:58 INFO - '_': '/tools/buildbot/bin/python'} 05:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:58 INFO - Downloading/unpacking flake8 05:40:58 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:40:58 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:40:58 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:40:58 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:40:58 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:40:58 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:41:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:41:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:41:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:41:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:41:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:41:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:41:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:41:00 INFO - no previously-included directories found matching 'docs/_build' 05:41:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:41:00 INFO - Running setup.py install for pep8 05:41:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:41:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:41:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:41:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:41:01 INFO - no previously-included directories found matching 'docs/_build' 05:41:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:41:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:41:01 INFO - Cleaning up... 05:41:01 INFO - Return code: 0 05:41:01 INFO - Running post-action listener: _resource_record_post_action 05:41:01 INFO - Running post-action listener: _start_resource_monitoring 05:41:01 INFO - Starting resource monitoring. 05:41:01 INFO - ##### 05:41:01 INFO - ##### Finished create-virtualenv step (success) 05:41:01 INFO - ##### 05:41:01 INFO - ##### 05:41:01 INFO - ##### Running install step. 05:41:01 INFO - ##### 05:41:01 INFO - Running pre-action listener: _resource_record_pre_action 05:41:01 INFO - Running main action method: install 05:41:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:41:01 INFO - Reading from file tmpfile_stdout 05:41:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:41:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:41:01 INFO - Reading from file tmpfile_stdout 05:41:01 INFO - Output received: 05:41:01 INFO - Usage: mozinstall [options] installer 05:41:01 INFO - Options: 05:41:01 INFO - -h, --help show this help message and exit 05:41:01 INFO - -d DEST, --destination=DEST 05:41:01 INFO - Directory to install application into. [default: 05:41:01 INFO - "/builds/slave/test"] 05:41:01 INFO - --app=APP Application being installed. [default: firefox] 05:41:01 INFO - mkdir: /builds/slave/test/build/application 05:41:01 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:41:01 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:41:17 INFO - Reading from file tmpfile_stdout 05:41:17 INFO - Output received: 05:41:17 INFO - /builds/slave/test/build/application/firefox/firefox 05:41:17 INFO - Running post-action listener: _resource_record_post_action 05:41:17 INFO - ##### 05:41:17 INFO - ##### Finished install step (success) 05:41:17 INFO - ##### 05:41:17 INFO - ##### 05:41:17 INFO - ##### Running run-tests step. 05:41:17 INFO - ##### 05:41:17 INFO - Running pre-action listener: _resource_record_pre_action 05:41:17 INFO - Running main action method: run_tests 05:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:41:17 INFO - Python 2.7.3 05:41:17 INFO - Return code: 0 05:41:17 INFO - grabbing minidump binary from tooltool 05:41:17 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:41:17 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 0x24841c0>, '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 0x24850c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2485550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:41:17 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:41:17 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:41:17 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:41:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:17 INFO - Return code: 0 05:41:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:41:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:41:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:41:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:41:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:41:18 INFO - Return code: 0 05:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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:41:18 INFO - Using env: {'DISPLAY': ':0', 05:41:18 INFO - 'HOME': '/home/cltbld', 05:41:18 INFO - 'LANG': 'en_US.UTF-8', 05:41:18 INFO - 'LANGUAGE': 'en_US:en', 05:41:18 INFO - 'LOGNAME': 'cltbld', 05:41:18 INFO - 'MAIL': '/var/mail/cltbld', 05:41:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:41:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:18 INFO - 'MOZ_NO_REMOTE': '1', 05:41:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:18 INFO - 'NO_EM_RESTART': '1', 05:41:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:18 INFO - 'PWD': '/builds/slave/test', 05:41:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:41:18 INFO - 'SHELL': '/bin/bash', 05:41:18 INFO - 'SHLVL': '1', 05:41:18 INFO - 'TERM': 'linux', 05:41:18 INFO - 'TMOUT': '86400', 05:41:18 INFO - 'USER': 'cltbld', 05:41:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321', 05:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:18 INFO - '_': '/tools/buildbot/bin/python'} 05:41:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:41:18 INFO - mozversion application_buildid: 20160616051126 05:41:18 INFO - mozversion application_changeset: 61b7d2351dd2ed50789df8aed472ee0af1e06829 05:41:18 INFO - mozversion application_display_name: Nightly 05:41:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:18 INFO - mozversion application_name: Firefox 05:41:18 INFO - mozversion application_remotingname: firefox 05:41:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:41:18 INFO - mozversion application_vendor: Mozilla 05:41:18 INFO - mozversion application_version: 50.0a1 05:41:18 INFO - mozversion platform_buildid: 20160616051126 05:41:18 INFO - mozversion platform_changeset: 61b7d2351dd2ed50789df8aed472ee0af1e06829 05:41:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:41:18 INFO - mozversion platform_version: 50.0a1 05:41:18 INFO - using testdate: 1466080878 05:41:18 INFO - actual date: 1466080878 05:41:18 INFO - starting webserver on 'localhost:36229' 05:41:18 INFO - SUITE-START | Running 2 tests 05:41:18 INFO - TEST-START | dromaeo_css 05:41:18 INFO - operating with platform_type : linux_ 05:41:18 INFO - Initialising browser for dromaeo_css test... 05:41:18 INFO - TEST-INFO | started process 9045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC0dXia/profile http://localhost:36229/getInfo.html) 05:41:23 INFO - PROCESS | 9045 | __metrics Screen width/height:1600/1200 05:41:23 INFO - PROCESS | 9045 | colorDepth:24 05:41:23 INFO - PROCESS | 9045 | Browser inner width/height: 1024/697 05:41:23 INFO - PROCESS | 9045 | __metrics 05:41:24 INFO - PROCESS | 9045 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:41:25 INFO - TEST-INFO | 9045: exit 0 05:41:25 INFO - Browser initialized. 05:41:25 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:25 INFO - TEST-INFO | started process 9128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC0dXia/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:37 INFO - PROCESS | 9128 | RSS: Main: 175898624 05:41:37 INFO - PROCESS | 9128 | 05:42:28 INFO - PROCESS | 9128 | 1466080948669 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:44:41 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:36229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36229/tests/dromaeo/cssquery-ext.html) 05:44:42 INFO - PROCESS | 9128 | RSS: Main: 258580480 05:44:42 INFO - PROCESS | 9128 | 05:47:45 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:36229/tests/dromaeo/cssquery-ext.html (next: http://localhost:36229/tests/dromaeo/cssquery-jquery.html) 05:47:46 INFO - PROCESS | 9128 | RSS: Main: 259567616 05:47:46 INFO - PROCESS | 9128 | 05:50:48 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:36229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36229/tests/dromaeo/cssquery-mootools.html) 05:50:49 INFO - PROCESS | 9128 | RSS: Main: 260902912 05:50:49 INFO - PROCESS | 9128 | 05:53:51 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:36229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36229/tests/dromaeo/cssquery-prototype.html) 05:53:52 INFO - PROCESS | 9128 | RSS: Main: 263102464 05:53:52 INFO - PROCESS | 9128 | 05:56:55 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:36229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36229/tests/dromaeo/cssquery-yui.html) 05:56:55 INFO - PROCESS | 9128 | RSS: Main: 240771072 05:56:55 INFO - PROCESS | 9128 | 05:59:58 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:36229/tests/dromaeo/cssquery-yui.html (next: http://localhost:36229/tests/dromaeo/cssquery-dojo.html) 05:59:58 INFO - PROCESS | 9128 | RSS: Main: 292323328 05:59:58 INFO - PROCESS | 9128 | 05:59:58 INFO - PROCESS | 9128 | __start_tp_report 05:59:58 INFO - PROCESS | 9128 | _x_x_mozilla_page_load 05:59:58 INFO - PROCESS | 9128 | _x_x_mozilla_page_load_details 05:59:58 INFO - PROCESS | 9128 | |i|pagename|runs| 05:59:58 INFO - PROCESS | 9128 | |0;dojo.html;2643.471305738852;2651.3636727185476;2658.89364425423;2688.354794849237;2693.6094266331384;4716.575508204261;4802.8078876844975;4853.514648535145;4927.704337739739;4964.1312770265195;4868.269759536071;4884;4888.608911287098;4922.6800257983205;4929.408470983478;4410.8235670573295;4418;4453.153900758862;4507.932381014288;4589.563991420827;4501.099780044005;4538.341940418637;4554.567316104964;4557.134144512549;4589.65577581681;4382.868513944587;4429.357743127229;4436.268015777425;4474.172278128557;4510.684252102355;4382.517923028464;4385.56144385562;4393.275109606911;4458.308962110878;4495.955040449587;4441.467023957113;4442.755648439334;4444.688871778977;4447.1995040892625;4481.327800829869;4735.455422626374;4800.1119792838435;4845.5881250093435;4872.171730805771;4881.975590122062;5235.65968212065;5265.473452654704;5268.578513718931;5283.86790330241;5311.362636483608;5214.087534681454;5301.920471192935;5321.095413779667;5323.520883120499;5324.627276090675;4796.928046079312;4847.75761211938;4900.754962251873;4902.1176188285735;4917.754112294371;5354.4645535446925;5369.382521010056;5384;5424.294841670558;5439.156930675752;4912.214045752734;5155.458676838953;5191.584673226208;5196.428392876781;5205.167173252262;5154.561862241677;5228.372595288513;5232.947670523322;5233.502817232356;5234.162533994542;5195.220716892496;5212.869678257998;5215.608829337815;5221.269022336875;5270.92093618596;5004.099262132779;5091.41448733393;5188.533032027136;5193.37679478465;5194.68831870089;4349.717268377545;4368.759718215465;4381.956180438155;4426.11477704454;4428.2914733642465;3809.3143234218105;3818.9688784028713;3835.76985380878;3866.4973553438435;3885.203533275672;4356.194104090753;4399.758013309235;4410.669199810027;4492.932606010912;4541.43232095988;5165.638405311667;5182.455842136596;5191.896162076738;5201.08980928336;5275.182346736262;4431.0251744616135;4450.3991961085485;4456.9331460028125;4461.776911154429;4495.977520112444;4098.856540021085;4527.3435351873795;4545.113702827917;4668.3697700810635;4704.15325241453;4832.1543729846435;4845.563899249085;4848.10310092634;4865.099956508057;4892.437369702529;5155.53600175986;5157.896842063213;5158.845234642967;5159.845204643867;5164.431912489548;4769.73766442849;4830.516948305141;4830.734309613005;4839.685420447659;4868.878278042936;5117.513836185556;5133.897322053613;5135.845924622267;5139.100657384868;5185.870353241199;5192.506711862367;5199.7140157291715;5200.401953775213;5202.817901373433;5203.297554830049;5020.146575082172;5023.974880125576;5071.2139618359215;5087.364079490064;5094.872628184176;5066.9746651266505;5098.668586541863;5100.183970564692;5103.336566246364;5155.510226528474;4745.335653008513;4957.603391728581;4971.304017437634;5034.748262586929;5037.874053148554;5085.974570127126;5101;5107.489251074863;5115.693058416358;5137.383513978347;4991.550760431579;4998.700077995332;5035.974820125876;5045.722485263345;5073.543381095719 05:59:58 INFO - PROCESS | 9128 | |1;ext.html;587.0724255676032;589.7493565234774;591.5977135547828;595.5176307191173;601.0383386581473;26746.19761407156;30026.249343766416;30046.849765751194;38306.61693383065;39978.40032399516;40455.59544404555;40799.38800917981;40853.18293634133;40888.72890168787;40906;7808.258215469536;7911.723089691862;7959.522428654271;7975.282224599785;7976.082750483682;7540.849183016337;7766;10007;10245.07794298513;10245.180385569174;9848.310618256724;9981.75045623858;9993.450360230185;9996;9997.500124993721;7642.9235707642765;10202;10258.538365773484;10259.17926565873;10267.178625709963;9800.65697700577;9987.75030624233;10149.39103653783;10427.061564459234;10453.32053416533;37898.810505947295;38207.808960955015;38299.425508617394;38302.61697383018;38360.42459363112;2969.2428430750238;3005;3472.930541389158;3555.377808883435;3653.488511608377;28959.855200724072;29216.415671686445;29374.118776436742;29631.259218519495;30758.53862192069;3547.6984456321243;3569.125564236753;3589.10272431892;3604.567451905762;3647.908802279938;258280;260478;260933;261355;261933;30889.8455507721;32047.679523204468;46578.301325479464;46615;46659.30011049837;33830.15424614404;33836.154096147795;33945.66054339425;33986;34015;13154.276514791778;13347.93326033383;13350.799738003938;13372.73254534904;13374.39815208318;8247.752567422987;9999.650012249536;10068.44623545712;10087.546060427298;10575.841362379571;7746.535207887545;7810;7836.764897053097;7868.567228802471;7967.203279671987;3038.6353637563634;3049.5120780674984;3091.5671805947186;3095.2261934516373;3104.425681248976;736.6243215959792;803.541981070784;976.4873441443299;1015.7765291635828;1034.1726618705006;25727.356816079748;27740.16779496578;28321;28475.430491390056;28495.57256641152;932.5011119051275;951.7240000399945;958.9760255993516;972.397113789455;1011.5801942193907;14795.260236988108;14904.850951490564;14943.384907641337;15022.774658380133;15064.849351506344;395607;400081;403581;403624;406624;49147;49639.75180124076;49663;49719.50280497221;49809.50190498048;1031.6492392586406;1147.8450409194652;1167.416291854073;1189.9464524096263;1192.9642110736693;27900.58149127805;29004.27489312784;29160.562591561567;29299.560506592843;29718.851405742833;41778.164436711704;42424.5757542433;42558.5744142567;42568.36147457729;42599.361009585504;317189;325514;326370;327268;327871;21978.89010554937;23935;24550.386240344134;24892.128775493497;26662.20013399601;40508;40859.79570102131;40991.180176396905;41495.377569335884;41715.37426938659;34684.65315346814;34952.12619684528;35198.64801351954;35463.46804797982;35843.28313433769;35236.64763352334;35748.106297342776;35868.28263434769;35920.820395897856;36182.27635447329;33968.32063358768;34400.65599344075;34956.47565286574;35181.82409087938;35208.295834083685;30746.692533074383;31417.792770315362;31738.36523269568;31975.840120799247;32013.67986320107;24841.751582483943;25049.373765656004;25277.241682749547;25444.618330724683;25591.232263031394 05:59:58 INFO - PROCESS | 9128 | |2;jquery.html;370.8905872767534;371.82895867900766;373.66930266713956;384.05139305914383;386.7022392757577;15593.53219403417;16272.91863540682;16920.492385228434;16961.49115526536;16985.3205871765;14866.55400337989;15512.534623961272;15603.375864965416;15737.291821868015;15764.290606922686;4946.381702287205;5132.384113906336;5198.376194856603;5201.947980520203;5205.765740541685;3694.667479926806;3871.1096447817017;5099.056674515208;5644.435556444343;5952.642841429528;5963.045912653976;5967.970160149193;5984.162217289583;5995.07076403156;5997.940020599782;5897.085951677497;5906.2912450506;5932.199153114339;6082.452579267843;6085.117657939618;3379.746519011084;4893.437254715717;5197.48025197481;5208.635395522315;5333.733313334318;17240.39658611955;17266.827331726647;17603.911980440145;19752.80247197524;20373.898130509253;1910.5804496890437;1911.6081203353278;1922.2503223742613;1972.5956178983274;1981.2075169931998;12773.808392874114;13036.86963130366;13144.6713832154;13250.536231231861;13783.379747911367;1693.8136804951446;1720.5182548886332;1749.8250174982527;1867;1874.643817674651;62024.37975620231;63257.68371158161;64387;65673;65761.34238657648;8779.341549383822;9713.465759383302;10175.694729158136;10188.643397481053;10318.380897146195;13087;13133.540326088541;13176;13187.472501100041;13201.339933003312;6759.138556481569;6794.252632210453;6816.659167041628;7025.89461158083;7061.682224299919;6321.462675672527;6375.71309291083;6484.221893372825;6517;6518.837029074216;5945.16767652529;6059.969700151471;6117.296510901214;6136.110264011693;6297.811065668037;1608.4048901906135;1643.416587111582;1727.6112874603114;1779.9854083172727;1780.4391616640717;761.7219714804056;819.6024927909959;829.2950991657164;835.4360806455618;897.8473659477904;16549.917250413913;16775.832241677428;16898.15509224534;17128;17349;811.9797005074802;846.7967687754895;860.819227962135;863.6070587882498;868.4658934755206;9465.90534094664;10062.446565438824;10072.697819065439;10143.289969702199;10323.432211228455;381729;387551;392373;392845;393414;61504;64504.35495644983;65965.67017164979;65991.34008659948;67958.3204167952;869.482657818597;895.7491902267376;906.7506435730095;917.3578495053489;919.0212423768799;15055;15169.165695886832;15406.69186616239;15460;15609.92195039063;33601;34167.41242169636;35359.82320088383;35365.469517956735;35562.82218588891;44185.779071104436;44788.77605611951;45461.77269113765;45528.317075243234;45939;7711.421643376882;7725.188855170126;7758.7672369829;7816.10114836801;7823.374130069467;11568.24806387582;11829;12123.878761212274;12172.939135304267;12178.634640960785;7299.8540029200185;10066.949665251626;10228.335158214692;10584;10685.145188385066;9906.504674766089;10203.693889183336;10249.641262555775;10281.12610428092;10431.321964072615;10272.33229840058;10511.369317840954;10642.125036747706;10696.786064278514;10755.569777208824;7470.178280389261;7509.812254693677;7572.962135189288;7734.149243583314;7813.531188128731;9359.251259899327;9961.750956226153;9975.900240997787;10274.178065754872;10685.305455145392 05:59:58 INFO - PROCESS | 9128 | |3;mootools.html;1261.0794120292192;1371.4445649511945;1407.0221196268592;1474.9336279867405;1723.2503860820536;6867.107276054112;7654.158042615308;7908.683652653887;7911.762647120589;8155.796105097375;7878.881816772753;8000.799980000488;8017.7594672159785;8022.438429309951;8022.638981245844;2227.7438094619083;2258.3337915315024;2262.9434264143365;2263.875486848223;2263.875486848223;2193.7257842769654;2224.7775222477785;2231.7433495148102;2236.5303286309895;2250.4036430345973;2137.743470783508;2166.5341951480427;2175.82593392529;2177.0638625391075;2182.2471247419694;2044.9693254601193;2045.836333093349;2051.7948205179514;2053.4968932611455;2055.4553043443498;2040.7959204079473;2121.5756848630335;2127.1597718901103;2131.8081372676534;2133.040131940633;7872.488288261302;7881.566513841736;8034.558099304536;8040;8156.306713929323;4383.079553293812;4500.122476117159;4501.122281155176;4506.346579745951;4510.503844577094;2753.9586906196223;2888.638920134983;2925.0786002409172;2940.059181062061;2948.8525573721445;962.485070487286;967.7677357434236;967.9661211857622;996.2378780233128;1004.6835246897203;10903.727406814814;10937.343759374384;10943.343399396063;11057.281276716987;11074.833877491845;4102.138550904344;4121.093359460914;4212.789360531961;4264.680148988777;4281.957180428218;8660.8700869487;8685.08806575313;8712.825743485222;8718.825623487495;8727.170918762708;4464.933026004613;4465.843695470708;4466.419365482467;4467.441569803775;4470;3573.7855728656364;3719.9256014880093;3868.458415821787;4138.937915931264;4139.254934111888;3157.3211759471824;3244.8053116812594;3252.495863141217;3420.9486857697157;3439.3809114359656;1041.3803786747026;1044.237706474263;1060.0247772049734;1066.195022757813;1067.957281708723;754.9056367954006;794.9562774047367;822.7572866004423;826.4710585225461;827.185222555782;5459.590530710133;5516.613837031449;5652.971735141298;5748.798792042258;5781.103928891029;823.0452674897091;863.210162701134;878.5036454403241;891.6032365597376;891.9955400222957;3449.793012419263;3609.4946707460977;3618.113562177231;3640.4357324614725;3647.252313275772;9741.659041933499;10061.4466204358;10094.343867648578;10121.139703125169;10130.645427410005;9886.505674716236;9919.50402479873;9992.600295988079;10079.143272821746;10123.139533139765;7391.556506609621;7430.702771889172;7508.43686723487;7537.2085930977555;7545.924540754632;5005.399352077774;5087.160618497906;5207.140821764367;5238.947610523998;5252.921206181987;9122.586939856235;9145.542722863696;9256.07439256069;9339.486328252011;9351.39215950961;9360.391574547904;9664.71005869825;9673.274504412339;9681.515924203903;9697.369670971364;6536.7712130075215;6622.10601568782;6672.6997285121315;6684.364985326386;6685.298043705536;6889.173299204128;7458.627068646654;7713.19011503784;7736.149023607286;7949.3243074339325;6536.4117229447675;6765.864682706417;6781.254062053269;6866.073080134118;7030.287307867015;6699.430548403246;6796.592204467748;6887.965560172167;6957.965210173917;7102.289771022856;6231.4391704746795;6402.487800976004;6432.163818703539;6442.452391546583;6446.5165112615805;4277.957220427756;4391.7584532851;4429.933550996802;4505.932411013772;4517.932231016472;4511.8646440606835;4551.226291530382;4594.1271158479785;4596.977015114903;4640.535946405333 05:59:58 INFO - PROCESS | 9128 | |4;prototype.html;292.1818907060231;296.51371750329463;300.95636132760734;301.4393228594813;303.46590001597184;4877.317175595419;4889.217725163974;4897.632677549189;4913.238448040551;4936.0868239375695;4777.355057067295;4796.976015119928;4805.135075686384;4823.975880120594;4890.559849613534;3600.207954250061;3696.537932758405;3726.4037753959374;3806.6574008339244;3847.48059012034;3794.7912864792424;3816.2749077675153;3819.197968426634;3830.9616903830884;3840.2127563849485;3619.1314084619767;3766.811659417032;3767.340715374812;3777.8299976500984;3781.8487260509546;3659.6889264412425;3783.8675646352385;3811.8094095295123;3814.5422549293985;3821.713371497121;3348.1796959744775;3361.5125806757883;3369.427197376452;3370.6966373026544;3393.575803024622;4706.388169537938;4717.504662010508;4740.336352910595;4807.95192048082;4827.396575428072;4249.617534421917;4308.267594508941;4349.890777851628;4361.694681372305;4380.846670366554;5093.363329583802;5117.02776472469;5120.743962801845;5135.435102138762;5139.537441630234;3666.3400587894166;3696.445533170019;3698.001539584297;3700.3154416433044;3704.3887758519813;5195.506426889439;5357.142857142839;5380.4350543192795;5407.675539467606;5447.766415769555;3745.9438108428394;3747.138158223624;3756.624337566276;3768.924621507609;3777.3946072918898;3814.2180852925085;3820.2168555446624;3820.8089595520114;3821.1658403966253;3826.4642949987024;4324.783760811947;4334.631556317685;4361.520232774392;4370.300751879684;4371.322445021026;4840.177169881129;5141.228815677603;5142.6914385137015;5174.53429191367;5185.559227465632;1285.6078895936641;1305.7257975824994;1306.4055854586331;1308.2542950518114;1308.6205000549924;810.6028046257292;830.8451252758671;833.295864994079;834.7203686764881;836.7532376758708;4422.447194100738;4423.845165419195;4542.750148741851;4554.908901822011;4567.725936443824;5230.738463076831;5264.763085661154;5285.286486324297;5322.897455505054;5329.534378046068;4295.74225546462;4495.910081798345;4497.415336006364;4499.280115181556;4561.338605902192;2782.8052036357667;2797.6850880086326;2798.454301411205;2806.8315901046003;2809.817361871472;4973.005398920231;4973.42805577356;4981.252812078144;5002.974985125051;5005.72468514228;5144.762028517607;5410.242566040757;5422.6475279106735;5424.321959755031;5443.836684899459;4958.256261560795;4995.550400463976;5020.523050310215;5025.3718285214345;5027.441493137139;5282.207668849704;5312.867178320573;5314.22943673173;5327.440618735132;5333.759980800795;4935.876603084952;5161.3032240647035;5259.579233661374;5259.684418934876;5269.736513174403;4996.475370086234;4997.800087996439;5020.246962955586;5038.823641172541;5073.720945348041;3804.372278574004;3845.8653947111716;3854.421836724514;3860.613938606229;3868.5744568096925;5112.71880046601;5269.657472264291;5281.709505977208;5281.7359132042475;5354.170103633943;5075.670081444694;5088.338515992898;5112.130937740519;5116.258142569232;5118.283440318284;5145.948540514547;5146.819861304836;5152.819651312186;5155.819546315861;5156.329677141947;4795.400574928134;4863.270509423614;5014.197728363444;5021.221710634857;5022.27177059317;5051.2423136529815;5167.844964651066;5195.376554813447;5197.142471492161;5212.635115541876;5060.822871199491;5077.898442031213;5086.821961231339;5087.2623469595965;5098.541131298052 05:59:58 INFO - PROCESS | 9128 | |5;yui.html;620.9503239740819;681.3663293137383;692.2385376086303;735.4148525936062;749.6888791151674;12553.874461255386;13220.603381898534;13501.932490337547;13839.169649821006;13940;13702.588922332347;13765.31173441329;13885.23631200286;13898.93050534746;13899.930500347484;636.668932155279;773.9032620922385;784.2823816208177;795.5266616363255;797.3461761355691;797.9162187970267;800.7157459101993;801.2388231180402;803.2008151888849;803.7789607857857;842.1830824100613;843.6035063520136;843.8649816029437;844.7381311793364;846.4075147396846;657.1555551116816;799.4164260090108;821.2936874288107;822.9958850205711;837.9078301386843;607.313735478906;608.057510858168;608.0666177417643;609.4788955443121;609.6555446172898;13775;13901.860981390158;13925.442982280696;13950.651233719238;13951.093178943336;12358.505659773598;12795.936020319932;12807.74384512314;13303.467861285537;13423.060385773;9903.504824758733;10324.122449591794;10623.097036751886;10747.516361763739;10787.83818242727;4206.873793786161;4238.046439551076;4260.169266992938;4458.598726114633;4467.1735728889935;61740.69129654368;62789.37210627927;63027.68486157586;63535.682321588094;64505.3549464504;10139.847902281472;10300.793984120426;10376.481175941173;10428.843567346496;10482.056614904695;17828;17835.821641783674;17839.821601784075;17850.642987140185;17850.732239016426;6671.866562668816;6679.265280819106;6740.932590674129;6767.2894346093935;6862.107925969692;3682.815859207029;3779.7732136071922;3781.962180378216;3787.6023017583307;3886.125621735087;2540.1998370513597;2593.2738833126377;2601.9609705854427;2602.62261972013;2612.4513852090895;419.7670292987421;483.14483364445437;489.3051866349792;500.31207090250905;503.4889587069128;528.9603279754034;532.824168024551;533.9119045357551;534.188034188032;539.0970125040542;8073.233042860918;8104.756857294291;8105.635246413925;8108.351331893435;8554.35842311829;521.2832355511172;528.5903424845775;532.5313723922923;533.1655958425052;540.3299908113911;3824.8852534424013;3868.537153621199;3986.421968814506;4014.538328092307;4059.4925634295714;102670;104536.47731761292;107045;107650;108775;52771.47228527666;59338.40661593415;86714.13285867187;88380.5580972091;89722.55138724265;77114.22885771071;79124.20875791284;80833;81684;83452;7406.296401841816;7436.293552112541;7451.739189128354;7460.0301960744755;7654.923450765421;46185;46638;46655;47540.28689569728;48064;41795.582044179166;49540.25689614587;59326.406735933815;60534.39465605288;64882;9282.860757088514;9598.808023839623;9652.420854748456;9787.730579209954;9852.802943941224;10696.62561810333;10754;11065.391403472886;11073.557057717924;11170.776584468103;10033.397996119964;10166.440845753554;10187.643432479828;10425.061744443037;10495.317804342998;9560.76098097553;9616.807663846825;9807.607695692092;9854.655087071918;10135.898641013495;10037.5483103262;10108.39349639024;10317.587296508356;10502;10733.838992414963;8415.831683366421;8430.988281406271;8631.093735157969;8909.1536304051;9264.351495395258;9439.339246252697;9769.31614786958;9799.461029643153;9824.852627210741;9856.901430985597 05:59:58 INFO - PROCESS | 9128 | __end_tp_report 05:59:58 INFO - PROCESS | 9128 | __start_cc_report 05:59:58 INFO - PROCESS | 9128 | _x_x_mozilla_cycle_collect,993 05:59:58 INFO - PROCESS | 9128 | __end_cc_report 05:59:58 INFO - PROCESS | 9128 | __startTimestamp1466081998931__endTimestamp 05:59:58 INFO - PROCESS | 9128 | 05:59:58 INFO - PROCESS | 9128 | ------- Summary: start ------- 05:59:58 INFO - PROCESS | 9128 | Number of tests: 6 05:59:58 INFO - PROCESS | 9128 | 05:59:58 INFO - PROCESS | 9128 | [#0] dojo.html Cycles:165 Average:4800.58 Median:4917.75 stddev:522.60 (10.6%) stddev-sans-first:496.05 05:59:58 INFO - PROCESS | 9128 | Values: 2643.5 2651.4 2658.9 2688.4 2693.6 4716.6 4802.8 4853.5 4927.7 4964.1 4868.3 4884.0 4888.6 4922.7 4929.4 4410.8 4418.0 4453.2 4507.9 4589.6 4501.1 4538.3 4554.6 4557.1 4589.7 4382.9 4429.4 4436.3 4474.2 4510.7 4382.5 4385.6 4393.3 4458.3 4496.0 4441.5 4442.8 4444.7 4447.2 4481.3 4735.5 4800.1 4845.6 4872.2 4882.0 5235.7 5265.5 5268.6 5283.9 5311.4 5214.1 5301.9 5321.1 5323.5 5324.6 4796.9 4847.8 4900.8 4902.1 4917.8 5354.5 5369.4 5384.0 5424.3 5439.2 4912.2 5155.5 5191.6 5196.4 5205.2 5154.6 5228.4 5232.9 5233.5 5234.2 5195.2 5212.9 5215.6 5221.3 5270.9 5004.1 5091.4 5188.5 5193.4 5194.7 4349.7 4368.8 4382.0 4426.1 4428.3 3809.3 3819.0 3835.8 3866.5 3885.2 4356.2 4399.8 4410.7 4492.9 4541.4 5165.6 5182.5 5191.9 5201.1 5275.2 4431.0 4450.4 4456.9 4461.8 4496.0 4098.9 4527.3 4545.1 4668.4 4704.2 4832.2 4845.6 4848.1 4865.1 4892.4 5155.5 5157.9 5158.8 5159.8 5164.4 4769.7 4830.5 4830.7 4839.7 4868.9 5117.5 5133.9 5135.8 5139.1 5185.9 5192.5 5199.7 5200.4 5202.8 5203.3 5020.1 5024.0 5071.2 5087.4 5094.9 5067.0 5098.7 5100.2 5103.3 5155.5 4745.3 4957.6 4971.3 5034.7 5037.9 5086.0 5101.0 5107.5 5115.7 5137.4 4991.6 4998.7 5036.0 5045.7 5073.5 05:59:58 INFO - PROCESS | 9128 | 05:59:58 INFO - PROCESS | 9128 | [#1] ext.html Cycles:180 Average:46853.89 Median:19078.79 stddev:88199.29 (462.3%) stddev-sans-first:88378.30 05:59:58 INFO - PROCESS | 9128 | Values: 587.1 589.7 591.6 595.5 601.0 26746.2 30026.2 30046.8 38306.6 39978.4 40455.6 40799.4 40853.2 40888.7 40906.0 7808.3 7911.7 7959.5 7975.3 7976.1 7540.8 7766.0 10007.0 10245.1 10245.2 9848.3 9981.8 9993.5 9996.0 9997.5 7642.9 10202.0 10258.5 10259.2 10267.2 9800.7 9987.8 10149.4 10427.1 10453.3 37898.8 38207.8 38299.4 38302.6 38360.4 2969.2 3005.0 3472.9 3555.4 3653.5 28959.9 29216.4 29374.1 29631.3 30758.5 3547.7 3569.1 3589.1 3604.6 3647.9 258280.0 260478.0 260933.0 261355.0 261933.0 30889.8 32047.7 46578.3 46615.0 46659.3 33830.2 33836.2 33945.7 33986.0 34015.0 13154.3 13347.9 13350.8 13372.7 13374.4 8247.8 9999.7 10068.4 10087.5 10575.8 7746.5 7810.0 7836.8 7868.6 7967.2 3038.6 3049.5 3091.6 3095.2 3104.4 736.6 803.5 976.5 1015.8 1034.2 25727.4 27740.2 28321.0 28475.4 28495.6 932.5 951.7 959.0 972.4 1011.6 14795.3 14904.9 14943.4 15022.8 15064.8 395607.0 400081.0 403581.0 403624.0 406624.0 49147.0 49639.8 49663.0 49719.5 49809.5 1031.6 1147.8 1167.4 1189.9 1193.0 27900.6 29004.3 29160.6 29299.6 29718.9 41778.2 42424.6 42558.6 42568.4 42599.4 317189.0 325514.0 326370.0 327268.0 327871.0 21978.9 23935.0 24550.4 24892.1 26662.2 40508.0 40859.8 40991.2 41495.4 41715.4 34684.7 34952.1 35198.6 35463.5 35843.3 35236.6 35748.1 35868.3 35920.8 36182.3 33968.3 34400.7 34956.5 35181.8 35208.3 30746.7 31417.8 31738.4 31975.8 32013.7 24841.8 25049.4 25277.2 25444.6 25591.2 05:59:58 INFO - PROCESS | 9128 | 05:59:58 INFO - PROCESS | 9128 | [#2] jquery.html Cycles:180 Average:23625.51 Median:195711.05 stddev:63908.77 (32.7%) stddev-sans-first:64064.20 05:59:58 INFO - PROCESS | 9128 | Values: 370.9 371.8 373.7 384.1 386.7 15593.5 16272.9 16920.5 16961.5 16985.3 14866.6 15512.5 15603.4 15737.3 15764.3 4946.4 5132.4 5198.4 5201.9 5205.8 3694.7 3871.1 5099.1 5644.4 5952.6 5963.0 5968.0 5984.2 5995.1 5997.9 5897.1 5906.3 5932.2 6082.5 6085.1 3379.7 4893.4 5197.5 5208.6 5333.7 17240.4 17266.8 17603.9 19752.8 20373.9 1910.6 1911.6 1922.3 1972.6 1981.2 12773.8 13036.9 13144.7 13250.5 13783.4 1693.8 1720.5 1749.8 1867.0 1874.6 62024.4 63257.7 64387.0 65673.0 65761.3 8779.3 9713.5 10175.7 10188.6 10318.4 13087.0 13133.5 13176.0 13187.5 13201.3 6759.1 6794.3 6816.7 7025.9 7061.7 6321.5 6375.7 6484.2 6517.0 6518.8 5945.2 6060.0 6117.3 6136.1 6297.8 1608.4 1643.4 1727.6 1780.0 1780.4 761.7 819.6 829.3 835.4 897.8 16549.9 16775.8 16898.2 17128.0 17349.0 812.0 846.8 860.8 863.6 868.5 9465.9 10062.4 10072.7 10143.3 10323.4 381729.0 387551.0 392373.0 392845.0 393414.0 61504.0 64504.4 65965.7 65991.3 67958.3 869.5 895.7 906.8 917.4 919.0 15055.0 15169.2 15406.7 15460.0 15609.9 33601.0 34167.4 35359.8 35365.5 35562.8 44185.8 44788.8 45461.8 45528.3 45939.0 7711.4 7725.2 7758.8 7816.1 7823.4 11568.2 11829.0 12123.9 12172.9 12178.6 7299.9 10066.9 10228.3 10584.0 10685.1 9906.5 10203.7 10249.6 10281.1 10431.3 10272.3 10511.4 10642.1 10696.8 10755.6 7470.2 7509.8 7573.0 7734.1 7813.5 9359.3 9961.8 9975.9 10274.2 10685.3 05:59:58 INFO - PROCESS | 9128 | 05:59:58 INFO - PROCESS | 9128 | [#3] mootools.html Cycles:180 Average:5183.02 Median:4618.76 stddev:2988.54 (64.7%) stddev-sans-first:2982.39 05:59:58 INFO - PROCESS | 9128 | Values: 1261.1 1371.4 1407.0 1474.9 1723.3 6867.1 7654.2 7908.7 7911.8 8155.8 7878.9 8000.8 8017.8 8022.4 8022.6 2227.7 2258.3 2262.9 2263.9 2263.9 2193.7 2224.8 2231.7 2236.5 2250.4 2137.7 2166.5 2175.8 2177.1 2182.2 2045.0 2045.8 2051.8 2053.5 2055.5 2040.8 2121.6 2127.2 2131.8 2133.0 7872.5 7881.6 8034.6 8040.0 8156.3 4383.1 4500.1 4501.1 4506.3 4510.5 2754.0 2888.6 2925.1 2940.1 2948.9 962.5 967.8 968.0 996.2 1004.7 10903.7 10937.3 10943.3 11057.3 11074.8 4102.1 4121.1 4212.8 4264.7 4282.0 8660.9 8685.1 8712.8 8718.8 8727.2 4464.9 4465.8 4466.4 4467.4 4470.0 3573.8 3719.9 3868.5 4138.9 4139.3 3157.3 3244.8 3252.5 3420.9 3439.4 1041.4 1044.2 1060.0 1066.2 1068.0 754.9 795.0 822.8 826.5 827.2 5459.6 5516.6 5653.0 5748.8 5781.1 823.0 863.2 878.5 891.6 892.0 3449.8 3609.5 3618.1 3640.4 3647.3 9741.7 10061.4 10094.3 10121.1 10130.6 9886.5 9919.5 9992.6 10079.1 10123.1 7391.6 7430.7 7508.4 7537.2 7545.9 5005.4 5087.2 5207.1 5238.9 5252.9 9122.6 9145.5 9256.1 9339.5 9351.4 9360.4 9664.7 9673.3 9681.5 9697.4 6536.8 6622.1 6672.7 6684.4 6685.3 6889.2 7458.6 7713.2 7736.1 7949.3 6536.4 6765.9 6781.3 6866.1 7030.3 6699.4 6796.6 6888.0 6958.0 7102.3 6231.4 6402.5 6432.2 6442.5 6446.5 4278.0 4391.8 4429.9 4505.9 4517.9 4511.9 4551.2 4594.1 4597.0 4640.5 05:59:58 INFO - PROCESS | 9128 | 05:59:58 INFO - PROCESS | 9128 | [#4] prototype.html Cycles:180 Average:4260.46 Median:4851.72 stddev:1242.42 (25.6%) stddev-sans-first:1209.67 05:59:58 INFO - PROCESS | 9128 | Values: 292.2 296.5 301.0 301.4 303.5 4877.3 4889.2 4897.6 4913.2 4936.1 4777.4 4797.0 4805.1 4824.0 4890.6 3600.2 3696.5 3726.4 3806.7 3847.5 3794.8 3816.3 3819.2 3831.0 3840.2 3619.1 3766.8 3767.3 3777.8 3781.8 3659.7 3783.9 3811.8 3814.5 3821.7 3348.2 3361.5 3369.4 3370.7 3393.6 4706.4 4717.5 4740.3 4808.0 4827.4 4249.6 4308.3 4349.9 4361.7 4380.8 5093.4 5117.0 5120.7 5135.4 5139.5 3666.3 3696.4 3698.0 3700.3 3704.4 5195.5 5357.1 5380.4 5407.7 5447.8 3745.9 3747.1 3756.6 3768.9 3777.4 3814.2 3820.2 3820.8 3821.2 3826.5 4324.8 4334.6 4361.5 4370.3 4371.3 4840.2 5141.2 5142.7 5174.5 5185.6 1285.6 1305.7 1306.4 1308.3 1308.6 810.6 830.8 833.3 834.7 836.8 4422.4 4423.8 4542.8 4554.9 4567.7 5230.7 5264.8 5285.3 5322.9 5329.5 4295.7 4495.9 4497.4 4499.3 4561.3 2782.8 2797.7 2798.5 2806.8 2809.8 4973.0 4973.4 4981.3 5003.0 5005.7 5144.8 5410.2 5422.6 5424.3 5443.8 4958.3 4995.6 5020.5 5025.4 5027.4 5282.2 5312.9 5314.2 5327.4 5333.8 4935.9 5161.3 5259.6 5259.7 5269.7 4996.5 4997.8 5020.2 5038.8 5073.7 3804.4 3845.9 3854.4 3860.6 3868.6 5112.7 5269.7 5281.7 5281.7 5354.2 5075.7 5088.3 5112.1 5116.3 5118.3 5145.9 5146.8 5152.8 5155.8 5156.3 4795.4 4863.3 5014.2 5021.2 5022.3 5051.2 5167.8 5195.4 5197.1 5212.6 5060.8 5077.9 5086.8 5087.3 5098.5 05:59:58 INFO - PROCESS | 9128 | 05:59:58 INFO - PROCESS | 9128 | [#5] yui.html Cycles:180 Average:17572.65 Median:530.75 stddev:25928.84 (4885.4%) stddev-sans-first:25970.34 05:59:58 INFO - PROCESS | 9128 | Values: 621.0 681.4 692.2 735.4 749.7 12553.9 13220.6 13501.9 13839.2 13940.0 13702.6 13765.3 13885.2 13898.9 13899.9 636.7 773.9 784.3 795.5 797.3 797.9 800.7 801.2 803.2 803.8 842.2 843.6 843.9 844.7 846.4 657.2 799.4 821.3 823.0 837.9 607.3 608.1 608.1 609.5 609.7 13775.0 13901.9 13925.4 13950.7 13951.1 12358.5 12795.9 12807.7 13303.5 13423.1 9903.5 10324.1 10623.1 10747.5 10787.8 4206.9 4238.0 4260.2 4458.6 4467.2 61740.7 62789.4 63027.7 63535.7 64505.4 10139.8 10300.8 10376.5 10428.8 10482.1 17828.0 17835.8 17839.8 17850.6 17850.7 6671.9 6679.3 6740.9 6767.3 6862.1 3682.8 3779.8 3782.0 3787.6 3886.1 2540.2 2593.3 2602.0 2602.6 2612.5 419.8 483.1 489.3 500.3 503.5 529.0 532.8 533.9 534.2 539.1 8073.2 8104.8 8105.6 8108.4 8554.4 521.3 528.6 532.5 533.2 540.3 3824.9 3868.5 3986.4 4014.5 4059.5 102670.0 104536.5 107045.0 107650.0 108775.0 52771.5 59338.4 86714.1 88380.6 89722.6 77114.2 79124.2 80833.0 81684.0 83452.0 7406.3 7436.3 7451.7 7460.0 7654.9 46185.0 46638.0 46655.0 47540.3 48064.0 41795.6 49540.3 59326.4 60534.4 64882.0 9282.9 9598.8 9652.4 9787.7 9852.8 10696.6 10754.0 11065.4 11073.6 11170.8 10033.4 10166.4 10187.6 10425.1 10495.3 9560.8 9616.8 9807.6 9854.7 10135.9 10037.5 10108.4 10317.6 10502.0 10733.8 8415.8 8431.0 8631.1 8909.2 9264.4 9439.3 9769.3 9799.5 9824.9 9856.9 05:59:58 INFO - PROCESS | 9128 | -------- Summary: end -------- 05:59:58 INFO - PROCESS | 9128 | 05:59:59 INFO - TEST-INFO | 9128: exit 0 05:59:59 INFO - TEST-OK | dromaeo_css | took 1121096ms 05:59:59 INFO - TEST-START | kraken 05:59:59 INFO - operating with platform_type : linux_ 05:59:59 INFO - Initialising browser for kraken test... 05:59:59 INFO - TEST-INFO | started process 9308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajrH7R/profile http://localhost:36229/getInfo.html) 06:00:04 INFO - PROCESS | 9308 | __metrics Screen width/height:1600/1200 06:00:04 INFO - PROCESS | 9308 | colorDepth:24 06:00:04 INFO - PROCESS | 9308 | Browser inner width/height: 1024/697 06:00:04 INFO - PROCESS | 9308 | __metrics 06:00:05 INFO - PROCESS | 9308 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:06 INFO - TEST-INFO | 9308: exit 0 06:00:06 INFO - Browser initialized. 06:00:06 INFO - Running cycle 1/1 for kraken test... 06:00:06 INFO - TEST-INFO | started process 9388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajrH7R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:18 INFO - PROCESS | 9388 | RSS: Main: 175673344 06:00:18 INFO - PROCESS | 9388 | 06:00:20 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36229/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:21 INFO - PROCESS | 9388 | RSS: Main: 234344448 06:00:21 INFO - PROCESS | 9388 | 06:00:24 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36229/tests/kraken/driver.html?testName=audio-dft) 06:00:25 INFO - PROCESS | 9388 | RSS: Main: 221360128 06:00:25 INFO - PROCESS | 9388 | 06:00:28 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36229/tests/kraken/driver.html?testName=audio-fft) 06:00:29 INFO - PROCESS | 9388 | RSS: Main: 289669120 06:00:29 INFO - PROCESS | 9388 | 06:00:31 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36229/tests/kraken/driver.html?testName=audio-oscillator) 06:00:31 INFO - PROCESS | 9388 | RSS: Main: 199618560 06:00:31 INFO - PROCESS | 9388 | 06:00:34 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:34 INFO - PROCESS | 9388 | RSS: Main: 202809344 06:00:34 INFO - PROCESS | 9388 | 06:00:38 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36229/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:38 INFO - PROCESS | 9388 | RSS: Main: 239636480 06:00:38 INFO - PROCESS | 9388 | 06:00:42 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36229/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:42 INFO - PROCESS | 9388 | RSS: Main: 240287744 06:00:42 INFO - PROCESS | 9388 | 06:00:45 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36229/tests/kraken/driver.html?testName=json-parse-financial) 06:00:46 INFO - PROCESS | 9388 | RSS: Main: 240066560 06:00:46 INFO - PROCESS | 9388 | 06:00:47 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:48 INFO - PROCESS | 9388 | RSS: Main: 225787904 06:00:48 INFO - PROCESS | 9388 | 06:00:50 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36229/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:51 INFO - PROCESS | 9388 | RSS: Main: 231575552 06:00:51 INFO - PROCESS | 9388 | 06:00:53 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:54 INFO - PROCESS | 9388 | RSS: Main: 239726592 06:00:54 INFO - PROCESS | 9388 | 06:00:56 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:57 INFO - PROCESS | 9388 | RSS: Main: 242409472 06:00:57 INFO - PROCESS | 9388 | 06:01:00 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:01:00 INFO - PROCESS | 9388 | RSS: Main: 241848320 06:01:00 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:36229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36229/tests/kraken/driver.html?testName=ai-astar) 06:01:02 INFO - PROCESS | 9388 | RSS: Main: 284991488 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | __start_tp_report 06:01:02 INFO - PROCESS | 9388 | _x_x_mozilla_page_load 06:01:02 INFO - PROCESS | 9388 | _x_x_mozilla_page_load_details 06:01:02 INFO - PROCESS | 9388 | |i|pagename|runs| 06:01:02 INFO - PROCESS | 9388 | |0;ai-astar;112;107;112;111;113;112;112;113;111;111 06:01:02 INFO - PROCESS | 9388 | |1;audio-beat-detection;155;139;137;192;132;159;155;131;186;133 06:01:02 INFO - PROCESS | 9388 | |2;audio-dft;162;160;160;161;162;161;162;162;162;161 06:01:02 INFO - PROCESS | 9388 | |3;audio-fft;75;75;76;101;76;76;75;75;97;77 06:01:02 INFO - PROCESS | 9388 | |4;audio-oscillator;86;87;111;87;86;86;127;86;87;132 06:01:02 INFO - PROCESS | 9388 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;119;117;117 06:01:02 INFO - PROCESS | 9388 | |6;imaging-darkroom;146;148;146;146;146;147;147;147;147;146 06:01:02 INFO - PROCESS | 9388 | |7;imaging-desaturate;96;94;95;96;95;95;94;95;95;94 06:01:02 INFO - PROCESS | 9388 | |8;json-parse-financial;63;62;63;62;62;64;63;63;62;63 06:01:02 INFO - PROCESS | 9388 | |9;json-stringify-tinderbox;64;66;65;65;65;65;65;67;64;65 06:01:02 INFO - PROCESS | 9388 | |10;stanford-crypto-aes;83;85;85;83;85;85;89;87;123;84 06:01:02 INFO - PROCESS | 9388 | |11;stanford-crypto-ccm;137;139;132;131;138;128;128;131;144;133 06:01:02 INFO - PROCESS | 9388 | |12;stanford-crypto-pbkdf2;172;175;175;173;174;168;167;171;170;171 06:01:02 INFO - PROCESS | 9388 | |13;stanford-crypto-sha256-iterative;66;68;68;68;68;68;71;67;66;66 06:01:02 INFO - PROCESS | 9388 | __end_tp_report 06:01:02 INFO - PROCESS | 9388 | __start_cc_report 06:01:02 INFO - PROCESS | 9388 | _x_x_mozilla_cycle_collect,1881 06:01:02 INFO - PROCESS | 9388 | __end_cc_report 06:01:02 INFO - PROCESS | 9388 | __startTimestamp1466082062896__endTimestamp 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | ------- Summary: start ------- 06:01:02 INFO - PROCESS | 9388 | Number of tests: 14 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:1.71 (1.5%) stddev-sans-first:1.80 06:01:02 INFO - PROCESS | 9388 | Values: 112.0 107.0 112.0 111.0 113.0 112.0 112.0 113.0 111.0 111.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:155.00 stddev:22.16 (14.3%) stddev-sans-first:23.47 06:01:02 INFO - PROCESS | 9388 | Values: 155.0 139.0 137.0 192.0 132.0 159.0 155.0 131.0 186.0 133.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 06:01:02 INFO - PROCESS | 9388 | Values: 162.0 160.0 160.0 161.0 162.0 161.0 162.0 162.0 162.0 161.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#3] audio-fft Cycles:10 Average:80.30 Median:76.00 stddev:9.92 (13.1%) stddev-sans-first:10.34 06:01:02 INFO - PROCESS | 9388 | Values: 75.0 75.0 76.0 101.0 76.0 76.0 75.0 75.0 97.0 77.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:86.00 stddev:18.57 (21.6%) stddev-sans-first:19.22 06:01:02 INFO - PROCESS | 9388 | Values: 86.0 87.0 111.0 87.0 86.0 86.0 127.0 86.0 87.0 132.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 06:01:02 INFO - PROCESS | 9388 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 119.0 117.0 117.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 06:01:02 INFO - PROCESS | 9388 | Values: 146.0 148.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 06:01:02 INFO - PROCESS | 9388 | Values: 96.0 94.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 94.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 06:01:02 INFO - PROCESS | 9388 | Values: 63.0 62.0 63.0 62.0 62.0 64.0 63.0 63.0 62.0 63.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 06:01:02 INFO - PROCESS | 9388 | Values: 64.0 66.0 65.0 65.0 65.0 65.0 65.0 67.0 64.0 65.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:85.00 stddev:12.11 (14.3%) stddev-sans-first:12.66 06:01:02 INFO - PROCESS | 9388 | Values: 83.0 85.0 85.0 83.0 85.0 85.0 89.0 87.0 123.0 84.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:135.00 stddev:5.22 (3.9%) stddev-sans-first:5.43 06:01:02 INFO - PROCESS | 9388 | Values: 137.0 139.0 132.0 131.0 138.0 128.0 128.0 131.0 144.0 133.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:172.50 stddev:2.76 (1.6%) stddev-sans-first:2.92 06:01:02 INFO - PROCESS | 9388 | Values: 172.0 175.0 175.0 173.0 174.0 168.0 167.0 171.0 170.0 171.0 06:01:02 INFO - PROCESS | 9388 | 06:01:02 INFO - PROCESS | 9388 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.51 (2.2%) stddev-sans-first:1.48 06:01:02 INFO - PROCESS | 9388 | Values: 66.0 68.0 68.0 68.0 68.0 68.0 71.0 67.0 66.0 66.0 06:01:02 INFO - PROCESS | 9388 | -------- Summary: end -------- 06:01:02 INFO - PROCESS | 9388 | 06:01:03 INFO - TEST-INFO | 9388: exit 0 06:01:03 INFO - TEST-OK | kraken | took 64234ms 06:01:03 INFO - SUITE-END | took 1185s 06:01:04 INFO - Completed test suite (00:19:45) 06:01:04 INFO - javascript benchmark 06:01:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.471305738852, 2651.3636727185476, 2658.89364425423, 2688.354794849237, 2693.6094266331384, 4716.575508204261, 4802.8078876844975, 4853.514648535145, 4927.704337739739, 4964.1312770265195, 4868.269759536071, 4884.0, 4888.608911287098, 4922.6800257983205, 4929.408470983478, 4410.8235670573295, 4418.0, 4453.153900758862, 4507.932381014288, 4589.563991420827, 4501.099780044005, 4538.341940418637, 4554.567316104964, 4557.134144512549, 4589.65577581681, 4382.868513944587, 4429.357743127229, 4436.268015777425, 4474.172278128557, 4510.684252102355, 4382.517923028464, 4385.56144385562, 4393.275109606911, 4458.308962110878, 4495.955040449587, 4441.467023957113, 4442.755648439334, 4444.688871778977, 4447.1995040892625, 4481.327800829869, 4735.455422626374, 4800.1119792838435, 4845.5881250093435, 4872.171730805771, 4881.975590122062, 5235.65968212065, 5265.473452654704, 5268.578513718931, 5283.86790330241, 5311.362636483608, 5214.087534681454, 5301.920471192935, 5321.095413779667, 5323.520883120499, 5324.627276090675, 4796.928046079312, 4847.75761211938, 4900.754962251873, 4902.1176188285735, 4917.754112294371, 5354.4645535446925, 5369.382521010056, 5384.0, 5424.294841670558, 5439.156930675752, 4912.214045752734, 5155.458676838953, 5191.584673226208, 5196.428392876781, 5205.167173252262, 5154.561862241677, 5228.372595288513, 5232.947670523322, 5233.502817232356, 5234.162533994542, 5195.220716892496, 5212.869678257998, 5215.608829337815, 5221.269022336875, 5270.92093618596, 5004.099262132779, 5091.41448733393, 5188.533032027136, 5193.37679478465, 5194.68831870089, 4349.717268377545, 4368.759718215465, 4381.956180438155, 4426.11477704454, 4428.2914733642465, 3809.3143234218105, 3818.9688784028713, 3835.76985380878, 3866.4973553438435, 3885.203533275672, 4356.194104090753, 4399.758013309235, 4410.669199810027, 4492.932606010912, 4541.43232095988, 5165.638405311667, 5182.455842136596, 5191.896162076738, 5201.08980928336, 5275.182346736262, 4431.0251744616135, 4450.3991961085485, 4456.9331460028125, 4461.776911154429, 4495.977520112444, 4098.856540021085, 4527.3435351873795, 4545.113702827917, 4668.3697700810635, 4704.15325241453, 4832.1543729846435, 4845.563899249085, 4848.10310092634, 4865.099956508057, 4892.437369702529, 5155.53600175986, 5157.896842063213, 5158.845234642967, 5159.845204643867, 5164.431912489548, 4769.73766442849, 4830.516948305141, 4830.734309613005, 4839.685420447659, 4868.878278042936, 5117.513836185556, 5133.897322053613, 5135.845924622267, 5139.100657384868, 5185.870353241199, 5192.506711862367, 5199.7140157291715, 5200.401953775213, 5202.817901373433, 5203.297554830049, 5020.146575082172, 5023.974880125576, 5071.2139618359215, 5087.364079490064, 5094.872628184176, 5066.9746651266505, 5098.668586541863, 5100.183970564692, 5103.336566246364, 5155.510226528474, 4745.335653008513, 4957.603391728581, 4971.304017437634, 5034.748262586929, 5037.874053148554, 5085.974570127126, 5101.0, 5107.489251074863, 5115.693058416358, 5137.383513978347, 4991.550760431579, 4998.700077995332, 5035.974820125876, 5045.722485263345, 5073.543381095719], "value": 4766.09492526232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.0724255676032, 589.7493565234774, 591.5977135547828, 595.5176307191173, 601.0383386581473, 26746.19761407156, 30026.249343766416, 30046.849765751194, 38306.61693383065, 39978.40032399516, 40455.59544404555, 40799.38800917981, 40853.18293634133, 40888.72890168787, 40906.0, 7808.258215469536, 7911.723089691862, 7959.522428654271, 7975.282224599785, 7976.082750483682, 7540.849183016337, 7766.0, 10007.0, 10245.07794298513, 10245.180385569174, 9848.310618256724, 9981.75045623858, 9993.450360230185, 9996.0, 9997.500124993721, 7642.9235707642765, 10202.0, 10258.538365773484, 10259.17926565873, 10267.178625709963, 9800.65697700577, 9987.75030624233, 10149.39103653783, 10427.061564459234, 10453.32053416533, 37898.810505947295, 38207.808960955015, 38299.425508617394, 38302.61697383018, 38360.42459363112, 2969.2428430750238, 3005.0, 3472.930541389158, 3555.377808883435, 3653.488511608377, 28959.855200724072, 29216.415671686445, 29374.118776436742, 29631.259218519495, 30758.53862192069, 3547.6984456321243, 3569.125564236753, 3589.10272431892, 3604.567451905762, 3647.908802279938, 258280.0, 260478.0, 260933.0, 261355.0, 261933.0, 30889.8455507721, 32047.679523204468, 46578.301325479464, 46615.0, 46659.30011049837, 33830.15424614404, 33836.154096147795, 33945.66054339425, 33986.0, 34015.0, 13154.276514791778, 13347.93326033383, 13350.799738003938, 13372.73254534904, 13374.39815208318, 8247.752567422987, 9999.650012249536, 10068.44623545712, 10087.546060427298, 10575.841362379571, 7746.535207887545, 7810.0, 7836.764897053097, 7868.567228802471, 7967.203279671987, 3038.6353637563634, 3049.5120780674984, 3091.5671805947186, 3095.2261934516373, 3104.425681248976, 736.6243215959792, 803.541981070784, 976.4873441443299, 1015.7765291635828, 1034.1726618705006, 25727.356816079748, 27740.16779496578, 28321.0, 28475.430491390056, 28495.57256641152, 932.5011119051275, 951.7240000399945, 958.9760255993516, 972.397113789455, 1011.5801942193907, 14795.260236988108, 14904.850951490564, 14943.384907641337, 15022.774658380133, 15064.849351506344, 395607.0, 400081.0, 403581.0, 403624.0, 406624.0, 49147.0, 49639.75180124076, 49663.0, 49719.50280497221, 49809.50190498048, 1031.6492392586406, 1147.8450409194652, 1167.416291854073, 1189.9464524096263, 1192.9642110736693, 27900.58149127805, 29004.27489312784, 29160.562591561567, 29299.560506592843, 29718.851405742833, 41778.164436711704, 42424.5757542433, 42558.5744142567, 42568.36147457729, 42599.361009585504, 317189.0, 325514.0, 326370.0, 327268.0, 327871.0, 21978.89010554937, 23935.0, 24550.386240344134, 24892.128775493497, 26662.20013399601, 40508.0, 40859.79570102131, 40991.180176396905, 41495.377569335884, 41715.37426938659, 34684.65315346814, 34952.12619684528, 35198.64801351954, 35463.46804797982, 35843.28313433769, 35236.64763352334, 35748.106297342776, 35868.28263434769, 35920.820395897856, 36182.27635447329, 33968.32063358768, 34400.65599344075, 34956.47565286574, 35181.82409087938, 35208.295834083685, 30746.692533074383, 31417.792770315362, 31738.36523269568, 31975.840120799247, 32013.67986320107, 24841.751582483943, 25049.373765656004, 25277.241682749547, 25444.618330724683, 25591.232263031394], "value": 16692.36298101389, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.8905872767534, 371.82895867900766, 373.66930266713956, 384.05139305914383, 386.7022392757577, 15593.53219403417, 16272.91863540682, 16920.492385228434, 16961.49115526536, 16985.3205871765, 14866.55400337989, 15512.534623961272, 15603.375864965416, 15737.291821868015, 15764.290606922686, 4946.381702287205, 5132.384113906336, 5198.376194856603, 5201.947980520203, 5205.765740541685, 3694.667479926806, 3871.1096447817017, 5099.056674515208, 5644.435556444343, 5952.642841429528, 5963.045912653976, 5967.970160149193, 5984.162217289583, 5995.07076403156, 5997.940020599782, 5897.085951677497, 5906.2912450506, 5932.199153114339, 6082.452579267843, 6085.117657939618, 3379.746519011084, 4893.437254715717, 5197.48025197481, 5208.635395522315, 5333.733313334318, 17240.39658611955, 17266.827331726647, 17603.911980440145, 19752.80247197524, 20373.898130509253, 1910.5804496890437, 1911.6081203353278, 1922.2503223742613, 1972.5956178983274, 1981.2075169931998, 12773.808392874114, 13036.86963130366, 13144.6713832154, 13250.536231231861, 13783.379747911367, 1693.8136804951446, 1720.5182548886332, 1749.8250174982527, 1867.0, 1874.643817674651, 62024.37975620231, 63257.68371158161, 64387.0, 65673.0, 65761.34238657648, 8779.341549383822, 9713.465759383302, 10175.694729158136, 10188.643397481053, 10318.380897146195, 13087.0, 13133.540326088541, 13176.0, 13187.472501100041, 13201.339933003312, 6759.138556481569, 6794.252632210453, 6816.659167041628, 7025.89461158083, 7061.682224299919, 6321.462675672527, 6375.71309291083, 6484.221893372825, 6517.0, 6518.837029074216, 5945.16767652529, 6059.969700151471, 6117.296510901214, 6136.110264011693, 6297.811065668037, 1608.4048901906135, 1643.416587111582, 1727.6112874603114, 1779.9854083172727, 1780.4391616640717, 761.7219714804056, 819.6024927909959, 829.2950991657164, 835.4360806455618, 897.8473659477904, 16549.917250413913, 16775.832241677428, 16898.15509224534, 17128.0, 17349.0, 811.9797005074802, 846.7967687754895, 860.819227962135, 863.6070587882498, 868.4658934755206, 9465.90534094664, 10062.446565438824, 10072.697819065439, 10143.289969702199, 10323.432211228455, 381729.0, 387551.0, 392373.0, 392845.0, 393414.0, 61504.0, 64504.35495644983, 65965.67017164979, 65991.34008659948, 67958.3204167952, 869.482657818597, 895.7491902267376, 906.7506435730095, 917.3578495053489, 919.0212423768799, 15055.0, 15169.165695886832, 15406.69186616239, 15460.0, 15609.92195039063, 33601.0, 34167.41242169636, 35359.82320088383, 35365.469517956735, 35562.82218588891, 44185.779071104436, 44788.77605611951, 45461.77269113765, 45528.317075243234, 45939.0, 7711.421643376882, 7725.188855170126, 7758.7672369829, 7816.10114836801, 7823.374130069467, 11568.24806387582, 11829.0, 12123.878761212274, 12172.939135304267, 12178.634640960785, 7299.8540029200185, 10066.949665251626, 10228.335158214692, 10584.0, 10685.145188385066, 9906.504674766089, 10203.693889183336, 10249.641262555775, 10281.12610428092, 10431.321964072615, 10272.33229840058, 10511.369317840954, 10642.125036747706, 10696.786064278514, 10755.569777208824, 7470.178280389261, 7509.812254693677, 7572.962135189288, 7734.149243583314, 7813.531188128731, 9359.251259899327, 9961.750956226153, 9975.900240997787, 10274.178065754872, 10685.305455145392], "value": 8163.117482098391, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1261.0794120292192, 1371.4445649511945, 1407.0221196268592, 1474.9336279867405, 1723.2503860820536, 6867.107276054112, 7654.158042615308, 7908.683652653887, 7911.762647120589, 8155.796105097375, 7878.881816772753, 8000.799980000488, 8017.7594672159785, 8022.438429309951, 8022.638981245844, 2227.7438094619083, 2258.3337915315024, 2262.9434264143365, 2263.875486848223, 2263.875486848223, 2193.7257842769654, 2224.7775222477785, 2231.7433495148102, 2236.5303286309895, 2250.4036430345973, 2137.743470783508, 2166.5341951480427, 2175.82593392529, 2177.0638625391075, 2182.2471247419694, 2044.9693254601193, 2045.836333093349, 2051.7948205179514, 2053.4968932611455, 2055.4553043443498, 2040.7959204079473, 2121.5756848630335, 2127.1597718901103, 2131.8081372676534, 2133.040131940633, 7872.488288261302, 7881.566513841736, 8034.558099304536, 8040.0, 8156.306713929323, 4383.079553293812, 4500.122476117159, 4501.122281155176, 4506.346579745951, 4510.503844577094, 2753.9586906196223, 2888.638920134983, 2925.0786002409172, 2940.059181062061, 2948.8525573721445, 962.485070487286, 967.7677357434236, 967.9661211857622, 996.2378780233128, 1004.6835246897203, 10903.727406814814, 10937.343759374384, 10943.343399396063, 11057.281276716987, 11074.833877491845, 4102.138550904344, 4121.093359460914, 4212.789360531961, 4264.680148988777, 4281.957180428218, 8660.8700869487, 8685.08806575313, 8712.825743485222, 8718.825623487495, 8727.170918762708, 4464.933026004613, 4465.843695470708, 4466.419365482467, 4467.441569803775, 4470.0, 3573.7855728656364, 3719.9256014880093, 3868.458415821787, 4138.937915931264, 4139.254934111888, 3157.3211759471824, 3244.8053116812594, 3252.495863141217, 3420.9486857697157, 3439.3809114359656, 1041.3803786747026, 1044.237706474263, 1060.0247772049734, 1066.195022757813, 1067.957281708723, 754.9056367954006, 794.9562774047367, 822.7572866004423, 826.4710585225461, 827.185222555782, 5459.590530710133, 5516.613837031449, 5652.971735141298, 5748.798792042258, 5781.103928891029, 823.0452674897091, 863.210162701134, 878.5036454403241, 891.6032365597376, 891.9955400222957, 3449.793012419263, 3609.4946707460977, 3618.113562177231, 3640.4357324614725, 3647.252313275772, 9741.659041933499, 10061.4466204358, 10094.343867648578, 10121.139703125169, 10130.645427410005, 9886.505674716236, 9919.50402479873, 9992.600295988079, 10079.143272821746, 10123.139533139765, 7391.556506609621, 7430.702771889172, 7508.43686723487, 7537.2085930977555, 7545.924540754632, 5005.399352077774, 5087.160618497906, 5207.140821764367, 5238.947610523998, 5252.921206181987, 9122.586939856235, 9145.542722863696, 9256.07439256069, 9339.486328252011, 9351.39215950961, 9360.391574547904, 9664.71005869825, 9673.274504412339, 9681.515924203903, 9697.369670971364, 6536.7712130075215, 6622.10601568782, 6672.6997285121315, 6684.364985326386, 6685.298043705536, 6889.173299204128, 7458.627068646654, 7713.19011503784, 7736.149023607286, 7949.3243074339325, 6536.4117229447675, 6765.864682706417, 6781.254062053269, 6866.073080134118, 7030.287307867015, 6699.430548403246, 6796.592204467748, 6887.965560172167, 6957.965210173917, 7102.289771022856, 6231.4391704746795, 6402.487800976004, 6432.163818703539, 6442.452391546583, 6446.5165112615805, 4277.957220427756, 4391.7584532851, 4429.933550996802, 4505.932411013772, 4517.932231016472, 4511.8646440606835, 4551.226291530382, 4594.1271158479785, 4596.977015114903, 4640.535946405333], "value": 4133.384900329974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.1818907060231, 296.51371750329463, 300.95636132760734, 301.4393228594813, 303.46590001597184, 4877.317175595419, 4889.217725163974, 4897.632677549189, 4913.238448040551, 4936.0868239375695, 4777.355057067295, 4796.976015119928, 4805.135075686384, 4823.975880120594, 4890.559849613534, 3600.207954250061, 3696.537932758405, 3726.4037753959374, 3806.6574008339244, 3847.48059012034, 3794.7912864792424, 3816.2749077675153, 3819.197968426634, 3830.9616903830884, 3840.2127563849485, 3619.1314084619767, 3766.811659417032, 3767.340715374812, 3777.8299976500984, 3781.8487260509546, 3659.6889264412425, 3783.8675646352385, 3811.8094095295123, 3814.5422549293985, 3821.713371497121, 3348.1796959744775, 3361.5125806757883, 3369.427197376452, 3370.6966373026544, 3393.575803024622, 4706.388169537938, 4717.504662010508, 4740.336352910595, 4807.95192048082, 4827.396575428072, 4249.617534421917, 4308.267594508941, 4349.890777851628, 4361.694681372305, 4380.846670366554, 5093.363329583802, 5117.02776472469, 5120.743962801845, 5135.435102138762, 5139.537441630234, 3666.3400587894166, 3696.445533170019, 3698.001539584297, 3700.3154416433044, 3704.3887758519813, 5195.506426889439, 5357.142857142839, 5380.4350543192795, 5407.675539467606, 5447.766415769555, 3745.9438108428394, 3747.138158223624, 3756.624337566276, 3768.924621507609, 3777.3946072918898, 3814.2180852925085, 3820.2168555446624, 3820.8089595520114, 3821.1658403966253, 3826.4642949987024, 4324.783760811947, 4334.631556317685, 4361.520232774392, 4370.300751879684, 4371.322445021026, 4840.177169881129, 5141.228815677603, 5142.6914385137015, 5174.53429191367, 5185.559227465632, 1285.6078895936641, 1305.7257975824994, 1306.4055854586331, 1308.2542950518114, 1308.6205000549924, 810.6028046257292, 830.8451252758671, 833.295864994079, 834.7203686764881, 836.7532376758708, 4422.447194100738, 4423.845165419195, 4542.750148741851, 4554.908901822011, 4567.725936443824, 5230.738463076831, 5264.763085661154, 5285.286486324297, 5322.897455505054, 5329.534378046068, 4295.74225546462, 4495.910081798345, 4497.415336006364, 4499.280115181556, 4561.338605902192, 2782.8052036357667, 2797.6850880086326, 2798.454301411205, 2806.8315901046003, 2809.817361871472, 4973.005398920231, 4973.42805577356, 4981.252812078144, 5002.974985125051, 5005.72468514228, 5144.762028517607, 5410.242566040757, 5422.6475279106735, 5424.321959755031, 5443.836684899459, 4958.256261560795, 4995.550400463976, 5020.523050310215, 5025.3718285214345, 5027.441493137139, 5282.207668849704, 5312.867178320573, 5314.22943673173, 5327.440618735132, 5333.759980800795, 4935.876603084952, 5161.3032240647035, 5259.579233661374, 5259.684418934876, 5269.736513174403, 4996.475370086234, 4997.800087996439, 5020.246962955586, 5038.823641172541, 5073.720945348041, 3804.372278574004, 3845.8653947111716, 3854.421836724514, 3860.613938606229, 3868.5744568096925, 5112.71880046601, 5269.657472264291, 5281.709505977208, 5281.7359132042475, 5354.170103633943, 5075.670081444694, 5088.338515992898, 5112.130937740519, 5116.258142569232, 5118.283440318284, 5145.948540514547, 5146.819861304836, 5152.819651312186, 5155.819546315861, 5156.329677141947, 4795.400574928134, 4863.270509423614, 5014.197728363444, 5021.221710634857, 5022.27177059317, 5051.2423136529815, 5167.844964651066, 5195.376554813447, 5197.142471492161, 5212.635115541876, 5060.822871199491, 5077.898442031213, 5086.821961231339, 5087.2623469595965, 5098.541131298052], "value": 3860.759532930126, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.9503239740819, 681.3663293137383, 692.2385376086303, 735.4148525936062, 749.6888791151674, 12553.874461255386, 13220.603381898534, 13501.932490337547, 13839.169649821006, 13940.0, 13702.588922332347, 13765.31173441329, 13885.23631200286, 13898.93050534746, 13899.930500347484, 636.668932155279, 773.9032620922385, 784.2823816208177, 795.5266616363255, 797.3461761355691, 797.9162187970267, 800.7157459101993, 801.2388231180402, 803.2008151888849, 803.7789607857857, 842.1830824100613, 843.6035063520136, 843.8649816029437, 844.7381311793364, 846.4075147396846, 657.1555551116816, 799.4164260090108, 821.2936874288107, 822.9958850205711, 837.9078301386843, 607.313735478906, 608.057510858168, 608.0666177417643, 609.4788955443121, 609.6555446172898, 13775.0, 13901.860981390158, 13925.442982280696, 13950.651233719238, 13951.093178943336, 12358.505659773598, 12795.936020319932, 12807.74384512314, 13303.467861285537, 13423.060385773, 9903.504824758733, 10324.122449591794, 10623.097036751886, 10747.516361763739, 10787.83818242727, 4206.873793786161, 4238.046439551076, 4260.169266992938, 4458.598726114633, 4467.1735728889935, 61740.69129654368, 62789.37210627927, 63027.68486157586, 63535.682321588094, 64505.3549464504, 10139.847902281472, 10300.793984120426, 10376.481175941173, 10428.843567346496, 10482.056614904695, 17828.0, 17835.821641783674, 17839.821601784075, 17850.642987140185, 17850.732239016426, 6671.866562668816, 6679.265280819106, 6740.932590674129, 6767.2894346093935, 6862.107925969692, 3682.815859207029, 3779.7732136071922, 3781.962180378216, 3787.6023017583307, 3886.125621735087, 2540.1998370513597, 2593.2738833126377, 2601.9609705854427, 2602.62261972013, 2612.4513852090895, 419.7670292987421, 483.14483364445437, 489.3051866349792, 500.31207090250905, 503.4889587069128, 528.9603279754034, 532.824168024551, 533.9119045357551, 534.188034188032, 539.0970125040542, 8073.233042860918, 8104.756857294291, 8105.635246413925, 8108.351331893435, 8554.35842311829, 521.2832355511172, 528.5903424845775, 532.5313723922923, 533.1655958425052, 540.3299908113911, 3824.8852534424013, 3868.537153621199, 3986.421968814506, 4014.538328092307, 4059.4925634295714, 102670.0, 104536.47731761292, 107045.0, 107650.0, 108775.0, 52771.47228527666, 59338.40661593415, 86714.13285867187, 88380.5580972091, 89722.55138724265, 77114.22885771071, 79124.20875791284, 80833.0, 81684.0, 83452.0, 7406.296401841816, 7436.293552112541, 7451.739189128354, 7460.0301960744755, 7654.923450765421, 46185.0, 46638.0, 46655.0, 47540.28689569728, 48064.0, 41795.582044179166, 49540.25689614587, 59326.406735933815, 60534.39465605288, 64882.0, 9282.860757088514, 9598.808023839623, 9652.420854748456, 9787.730579209954, 9852.802943941224, 10696.62561810333, 10754.0, 11065.391403472886, 11073.557057717924, 11170.776584468103, 10033.397996119964, 10166.440845753554, 10187.643432479828, 10425.061744443037, 10495.317804342998, 9560.76098097553, 9616.807663846825, 9807.607695692092, 9854.655087071918, 10135.898641013495, 10037.5483103262, 10108.39349639024, 10317.587296508356, 10502.0, 10733.838992414963, 8415.831683366421, 8430.988281406271, 8631.093735157969, 8909.1536304051, 9264.351495395258, 9439.339246252697, 9769.31614786958, 9799.461029643153, 9824.852627210741, 9856.901430985597], "value": 6396.285465954673, "unit": "score"}], "name": "dromaeo_css", "value": 6361.8222492448895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 112.0, 111.0, 113.0, 112.0, 112.0, 113.0, 111.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 139.0, 137.0, 192.0, 132.0, 159.0, 155.0, 131.0, 186.0, 133.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 101.0, 76.0, 76.0, 75.0, 75.0, 97.0, 77.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 111.0, 87.0, 86.0, 86.0, 127.0, 86.0, 87.0, 132.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 62.0, 62.0, 64.0, 63.0, 63.0, 62.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 64.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 83.0, 85.0, 85.0, 89.0, 87.0, 123.0, 84.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 132.0, 131.0, 138.0, 128.0, 128.0, 131.0, 144.0, 133.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 175.0, 173.0, 174.0, 168.0, 167.0, 171.0, 170.0, 171.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 68.0, 68.0, 68.0, 71.0, 67.0, 66.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1551.1999999999998, "alertThreshold": 2.0}]} 06:01:04 INFO - Return code: 0 06:01:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:01:04 INFO - # TBPL SUCCESS # 06:01:04 INFO - Running post-action listener: _resource_record_post_action 06:01:04 INFO - ##### 06:01:04 INFO - ##### Finished run-tests step (success) 06:01:04 INFO - ##### 06:01:04 INFO - Running post-run listener: _resource_record_post_run 06:01:04 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 3301376; Write bytes: 291586048; Read time: 212; Write time: 201640 06:01:04 INFO - TinderboxPrint: CPU usage
13.1% 06:01:04 INFO - TinderboxPrint: I/O read bytes / time
3,301,376 / 212 06:01:04 INFO - TinderboxPrint: I/O write bytes / time
291,586,048 / 201,640 06:01:04 INFO - TinderboxPrint: CPU idle
8,333.3 (86.9%) 06:01:04 INFO - TinderboxPrint: CPU user
1,214.0 (12.7%) 06:01:04 INFO - TinderboxPrint: Swap in / out
0 / 0 06:01:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6815744; Read time: 0; Write time: 920 06:01:04 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 3301376; Write bytes: 284770304; Read time: 212; Write time: 200720 06:01:04 INFO - Running post-run listener: _upload_blobber_files 06:01:04 INFO - Blob upload gear active. 06:01:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:01:04 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 06:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:01:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:01:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:01:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:01:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:08 INFO - (blobuploader) - INFO - Done attempting. 06:01:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:01:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:01:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:10 INFO - (blobuploader) - INFO - Done attempting. 06:01:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:01:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:01:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:11 INFO - (blobuploader) - INFO - Done attempting. 06:01:11 INFO - (blobuploader) - INFO - Iteration through files over. 06:01:11 INFO - Return code: 0 06:01:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:01:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:01:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12c93a6bd48930a6b2e63e2fafa37d9e716bd6126ab6b5a9f3f89c364f232d7b88f9ebe2cf5b6c9a0a13dd199aaf789087aac47594e22bfddbf677b71c322d0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8f58a598dee02cfc29c030b83f1f26ed381caf62d54b92b87f1ab67b3679c723b9ae5cc02f8506be09476bdae864aa16a427f8a5c719b3038845a5bd5b34cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1251e1137668e90748856433effda75aad908b58232a986c70077fa4b5b825255c7b7e4afba4ab920e39013797392053cf8dd094df842975f7894fcba73a4ac9"} 06:01:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:01:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:01:11 INFO - Contents: 06:01:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12c93a6bd48930a6b2e63e2fafa37d9e716bd6126ab6b5a9f3f89c364f232d7b88f9ebe2cf5b6c9a0a13dd199aaf789087aac47594e22bfddbf677b71c322d0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8f58a598dee02cfc29c030b83f1f26ed381caf62d54b92b87f1ab67b3679c723b9ae5cc02f8506be09476bdae864aa16a427f8a5c719b3038845a5bd5b34cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1251e1137668e90748856433effda75aad908b58232a986c70077fa4b5b825255c7b7e4afba4ab920e39013797392053cf8dd094df842975f7894fcba73a4ac9"} 06:01:11 INFO - Running post-run listener: copy_logs_to_upload_dir 06:01:11 INFO - Copying logs to upload dir... 06:01:11 INFO - mkdir: /builds/slave/test/build/upload/logs 06:01:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.510120 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-16 06:01:11.511311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 06:01:11.517022) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12c93a6bd48930a6b2e63e2fafa37d9e716bd6126ab6b5a9f3f89c364f232d7b88f9ebe2cf5b6c9a0a13dd199aaf789087aac47594e22bfddbf677b71c322d0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8f58a598dee02cfc29c030b83f1f26ed381caf62d54b92b87f1ab67b3679c723b9ae5cc02f8506be09476bdae864aa16a427f8a5c719b3038845a5bd5b34cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1251e1137668e90748856433effda75aad908b58232a986c70077fa4b5b825255c7b7e4afba4ab920e39013797392053cf8dd094df842975f7894fcba73a4ac9"} build_url:https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/PP_y5hEoQ52kEEqMilp7rA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12c93a6bd48930a6b2e63e2fafa37d9e716bd6126ab6b5a9f3f89c364f232d7b88f9ebe2cf5b6c9a0a13dd199aaf789087aac47594e22bfddbf677b71c322d0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8f58a598dee02cfc29c030b83f1f26ed381caf62d54b92b87f1ab67b3679c723b9ae5cc02f8506be09476bdae864aa16a427f8a5c719b3038845a5bd5b34cf4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1251e1137668e90748856433effda75aad908b58232a986c70077fa4b5b825255c7b7e4afba4ab920e39013797392053cf8dd094df842975f7894fcba73a4ac9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 06:01:11.545480) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 06:01:11.545862) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466080422.573099-1727655321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 06:01:11.626487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 06:01:11.626812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 06:01:11.627119) ========= ========= Total master_lag: 0.20 =========