builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1465906278.35 results: success (0) buildid: 20160614043925 builduid: e7cc7e20383f4bf78e138685a792ee67 revision: 4eb7afe97b2b470c9276a8af9c23910cdbd02563 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:18.354385) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:18.354887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:18.355177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:18.369892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:18.370217) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 05:11:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.3M=0s 2016-06-14 05:11:18 (38.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127145 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:18.511691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:18.512047) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018316 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:18.562909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:18.563305) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4eb7afe97b2b470c9276a8af9c23910cdbd02563 --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 4eb7afe97b2b470c9276a8af9c23910cdbd02563 --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=337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 05:11:18,818 truncating revision to first 12 chars 2016-06-14 05:11:18,819 Setting DEBUG logging. 2016-06-14 05:11:18,819 attempt 1/10 2016-06-14 05:11:18,819 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4eb7afe97b2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 05:11:19,119 unpacking tar archive at: fx-team-4eb7afe97b2b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:19.221101) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:19.221427) ========= script_repo_revision: 4eb7afe97b2b470c9276a8af9c23910cdbd02563 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:19.221859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:19.222132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 05:11:19.232908) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-14 05:11:19.233279) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:11:19 INFO - MultiFileLogger online at 20160614 05:11:19 in /builds/slave/test 05:11:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:11:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:11:19 INFO - {'append_to_log': False, 05:11:19 INFO - 'base_work_dir': '/builds/slave/test', 05:11:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:11:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:11:19 INFO - 'branch': 'Fx-Team-Non-PGO', 05:11:19 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:19 INFO - 'config_files': ('talos/linux_config.py',), 05:11:19 INFO - 'default_actions': ('clobber', 05:11:19 INFO - 'read-buildbot-config', 05:11:19 INFO - 'download-and-extract', 05:11:19 INFO - 'populate-webroot', 05:11:19 INFO - 'create-virtualenv', 05:11:19 INFO - 'install', 05:11:19 INFO - 'run-tests'), 05:11:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:19 INFO - 'download_minidump_stackwalk': True, 05:11:19 INFO - 'download_symbols': 'ondemand', 05:11:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:19 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:19 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:19 INFO - 'installer_path': 'installer.exe', 05:11:19 INFO - 'log_level': 'info', 05:11:19 INFO - 'log_name': 'talos', 05:11:19 INFO - 'log_to_console': True, 05:11:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:11:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:11:19 INFO - 'opt_config_files': (), 05:11:19 INFO - 'pip_index': False, 05:11:19 INFO - 'sps_profile': False, 05:11:19 INFO - 'sps_profile_interval': 0, 05:11:19 INFO - 'suite': 'dromaeojs-e10s', 05:11:19 INFO - 'system_bits': '32', 05:11:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:19 INFO - 'title': 'talos-linux64-ix-060', 05:11:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:19 INFO - 'use_talos_json': True, 05:11:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:11:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:19 INFO - 'work_dir': 'build'} 05:11:19 INFO - ##### 05:11:19 INFO - ##### Running clobber step. 05:11:19 INFO - ##### 05:11:19 INFO - Running pre-action listener: _resource_record_pre_action 05:11:19 INFO - Running main action method: clobber 05:11:19 INFO - rmtree: /builds/slave/test/build 05:11:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:11:20 INFO - Running post-action listener: _resource_record_post_action 05:11:20 INFO - ##### 05:11:20 INFO - ##### Finished clobber step (success) 05:11:20 INFO - ##### 05:11:20 INFO - ##### 05:11:20 INFO - ##### Running read-buildbot-config step. 05:11:20 INFO - ##### 05:11:20 INFO - Running pre-action listener: _resource_record_pre_action 05:11:20 INFO - Running main action method: read_buildbot_config 05:11:20 INFO - Using buildbot properties: 05:11:20 INFO - { 05:11:20 INFO - "project": "", 05:11:20 INFO - "product": "firefox", 05:11:20 INFO - "script_repo_revision": "production", 05:11:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:11:20 INFO - "repository": "", 05:11:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:11:20 INFO - "buildid": "20160614043925", 05:11:20 INFO - "pgo_build": "False", 05:11:20 INFO - "basedir": "/builds/slave/test", 05:11:20 INFO - "buildnumber": 1367, 05:11:20 INFO - "slavename": "talos-linux64-ix-060", 05:11:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:11:20 INFO - "platform": "ubuntu64_hw", 05:11:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:11:20 INFO - "branch": "fx-team", 05:11:20 INFO - "repo_path": "integration/fx-team", 05:11:20 INFO - "revision": "4eb7afe97b2b470c9276a8af9c23910cdbd02563", 05:11:20 INFO - "stage_platform": "linux64", 05:11:20 INFO - "builduid": "e7cc7e20383f4bf78e138685a792ee67", 05:11:20 INFO - "slavebuilddir": "test" 05:11:20 INFO - } 05:11:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:11:20 INFO - Running post-action listener: _resource_record_post_action 05:11:20 INFO - ##### 05:11:20 INFO - ##### Finished read-buildbot-config step (success) 05:11:20 INFO - ##### 05:11:20 INFO - ##### 05:11:20 INFO - ##### Running download-and-extract step. 05:11:20 INFO - ##### 05:11:20 INFO - Running pre-action listener: _resource_record_pre_action 05:11:20 INFO - Running main action method: download_and_extract 05:11:20 INFO - mkdir: /builds/slave/test/build/tests 05:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:20 INFO - https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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:11:20 INFO - Downloaded 1361 bytes. 05:11:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:11:20 INFO - Using the following test package requirements: 05:11:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:11:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:20 INFO - u'jsshell-linux-x86_64.zip'], 05:11:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:11:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:11:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:20 INFO - https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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:11:22 INFO - Downloaded 22653673 bytes. 05:11:22 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:11:22 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:11:23 INFO - Return code: 0 05:11:23 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:11:23 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:11:23 INFO - https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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:11:24 INFO - Downloaded 22653673 bytes. 05:11:24 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:11:24 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:11:26 INFO - Return code: 0 05:11:26 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:11:26 INFO - https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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:11:27 INFO - Downloaded 14405384 bytes. 05:11:27 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:11:27 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:11:27 INFO - Return code: 0 05:11:27 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:11:27 INFO - https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:11:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJANoH3LQBGu5d01cnn7Gg/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:11:32 INFO - Downloaded 55399292 bytes. 05:11:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:32 INFO - mkdir: /builds/slave/test/properties 05:11:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:32 INFO - Contents: 05:11:32 INFO - build_url:https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:32 INFO - Running post-action listener: _resource_record_post_action 05:11:32 INFO - Running post-action listener: set_extra_try_arguments 05:11:32 INFO - ##### 05:11:32 INFO - ##### Finished download-and-extract step (success) 05:11:32 INFO - ##### 05:11:32 INFO - ##### 05:11:32 INFO - ##### Running populate-webroot step. 05:11:32 INFO - ##### 05:11:32 INFO - Running pre-action listener: _resource_record_pre_action 05:11:32 INFO - Running main action method: populate_webroot 05:11:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:32 INFO - '--tppagecycles', 05:11:32 INFO - '7'], 05:11:32 INFO - 'tests': ['tsvgm']}}, 05:11:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:32 INFO - 'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:32 INFO - 'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['damp', 'tps']}, 05:11:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:32 INFO - 'tests': ['damp', 'tps']}, 05:11:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['dromaeo_dom']}, 05:11:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['basic_compositor_video']}, 05:11:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:11:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['a11yr', 05:11:32 INFO - 'ts_paint', 05:11:32 INFO - 'tpaint', 05:11:32 INFO - 'sessionrestore', 05:11:32 INFO - 'sessionrestore_no_auto_restore', 05:11:32 INFO - 'tabpaint']}, 05:11:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:32 INFO - 'ts_paint', 05:11:32 INFO - 'tpaint', 05:11:32 INFO - 'sessionrestore', 05:11:32 INFO - 'sessionrestore_no_auto_restore', 05:11:32 INFO - 'tabpaint']}, 05:11:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:32 INFO - 'ts_paint', 05:11:32 INFO - 'tpaint', 05:11:32 INFO - 'sessionrestore', 05:11:32 INFO - 'sessionrestore_no_auto_restore', 05:11:32 INFO - 'tabpaint']}, 05:11:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:32 INFO - 'ts_paint', 05:11:32 INFO - 'tpaint', 05:11:32 INFO - 'sessionrestore', 05:11:32 INFO - 'sessionrestore_no_auto_restore', 05:11:32 INFO - 'tabpaint']}, 05:11:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['a11yr', 05:11:32 INFO - 'ts_paint', 05:11:32 INFO - 'tpaint', 05:11:32 INFO - 'sessionrestore', 05:11:32 INFO - 'sessionrestore_no_auto_restore', 05:11:32 INFO - 'tabpaint']}, 05:11:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['a11yr', 05:11:32 INFO - 'ts_paint', 05:11:32 INFO - 'tpaint', 05:11:32 INFO - 'sessionrestore', 05:11:32 INFO - 'sessionrestore_no_auto_restore', 05:11:32 INFO - 'tabpaint']}, 05:11:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['tsvgx', 05:11:32 INFO - 'tsvgr_opacity', 05:11:32 INFO - 'tart', 05:11:32 INFO - 'tscrollx', 05:11:32 INFO - 'cart']}, 05:11:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:32 INFO - 'tsvgr_opacity', 05:11:32 INFO - 'tart', 05:11:32 INFO - 'tscrollx', 05:11:32 INFO - 'cart']}, 05:11:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:32 INFO - 'talos_options': ['--disable-e10s'], 05:11:32 INFO - 'tests': ['tp5o']}, 05:11:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:32 INFO - 'tests': ['tp5o']}, 05:11:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:32 INFO - 'talos_options': ['--disable-e10s', 05:11:32 INFO - '--xperf_path', 05:11:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:32 INFO - 'tests': ['tp5n']}, 05:11:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:32 INFO - 'talos_options': ['--xperf_path', 05:11:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:32 INFO - 'tests': ['tp5n']}}, 05:11:32 INFO - 'talos.zip': {'path': '', 05:11:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:32 INFO - Running post-action listener: _resource_record_post_action 05:11:32 INFO - ##### 05:11:32 INFO - ##### Finished populate-webroot step (success) 05:11:32 INFO - ##### 05:11:32 INFO - ##### 05:11:32 INFO - ##### Running create-virtualenv step. 05:11:32 INFO - ##### 05:11:32 INFO - Running pre-action listener: _resource_record_pre_action 05:11:32 INFO - Running main action method: create_virtualenv 05:11:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:32 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:11:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:33 INFO - Using real prefix '/usr' 05:11:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:35 INFO - Installing pip.................done. 05:11:35 INFO - Return code: 0 05:11:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:35 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 0x7fdbb3b69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', '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:11:35 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:11:35 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:11:35 INFO - Using env: {'DISPLAY': ':0', 05:11:35 INFO - 'HOME': '/home/cltbld', 05:11:35 INFO - 'LANG': 'en_US.UTF-8', 05:11:35 INFO - 'LANGUAGE': 'en_US:en', 05:11:35 INFO - 'LOGNAME': 'cltbld', 05:11:35 INFO - 'MAIL': '/var/mail/cltbld', 05:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:35 INFO - 'MOZ_NO_REMOTE': '1', 05:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:35 INFO - 'NO_EM_RESTART': '1', 05:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:35 INFO - 'PWD': '/builds/slave/test', 05:11:35 INFO - 'SHELL': '/bin/bash', 05:11:35 INFO - 'SHLVL': '1', 05:11:35 INFO - 'TERM': 'linux', 05:11:35 INFO - 'TMOUT': '86400', 05:11:35 INFO - 'USER': 'cltbld', 05:11:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:35 INFO - '_': '/tools/buildbot/bin/python'} 05:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:35 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:11:35 INFO - Cleaning up... 05:11:35 INFO - Return code: 0 05:11:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:35 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 0x7fdbb3b69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', '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:11:35 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:11:35 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:11:35 INFO - Using env: {'DISPLAY': ':0', 05:11:35 INFO - 'HOME': '/home/cltbld', 05:11:35 INFO - 'LANG': 'en_US.UTF-8', 05:11:35 INFO - 'LANGUAGE': 'en_US:en', 05:11:35 INFO - 'LOGNAME': 'cltbld', 05:11:35 INFO - 'MAIL': '/var/mail/cltbld', 05:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:35 INFO - 'MOZ_NO_REMOTE': '1', 05:11:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:35 INFO - 'NO_EM_RESTART': '1', 05:11:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:35 INFO - 'PWD': '/builds/slave/test', 05:11:35 INFO - 'SHELL': '/bin/bash', 05:11:35 INFO - 'SHLVL': '1', 05:11:35 INFO - 'TERM': 'linux', 05:11:35 INFO - 'TMOUT': '86400', 05:11:35 INFO - 'USER': 'cltbld', 05:11:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:35 INFO - '_': '/tools/buildbot/bin/python'} 05:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:35 INFO - Downloading/unpacking psutil>=3.1.1 05:11:35 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:11:35 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:11:35 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:11:35 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:11:35 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:11:35 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:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:38 INFO - Installing collected packages: psutil 05:11:38 INFO - Running setup.py install for psutil 05:11:38 INFO - building 'psutil._psutil_linux' extension 05:11:38 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:11:38 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:11:38 INFO - building 'psutil._psutil_posix' extension 05:11:38 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:11:38 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:11:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:38 INFO - Successfully installed psutil 05:11:38 INFO - Cleaning up... 05:11:38 INFO - Return code: 0 05:11:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:38 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 0x7fdbb3b69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', '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:11:38 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:11:38 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:11:38 INFO - Using env: {'DISPLAY': ':0', 05:11:38 INFO - 'HOME': '/home/cltbld', 05:11:38 INFO - 'LANG': 'en_US.UTF-8', 05:11:38 INFO - 'LANGUAGE': 'en_US:en', 05:11:38 INFO - 'LOGNAME': 'cltbld', 05:11:38 INFO - 'MAIL': '/var/mail/cltbld', 05:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:38 INFO - 'MOZ_NO_REMOTE': '1', 05:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:38 INFO - 'NO_EM_RESTART': '1', 05:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:38 INFO - 'PWD': '/builds/slave/test', 05:11:38 INFO - 'SHELL': '/bin/bash', 05:11:38 INFO - 'SHLVL': '1', 05:11:38 INFO - 'TERM': 'linux', 05:11:38 INFO - 'TMOUT': '86400', 05:11:38 INFO - 'USER': 'cltbld', 05:11:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:38 INFO - '_': '/tools/buildbot/bin/python'} 05:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:11:38 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:11:38 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:11:38 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:11:38 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:11:38 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:11:38 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:11:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:11:40 INFO - Installing collected packages: mozsystemmonitor 05:11:40 INFO - Running setup.py install for mozsystemmonitor 05:11:40 INFO - Successfully installed mozsystemmonitor 05:11:40 INFO - Cleaning up... 05:11:40 INFO - Return code: 0 05:11:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdbb3b69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', '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:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:11:40 INFO - Using env: {'DISPLAY': ':0', 05:11:40 INFO - 'HOME': '/home/cltbld', 05:11:40 INFO - 'LANG': 'en_US.UTF-8', 05:11:40 INFO - 'LANGUAGE': 'en_US:en', 05:11:40 INFO - 'LOGNAME': 'cltbld', 05:11:40 INFO - 'MAIL': '/var/mail/cltbld', 05:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:40 INFO - 'MOZ_NO_REMOTE': '1', 05:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:40 INFO - 'NO_EM_RESTART': '1', 05:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:40 INFO - 'PWD': '/builds/slave/test', 05:11:40 INFO - 'SHELL': '/bin/bash', 05:11:40 INFO - 'SHLVL': '1', 05:11:40 INFO - 'TERM': 'linux', 05:11:40 INFO - 'TMOUT': '86400', 05:11:40 INFO - 'USER': 'cltbld', 05:11:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:40 INFO - '_': '/tools/buildbot/bin/python'} 05:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:41 INFO - Downloading/unpacking jsonschema==2.5.1 05:11:41 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:11:41 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:11:41 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:11:41 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:11:41 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:11:41 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:11:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:43 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:43 INFO - warning: no files found matching '*.txt' 05:11:43 INFO - no previously-included directories found matching 'build' 05:11:43 INFO - no previously-included directories found matching 'dist' 05:11:43 INFO - no previously-included directories found matching '.git*' 05:11:43 INFO - Installing collected packages: jsonschema, functools32 05:11:43 INFO - Running setup.py install for functools32 05:11:43 INFO - warning: no files found matching '*.txt' 05:11:43 INFO - no previously-included directories found matching 'build' 05:11:43 INFO - no previously-included directories found matching 'dist' 05:11:43 INFO - no previously-included directories found matching '.git*' 05:11:43 INFO - Successfully installed jsonschema functools32 05:11:43 INFO - Cleaning up... 05:11:43 INFO - Return code: 0 05:11:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdbb3b69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', '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:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:11:43 INFO - Using env: {'DISPLAY': ':0', 05:11:43 INFO - 'HOME': '/home/cltbld', 05:11:43 INFO - 'LANG': 'en_US.UTF-8', 05:11:43 INFO - 'LANGUAGE': 'en_US:en', 05:11:43 INFO - 'LOGNAME': 'cltbld', 05:11:43 INFO - 'MAIL': '/var/mail/cltbld', 05:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:43 INFO - 'MOZ_NO_REMOTE': '1', 05:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:43 INFO - 'NO_EM_RESTART': '1', 05:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:43 INFO - 'PWD': '/builds/slave/test', 05:11:43 INFO - 'SHELL': '/bin/bash', 05:11:43 INFO - 'SHLVL': '1', 05:11:43 INFO - 'TERM': 'linux', 05:11:43 INFO - 'TMOUT': '86400', 05:11:43 INFO - 'USER': 'cltbld', 05:11:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:43 INFO - '_': '/tools/buildbot/bin/python'} 05:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11: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:11: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:11: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:11: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:11: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:11: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:11:46 INFO - Downloading docopt-0.6.1.tar.gz 05:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:46 INFO - Running setup.py install for blobuploader 05:11:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:46 INFO - Running setup.py install for requests 05:11:46 INFO - Running setup.py install for docopt 05:11:46 INFO - Successfully installed blobuploader requests docopt 05:11:46 INFO - Cleaning up... 05:11:47 INFO - Return code: 0 05:11:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:47 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 0x7fdbb3b69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', '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:11:47 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:11:47 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:11:47 INFO - Using env: {'DISPLAY': ':0', 05:11:47 INFO - 'HOME': '/home/cltbld', 05:11:47 INFO - 'LANG': 'en_US.UTF-8', 05:11:47 INFO - 'LANGUAGE': 'en_US:en', 05:11:47 INFO - 'LOGNAME': 'cltbld', 05:11:47 INFO - 'MAIL': '/var/mail/cltbld', 05:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:47 INFO - 'MOZ_NO_REMOTE': '1', 05:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:47 INFO - 'NO_EM_RESTART': '1', 05:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:47 INFO - 'PWD': '/builds/slave/test', 05:11:47 INFO - 'SHELL': '/bin/bash', 05:11:47 INFO - 'SHLVL': '1', 05:11:47 INFO - 'TERM': 'linux', 05:11:47 INFO - 'TMOUT': '86400', 05:11:47 INFO - 'USER': 'cltbld', 05:11:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:47 INFO - '_': '/tools/buildbot/bin/python'} 05:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:47 INFO - Running setup.py (path:/tmp/pip-PSis9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:47 INFO - Running setup.py (path:/tmp/pip-1O7j4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:47 INFO - Running setup.py (path:/tmp/pip-vGtsgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:47 INFO - Running setup.py (path:/tmp/pip-ciRcQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:47 INFO - Running setup.py (path:/tmp/pip-6FPmMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:47 INFO - Running setup.py (path:/tmp/pip-iP4NRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:47 INFO - Running setup.py (path:/tmp/pip-J_XVLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:47 INFO - Running setup.py (path:/tmp/pip-nKJ_WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:47 INFO - Running setup.py (path:/tmp/pip-yHYeks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:47 INFO - Running setup.py (path:/tmp/pip-sXfKoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:47 INFO - Running setup.py (path:/tmp/pip-mIxlB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:48 INFO - Running setup.py (path:/tmp/pip-jUAAlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:48 INFO - Running setup.py (path:/tmp/pip-ywqLGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:48 INFO - Running setup.py (path:/tmp/pip-GANhWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:48 INFO - Running setup.py (path:/tmp/pip-YRHCN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:48 INFO - Running setup.py (path:/tmp/pip-Uk2lSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:48 INFO - Running setup.py (path:/tmp/pip-F0Hwzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:48 INFO - Running setup.py install for manifestparser 05:11:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:48 INFO - Running setup.py install for mozcrash 05:11:48 INFO - Running setup.py install for mozdebug 05:11:48 INFO - Running setup.py install for mozdevice 05:11:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:48 INFO - Running setup.py install for mozfile 05:11:48 INFO - Running setup.py install for mozhttpd 05:11:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Running setup.py install for mozinfo 05:11:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Running setup.py install for mozInstall 05:11:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Running setup.py install for mozleak 05:11:49 INFO - Running setup.py install for mozlog 05:11:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Running setup.py install for moznetwork 05:11:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Running setup.py install for mozprocess 05:11:49 INFO - Running setup.py install for mozprofile 05:11:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Running setup.py install for mozrunner 05:11:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:49 INFO - Running setup.py install for mozscreenshot 05:11:50 INFO - Running setup.py install for moztest 05:11:50 INFO - Running setup.py install for mozversion 05:11:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:50 INFO - Cleaning up... 05:11:50 INFO - Return code: 0 05:11:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11: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:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:50 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 0x7fdbb3b69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', '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:11:50 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:11:50 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:11:50 INFO - Using env: {'DISPLAY': ':0', 05:11:50 INFO - 'HOME': '/home/cltbld', 05:11:50 INFO - 'LANG': 'en_US.UTF-8', 05:11:50 INFO - 'LANGUAGE': 'en_US:en', 05:11:50 INFO - 'LOGNAME': 'cltbld', 05:11:50 INFO - 'MAIL': '/var/mail/cltbld', 05:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:50 INFO - 'MOZ_NO_REMOTE': '1', 05:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:50 INFO - 'NO_EM_RESTART': '1', 05:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:50 INFO - 'PWD': '/builds/slave/test', 05:11:50 INFO - 'SHELL': '/bin/bash', 05:11:50 INFO - 'SHLVL': '1', 05:11:50 INFO - 'TERM': 'linux', 05:11:50 INFO - 'TMOUT': '86400', 05:11:50 INFO - 'USER': 'cltbld', 05:11:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:50 INFO - '_': '/tools/buildbot/bin/python'} 05:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:50 INFO - Running setup.py (path:/tmp/pip-WJlUG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:50 INFO - Running setup.py (path:/tmp/pip-MAQOso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:50 INFO - Running setup.py (path:/tmp/pip-5RnNVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:50 INFO - Running setup.py (path:/tmp/pip-tyzCV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:50 INFO - Running setup.py (path:/tmp/pip-PKDJZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:50 INFO - Running setup.py (path:/tmp/pip-h5r7TV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:50 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:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:50 INFO - Running setup.py (path:/tmp/pip-OSrRah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:51 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:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:51 INFO - Running setup.py (path:/tmp/pip-W_OAKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:51 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:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:51 INFO - Running setup.py (path:/tmp/pip-DZiWGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:51 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:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:51 INFO - Running setup.py (path:/tmp/pip-oo4sD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:51 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:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:51 INFO - Running setup.py (path:/tmp/pip-6RhEZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:51 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:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:51 INFO - Running setup.py (path:/tmp/pip-ntcbHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:51 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:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:51 INFO - Running setup.py (path:/tmp/pip-M4eZtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:51 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:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:51 INFO - Running setup.py (path:/tmp/pip-jXmqWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:51 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:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:51 INFO - Running setup.py (path:/tmp/pip-uefnWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:51 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:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:51 INFO - Running setup.py (path:/tmp/pip-MSkEo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:51 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:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:51 INFO - Running setup.py (path:/tmp/pip-THDsvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:51 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:11:51 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:11:51 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:11:51 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:11:51 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:11:51 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:11:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:51 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:11:51 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:11:51 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:11:51 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:11:51 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:11:51 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:11:53 INFO - Downloading blessings-1.6.tar.gz 05:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:53 INFO - Installing collected packages: blessings 05:11:53 INFO - Running setup.py install for blessings 05:11:53 INFO - Successfully installed blessings 05:11:53 INFO - Cleaning up... 05:11:53 INFO - Return code: 0 05:11:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:54 INFO - Reading from file tmpfile_stdout 05:11:54 INFO - Current package versions: 05:11:54 INFO - argparse == 1.2.1 05:11:54 INFO - blessings == 1.6 05:11:54 INFO - blobuploader == 1.2.4 05:11:54 INFO - docopt == 0.6.1 05:11:54 INFO - functools32 == 3.2.3-2 05:11:54 INFO - jsonschema == 2.5.1 05:11:54 INFO - manifestparser == 1.1 05:11:54 INFO - mozInstall == 1.12 05:11:54 INFO - mozcrash == 0.17 05:11:54 INFO - mozdebug == 0.1 05:11:54 INFO - mozdevice == 0.48 05:11:54 INFO - mozfile == 1.2 05:11:54 INFO - mozhttpd == 0.7 05:11:54 INFO - mozinfo == 0.9 05:11:54 INFO - mozleak == 0.1 05:11:54 INFO - mozlog == 3.2 05:11:54 INFO - moznetwork == 0.27 05:11:54 INFO - mozprocess == 0.22 05:11:54 INFO - mozprofile == 0.28 05:11:54 INFO - mozrunner == 6.11 05:11:54 INFO - mozscreenshot == 0.1 05:11:54 INFO - mozsystemmonitor == 0.3 05:11:54 INFO - moztest == 0.7 05:11:54 INFO - mozversion == 1.4 05:11:54 INFO - psutil == 3.1.1 05:11:54 INFO - requests == 1.2.3 05:11:54 INFO - wsgiref == 0.1.2 05:11:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:54 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 0x7fdbb3b69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', '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:11:54 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:11:54 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:11:54 INFO - Using env: {'DISPLAY': ':0', 05:11:54 INFO - 'HOME': '/home/cltbld', 05:11:54 INFO - 'LANG': 'en_US.UTF-8', 05:11:54 INFO - 'LANGUAGE': 'en_US:en', 05:11:54 INFO - 'LOGNAME': 'cltbld', 05:11:54 INFO - 'MAIL': '/var/mail/cltbld', 05:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:54 INFO - 'MOZ_NO_REMOTE': '1', 05:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:54 INFO - 'NO_EM_RESTART': '1', 05:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:54 INFO - 'PWD': '/builds/slave/test', 05:11:54 INFO - 'SHELL': '/bin/bash', 05:11:54 INFO - 'SHLVL': '1', 05:11:54 INFO - 'TERM': 'linux', 05:11:54 INFO - 'TMOUT': '86400', 05:11:54 INFO - 'USER': 'cltbld', 05:11:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:54 INFO - '_': '/tools/buildbot/bin/python'} 05:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:54 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:11:54 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:11:54 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:11:54 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:11:54 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:11:54 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:11:54 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:11:54 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:11:54 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:11:54 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:11:54 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:11:54 INFO - Cleaning up... 05:11:54 INFO - Return code: 0 05:11:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbb3b69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', '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:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:11:54 INFO - Using env: {'DISPLAY': ':0', 05:11:54 INFO - 'HOME': '/home/cltbld', 05:11:54 INFO - 'LANG': 'en_US.UTF-8', 05:11:54 INFO - 'LANGUAGE': 'en_US:en', 05:11:54 INFO - 'LOGNAME': 'cltbld', 05:11:54 INFO - 'MAIL': '/var/mail/cltbld', 05:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:54 INFO - 'MOZ_NO_REMOTE': '1', 05:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:54 INFO - 'NO_EM_RESTART': '1', 05:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:54 INFO - 'PWD': '/builds/slave/test', 05:11:54 INFO - 'SHELL': '/bin/bash', 05:11:54 INFO - 'SHLVL': '1', 05:11:54 INFO - 'TERM': 'linux', 05:11:54 INFO - 'TMOUT': '86400', 05:11:54 INFO - 'USER': 'cltbld', 05:11:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:54 INFO - '_': '/tools/buildbot/bin/python'} 05:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:11:54 INFO - Cleaning up... 05:11:54 INFO - Return code: 0 05:11:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbb3b69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', '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:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:11:54 INFO - Using env: {'DISPLAY': ':0', 05:11:54 INFO - 'HOME': '/home/cltbld', 05:11:54 INFO - 'LANG': 'en_US.UTF-8', 05:11:54 INFO - 'LANGUAGE': 'en_US:en', 05:11:54 INFO - 'LOGNAME': 'cltbld', 05:11:54 INFO - 'MAIL': '/var/mail/cltbld', 05:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:54 INFO - 'MOZ_NO_REMOTE': '1', 05:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:54 INFO - 'NO_EM_RESTART': '1', 05:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:54 INFO - 'PWD': '/builds/slave/test', 05:11:54 INFO - 'SHELL': '/bin/bash', 05:11:54 INFO - 'SHLVL': '1', 05:11:54 INFO - 'TERM': 'linux', 05:11:54 INFO - 'TMOUT': '86400', 05:11:54 INFO - 'USER': 'cltbld', 05:11:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:54 INFO - '_': '/tools/buildbot/bin/python'} 05:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:54 INFO - Downloading/unpacking flake8 05:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:11:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:11:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:11:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:57 INFO - no previously-included directories found matching 'docs/_build' 05:11:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:11:57 INFO - Running setup.py install for pep8 05:11:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:11:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:11:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:11:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:11:57 INFO - no previously-included directories found matching 'docs/_build' 05:11:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:11:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:11:57 INFO - Cleaning up... 05:11:57 INFO - Return code: 0 05:11:57 INFO - Running post-action listener: _resource_record_post_action 05:11:57 INFO - Running post-action listener: _start_resource_monitoring 05:11:57 INFO - Starting resource monitoring. 05:11:57 INFO - ##### 05:11:57 INFO - ##### Finished create-virtualenv step (success) 05:11:57 INFO - ##### 05:11:57 INFO - ##### 05:11:57 INFO - ##### Running install step. 05:11:57 INFO - ##### 05:11:57 INFO - Running pre-action listener: _resource_record_pre_action 05:11:57 INFO - Running main action method: install 05:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:57 INFO - Reading from file tmpfile_stdout 05:11:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:57 INFO - Reading from file tmpfile_stdout 05:11:57 INFO - Output received: 05:11:57 INFO - Usage: mozinstall [options] installer 05:11:57 INFO - Options: 05:11:57 INFO - -h, --help show this help message and exit 05:11:57 INFO - -d DEST, --destination=DEST 05:11:57 INFO - Directory to install application into. [default: 05:11:57 INFO - "/builds/slave/test"] 05:11:57 INFO - --app=APP Application being installed. [default: firefox] 05:11:57 INFO - mkdir: /builds/slave/test/build/application 05:11:57 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:11:57 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:12:13 INFO - Reading from file tmpfile_stdout 05:12:13 INFO - Output received: 05:12:13 INFO - /builds/slave/test/build/application/firefox/firefox 05:12:13 INFO - Running post-action listener: _resource_record_post_action 05:12:13 INFO - ##### 05:12:13 INFO - ##### Finished install step (success) 05:12:13 INFO - ##### 05:12:13 INFO - ##### 05:12:13 INFO - ##### Running run-tests step. 05:12:13 INFO - ##### 05:12:13 INFO - Running pre-action listener: _resource_record_pre_action 05:12:13 INFO - Running main action method: run_tests 05:12:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:13 INFO - Python 2.7.3 05:12:13 INFO - Return code: 0 05:12:13 INFO - grabbing minidump binary from tooltool 05:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:13 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 0x13b82e0>, '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 0x1324140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13245d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:13 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:12:13 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:12:13 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:12:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:14 INFO - Return code: 0 05:12:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:12:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:12:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:12:14 INFO - Return code: 0 05:12:14 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:12:14 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:12:14 INFO - Using env: {'DISPLAY': ':0', 05:12:14 INFO - 'HOME': '/home/cltbld', 05:12:14 INFO - 'LANG': 'en_US.UTF-8', 05:12:14 INFO - 'LANGUAGE': 'en_US:en', 05:12:14 INFO - 'LOGNAME': 'cltbld', 05:12:14 INFO - 'MAIL': '/var/mail/cltbld', 05:12:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:14 INFO - 'MOZ_NO_REMOTE': '1', 05:12:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:14 INFO - 'NO_EM_RESTART': '1', 05:12:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:14 INFO - 'PWD': '/builds/slave/test', 05:12:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:14 INFO - 'SHELL': '/bin/bash', 05:12:14 INFO - 'SHLVL': '1', 05:12:14 INFO - 'TERM': 'linux', 05:12:14 INFO - 'TMOUT': '86400', 05:12:14 INFO - 'USER': 'cltbld', 05:12:14 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514', 05:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:14 INFO - '_': '/tools/buildbot/bin/python'} 05:12:14 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:12:15 INFO - mozversion application_buildid: 20160614043925 05:12:15 INFO - mozversion application_changeset: 4eb7afe97b2b470c9276a8af9c23910cdbd02563 05:12:15 INFO - mozversion application_display_name: Nightly 05:12:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:15 INFO - mozversion application_name: Firefox 05:12:15 INFO - mozversion application_remotingname: firefox 05:12:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:12:15 INFO - mozversion application_vendor: Mozilla 05:12:15 INFO - mozversion application_version: 50.0a1 05:12:15 INFO - mozversion platform_buildid: 20160614043925 05:12:15 INFO - mozversion platform_changeset: 4eb7afe97b2b470c9276a8af9c23910cdbd02563 05:12:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:12:15 INFO - mozversion platform_version: 50.0a1 05:12:15 INFO - using testdate: 1465906335 05:12:15 INFO - actual date: 1465906335 05:12:15 INFO - starting webserver on 'localhost:42404' 05:12:15 INFO - SUITE-START | Running 2 tests 05:12:15 INFO - TEST-START | dromaeo_css 05:12:15 INFO - operating with platform_type : linux_ 05:12:15 INFO - Initialising browser for dromaeo_css test... 05:12:15 INFO - TEST-INFO | started process 26596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ABWV_/profile http://localhost:42404/getInfo.html) 05:12:20 INFO - PROCESS | 26596 | __metrics Screen width/height:1600/1200 05:12:20 INFO - PROCESS | 26596 | colorDepth:24 05:12:20 INFO - PROCESS | 26596 | Browser inner width/height: 1024/697 05:12:20 INFO - PROCESS | 26596 | __metrics 05:12:21 ERROR - PROCESS | 26596 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:12:21 INFO - TEST-INFO | 26596: exit 0 05:12:21 INFO - Browser initialized. 05:12:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:21 INFO - TEST-INFO | started process 26716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9ABWV_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:34 INFO - PROCESS | 26716 | RSS: Main: 186302464 05:12:34 INFO - PROCESS | 26716 | 05:13:23 INFO - PROCESS | 26716 | 1465906403631 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:15:35 INFO - PROCESS | 26716 | Cycle 1(1): loaded http://localhost:42404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42404/tests/dromaeo/cssquery-ext.html) 05:15:36 INFO - PROCESS | 26716 | RSS: Main: 189448192 05:15:36 INFO - PROCESS | 26716 | 05:18:39 INFO - PROCESS | 26716 | Cycle 1(1): loaded http://localhost:42404/tests/dromaeo/cssquery-ext.html (next: http://localhost:42404/tests/dromaeo/cssquery-jquery.html) 05:18:39 INFO - PROCESS | 26716 | RSS: Main: 188383232 05:18:39 INFO - PROCESS | 26716 | 05:21:41 INFO - PROCESS | 26716 | Cycle 1(1): loaded http://localhost:42404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42404/tests/dromaeo/cssquery-mootools.html) 05:21:42 INFO - PROCESS | 26716 | RSS: Main: 190300160 05:21:42 INFO - PROCESS | 26716 | 05:24:44 INFO - PROCESS | 26716 | Cycle 1(1): loaded http://localhost:42404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42404/tests/dromaeo/cssquery-prototype.html) 05:24:44 INFO - PROCESS | 26716 | RSS: Main: 187023360 05:24:44 INFO - PROCESS | 26716 | 05:27:47 INFO - PROCESS | 26716 | Cycle 1(1): loaded http://localhost:42404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42404/tests/dromaeo/cssquery-yui.html) 05:27:48 INFO - PROCESS | 26716 | RSS: Main: 189394944 05:27:48 INFO - PROCESS | 26716 | 05:30:50 INFO - PROCESS | 26716 | Cycle 1(1): loaded http://localhost:42404/tests/dromaeo/cssquery-yui.html (next: http://localhost:42404/tests/dromaeo/cssquery-dojo.html) 05:30:51 INFO - PROCESS | 26716 | RSS: Main: 190533632 05:30:51 INFO - PROCESS | 26716 | 05:30:51 INFO - PROCESS | 26716 | __start_tp_report 05:30:51 INFO - PROCESS | 26716 | _x_x_mozilla_page_load 05:30:51 INFO - PROCESS | 26716 | _x_x_mozilla_page_load_details 05:30:51 INFO - PROCESS | 26716 | |i|pagename|runs| 05:30:51 INFO - PROCESS | 26716 | |0;dojo.html;2630.9079182228625;2697.716739742327;2719.632849565308;2721.1700431368427;2731.0441345529066;4821.3491178690865;4833;4860.05228980349;4930.80276788928;4985.900281994358;4719.480857105724;4849.199882019471;4892.266160075981;4892.4618291987945;4892.608591312695;4441.777911104448;4487.371767952489;4615.100055489181;4618.930716039262;4624.052069325797;594.6375255548527;4148.43996060531;4341.50072741634;4437.090396468732;4492.213862574036;4490.259107247301;4499.257622492301;4528.1622899763315;4543.432070991126;4599.471060828014;4550.749708766017;4558.270676691714;4561.589456948891;4586.564276393738;4608.746518941457;4278.893027674302;4469.508354081048;4485.3944717463055;4527.569880861313;4551.089782043605;4879.072976134523;4926.852194434173;4933.876653083666;4939.185034469308;5021.422536408323;5007.32401125847;5281.36623605166;5290.497402746733;5300.072487314743;5350.839474815762;5083.085044691954;5128.435872054071;5129.3075434816565;5166.147585648364;5218;4881.145799485112;4887.120318342661;4888.511148885154;4892.804287828518;4936.308916751657;5095.031943930641;5272;5338.839834804962;5348.03735327637;5348.652337598043;5111.463296353903;5125;5147.433782283946;5176.094183517869;5212.452692467236;5230.372355317386;5236.92144617831;5242.161254199386;5242.606804489678;5319.601029922771;5008.724520151427;5111.207762796773;5172.456892026283;5199.610029247821;5204.8959020819375;5155.072087024371;5186;5193.558547523503;5211.296474975829;5219.765110570033;4440.955590444119;4464.843730469418;4471.754053527087;4512.4133862597655;4526.79629416677;3768.4347347897487;3819.8854034379015;3835.1179228777537;3865.420186971977;3914.2954268231424;4490.3040028795585;4507.166174257773;4517.81928722854;4549.499555048942;4607.124646317189;5243.685378877203;5274.050670879202;5287.101192797234;5288.92066619001;5316.3354580677415;4359.476862776487;4466.3747075409465;4493.550644935545;4507.57178068083;4518.412606361152;4639.37368455261;4682.461516925529;4688.742119183409;4699.90789375416;4736.668433209711;4729.55069268419;4848.127337079219;4850.854474365775;4898.853034408973;4959.504049595012;5165.638405311592;5255.63210575256;5279.762410691605;5303.4696530346655;5326.307580014573;4900.803967841246;4915.4592994771265;4946.0355230729665;4962.42932062803;4967.379077615298;4902.92645610309;5087.542121209109;5151.25306830515;5175.4565770593545;5188.948110518997;5237.109691352555;5264.473552644705;5268.288781014668;5274.868128296824;5329.973350133225;5153.896922061463;5157.484251574812;5167.276581278549;5183.844484665466;5229.058769421541;4871.585915197106;5042.4705405931845;5048.570871475966;5176;5177.741112944413;4941.962187940573;4971.726555039508;5021.246812978083;5022.070916880389;5041.067402530543;5188.9740551297;5195.636305458582;5197.532222100029;5206.401263854554;5233.555147812479;4830.2996065571;4998.075356059141;5030.748462576929;5071.644984851173;5083.6187285952965 05:30:51 INFO - PROCESS | 26716 | |1;ext.html;563.7829435667264;569.8091139468278;586.5190543754121;588.8939990801657;602.9005214139668;37499.43750843736;38500.61499385005;38816.22367552651;39049.80475097628;39069.60930390695;38564.61435385645;39239.803800981026;39532.407013894815;39644.405333919945;39768.80115599418;7749.845003099935;7836.764897053097;7914.6438410271385;7920.881186782203;7935;7682.193369696185;7774.611269436534;7779.76660700177;7811.531308121503;7819.765407037798;7839.25527074927;7842.647080881346;7909.129995700497;7922.603869806487;7926.167752385974;7832.412569057315;7839.725609603636;7867.881981770278;7870.449068565203;7879.8030049248655;7860.960695196544;7944.880826787603;7962.124166341698;7972.601369931538;7984.8403031939615;37257.25485490275;37450.4382434261;37644.62355376466;37681.434778478346;37806.29871655755;3390.3049874775857;3771.679407250387;3808.6000969898314;3845.0771814764535;3903.9219215615813;29110.563341549892;29380.26549336262;30015;30021.849890750407;30801.229969250722;3525.735569832247;3547.1336243494716;3557.5730912290433;3590.4255319149074;3660.9200285915717;245728;246165;246853;247599;248350;45457;45755.542444575796;45771;45826.54173458223;45923.540764592595;34437.827810860785;35309.47035794465;35330.29339413249;35447.11382215465;35526.289474210374;14412;14499.782503262459;14513.274336283144;14515.05652132629;14582.19797911125;10747.140228781835;10800.1899857511;10808.89191108079;10812.621558245424;10864.511097000654;18106.818931810514;18156.909215453838;18374.17316220773;18421.63156736858;18443.72334414985;6807.2512023677355;6964.547304425196;7050.753223637148;7131.251218622074;7198.892016619755;792.1088775127981;853.7054716122927;871.5598622695499;971.5433746139303;982.9803403931882;28499.857500712365;28870.566941495894;28916.566251506243;31975.23108678109;32235.516467253008;900.7658008917729;937.6483818568037;997.2819569909653;1006.3207335048813;1011.701548043329;13794.65513362174;14321.6419589509;14530.564083077525;14589.708205835825;14687.55937321882;372479;377225;378745;378754;379136;47227.29159062617;47610;47634.76182619065;48141;48167.27749083767;1146.2606618730872;1189.149757923089;1204.0548169686754;1225.3444407242082;1228.0421271408316;26043.609345859448;26671.33321666974;26995.730042700106;27284;27447.725522744517;41392.79303603463;42024.36963445612;42140.578594214894;42148.789256053526;42168;293975;300972;355125;355226;356483;24978.125765598117;25187.496250074528;25258.494830103664;25362.365940851625;25375.492490149725;40895.386569202085;41761.791191045064;41960.58039419689;42761.57238427576;42927.785361072994;35692.82153589215;35986;36212.81893590621;36471.45292820557;36561;35895;35927.46108808422;36340.81829590835;36372.818135909154;36417.635823642486;34720.305593887475;35617;35631.64368356387;35684.46473302954;35841.28317433585;31187.37625247437;31678.841605791822;32441.351172975938;32933.83533082319;33056.338873222885;24702.752972470043;25164.622530662422;25361.61957570601;25485.617715733908;25703.10039148621 05:30:51 INFO - PROCESS | 26716 | |2;jquery.html;366.9614690457501;368.45468706314637;371.5411466838455;378.8465671403081;380.54334798242115;14649.487267945624;15915.283812228448;17646.117694115273;17736.645267094667;17748.11259437026;16052.919735401307;16410.343586256535;16851.241694123764;17128.486145415656;17137.14314284287;4972.502749725026;5153.458886816887;5153.793848246066;5154.561862241714;5172.922406163911;5051.166557518005;5069.822556210534;5100.081985242655;5117.48825117489;5149.433562308143;5366.624336296461;5423.566114710833;5441.891162176754;5466.562674985991;5468.2891224141;5264.789408423659;5292.841214763564;5299.788008479675;5309.097453432925;5351.117065684158;5073.771680274396;5162.225666150108;5182.196759502283;5200.271961925334;5244.160934250502;11532.827007594893;11696.766064678744;11771.646850594496;11789.646310610695;11823.054155667613;1875.1468082022784;1925.663008973424;1976.071246514136;2043.4584835018732;2049.7745248022707;9010.23413009895;9129.954350228272;9348.626054957793;10194;13442.932785336108;1651.900885946835;1738.617504149085;1816.1191821966336;1843.5759775251634;1844.2438600173998;67169.3283067168;67684.32315676879;67976.98034529436;68411.31588684149;69093;9664.565094570762;9883.604655813831;10038.598456061676;10134.847977280348;10323.896761032294;13476.39356228972;13533.661658458617;13547.458101675822;13592.66018349549;13706.588802335946;6979.4765392595755;7164.391026762679;7227.421806255487;7379.188289288174;7402.074740657418;6747.662616869137;6747.865042699119;6803.183617965876;6888.655567221619;6939.826504337432;4260;4288.50682171548;4298.699091063658;4389.736615803062;4442.867068897411;1776.067564528607;1820.644974230039;1827.2690923630655;1829.0945981739123;1901.9239230430906;789.7354386280546;803.7186984555359;832.3133414932705;900.8648702694649;929.7489677787095;16110.677786444205;17015.319387224372;17205.91397043007;17534.91232543829;17675.20461579232;827.6234313387395;835.1314632781961;861.4831101339272;862.3575436299872;874.7681864305964;9339.859902101474;9679.70960871175;9701.17540009093;9854.310198286195;9897.851532227023;401634;403106;422673;424266;432010;78267;81721.59139204385;84963.57518212369;85127.5743621278;86821;912.3248795891126;933.7385532051037;945.1588086602928;947.209080417845;949.9572519236651;14646.340914658653;16081.195940203177;16143.434979775651;16292.103934283728;16620.168991550618;27673.861630691717;32200.838995805807;33795.83102084474;37928;39441.60558394379;44143.77928110339;49468.75265623649;51730.48269517257;52076.47923520716;52410.47589524208;7352.852942941218;7656.272654097852;7657.387409007155;7766.339861111643;7806.92193078062;11432.542698291974;11684.240524365889;12111;12302.0773441994;12349.135560510678;10082;10206.744831379276;10310.482723501382;10326.432046237229;10677.466126693478;9105.726828195166;10034.598616055568;10078.244131690006;10097.596096156072;10318.329308594917;9969;9987.750306242111;10107.090361867173;10208.846867297145;10719.088877445505;6417.101605775289;6600.80197594073;6808.285130061272;6851.657417129024;7855.489393189425;9710.077542633438;9868.259880509135;10465.9476702616;10522.473876306001;10647.733806654896 05:30:51 INFO - PROCESS | 26716 | |3;mootools.html;1361.99319003405;1407.3401271596683;1505.5408100529341;1680.386658869513;1730.6625208084429;7012.298770122985;7581.431392645546;7654.808629784258;8144.592770361481;8147.26674599286;7754.573498457583;7977.9202207977905;8012.23883731046;8025.598720063988;8028.638711257993;2227.131418746694;2260.672202530632;2261.2198791416936;2264;2266.2408093288686;2177.2488491470417;2187.628103222456;2226.3988723044768;2229.3869185973904;2244.1808739809935;2224.043661225672;2238.6194346961056;2247.381969958258;2259.2996171186983;2259.5819773341987;2157.1802714968367;2160.762316145223;2179.3897708641525;2180.6510958246604;2216.612092883739;2157.568486302746;2186.191109289573;2188.0919418441326;2206.7572567017614;2212.7565967743535;7981.042274927046;8040.2361775631225;8042.839143217161;8049.275565199102;8063.596820159028;4646.79089440976;4756.7145971241835;4760.809567617292;4766.356541866873;4775.617950563947;2965.1549308447206;2993.895213667511;3053.923651908698;3062.969370306291;3064.724174824254;1014.523174108168;1025.3489034463096;1037.6600765274259;1052.831546952484;1062.9468526573717;10763.623273185402;10788;10796.784064318748;10803.459827008697;10811.243212975094;4325.84859529915;4351.19502891966;4410.779461027;4516;4526.886827829265;8526.65893364271;8567.186117318844;8611.052784193733;8629.266512346521;8640.913590864136;4642;4683.274092515666;4689.788959496763;4692.272697731857;4696.60078893291;3805.4482100095884;4167.249895018865;4313.223619748413;4326.156399502067;4345.9348109778375;3455.9827200863833;3490.47642853574;3537.4340105582983;3539.4867744177463;3672.210474747942;1019.3323373190424;1030.9432981186108;1047.5652604169184;1052.2318707343682;1054.2093429927554;755.7014979083232;864.8962124545095;873.5894129759004;894.7181637784078;918.169057003413;5495.862603434866;5539.335279766454;5550.888982220333;5585.916211256753;5781.392953739881;846.3525403066659;886.1360173830592;939.3002213351098;939.52553960251;942.1850099663742;3662.5788034375855;3771.132639492932;3833.8466461341236;3870.5161854768153;3944.6449819516383;9327.906720932704;9459.574319155518;9491.715248542554;9605.18355939753;9608.327417080738;9581.520923953774;9586.66446674377;9608.183304419063;9619.615215391446;9633;7275.636218189175;7538.849223015619;7626.313631773167;7642.235776422424;7643.082830060317;5221.295125158207;5277.815276465305;5430.728463576885;5436.836894893159;5619.185218143428;9132.589033493376;9142.771430714285;9195.494247816434;9215.078492150731;9280.211182049601;8660.523671197892;8988.415752976036;8999.37004409685;9229.123233292827;9300.209482193819;6054.939450605614;6444.838879027874;6562.639054852029;6629.270780214076;6670.966645166937;7541.773746787605;7588.924110758821;7612.7716168515035;7640.3505702015955;7646.502977306457;6404.775832845828;6730.764423245163;6756.256811750605;6783.118194634666;6852.931470685229;6603.867922641616;6628;6723.2604413515455;6757.526973112032;6844.4182244509775;6394.392532709571;6406.423421892052;6445.1943507061615;6476.5466417350335;6489.805305840832;4516.796744146455;4712.081144176853;4748.121597504334;4753.857384278477;4815.15734746425;4511.977440112779;4560;4565.109803588269;4604.631629469702;4700.388949436551 05:30:51 INFO - PROCESS | 26716 | |4;prototype.html;294.62582520199334;297.0938637156672;302.67311303791905;308.6188557131943;311.220392915746;4944.802207911679;4957.3059771632;5089.872753181172;5177.825313368389;5208.791648334067;5023.623228257886;5036.7481625918745;5075.213341931997;5075.619328550355;5096.796128154879;3899.1032062625613;3932.9016774580577;3983.1237127831832;3989.481367422231;3996;3867.2652196082795;3923.2349691809964;3963.2073585282915;3964.8612298569556;3969.4641223434755;3877.747946383476;3914.2367238388383;3931.6854651627946;3942.3889297158844;3983.58172391899;3926.391409331558;3939.153082087365;3943.507061617298;3958.4853968984135;3960.980195099035;3470.8958731238104;3491.720662347006;3504.351694936445;3511.4206155984234;3521.383757842393;4836.975815120937;4837.226043833005;4905.656604037718;4919.975400122977;4937.7777999990085;4468.84359047435;4485.237509623372;4514.345419914094;4515.36784850118;4517.390152329426;5249.818790772084;5250.579953603703;5250.7637156328055;5258.39528454225;5278.076336641073;3690.2988432197794;3802.752821066622;3816.9312592474153;3826.4260360945805;3830.616938306175;5541.722913854291;5589.301337332833;5597.704940974222;5598.964191624522;5620.634658747168;3921.137349783043;3922.980385098056;3923.293807114747;3925.9988702881155;3955.92088158241;3835.808209589565;3972.1857019310974;3984.541777695544;3985.442038114666;3990.341593637075;4504.977475112669;4520.683552151384;4528;4535.387722657465;4558.566936141061;5326.934613077323;5365.356157261153;5366.91949620756;5374.662022020434;5382.381026181961;1293.9482420703066;1298.2210673595955;1350.156152404747;1361.7335877633896;1373.574192000483;871.1941454154882;877.5173654490005;881.2421317666801;883.3330835219368;895.5029958373035;4135.627793498599;4161.564260330181;4199.538050814408;4207.179599977975;4233.682473814415;4805.471398146201;4816.373871396696;4875.414950205927;4889.364382630307;4902.646729569827;4111.527174374985;4116.197341518375;4143.948745371061;4162.2091802558025;4242.087951090531;2523.3943853475034;2641.7622413982835;2650.324167337355;2652.3501742073317;2661.574148136289;4620.722756634613;4630.814767409266;4657.580817726421;4659.347691323217;4660.04469083837;4957.454679985199;4972.389495514812;5009.624278179152;5009.974950125226;5011.173156429221;4246.87457823677;4606.147862645421;4615.330777037378;4620.214563524209;4642.976785116053;4779.976100119617;4839.733814640229;4840.152973229741;4860.95139048605;4899.951000489949;4655.790489427916;4702.882427939329;4707.764611769329;4725.763711814327;4732.763361831963;4356.845435959537;4520.16933142078;4578.985246491533;4586.678932474695;4588.977055114703;3578.785272883635;3587.8744243951337;3594.029612004692;3595.298916711321;3628.365036118616;4821.614270858393;4868.683535570177;4876.634252431011;4890.828820991248;5255.632105752714;5206.843794686166;5278.1027225372545;5287.57699384056;5291.9470805292995;5325.973370133124;5221.947780522146;5237.685738855681;5289.814856480005;5333.839984800462;5358.7856485741695;5074.873128171826;5127.307813445137;5172.224166374924;5196.4283928767045;5248.396434410091;5333.839984800462;5381.13901775714;5402.216678581505;5411.997560902491;5423.918641220306;5219.660722053054;5246.842594722164;5250.448702886142;5262.473752624707;5267.762950667153 05:30:51 INFO - PROCESS | 26716 | |5;yui.html;695.3498478922205;722.5086940880201;728.4427413029034;754.5548126605302;759.2673070486981;11505.4822532986;12441.502339906416;12510.749785004306;12529.122961392706;12532.498700051998;13060.151090179132;13173.40719667615;13209.273489958048;13230.801537976939;13236.735265294688;725.6952080126347;786.0567319216963;786.6617354537547;786.685325869651;788.7160622176012;780.8516381887451;784.2627929746048;784.3176436500253;789.1556035042507;790.7983464216617;828.7596596986866;831.1522247307743;833.6623667414707;837.9245867871921;838.7316058861167;823.1480417767611;825.686239229092;827.3133299361516;827.3960009193322;828.5898480252254;607.9118527813442;609.7042934176965;610.1305639463791;610.8472881779555;611.8745657140275;13410.664733381645;13449.596512104554;13468;13480.5281815136;13483.056186066979;13104.541341053113;13519.324033798272;13658.983239778725;13841.169529828243;13858.16850988944;10010.699679009642;10149.746256343577;10235.385876847413;10340.327878687936;10420.843687344695;3382.746294027958;3392.9830350848333;3418.8119653419053;3421.5038819371052;3441.8795342163153;43382.349264761055;60330.39669603336;60466.093008604905;61422;62272;10776.622818201326;10917.290376125526;10926.945365273281;11109.388983605979;11118.444077796077;19617.509562261057;19623.607527849363;19817.306394276133;19841.801581983997;20001.899990500246;7035.050268213828;7069.081019467436;7069.540479868792;7182.099690340688;7259.346658800628;3804.8287827047297;3869.1101046759404;3878.70909681775;3945.0531872351003;3953.8220780064967;2972.658144313388;3136.498160294342;3138.1997590614246;3140.8586613602442;3159.0680749179046;522.2610006840279;523.0950455711641;526.1318823940529;535.4003516061957;537.9515843574019;427.05194468280365;460.6591122569275;467.97894094765815;474.9240121580531;483.7968053417573;7103.2541583133025;7358.300961408658;7453.590052547053;7521.247875212544;7661.344625836107;462.96296296296214;502.04861786913597;510.8007876928001;512.2879197914901;529.1982646290872;3445.672661097192;3460.2906404187083;3515.20907795749;3534.505169276303;3565.090901820019;89095;94305.5284723572;95791.52104239434;96124.51937740267;96535;81742.18257817345;82452.58773706094;82932.58533707293;82959.5852020736;82997.17002830016;62215;72240.38798060076;73391;73759.26240737631;74048;7985.880211796712;8026.197380261927;8138.755837324889;8175.584627394878;8480.915190848013;43144.56855431406;43350.13299733924;43501;43651.90870228269;43701.562984369746;39869.202615948096;55028.72485637546;60551.69724151351;62406.687966559875;62625.68687156535;11890.34603096838;11894.940525297317;11915.94042029819;12119.81820272679;12316.753664926471;12021.278723276631;12453.367025139498;12471.563495277622;12642.115051946275;12814;11174.608888688857;11239.100871930063;11587.710307242387;11849.111316651113;11956.76086478283;11283.435828208721;11419.885801142214;11548.133889958455;12021.21862078997;12028.939855300667;10714.73213169677;11050.226484146033;11054.944725276322;11488;11494.827577586175;9740.659076932274;10206.826214985074;10242.385456872611;10271.126954208677;10341.74145646365;9221.17009469151;9314.487703176119;9463.810723785624;9568.856467152858;9755.365901216399 05:30:51 INFO - PROCESS | 26716 | __end_tp_report 05:30:51 INFO - PROCESS | 26716 | __start_cc_report 05:30:51 INFO - PROCESS | 26716 | _x_x_mozilla_cycle_collect,401 05:30:51 INFO - PROCESS | 26716 | __end_cc_report 05:30:51 INFO - PROCESS | 26716 | __startTimestamp1465907451017__endTimestamp 05:30:51 INFO - PROCESS | 26716 | 05:30:51 INFO - PROCESS | 26716 | ------- Summary: start ------- 05:30:51 INFO - PROCESS | 26716 | Number of tests: 6 05:30:51 INFO - PROCESS | 26716 | 05:30:51 INFO - PROCESS | 26716 | [#0] dojo.html Cycles:165 Average:4806.04 Median:4946.04 stddev:609.38 (12.3%) stddev-sans-first:586.88 05:30:51 INFO - PROCESS | 26716 | Values: 2630.9 2697.7 2719.6 2721.2 2731.0 4821.3 4833.0 4860.1 4930.8 4985.9 4719.5 4849.2 4892.3 4892.5 4892.6 4441.8 4487.4 4615.1 4618.9 4624.1 594.6 4148.4 4341.5 4437.1 4492.2 4490.3 4499.3 4528.2 4543.4 4599.5 4550.7 4558.3 4561.6 4586.6 4608.7 4278.9 4469.5 4485.4 4527.6 4551.1 4879.1 4926.9 4933.9 4939.2 5021.4 5007.3 5281.4 5290.5 5300.1 5350.8 5083.1 5128.4 5129.3 5166.1 5218.0 4881.1 4887.1 4888.5 4892.8 4936.3 5095.0 5272.0 5338.8 5348.0 5348.7 5111.5 5125.0 5147.4 5176.1 5212.5 5230.4 5236.9 5242.2 5242.6 5319.6 5008.7 5111.2 5172.5 5199.6 5204.9 5155.1 5186.0 5193.6 5211.3 5219.8 4441.0 4464.8 4471.8 4512.4 4526.8 3768.4 3819.9 3835.1 3865.4 3914.3 4490.3 4507.2 4517.8 4549.5 4607.1 5243.7 5274.1 5287.1 5288.9 5316.3 4359.5 4466.4 4493.6 4507.6 4518.4 4639.4 4682.5 4688.7 4699.9 4736.7 4729.6 4848.1 4850.9 4898.9 4959.5 5165.6 5255.6 5279.8 5303.5 5326.3 4900.8 4915.5 4946.0 4962.4 4967.4 4902.9 5087.5 5151.3 5175.5 5188.9 5237.1 5264.5 5268.3 5274.9 5330.0 5153.9 5157.5 5167.3 5183.8 5229.1 4871.6 5042.5 5048.6 5176.0 5177.7 4942.0 4971.7 5021.2 5022.1 5041.1 5189.0 5195.6 5197.5 5206.4 5233.6 4830.3 4998.1 5030.7 5071.6 5083.6 05:30:51 INFO - PROCESS | 26716 | 05:30:51 INFO - PROCESS | 26716 | [#1] ext.html Cycles:180 Average:46601.41 Median:36516.23 stddev:85218.58 (233.4%) stddev-sans-first:85387.54 05:30:51 INFO - PROCESS | 26716 | Values: 563.8 569.8 586.5 588.9 602.9 37499.4 38500.6 38816.2 39049.8 39069.6 38564.6 39239.8 39532.4 39644.4 39768.8 7749.8 7836.8 7914.6 7920.9 7935.0 7682.2 7774.6 7779.8 7811.5 7819.8 7839.3 7842.6 7909.1 7922.6 7926.2 7832.4 7839.7 7867.9 7870.4 7879.8 7861.0 7944.9 7962.1 7972.6 7984.8 37257.3 37450.4 37644.6 37681.4 37806.3 3390.3 3771.7 3808.6 3845.1 3903.9 29110.6 29380.3 30015.0 30021.8 30801.2 3525.7 3547.1 3557.6 3590.4 3660.9 245728.0 246165.0 246853.0 247599.0 248350.0 45457.0 45755.5 45771.0 45826.5 45923.5 34437.8 35309.5 35330.3 35447.1 35526.3 14412.0 14499.8 14513.3 14515.1 14582.2 10747.1 10800.2 10808.9 10812.6 10864.5 18106.8 18156.9 18374.2 18421.6 18443.7 6807.3 6964.5 7050.8 7131.3 7198.9 792.1 853.7 871.6 971.5 983.0 28499.9 28870.6 28916.6 31975.2 32235.5 900.8 937.6 997.3 1006.3 1011.7 13794.7 14321.6 14530.6 14589.7 14687.6 372479.0 377225.0 378745.0 378754.0 379136.0 47227.3 47610.0 47634.8 48141.0 48167.3 1146.3 1189.1 1204.1 1225.3 1228.0 26043.6 26671.3 26995.7 27284.0 27447.7 41392.8 42024.4 42140.6 42148.8 42168.0 293975.0 300972.0 355125.0 355226.0 356483.0 24978.1 25187.5 25258.5 25362.4 25375.5 40895.4 41761.8 41960.6 42761.6 42927.8 35692.8 35986.0 36212.8 36471.5 36561.0 35895.0 35927.5 36340.8 36372.8 36417.6 34720.3 35617.0 35631.6 35684.5 35841.3 31187.4 31678.8 32441.4 32933.8 33056.3 24702.8 25164.6 25361.6 25485.6 25703.1 05:30:51 INFO - PROCESS | 26716 | 05:30:51 INFO - PROCESS | 26716 | [#2] jquery.html Cycles:180 Average:24845.56 Median:26955.81 stddev:68818.57 (255.3%) stddev-sans-first:68987.08 05:30:51 INFO - PROCESS | 26716 | Values: 367.0 368.5 371.5 378.8 380.5 14649.5 15915.3 17646.1 17736.6 17748.1 16052.9 16410.3 16851.2 17128.5 17137.1 4972.5 5153.5 5153.8 5154.6 5172.9 5051.2 5069.8 5100.1 5117.5 5149.4 5366.6 5423.6 5441.9 5466.6 5468.3 5264.8 5292.8 5299.8 5309.1 5351.1 5073.8 5162.2 5182.2 5200.3 5244.2 11532.8 11696.8 11771.6 11789.6 11823.1 1875.1 1925.7 1976.1 2043.5 2049.8 9010.2 9130.0 9348.6 10194.0 13442.9 1651.9 1738.6 1816.1 1843.6 1844.2 67169.3 67684.3 67977.0 68411.3 69093.0 9664.6 9883.6 10038.6 10134.8 10323.9 13476.4 13533.7 13547.5 13592.7 13706.6 6979.5 7164.4 7227.4 7379.2 7402.1 6747.7 6747.9 6803.2 6888.7 6939.8 4260.0 4288.5 4298.7 4389.7 4442.9 1776.1 1820.6 1827.3 1829.1 1901.9 789.7 803.7 832.3 900.9 929.7 16110.7 17015.3 17205.9 17534.9 17675.2 827.6 835.1 861.5 862.4 874.8 9339.9 9679.7 9701.2 9854.3 9897.9 401634.0 403106.0 422673.0 424266.0 432010.0 78267.0 81721.6 84963.6 85127.6 86821.0 912.3 933.7 945.2 947.2 950.0 14646.3 16081.2 16143.4 16292.1 16620.2 27673.9 32200.8 33795.8 37928.0 39441.6 44143.8 49468.8 51730.5 52076.5 52410.5 7352.9 7656.3 7657.4 7766.3 7806.9 11432.5 11684.2 12111.0 12302.1 12349.1 10082.0 10206.7 10310.5 10326.4 10677.5 9105.7 10034.6 10078.2 10097.6 10318.3 9969.0 9987.8 10107.1 10208.8 10719.1 6417.1 6600.8 6808.3 6851.7 7855.5 9710.1 9868.3 10465.9 10522.5 10647.7 05:30:51 INFO - PROCESS | 26716 | 05:30:51 INFO - PROCESS | 26716 | [#3] mootools.html Cycles:180 Average:5196.92 Median:5249.56 stddev:2869.82 (54.7%) stddev-sans-first:2863.40 05:30:51 INFO - PROCESS | 26716 | Values: 1362.0 1407.3 1505.5 1680.4 1730.7 7012.3 7581.4 7654.8 8144.6 8147.3 7754.6 7977.9 8012.2 8025.6 8028.6 2227.1 2260.7 2261.2 2264.0 2266.2 2177.2 2187.6 2226.4 2229.4 2244.2 2224.0 2238.6 2247.4 2259.3 2259.6 2157.2 2160.8 2179.4 2180.7 2216.6 2157.6 2186.2 2188.1 2206.8 2212.8 7981.0 8040.2 8042.8 8049.3 8063.6 4646.8 4756.7 4760.8 4766.4 4775.6 2965.2 2993.9 3053.9 3063.0 3064.7 1014.5 1025.3 1037.7 1052.8 1062.9 10763.6 10788.0 10796.8 10803.5 10811.2 4325.8 4351.2 4410.8 4516.0 4526.9 8526.7 8567.2 8611.1 8629.3 8640.9 4642.0 4683.3 4689.8 4692.3 4696.6 3805.4 4167.2 4313.2 4326.2 4345.9 3456.0 3490.5 3537.4 3539.5 3672.2 1019.3 1030.9 1047.6 1052.2 1054.2 755.7 864.9 873.6 894.7 918.2 5495.9 5539.3 5550.9 5585.9 5781.4 846.4 886.1 939.3 939.5 942.2 3662.6 3771.1 3833.8 3870.5 3944.6 9327.9 9459.6 9491.7 9605.2 9608.3 9581.5 9586.7 9608.2 9619.6 9633.0 7275.6 7538.8 7626.3 7642.2 7643.1 5221.3 5277.8 5430.7 5436.8 5619.2 9132.6 9142.8 9195.5 9215.1 9280.2 8660.5 8988.4 8999.4 9229.1 9300.2 6054.9 6444.8 6562.6 6629.3 6671.0 7541.8 7588.9 7612.8 7640.4 7646.5 6404.8 6730.8 6756.3 6783.1 6852.9 6603.9 6628.0 6723.3 6757.5 6844.4 6394.4 6406.4 6445.2 6476.5 6489.8 4516.8 4712.1 4748.1 4753.9 4815.2 4512.0 4560.0 4565.1 4604.6 4700.4 05:30:51 INFO - PROCESS | 26716 | 05:30:51 INFO - PROCESS | 26716 | [#4] prototype.html Cycles:180 Average:4242.54 Median:4636.90 stddev:1221.60 (26.3%) stddev-sans-first:1188.54 05:30:51 INFO - PROCESS | 26716 | Values: 294.6 297.1 302.7 308.6 311.2 4944.8 4957.3 5089.9 5177.8 5208.8 5023.6 5036.7 5075.2 5075.6 5096.8 3899.1 3932.9 3983.1 3989.5 3996.0 3867.3 3923.2 3963.2 3964.9 3969.5 3877.7 3914.2 3931.7 3942.4 3983.6 3926.4 3939.2 3943.5 3958.5 3961.0 3470.9 3491.7 3504.4 3511.4 3521.4 4837.0 4837.2 4905.7 4920.0 4937.8 4468.8 4485.2 4514.3 4515.4 4517.4 5249.8 5250.6 5250.8 5258.4 5278.1 3690.3 3802.8 3816.9 3826.4 3830.6 5541.7 5589.3 5597.7 5599.0 5620.6 3921.1 3923.0 3923.3 3926.0 3955.9 3835.8 3972.2 3984.5 3985.4 3990.3 4505.0 4520.7 4528.0 4535.4 4558.6 5326.9 5365.4 5366.9 5374.7 5382.4 1293.9 1298.2 1350.2 1361.7 1373.6 871.2 877.5 881.2 883.3 895.5 4135.6 4161.6 4199.5 4207.2 4233.7 4805.5 4816.4 4875.4 4889.4 4902.6 4111.5 4116.2 4143.9 4162.2 4242.1 2523.4 2641.8 2650.3 2652.4 2661.6 4620.7 4630.8 4657.6 4659.3 4660.0 4957.5 4972.4 5009.6 5010.0 5011.2 4246.9 4606.1 4615.3 4620.2 4643.0 4780.0 4839.7 4840.2 4861.0 4900.0 4655.8 4702.9 4707.8 4725.8 4732.8 4356.8 4520.2 4579.0 4586.7 4589.0 3578.8 3587.9 3594.0 3595.3 3628.4 4821.6 4868.7 4876.6 4890.8 5255.6 5206.8 5278.1 5287.6 5291.9 5326.0 5221.9 5237.7 5289.8 5333.8 5358.8 5074.9 5127.3 5172.2 5196.4 5248.4 5333.8 5381.1 5402.2 5412.0 5423.9 5219.7 5246.8 5250.4 5262.5 5267.8 05:30:51 INFO - PROCESS | 26716 | 05:30:51 INFO - PROCESS | 26716 | [#5] yui.html Cycles:180 Average:17221.52 Median:43676.74 stddev:24241.89 (55.5%) stddev-sans-first:24278.13 05:30:51 INFO - PROCESS | 26716 | Values: 695.3 722.5 728.4 754.6 759.3 11505.5 12441.5 12510.7 12529.1 12532.5 13060.2 13173.4 13209.3 13230.8 13236.7 725.7 786.1 786.7 786.7 788.7 780.9 784.3 784.3 789.2 790.8 828.8 831.2 833.7 837.9 838.7 823.1 825.7 827.3 827.4 828.6 607.9 609.7 610.1 610.8 611.9 13410.7 13449.6 13468.0 13480.5 13483.1 13104.5 13519.3 13659.0 13841.2 13858.2 10010.7 10149.7 10235.4 10340.3 10420.8 3382.7 3393.0 3418.8 3421.5 3441.9 43382.3 60330.4 60466.1 61422.0 62272.0 10776.6 10917.3 10926.9 11109.4 11118.4 19617.5 19623.6 19817.3 19841.8 20001.9 7035.1 7069.1 7069.5 7182.1 7259.3 3804.8 3869.1 3878.7 3945.1 3953.8 2972.7 3136.5 3138.2 3140.9 3159.1 522.3 523.1 526.1 535.4 538.0 427.1 460.7 468.0 474.9 483.8 7103.3 7358.3 7453.6 7521.2 7661.3 463.0 502.0 510.8 512.3 529.2 3445.7 3460.3 3515.2 3534.5 3565.1 89095.0 94305.5 95791.5 96124.5 96535.0 81742.2 82452.6 82932.6 82959.6 82997.2 62215.0 72240.4 73391.0 73759.3 74048.0 7985.9 8026.2 8138.8 8175.6 8480.9 43144.6 43350.1 43501.0 43651.9 43701.6 39869.2 55028.7 60551.7 62406.7 62625.7 11890.3 11894.9 11915.9 12119.8 12316.8 12021.3 12453.4 12471.6 12642.1 12814.0 11174.6 11239.1 11587.7 11849.1 11956.8 11283.4 11419.9 11548.1 12021.2 12028.9 10714.7 11050.2 11054.9 11488.0 11494.8 9740.7 10206.8 10242.4 10271.1 10341.7 9221.2 9314.5 9463.8 9568.9 9755.4 05:30:51 INFO - PROCESS | 26716 | -------- Summary: end -------- 05:30:51 INFO - PROCESS | 26716 | 05:30:51 INFO - TEST-INFO | 26716: exit 0 05:30:51 INFO - TEST-OK | dromaeo_css | took 1116634ms 05:30:51 INFO - TEST-START | kraken 05:30:51 INFO - operating with platform_type : linux_ 05:30:51 INFO - Initialising browser for kraken test... 05:30:51 INFO - TEST-INFO | started process 26954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPatT8t/profile http://localhost:42404/getInfo.html) 05:30:56 INFO - PROCESS | 26954 | __metrics Screen width/height:1600/1200 05:30:56 INFO - PROCESS | 26954 | colorDepth:24 05:30:56 INFO - PROCESS | 26954 | Browser inner width/height: 1024/697 05:30:56 INFO - PROCESS | 26954 | __metrics 05:30:57 ERROR - PROCESS | 26954 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:30:58 INFO - TEST-INFO | 26954: exit 0 05:30:58 INFO - Browser initialized. 05:30:58 INFO - Running cycle 1/1 for kraken test... 05:30:58 INFO - TEST-INFO | started process 27074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPatT8t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:10 INFO - PROCESS | 27074 | RSS: Main: 186613760 05:31:10 INFO - PROCESS | 27074 | 05:31:13 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42404/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:14 INFO - PROCESS | 27074 | RSS: Main: 191012864 05:31:14 INFO - PROCESS | 27074 | 05:31:16 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42404/tests/kraken/driver.html?testName=audio-dft) 05:31:17 INFO - PROCESS | 27074 | RSS: Main: 190808064 05:31:17 INFO - PROCESS | 27074 | 05:31:20 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42404/tests/kraken/driver.html?testName=audio-fft) 05:31:21 INFO - PROCESS | 27074 | RSS: Main: 186531840 05:31:21 INFO - PROCESS | 27074 | 05:31:23 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42404/tests/kraken/driver.html?testName=audio-oscillator) 05:31:23 INFO - PROCESS | 27074 | RSS: Main: 187334656 05:31:23 INFO - PROCESS | 27074 | 05:31:26 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:26 INFO - PROCESS | 27074 | RSS: Main: 187707392 05:31:26 INFO - PROCESS | 27074 | 05:31:29 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42404/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:30 INFO - PROCESS | 27074 | RSS: Main: 187858944 05:31:30 INFO - PROCESS | 27074 | 05:31:34 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42404/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:34 INFO - PROCESS | 27074 | RSS: Main: 185217024 05:31:34 INFO - PROCESS | 27074 | 05:31:37 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42404/tests/kraken/driver.html?testName=json-parse-financial) 05:31:38 INFO - PROCESS | 27074 | RSS: Main: 186843136 05:31:38 INFO - PROCESS | 27074 | 05:31:40 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:40 INFO - PROCESS | 27074 | RSS: Main: 187146240 05:31:40 INFO - PROCESS | 27074 | 05:31:42 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42404/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:43 INFO - PROCESS | 27074 | RSS: Main: 187011072 05:31:43 INFO - PROCESS | 27074 | 05:31:45 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:46 INFO - PROCESS | 27074 | RSS: Main: 187363328 05:31:46 INFO - PROCESS | 27074 | 05:31:49 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:49 INFO - PROCESS | 27074 | RSS: Main: 187404288 05:31:49 INFO - PROCESS | 27074 | 05:31:52 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:53 INFO - PROCESS | 27074 | RSS: Main: 187437056 05:31:53 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | Cycle 1(1): loaded http://localhost:42404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42404/tests/kraken/driver.html?testName=ai-astar) 05:31:55 INFO - PROCESS | 27074 | RSS: Main: 188526592 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | __start_tp_report 05:31:55 INFO - PROCESS | 27074 | _x_x_mozilla_page_load 05:31:55 INFO - PROCESS | 27074 | _x_x_mozilla_page_load_details 05:31:55 INFO - PROCESS | 27074 | |i|pagename|runs| 05:31:55 INFO - PROCESS | 27074 | |0;ai-astar;112;107;113;114;114;114;112;112;115;112 05:31:55 INFO - PROCESS | 27074 | |1;audio-beat-detection;162;130;157;174;134;158;157;132;196;131 05:31:55 INFO - PROCESS | 27074 | |2;audio-dft;165;165;167;168;162;163;162;164;162;161 05:31:55 INFO - PROCESS | 27074 | |3;audio-fft;76;76;78;162;77;76;77;76;163;77 05:31:55 INFO - PROCESS | 27074 | |4;audio-oscillator;86;86;137;87;85;85;134;86;86;129 05:31:55 INFO - PROCESS | 27074 | |5;imaging-gaussian-blur;117;118;118;118;119;118;117;119;119;117 05:31:55 INFO - PROCESS | 27074 | |6;imaging-darkroom;148;149;147;150;148;148;146;148;148;150 05:31:55 INFO - PROCESS | 27074 | |7;imaging-desaturate;96;95;96;95;96;96;95;96;97;96 05:31:55 INFO - PROCESS | 27074 | |8;json-parse-financial;67;71;66;67;66;67;66;65;65;67 05:31:55 INFO - PROCESS | 27074 | |9;json-stringify-tinderbox;66;66;66;65;65;65;65;66;65;69 05:31:55 INFO - PROCESS | 27074 | |10;stanford-crypto-aes;85;83;85;83;87;85;84;85;111;85 05:31:55 INFO - PROCESS | 27074 | |11;stanford-crypto-ccm;139;146;151;135;146;141;157;155;146;140 05:31:55 INFO - PROCESS | 27074 | |12;stanford-crypto-pbkdf2;175;181;174;175;167;174;175;168;173;166 05:31:55 INFO - PROCESS | 27074 | |13;stanford-crypto-sha256-iterative;69;69;67;69;69;68;66;68;67;73 05:31:55 INFO - PROCESS | 27074 | __end_tp_report 05:31:55 INFO - PROCESS | 27074 | __start_cc_report 05:31:55 INFO - PROCESS | 27074 | _x_x_mozilla_cycle_collect,990 05:31:55 INFO - PROCESS | 27074 | __end_cc_report 05:31:55 INFO - PROCESS | 27074 | __startTimestamp1465907515447__endTimestamp 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | ------- Summary: start ------- 05:31:55 INFO - PROCESS | 27074 | Number of tests: 14 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:2.22 (2.0%) stddev-sans-first:2.35 05:31:55 INFO - PROCESS | 27074 | Values: 112.0 107.0 113.0 114.0 114.0 114.0 112.0 112.0 115.0 112.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:157.50 stddev:21.71 (13.8%) stddev-sans-first:22.79 05:31:55 INFO - PROCESS | 27074 | Values: 162.0 130.0 157.0 174.0 134.0 158.0 157.0 132.0 196.0 131.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.50 stddev:2.33 (1.4%) stddev-sans-first:2.44 05:31:55 INFO - PROCESS | 27074 | Values: 165.0 165.0 167.0 168.0 162.0 163.0 162.0 164.0 162.0 161.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.50 stddev:36.21 (47.3%) stddev-sans-first:37.83 05:31:55 INFO - PROCESS | 27074 | Values: 76.0 76.0 78.0 162.0 77.0 76.0 77.0 76.0 163.0 77.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#4] audio-oscillator Cycles:10 Average:100.10 Median:86.00 stddev:23.02 (26.8%) stddev-sans-first:23.84 05:31:55 INFO - PROCESS | 27074 | Values: 86.0 86.0 137.0 87.0 85.0 85.0 134.0 86.0 86.0 129.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 05:31:55 INFO - PROCESS | 27074 | Values: 117.0 118.0 118.0 118.0 119.0 118.0 117.0 119.0 119.0 117.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 05:31:55 INFO - PROCESS | 27074 | Values: 148.0 149.0 147.0 150.0 148.0 148.0 146.0 148.0 148.0 150.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:31:55 INFO - PROCESS | 27074 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 97.0 96.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:67.00 stddev:1.70 (2.5%) stddev-sans-first:1.80 05:31:55 INFO - PROCESS | 27074 | Values: 67.0 71.0 66.0 67.0 66.0 67.0 66.0 65.0 65.0 67.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:1.23 (1.9%) stddev-sans-first:1.30 05:31:55 INFO - PROCESS | 27074 | Values: 66.0 66.0 66.0 65.0 65.0 65.0 65.0 66.0 65.0 69.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:85.00 stddev:8.41 (9.9%) stddev-sans-first:8.88 05:31:55 INFO - PROCESS | 27074 | Values: 85.0 83.0 85.0 83.0 87.0 85.0 84.0 85.0 111.0 85.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:146.00 stddev:7.12 (4.9%) stddev-sans-first:7.14 05:31:55 INFO - PROCESS | 27074 | Values: 139.0 146.0 151.0 135.0 146.0 141.0 157.0 155.0 146.0 140.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:174.50 stddev:4.57 (2.6%) stddev-sans-first:4.77 05:31:55 INFO - PROCESS | 27074 | Values: 175.0 181.0 174.0 175.0 167.0 174.0 175.0 168.0 173.0 166.0 05:31:55 INFO - PROCESS | 27074 | 05:31:55 INFO - PROCESS | 27074 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.90 (2.8%) stddev-sans-first:2.01 05:31:55 INFO - PROCESS | 27074 | Values: 69.0 69.0 67.0 69.0 69.0 68.0 66.0 68.0 67.0 73.0 05:31:55 INFO - PROCESS | 27074 | -------- Summary: end -------- 05:31:55 INFO - PROCESS | 27074 | 05:31:56 INFO - TEST-INFO | 27074: exit 0 05:31:56 INFO - TEST-OK | kraken | took 64805ms 05:31:56 INFO - SUITE-END | took 1181s 05:31:56 INFO - Completed test suite (00:19:41) 05:31:56 INFO - javascript benchmark 05:31:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6421.007465357271, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2630.9079182228625, 2697.716739742327, 2719.632849565308, 2721.1700431368427, 2731.0441345529066, 4821.3491178690865, 4833.0, 4860.05228980349, 4930.80276788928, 4985.900281994358, 4719.480857105724, 4849.199882019471, 4892.266160075981, 4892.4618291987945, 4892.608591312695, 4441.777911104448, 4487.371767952489, 4615.100055489181, 4618.930716039262, 4624.052069325797, 594.6375255548527, 4148.43996060531, 4341.50072741634, 4437.090396468732, 4492.213862574036, 4490.259107247301, 4499.257622492301, 4528.1622899763315, 4543.432070991126, 4599.471060828014, 4550.749708766017, 4558.270676691714, 4561.589456948891, 4586.564276393738, 4608.746518941457, 4278.893027674302, 4469.508354081048, 4485.3944717463055, 4527.569880861313, 4551.089782043605, 4879.072976134523, 4926.852194434173, 4933.876653083666, 4939.185034469308, 5021.422536408323, 5007.32401125847, 5281.36623605166, 5290.497402746733, 5300.072487314743, 5350.839474815762, 5083.085044691954, 5128.435872054071, 5129.3075434816565, 5166.147585648364, 5218.0, 4881.145799485112, 4887.120318342661, 4888.511148885154, 4892.804287828518, 4936.308916751657, 5095.031943930641, 5272.0, 5338.839834804962, 5348.03735327637, 5348.652337598043, 5111.463296353903, 5125.0, 5147.433782283946, 5176.094183517869, 5212.452692467236, 5230.372355317386, 5236.92144617831, 5242.161254199386, 5242.606804489678, 5319.601029922771, 5008.724520151427, 5111.207762796773, 5172.456892026283, 5199.610029247821, 5204.8959020819375, 5155.072087024371, 5186.0, 5193.558547523503, 5211.296474975829, 5219.765110570033, 4440.955590444119, 4464.843730469418, 4471.754053527087, 4512.4133862597655, 4526.79629416677, 3768.4347347897487, 3819.8854034379015, 3835.1179228777537, 3865.420186971977, 3914.2954268231424, 4490.3040028795585, 4507.166174257773, 4517.81928722854, 4549.499555048942, 4607.124646317189, 5243.685378877203, 5274.050670879202, 5287.101192797234, 5288.92066619001, 5316.3354580677415, 4359.476862776487, 4466.3747075409465, 4493.550644935545, 4507.57178068083, 4518.412606361152, 4639.37368455261, 4682.461516925529, 4688.742119183409, 4699.90789375416, 4736.668433209711, 4729.55069268419, 4848.127337079219, 4850.854474365775, 4898.853034408973, 4959.504049595012, 5165.638405311592, 5255.63210575256, 5279.762410691605, 5303.4696530346655, 5326.307580014573, 4900.803967841246, 4915.4592994771265, 4946.0355230729665, 4962.42932062803, 4967.379077615298, 4902.92645610309, 5087.542121209109, 5151.25306830515, 5175.4565770593545, 5188.948110518997, 5237.109691352555, 5264.473552644705, 5268.288781014668, 5274.868128296824, 5329.973350133225, 5153.896922061463, 5157.484251574812, 5167.276581278549, 5183.844484665466, 5229.058769421541, 4871.585915197106, 5042.4705405931845, 5048.570871475966, 5176.0, 5177.741112944413, 4941.962187940573, 4971.726555039508, 5021.246812978083, 5022.070916880389, 5041.067402530543, 5188.9740551297, 5195.636305458582, 5197.532222100029, 5206.401263854554, 5233.555147812479, 4830.2996065571, 4998.075356059141, 5030.748462576929, 5071.644984851173, 5083.6187285952965], "value": 4768.071117442857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.7829435667264, 569.8091139468278, 586.5190543754121, 588.8939990801657, 602.9005214139668, 37499.43750843736, 38500.61499385005, 38816.22367552651, 39049.80475097628, 39069.60930390695, 38564.61435385645, 39239.803800981026, 39532.407013894815, 39644.405333919945, 39768.80115599418, 7749.845003099935, 7836.764897053097, 7914.6438410271385, 7920.881186782203, 7935.0, 7682.193369696185, 7774.611269436534, 7779.76660700177, 7811.531308121503, 7819.765407037798, 7839.25527074927, 7842.647080881346, 7909.129995700497, 7922.603869806487, 7926.167752385974, 7832.412569057315, 7839.725609603636, 7867.881981770278, 7870.449068565203, 7879.8030049248655, 7860.960695196544, 7944.880826787603, 7962.124166341698, 7972.601369931538, 7984.8403031939615, 37257.25485490275, 37450.4382434261, 37644.62355376466, 37681.434778478346, 37806.29871655755, 3390.3049874775857, 3771.679407250387, 3808.6000969898314, 3845.0771814764535, 3903.9219215615813, 29110.563341549892, 29380.26549336262, 30015.0, 30021.849890750407, 30801.229969250722, 3525.735569832247, 3547.1336243494716, 3557.5730912290433, 3590.4255319149074, 3660.9200285915717, 245728.0, 246165.0, 246853.0, 247599.0, 248350.0, 45457.0, 45755.542444575796, 45771.0, 45826.54173458223, 45923.540764592595, 34437.827810860785, 35309.47035794465, 35330.29339413249, 35447.11382215465, 35526.289474210374, 14412.0, 14499.782503262459, 14513.274336283144, 14515.05652132629, 14582.19797911125, 10747.140228781835, 10800.1899857511, 10808.89191108079, 10812.621558245424, 10864.511097000654, 18106.818931810514, 18156.909215453838, 18374.17316220773, 18421.63156736858, 18443.72334414985, 6807.2512023677355, 6964.547304425196, 7050.753223637148, 7131.251218622074, 7198.892016619755, 792.1088775127981, 853.7054716122927, 871.5598622695499, 971.5433746139303, 982.9803403931882, 28499.857500712365, 28870.566941495894, 28916.566251506243, 31975.23108678109, 32235.516467253008, 900.7658008917729, 937.6483818568037, 997.2819569909653, 1006.3207335048813, 1011.701548043329, 13794.65513362174, 14321.6419589509, 14530.564083077525, 14589.708205835825, 14687.55937321882, 372479.0, 377225.0, 378745.0, 378754.0, 379136.0, 47227.29159062617, 47610.0, 47634.76182619065, 48141.0, 48167.27749083767, 1146.2606618730872, 1189.149757923089, 1204.0548169686754, 1225.3444407242082, 1228.0421271408316, 26043.609345859448, 26671.33321666974, 26995.730042700106, 27284.0, 27447.725522744517, 41392.79303603463, 42024.36963445612, 42140.578594214894, 42148.789256053526, 42168.0, 293975.0, 300972.0, 355125.0, 355226.0, 356483.0, 24978.125765598117, 25187.496250074528, 25258.494830103664, 25362.365940851625, 25375.492490149725, 40895.386569202085, 41761.791191045064, 41960.58039419689, 42761.57238427576, 42927.785361072994, 35692.82153589215, 35986.0, 36212.81893590621, 36471.45292820557, 36561.0, 35895.0, 35927.46108808422, 36340.81829590835, 36372.818135909154, 36417.635823642486, 34720.305593887475, 35617.0, 35631.64368356387, 35684.46473302954, 35841.28317433585, 31187.37625247437, 31678.841605791822, 32441.351172975938, 32933.83533082319, 33056.338873222885, 24702.752972470043, 25164.622530662422, 25361.61957570601, 25485.617715733908, 25703.10039148621], "value": 17330.27834026051, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.9614690457501, 368.45468706314637, 371.5411466838455, 378.8465671403081, 380.54334798242115, 14649.487267945624, 15915.283812228448, 17646.117694115273, 17736.645267094667, 17748.11259437026, 16052.919735401307, 16410.343586256535, 16851.241694123764, 17128.486145415656, 17137.14314284287, 4972.502749725026, 5153.458886816887, 5153.793848246066, 5154.561862241714, 5172.922406163911, 5051.166557518005, 5069.822556210534, 5100.081985242655, 5117.48825117489, 5149.433562308143, 5366.624336296461, 5423.566114710833, 5441.891162176754, 5466.562674985991, 5468.2891224141, 5264.789408423659, 5292.841214763564, 5299.788008479675, 5309.097453432925, 5351.117065684158, 5073.771680274396, 5162.225666150108, 5182.196759502283, 5200.271961925334, 5244.160934250502, 11532.827007594893, 11696.766064678744, 11771.646850594496, 11789.646310610695, 11823.054155667613, 1875.1468082022784, 1925.663008973424, 1976.071246514136, 2043.4584835018732, 2049.7745248022707, 9010.23413009895, 9129.954350228272, 9348.626054957793, 10194.0, 13442.932785336108, 1651.900885946835, 1738.617504149085, 1816.1191821966336, 1843.5759775251634, 1844.2438600173998, 67169.3283067168, 67684.32315676879, 67976.98034529436, 68411.31588684149, 69093.0, 9664.565094570762, 9883.604655813831, 10038.598456061676, 10134.847977280348, 10323.896761032294, 13476.39356228972, 13533.661658458617, 13547.458101675822, 13592.66018349549, 13706.588802335946, 6979.4765392595755, 7164.391026762679, 7227.421806255487, 7379.188289288174, 7402.074740657418, 6747.662616869137, 6747.865042699119, 6803.183617965876, 6888.655567221619, 6939.826504337432, 4260.0, 4288.50682171548, 4298.699091063658, 4389.736615803062, 4442.867068897411, 1776.067564528607, 1820.644974230039, 1827.2690923630655, 1829.0945981739123, 1901.9239230430906, 789.7354386280546, 803.7186984555359, 832.3133414932705, 900.8648702694649, 929.7489677787095, 16110.677786444205, 17015.319387224372, 17205.91397043007, 17534.91232543829, 17675.20461579232, 827.6234313387395, 835.1314632781961, 861.4831101339272, 862.3575436299872, 874.7681864305964, 9339.859902101474, 9679.70960871175, 9701.17540009093, 9854.310198286195, 9897.851532227023, 401634.0, 403106.0, 422673.0, 424266.0, 432010.0, 78267.0, 81721.59139204385, 84963.57518212369, 85127.5743621278, 86821.0, 912.3248795891126, 933.7385532051037, 945.1588086602928, 947.209080417845, 949.9572519236651, 14646.340914658653, 16081.195940203177, 16143.434979775651, 16292.103934283728, 16620.168991550618, 27673.861630691717, 32200.838995805807, 33795.83102084474, 37928.0, 39441.60558394379, 44143.77928110339, 49468.75265623649, 51730.48269517257, 52076.47923520716, 52410.47589524208, 7352.852942941218, 7656.272654097852, 7657.387409007155, 7766.339861111643, 7806.92193078062, 11432.542698291974, 11684.240524365889, 12111.0, 12302.0773441994, 12349.135560510678, 10082.0, 10206.744831379276, 10310.482723501382, 10326.432046237229, 10677.466126693478, 9105.726828195166, 10034.598616055568, 10078.244131690006, 10097.596096156072, 10318.329308594917, 9969.0, 9987.750306242111, 10107.090361867173, 10208.846867297145, 10719.088877445505, 6417.101605775289, 6600.80197594073, 6808.285130061272, 6851.657417129024, 7855.489393189425, 9710.077542633438, 9868.259880509135, 10465.9476702616, 10522.473876306001, 10647.733806654896], "value": 8073.708587091829, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.99319003405, 1407.3401271596683, 1505.5408100529341, 1680.386658869513, 1730.6625208084429, 7012.298770122985, 7581.431392645546, 7654.808629784258, 8144.592770361481, 8147.26674599286, 7754.573498457583, 7977.9202207977905, 8012.23883731046, 8025.598720063988, 8028.638711257993, 2227.131418746694, 2260.672202530632, 2261.2198791416936, 2264.0, 2266.2408093288686, 2177.2488491470417, 2187.628103222456, 2226.3988723044768, 2229.3869185973904, 2244.1808739809935, 2224.043661225672, 2238.6194346961056, 2247.381969958258, 2259.2996171186983, 2259.5819773341987, 2157.1802714968367, 2160.762316145223, 2179.3897708641525, 2180.6510958246604, 2216.612092883739, 2157.568486302746, 2186.191109289573, 2188.0919418441326, 2206.7572567017614, 2212.7565967743535, 7981.042274927046, 8040.2361775631225, 8042.839143217161, 8049.275565199102, 8063.596820159028, 4646.79089440976, 4756.7145971241835, 4760.809567617292, 4766.356541866873, 4775.617950563947, 2965.1549308447206, 2993.895213667511, 3053.923651908698, 3062.969370306291, 3064.724174824254, 1014.523174108168, 1025.3489034463096, 1037.6600765274259, 1052.831546952484, 1062.9468526573717, 10763.623273185402, 10788.0, 10796.784064318748, 10803.459827008697, 10811.243212975094, 4325.84859529915, 4351.19502891966, 4410.779461027, 4516.0, 4526.886827829265, 8526.65893364271, 8567.186117318844, 8611.052784193733, 8629.266512346521, 8640.913590864136, 4642.0, 4683.274092515666, 4689.788959496763, 4692.272697731857, 4696.60078893291, 3805.4482100095884, 4167.249895018865, 4313.223619748413, 4326.156399502067, 4345.9348109778375, 3455.9827200863833, 3490.47642853574, 3537.4340105582983, 3539.4867744177463, 3672.210474747942, 1019.3323373190424, 1030.9432981186108, 1047.5652604169184, 1052.2318707343682, 1054.2093429927554, 755.7014979083232, 864.8962124545095, 873.5894129759004, 894.7181637784078, 918.169057003413, 5495.862603434866, 5539.335279766454, 5550.888982220333, 5585.916211256753, 5781.392953739881, 846.3525403066659, 886.1360173830592, 939.3002213351098, 939.52553960251, 942.1850099663742, 3662.5788034375855, 3771.132639492932, 3833.8466461341236, 3870.5161854768153, 3944.6449819516383, 9327.906720932704, 9459.574319155518, 9491.715248542554, 9605.18355939753, 9608.327417080738, 9581.520923953774, 9586.66446674377, 9608.183304419063, 9619.615215391446, 9633.0, 7275.636218189175, 7538.849223015619, 7626.313631773167, 7642.235776422424, 7643.082830060317, 5221.295125158207, 5277.815276465305, 5430.728463576885, 5436.836894893159, 5619.185218143428, 9132.589033493376, 9142.771430714285, 9195.494247816434, 9215.078492150731, 9280.211182049601, 8660.523671197892, 8988.415752976036, 8999.37004409685, 9229.123233292827, 9300.209482193819, 6054.939450605614, 6444.838879027874, 6562.639054852029, 6629.270780214076, 6670.966645166937, 7541.773746787605, 7588.924110758821, 7612.7716168515035, 7640.3505702015955, 7646.502977306457, 6404.775832845828, 6730.764423245163, 6756.256811750605, 6783.118194634666, 6852.931470685229, 6603.867922641616, 6628.0, 6723.2604413515455, 6757.526973112032, 6844.4182244509775, 6394.392532709571, 6406.423421892052, 6445.1943507061615, 6476.5466417350335, 6489.805305840832, 4516.796744146455, 4712.081144176853, 4748.121597504334, 4753.857384278477, 4815.15734746425, 4511.977440112779, 4560.0, 4565.109803588269, 4604.631629469702, 4700.388949436551], "value": 4205.521139107025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.62582520199334, 297.0938637156672, 302.67311303791905, 308.6188557131943, 311.220392915746, 4944.802207911679, 4957.3059771632, 5089.872753181172, 5177.825313368389, 5208.791648334067, 5023.623228257886, 5036.7481625918745, 5075.213341931997, 5075.619328550355, 5096.796128154879, 3899.1032062625613, 3932.9016774580577, 3983.1237127831832, 3989.481367422231, 3996.0, 3867.2652196082795, 3923.2349691809964, 3963.2073585282915, 3964.8612298569556, 3969.4641223434755, 3877.747946383476, 3914.2367238388383, 3931.6854651627946, 3942.3889297158844, 3983.58172391899, 3926.391409331558, 3939.153082087365, 3943.507061617298, 3958.4853968984135, 3960.980195099035, 3470.8958731238104, 3491.720662347006, 3504.351694936445, 3511.4206155984234, 3521.383757842393, 4836.975815120937, 4837.226043833005, 4905.656604037718, 4919.975400122977, 4937.7777999990085, 4468.84359047435, 4485.237509623372, 4514.345419914094, 4515.36784850118, 4517.390152329426, 5249.818790772084, 5250.579953603703, 5250.7637156328055, 5258.39528454225, 5278.076336641073, 3690.2988432197794, 3802.752821066622, 3816.9312592474153, 3826.4260360945805, 3830.616938306175, 5541.722913854291, 5589.301337332833, 5597.704940974222, 5598.964191624522, 5620.634658747168, 3921.137349783043, 3922.980385098056, 3923.293807114747, 3925.9988702881155, 3955.92088158241, 3835.808209589565, 3972.1857019310974, 3984.541777695544, 3985.442038114666, 3990.341593637075, 4504.977475112669, 4520.683552151384, 4528.0, 4535.387722657465, 4558.566936141061, 5326.934613077323, 5365.356157261153, 5366.91949620756, 5374.662022020434, 5382.381026181961, 1293.9482420703066, 1298.2210673595955, 1350.156152404747, 1361.7335877633896, 1373.574192000483, 871.1941454154882, 877.5173654490005, 881.2421317666801, 883.3330835219368, 895.5029958373035, 4135.627793498599, 4161.564260330181, 4199.538050814408, 4207.179599977975, 4233.682473814415, 4805.471398146201, 4816.373871396696, 4875.414950205927, 4889.364382630307, 4902.646729569827, 4111.527174374985, 4116.197341518375, 4143.948745371061, 4162.2091802558025, 4242.087951090531, 2523.3943853475034, 2641.7622413982835, 2650.324167337355, 2652.3501742073317, 2661.574148136289, 4620.722756634613, 4630.814767409266, 4657.580817726421, 4659.347691323217, 4660.04469083837, 4957.454679985199, 4972.389495514812, 5009.624278179152, 5009.974950125226, 5011.173156429221, 4246.87457823677, 4606.147862645421, 4615.330777037378, 4620.214563524209, 4642.976785116053, 4779.976100119617, 4839.733814640229, 4840.152973229741, 4860.95139048605, 4899.951000489949, 4655.790489427916, 4702.882427939329, 4707.764611769329, 4725.763711814327, 4732.763361831963, 4356.845435959537, 4520.16933142078, 4578.985246491533, 4586.678932474695, 4588.977055114703, 3578.785272883635, 3587.8744243951337, 3594.029612004692, 3595.298916711321, 3628.365036118616, 4821.614270858393, 4868.683535570177, 4876.634252431011, 4890.828820991248, 5255.632105752714, 5206.843794686166, 5278.1027225372545, 5287.57699384056, 5291.9470805292995, 5325.973370133124, 5221.947780522146, 5237.685738855681, 5289.814856480005, 5333.839984800462, 5358.7856485741695, 5074.873128171826, 5127.307813445137, 5172.224166374924, 5196.4283928767045, 5248.396434410091, 5333.839984800462, 5381.13901775714, 5402.216678581505, 5411.997560902491, 5423.918641220306, 5219.660722053054, 5246.842594722164, 5250.448702886142, 5262.473752624707, 5267.762950667153], "value": 3855.8998351125438, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.3498478922205, 722.5086940880201, 728.4427413029034, 754.5548126605302, 759.2673070486981, 11505.4822532986, 12441.502339906416, 12510.749785004306, 12529.122961392706, 12532.498700051998, 13060.151090179132, 13173.40719667615, 13209.273489958048, 13230.801537976939, 13236.735265294688, 725.6952080126347, 786.0567319216963, 786.6617354537547, 786.685325869651, 788.7160622176012, 780.8516381887451, 784.2627929746048, 784.3176436500253, 789.1556035042507, 790.7983464216617, 828.7596596986866, 831.1522247307743, 833.6623667414707, 837.9245867871921, 838.7316058861167, 823.1480417767611, 825.686239229092, 827.3133299361516, 827.3960009193322, 828.5898480252254, 607.9118527813442, 609.7042934176965, 610.1305639463791, 610.8472881779555, 611.8745657140275, 13410.664733381645, 13449.596512104554, 13468.0, 13480.5281815136, 13483.056186066979, 13104.541341053113, 13519.324033798272, 13658.983239778725, 13841.169529828243, 13858.16850988944, 10010.699679009642, 10149.746256343577, 10235.385876847413, 10340.327878687936, 10420.843687344695, 3382.746294027958, 3392.9830350848333, 3418.8119653419053, 3421.5038819371052, 3441.8795342163153, 43382.349264761055, 60330.39669603336, 60466.093008604905, 61422.0, 62272.0, 10776.622818201326, 10917.290376125526, 10926.945365273281, 11109.388983605979, 11118.444077796077, 19617.509562261057, 19623.607527849363, 19817.306394276133, 19841.801581983997, 20001.899990500246, 7035.050268213828, 7069.081019467436, 7069.540479868792, 7182.099690340688, 7259.346658800628, 3804.8287827047297, 3869.1101046759404, 3878.70909681775, 3945.0531872351003, 3953.8220780064967, 2972.658144313388, 3136.498160294342, 3138.1997590614246, 3140.8586613602442, 3159.0680749179046, 522.2610006840279, 523.0950455711641, 526.1318823940529, 535.4003516061957, 537.9515843574019, 427.05194468280365, 460.6591122569275, 467.97894094765815, 474.9240121580531, 483.7968053417573, 7103.2541583133025, 7358.300961408658, 7453.590052547053, 7521.247875212544, 7661.344625836107, 462.96296296296214, 502.04861786913597, 510.8007876928001, 512.2879197914901, 529.1982646290872, 3445.672661097192, 3460.2906404187083, 3515.20907795749, 3534.505169276303, 3565.090901820019, 89095.0, 94305.5284723572, 95791.52104239434, 96124.51937740267, 96535.0, 81742.18257817345, 82452.58773706094, 82932.58533707293, 82959.5852020736, 82997.17002830016, 62215.0, 72240.38798060076, 73391.0, 73759.26240737631, 74048.0, 7985.880211796712, 8026.197380261927, 8138.755837324889, 8175.584627394878, 8480.915190848013, 43144.56855431406, 43350.13299733924, 43501.0, 43651.90870228269, 43701.562984369746, 39869.202615948096, 55028.72485637546, 60551.69724151351, 62406.687966559875, 62625.68687156535, 11890.34603096838, 11894.940525297317, 11915.94042029819, 12119.81820272679, 12316.753664926471, 12021.278723276631, 12453.367025139498, 12471.563495277622, 12642.115051946275, 12814.0, 11174.608888688857, 11239.100871930063, 11587.710307242387, 11849.111316651113, 11956.76086478283, 11283.435828208721, 11419.885801142214, 11548.133889958455, 12021.21862078997, 12028.939855300667, 10714.73213169677, 11050.226484146033, 11054.944725276322, 11488.0, 11494.827577586175, 9740.659076932274, 10206.826214985074, 10242.385456872611, 10271.126954208677, 10341.74145646365, 9221.17009469151, 9314.487703176119, 9463.810723785624, 9568.856467152858, 9755.365901216399], "value": 6477.4654483436925, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 113.0, 114.0, 114.0, 114.0, 112.0, 112.0, 115.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 130.0, 157.0, 174.0, 134.0, 158.0, 157.0, 132.0, 196.0, 131.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 167.0, 168.0, 162.0, 163.0, 162.0, 164.0, 162.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 162.0, 77.0, 76.0, 77.0, 76.0, 163.0, 77.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 137.0, 87.0, 85.0, 85.0, 134.0, 86.0, 86.0, 129.0], "value": 100.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 119.0, 119.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 150.0, 148.0, 148.0, 146.0, 148.0, 148.0, 150.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 66.0, 67.0, 66.0, 67.0, 66.0, 65.0, 65.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 69.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 85.0, 83.0, 87.0, 85.0, 84.0, 85.0, 111.0, 85.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 146.0, 151.0, 135.0, 146.0, 141.0, 157.0, 155.0, 146.0, 140.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 181.0, 174.0, 175.0, 167.0, 174.0, 175.0, 168.0, 173.0, 166.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 69.0, 69.0, 68.0, 66.0, 68.0, 67.0, 73.0], "value": 68.5, "unit": "score"}]}]} 05:31:56 INFO - Return code: 0 05:31:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:56 ERROR - # TBPL SUCCESS # 05:31:56 INFO - Running post-action listener: _resource_record_post_action 05:31:56 INFO - ##### 05:31:56 INFO - ##### Finished run-tests step (success) 05:31:56 INFO - ##### 05:31:56 INFO - Running post-run listener: _resource_record_post_run 05:31:56 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 0; Write bytes: 550117376; Read time: 0; Write time: 507568 05:31:56 INFO - TinderboxPrint: CPU usage
13.6% 05:31:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:31:56 INFO - TinderboxPrint: I/O write bytes / time
550,117,376 / 507,568 05:31:56 INFO - TinderboxPrint: CPU idle
8,267.0 (86.4%) 05:31:56 INFO - TinderboxPrint: CPU user
1,239.2 (13.0%) 05:31:56 INFO - TinderboxPrint: Swap in / out
0 / 0 05:31:56 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 201969664; Read time: 0; Write time: 249724 05:31:56 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 0; Write bytes: 298479616; Read time: 0; Write time: 235300 05:31:57 INFO - Running post-run listener: _upload_blobber_files 05:31:57 INFO - Blob upload gear active. 05:31:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:31:57 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'] 05:31:57 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 05:31:57 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:58 INFO - (blobuploader) - INFO - Done attempting. 05:31:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:32:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:02 INFO - (blobuploader) - INFO - Done attempting. 05:32:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:32:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:32:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:02 INFO - (blobuploader) - INFO - Done attempting. 05:32:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:02 INFO - Return code: 0 05:32:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a3af5e14f2ec3ad59efa89f15b069d1c70487bd2efd4cd2ca4cceceb98f32f04ea8780df0d41a5e6c7330a4eb14d38f636792e2fd42d3c05bfd3d9e6e154dda4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65012029e5ce61a439468152e5408ce116aa21aa363f01d14cf04a1340f9cbb565bb199da358cf8e6b11c1c42111ab323e2abca674706abee6657fb552c71055", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/347e03295e75e8b38b0f3cf5104cfc0a5c58c25c2b949a7ab48201eea23cae9fe3fbb3b437ebe042eafe9258bbba1778b118b78a21331dcfc717877fddad120a"} 05:32:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:02 INFO - Contents: 05:32:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a3af5e14f2ec3ad59efa89f15b069d1c70487bd2efd4cd2ca4cceceb98f32f04ea8780df0d41a5e6c7330a4eb14d38f636792e2fd42d3c05bfd3d9e6e154dda4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65012029e5ce61a439468152e5408ce116aa21aa363f01d14cf04a1340f9cbb565bb199da358cf8e6b11c1c42111ab323e2abca674706abee6657fb552c71055", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/347e03295e75e8b38b0f3cf5104cfc0a5c58c25c2b949a7ab48201eea23cae9fe3fbb3b437ebe042eafe9258bbba1778b118b78a21331dcfc717877fddad120a"} 05:32:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:02 INFO - Copying logs to upload dir... 05:32:02 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.431076 ========= master_lag: 19.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-06-14 05:32:21.966257) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 05:32:21.969940) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a3af5e14f2ec3ad59efa89f15b069d1c70487bd2efd4cd2ca4cceceb98f32f04ea8780df0d41a5e6c7330a4eb14d38f636792e2fd42d3c05bfd3d9e6e154dda4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65012029e5ce61a439468152e5408ce116aa21aa363f01d14cf04a1340f9cbb565bb199da358cf8e6b11c1c42111ab323e2abca674706abee6657fb552c71055", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/347e03295e75e8b38b0f3cf5104cfc0a5c58c25c2b949a7ab48201eea23cae9fe3fbb3b437ebe042eafe9258bbba1778b118b78a21331dcfc717877fddad120a"} build_url:https://queue.taskcluster.net/v1/task/bJANoH3LQBGu5d01cnn7Gg/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/bJANoH3LQBGu5d01cnn7Gg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a3af5e14f2ec3ad59efa89f15b069d1c70487bd2efd4cd2ca4cceceb98f32f04ea8780df0d41a5e6c7330a4eb14d38f636792e2fd42d3c05bfd3d9e6e154dda4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65012029e5ce61a439468152e5408ce116aa21aa363f01d14cf04a1340f9cbb565bb199da358cf8e6b11c1c42111ab323e2abca674706abee6657fb552c71055", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/347e03295e75e8b38b0f3cf5104cfc0a5c58c25c2b949a7ab48201eea23cae9fe3fbb3b437ebe042eafe9258bbba1778b118b78a21331dcfc717877fddad120a"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 05:32:22.095999) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:32:22.096350) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465906277.879797-1031563514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 05:32:22.112457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 05:32:22.112739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 05:32:22.113014) ========= ========= Total master_lag: 19.49 =========