builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1466509292.32 results: success (0) buildid: 20160621031601 builduid: e88eed9d164c42df9e180a238163bebe revision: eb945fc547afc9a4254ef339335fe831c0f68db2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:32.322802) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:32.323152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:32.323408) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:32.358333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:32.358623) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 04:41:32-- 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% 226M=0s 2016-06-21 04:41:32 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128010 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:32.516895) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:32.517200) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020089 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:32.566202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:32.566608) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb945fc547afc9a4254ef339335fe831c0f68db2 --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 eb945fc547afc9a4254ef339335fe831c0f68db2 --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=6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 04:41:32,634 truncating revision to first 12 chars 2016-06-21 04:41:32,634 Setting DEBUG logging. 2016-06-21 04:41:32,634 attempt 1/10 2016-06-21 04:41:32,634 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb945fc547af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 04:41:32,945 unpacking tar archive at: fx-team-eb945fc547af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676637 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:33.256707) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:33.257074) ========= script_repo_revision: eb945fc547afc9a4254ef339335fe831c0f68db2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:33.257450) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:33.257743) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 04:41:33.267935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-21 04:41:33.268198) ========= /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=6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:41:33 INFO - MultiFileLogger online at 20160621 04:41:33 in /builds/slave/test 04:41:33 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 04:41:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:33 INFO - {'append_to_log': False, 04:41:33 INFO - 'base_work_dir': '/builds/slave/test', 04:41:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:41:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:33 INFO - 'branch': 'Fx-Team-Non-PGO', 04:41:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:33 INFO - 'config_files': ('talos/linux_config.py',), 04:41:33 INFO - 'default_actions': ('clobber', 04:41:33 INFO - 'read-buildbot-config', 04:41:33 INFO - 'download-and-extract', 04:41:33 INFO - 'populate-webroot', 04:41:33 INFO - 'create-virtualenv', 04:41:33 INFO - 'install', 04:41:33 INFO - 'run-tests'), 04:41:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:33 INFO - 'download_minidump_stackwalk': True, 04:41:33 INFO - 'download_symbols': 'ondemand', 04:41:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:33 INFO - 'installer_path': 'installer.exe', 04:41:33 INFO - 'log_level': 'info', 04:41:33 INFO - 'log_name': 'talos', 04:41:33 INFO - 'log_to_console': True, 04:41:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:41:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:41:33 INFO - 'opt_config_files': (), 04:41:33 INFO - 'pip_index': False, 04:41:33 INFO - 'sps_profile': False, 04:41:33 INFO - 'sps_profile_interval': 0, 04:41:33 INFO - 'suite': 'dromaeojs-e10s', 04:41:33 INFO - 'system_bits': '32', 04:41:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:33 INFO - 'title': 'talos-linux64-ix-023', 04:41:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:33 INFO - 'use_talos_json': True, 04:41:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:33 INFO - 'work_dir': 'build'} 04:41:33 INFO - ##### 04:41:33 INFO - ##### Running clobber step. 04:41:33 INFO - ##### 04:41:33 INFO - Running pre-action listener: _resource_record_pre_action 04:41:33 INFO - Running main action method: clobber 04:41:33 INFO - rmtree: /builds/slave/test/build 04:41:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:33 INFO - Running post-action listener: _resource_record_post_action 04:41:33 INFO - ##### 04:41:33 INFO - ##### Finished clobber step (success) 04:41:33 INFO - ##### 04:41:33 INFO - ##### 04:41:33 INFO - ##### Running read-buildbot-config step. 04:41:33 INFO - ##### 04:41:33 INFO - Running pre-action listener: _resource_record_pre_action 04:41:33 INFO - Running main action method: read_buildbot_config 04:41:33 INFO - Using buildbot properties: 04:41:33 INFO - { 04:41:33 INFO - "project": "", 04:41:33 INFO - "product": "firefox", 04:41:33 INFO - "script_repo_revision": "production", 04:41:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:41:33 INFO - "repository": "", 04:41:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:41:33 INFO - "buildid": "20160621031601", 04:41:33 INFO - "pgo_build": "False", 04:41:33 INFO - "basedir": "/builds/slave/test", 04:41:33 INFO - "buildnumber": 1600, 04:41:33 INFO - "slavename": "talos-linux64-ix-023", 04:41:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:41:33 INFO - "platform": "ubuntu64_hw", 04:41:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:41:33 INFO - "branch": "fx-team", 04:41:33 INFO - "repo_path": "integration/fx-team", 04:41:33 INFO - "revision": "eb945fc547afc9a4254ef339335fe831c0f68db2", 04:41:33 INFO - "stage_platform": "linux64", 04:41:33 INFO - "builduid": "e88eed9d164c42df9e180a238163bebe", 04:41:33 INFO - "slavebuilddir": "test" 04:41:33 INFO - } 04:41:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:41:33 INFO - Running post-action listener: _resource_record_post_action 04:41:33 INFO - ##### 04:41:33 INFO - ##### Finished read-buildbot-config step (success) 04:41:33 INFO - ##### 04:41:33 INFO - ##### 04:41:33 INFO - ##### Running download-and-extract step. 04:41:33 INFO - ##### 04:41:33 INFO - Running pre-action listener: _resource_record_pre_action 04:41:33 INFO - Running main action method: download_and_extract 04:41:33 INFO - mkdir: /builds/slave/test/build/tests 04:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:33 INFO - https://queue.taskcluster.net/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:41:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:41:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:41:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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 04:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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 04:41:40 INFO - Downloaded 1361 bytes. 04:41:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:41:40 INFO - Using the following test package requirements: 04:41:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:41:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:41:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:40 INFO - u'jsshell-linux-x86_64.zip'], 04:41:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:41:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:41:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:41:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:41:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:41:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:41:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:41: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')]} 04:41:40 INFO - https://queue.taskcluster.net/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:41:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:41:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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 04:41:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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 04:41:47 INFO - Downloaded 22658730 bytes. 04:41:47 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'] 04:41:47 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 04:41:48 INFO - Return code: 0 04:41:48 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 04:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:48 INFO - https://queue.taskcluster.net/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:41:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:41:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:41:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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 04:41:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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 04:41:55 INFO - Downloaded 22658730 bytes. 04:41:55 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'] 04:41:55 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 04:41:56 INFO - Return code: 0 04:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:56 INFO - https://queue.taskcluster.net/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:41:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:41:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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 04:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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 04:41:58 INFO - Downloaded 14405384 bytes. 04:41:58 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'] 04:41:58 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 04:41:58 INFO - Return code: 0 04:41:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:58 INFO - https://queue.taskcluster.net/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:41:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:41:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:41:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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 04:41:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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 04:41:59 INFO - Downloaded 56231496 bytes. 04:41:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:41:59 INFO - mkdir: /builds/slave/test/properties 04:41:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:41:59 INFO - Writing to file /builds/slave/test/properties/build_url 04:41:59 INFO - Contents: 04:41:59 INFO - build_url:https://queue.taskcluster.net/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:42:00 INFO - Running post-action listener: _resource_record_post_action 04:42:00 INFO - Running post-action listener: set_extra_try_arguments 04:42:00 INFO - ##### 04:42:00 INFO - ##### Finished download-and-extract step (success) 04:42:00 INFO - ##### 04:42:00 INFO - ##### 04:42:00 INFO - ##### Running populate-webroot step. 04:42:00 INFO - ##### 04:42:00 INFO - Running pre-action listener: _resource_record_pre_action 04:42:00 INFO - Running main action method: populate_webroot 04:42:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:00 INFO - '--tppagecycles', 04:42:00 INFO - '7'], 04:42:00 INFO - 'tests': ['tsvgm']}}, 04:42:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:00 INFO - 'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:00 INFO - 'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['damp', 'tps']}, 04:42:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:00 INFO - 'tests': ['damp', 'tps']}, 04:42:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['dromaeo_dom']}, 04:42:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['basic_compositor_video']}, 04:42:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:42:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['a11yr', 04:42:00 INFO - 'ts_paint', 04:42:00 INFO - 'tpaint', 04:42:00 INFO - 'sessionrestore', 04:42:00 INFO - 'sessionrestore_no_auto_restore', 04:42:00 INFO - 'tabpaint']}, 04:42:00 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:00 INFO - 'ts_paint', 04:42:00 INFO - 'tpaint', 04:42:00 INFO - 'sessionrestore', 04:42:00 INFO - 'sessionrestore_no_auto_restore', 04:42:00 INFO - 'tabpaint']}, 04:42:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:00 INFO - 'ts_paint', 04:42:00 INFO - 'tpaint', 04:42:00 INFO - 'sessionrestore', 04:42:00 INFO - 'sessionrestore_no_auto_restore', 04:42:00 INFO - 'tabpaint']}, 04:42:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:00 INFO - 'ts_paint', 04:42:00 INFO - 'tpaint', 04:42:00 INFO - 'sessionrestore', 04:42:00 INFO - 'sessionrestore_no_auto_restore', 04:42:00 INFO - 'tabpaint']}, 04:42:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['a11yr', 04:42:00 INFO - 'ts_paint', 04:42:00 INFO - 'tpaint', 04:42:00 INFO - 'sessionrestore', 04:42:00 INFO - 'sessionrestore_no_auto_restore', 04:42:00 INFO - 'tabpaint']}, 04:42:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['a11yr', 04:42:00 INFO - 'ts_paint', 04:42:00 INFO - 'tpaint', 04:42:00 INFO - 'sessionrestore', 04:42:00 INFO - 'sessionrestore_no_auto_restore', 04:42:00 INFO - 'tabpaint']}, 04:42:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['tsvgx', 04:42:00 INFO - 'tsvgr_opacity', 04:42:00 INFO - 'tart', 04:42:00 INFO - 'tscrollx', 04:42:00 INFO - 'cart']}, 04:42:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:00 INFO - 'tsvgr_opacity', 04:42:00 INFO - 'tart', 04:42:00 INFO - 'tscrollx', 04:42:00 INFO - 'cart']}, 04:42:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:00 INFO - 'talos_options': ['--disable-e10s'], 04:42:00 INFO - 'tests': ['tp5o']}, 04:42:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:00 INFO - 'tests': ['tp5o']}, 04:42:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:00 INFO - 'talos_options': ['--disable-e10s', 04:42:00 INFO - '--xperf_path', 04:42:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:00 INFO - 'tests': ['tp5n']}, 04:42:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:00 INFO - 'talos_options': ['--xperf_path', 04:42:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:00 INFO - 'tests': ['tp5n']}}, 04:42:00 INFO - 'talos.zip': {'path': '', 04:42:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:00 INFO - Running post-action listener: _resource_record_post_action 04:42:00 INFO - ##### 04:42:00 INFO - ##### Finished populate-webroot step (success) 04:42:00 INFO - ##### 04:42:00 INFO - ##### 04:42:00 INFO - ##### Running create-virtualenv step. 04:42:00 INFO - ##### 04:42:00 INFO - Running pre-action listener: _resource_record_pre_action 04:42:00 INFO - Running main action method: create_virtualenv 04:42:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:00 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 04:42:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:00 INFO - Using real prefix '/usr' 04:42:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:03 INFO - Installing pip.................done. 04:42:03 INFO - Return code: 0 04:42:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe632521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, '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': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', '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 04:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:42:03 INFO - Using env: {'DISPLAY': ':0', 04:42:03 INFO - 'HOME': '/home/cltbld', 04:42:03 INFO - 'LANG': 'en_US.UTF-8', 04:42:03 INFO - 'LANGUAGE': 'en_US:en', 04:42:03 INFO - 'LOGNAME': 'cltbld', 04:42:03 INFO - 'MAIL': '/var/mail/cltbld', 04:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:03 INFO - 'MOZ_NO_REMOTE': '1', 04:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:03 INFO - 'NO_EM_RESTART': '1', 04:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:03 INFO - 'PWD': '/builds/slave/test', 04:42:03 INFO - 'SHELL': '/bin/bash', 04:42:03 INFO - 'SHLVL': '1', 04:42:03 INFO - 'TERM': 'linux', 04:42:03 INFO - 'TMOUT': '86400', 04:42:03 INFO - 'USER': 'cltbld', 04:42:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:03 INFO - '_': '/tools/buildbot/bin/python'} 04:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:04 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 04:42:04 INFO - Cleaning up... 04:42:04 INFO - Return code: 0 04:42:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:42:04 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')]} 04:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:04 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')]} 04:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:04 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 0x7fe632521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, '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': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', '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 04:42:04 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 04:42:04 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 04:42:04 INFO - Using env: {'DISPLAY': ':0', 04:42:04 INFO - 'HOME': '/home/cltbld', 04:42:04 INFO - 'LANG': 'en_US.UTF-8', 04:42:04 INFO - 'LANGUAGE': 'en_US:en', 04:42:04 INFO - 'LOGNAME': 'cltbld', 04:42:04 INFO - 'MAIL': '/var/mail/cltbld', 04:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:04 INFO - 'MOZ_NO_REMOTE': '1', 04:42:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:04 INFO - 'NO_EM_RESTART': '1', 04:42:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:04 INFO - 'PWD': '/builds/slave/test', 04:42:04 INFO - 'SHELL': '/bin/bash', 04:42:04 INFO - 'SHLVL': '1', 04:42:04 INFO - 'TERM': 'linux', 04:42:04 INFO - 'TMOUT': '86400', 04:42:04 INFO - 'USER': 'cltbld', 04:42:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:04 INFO - '_': '/tools/buildbot/bin/python'} 04:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:04 INFO - Downloading/unpacking psutil>=3.1.1 04:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:06 INFO - Installing collected packages: psutil 04:42:06 INFO - Running setup.py install for psutil 04:42:06 INFO - building 'psutil._psutil_linux' extension 04:42:06 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 04:42:07 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 04:42:07 INFO - building 'psutil._psutil_posix' extension 04:42:07 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 04:42:08 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 04:42:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:08 INFO - Successfully installed psutil 04:42:08 INFO - Cleaning up... 04:42:08 INFO - Return code: 0 04:42:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe632521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, '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': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', '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 04:42:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:42:08 INFO - Using env: {'DISPLAY': ':0', 04:42:08 INFO - 'HOME': '/home/cltbld', 04:42:08 INFO - 'LANG': 'en_US.UTF-8', 04:42:08 INFO - 'LANGUAGE': 'en_US:en', 04:42:08 INFO - 'LOGNAME': 'cltbld', 04:42:08 INFO - 'MAIL': '/var/mail/cltbld', 04:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:08 INFO - 'MOZ_NO_REMOTE': '1', 04:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:08 INFO - 'NO_EM_RESTART': '1', 04:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:08 INFO - 'PWD': '/builds/slave/test', 04:42:08 INFO - 'SHELL': '/bin/bash', 04:42:08 INFO - 'SHLVL': '1', 04:42:08 INFO - 'TERM': 'linux', 04:42:08 INFO - 'TMOUT': '86400', 04:42:08 INFO - 'USER': 'cltbld', 04:42:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:08 INFO - '_': '/tools/buildbot/bin/python'} 04:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:42:10 INFO - Installing collected packages: mozsystemmonitor 04:42:10 INFO - Running setup.py install for mozsystemmonitor 04:42:10 INFO - Successfully installed mozsystemmonitor 04:42:10 INFO - Cleaning up... 04:42:10 INFO - Return code: 0 04:42:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe632521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, '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': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', '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 04:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:42:10 INFO - Using env: {'DISPLAY': ':0', 04:42:10 INFO - 'HOME': '/home/cltbld', 04:42:10 INFO - 'LANG': 'en_US.UTF-8', 04:42:10 INFO - 'LANGUAGE': 'en_US:en', 04:42:10 INFO - 'LOGNAME': 'cltbld', 04:42:10 INFO - 'MAIL': '/var/mail/cltbld', 04:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:10 INFO - 'MOZ_NO_REMOTE': '1', 04:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:10 INFO - 'NO_EM_RESTART': '1', 04:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:10 INFO - 'PWD': '/builds/slave/test', 04:42:10 INFO - 'SHELL': '/bin/bash', 04:42:10 INFO - 'SHLVL': '1', 04:42:10 INFO - 'TERM': 'linux', 04:42:10 INFO - 'TMOUT': '86400', 04:42:10 INFO - 'USER': 'cltbld', 04:42:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:10 INFO - '_': '/tools/buildbot/bin/python'} 04:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:10 INFO - Downloading/unpacking jsonschema==2.5.1 04:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:12 INFO - warning: no files found matching '*.txt' 04:42:12 INFO - no previously-included directories found matching 'build' 04:42:12 INFO - no previously-included directories found matching 'dist' 04:42:12 INFO - no previously-included directories found matching '.git*' 04:42:12 INFO - Installing collected packages: jsonschema, functools32 04:42:12 INFO - Running setup.py install for functools32 04:42:13 INFO - warning: no files found matching '*.txt' 04:42:13 INFO - no previously-included directories found matching 'build' 04:42:13 INFO - no previously-included directories found matching 'dist' 04:42:13 INFO - no previously-included directories found matching '.git*' 04:42:13 INFO - Successfully installed jsonschema functools32 04:42:13 INFO - Cleaning up... 04:42:13 INFO - Return code: 0 04:42:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:13 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 0x7fe632521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, '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': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', '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 04:42:13 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 04:42:13 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 04:42:13 INFO - Using env: {'DISPLAY': ':0', 04:42:13 INFO - 'HOME': '/home/cltbld', 04:42:13 INFO - 'LANG': 'en_US.UTF-8', 04:42:13 INFO - 'LANGUAGE': 'en_US:en', 04:42:13 INFO - 'LOGNAME': 'cltbld', 04:42:13 INFO - 'MAIL': '/var/mail/cltbld', 04:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:13 INFO - 'MOZ_NO_REMOTE': '1', 04:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:13 INFO - 'NO_EM_RESTART': '1', 04:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:13 INFO - 'PWD': '/builds/slave/test', 04:42:13 INFO - 'SHELL': '/bin/bash', 04:42:13 INFO - 'SHLVL': '1', 04:42:13 INFO - 'TERM': 'linux', 04:42:13 INFO - 'TMOUT': '86400', 04:42:13 INFO - 'USER': 'cltbld', 04:42:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:13 INFO - '_': '/tools/buildbot/bin/python'} 04:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:13 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 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 04:42:13 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 04:42:15 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:15 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 04:42:15 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 04:42:15 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 04:42:15 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 04:42:15 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 04:42:15 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 04:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:15 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 04:42:15 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 04:42:15 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 04:42:15 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 04:42:15 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 04:42:15 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 04:42:15 INFO - Downloading docopt-0.6.1.tar.gz 04:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:16 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:16 INFO - Running setup.py install for blobuploader 04:42:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:16 INFO - Running setup.py install for requests 04:42:16 INFO - Running setup.py install for docopt 04:42:16 INFO - Successfully installed blobuploader requests docopt 04:42:16 INFO - Cleaning up... 04:42:16 INFO - Return code: 0 04:42:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:16 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 0x7fe632521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, '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': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', '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 04:42:16 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 04:42:16 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 04:42:16 INFO - Using env: {'DISPLAY': ':0', 04:42:16 INFO - 'HOME': '/home/cltbld', 04:42:16 INFO - 'LANG': 'en_US.UTF-8', 04:42:16 INFO - 'LANGUAGE': 'en_US:en', 04:42:16 INFO - 'LOGNAME': 'cltbld', 04:42:16 INFO - 'MAIL': '/var/mail/cltbld', 04:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:16 INFO - 'MOZ_NO_REMOTE': '1', 04:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:16 INFO - 'NO_EM_RESTART': '1', 04:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:16 INFO - 'PWD': '/builds/slave/test', 04:42:16 INFO - 'SHELL': '/bin/bash', 04:42:16 INFO - 'SHLVL': '1', 04:42:16 INFO - 'TERM': 'linux', 04:42:16 INFO - 'TMOUT': '86400', 04:42:16 INFO - 'USER': 'cltbld', 04:42:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:16 INFO - '_': '/tools/buildbot/bin/python'} 04:42:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:16 INFO - Running setup.py (path:/tmp/pip-2ygpzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:16 INFO - Running setup.py (path:/tmp/pip-n4jzMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:16 INFO - Running setup.py (path:/tmp/pip-62j5cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:17 INFO - Running setup.py (path:/tmp/pip-58ThJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:17 INFO - Running setup.py (path:/tmp/pip-i5FPL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:17 INFO - Running setup.py (path:/tmp/pip-Wk9YT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:17 INFO - Running setup.py (path:/tmp/pip-gR6vID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:17 INFO - Running setup.py (path:/tmp/pip-7E_qug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:17 INFO - Running setup.py (path:/tmp/pip-v1GOLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:17 INFO - Running setup.py (path:/tmp/pip-lM5U72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:17 INFO - Running setup.py (path:/tmp/pip-YWhjdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:17 INFO - Running setup.py (path:/tmp/pip-nZ9fpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:17 INFO - Running setup.py (path:/tmp/pip-oOXkVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:17 INFO - Running setup.py (path:/tmp/pip-mWyzFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:17 INFO - Running setup.py (path:/tmp/pip-YzmBTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:17 INFO - Running setup.py (path:/tmp/pip-adnUV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:17 INFO - Running setup.py (path:/tmp/pip-eoe7nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:18 INFO - Running setup.py install for manifestparser 04:42:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:18 INFO - Running setup.py install for mozcrash 04:42:18 INFO - Running setup.py install for mozdebug 04:42:18 INFO - Running setup.py install for mozdevice 04:42:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:42:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:18 INFO - Running setup.py install for mozfile 04:42:18 INFO - Running setup.py install for mozhttpd 04:42:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:18 INFO - Running setup.py install for mozinfo 04:42:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:18 INFO - Running setup.py install for mozInstall 04:42:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:18 INFO - Running setup.py install for mozleak 04:42:18 INFO - Running setup.py install for mozlog 04:42:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:19 INFO - Running setup.py install for moznetwork 04:42:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:19 INFO - Running setup.py install for mozprocess 04:42:19 INFO - Running setup.py install for mozprofile 04:42:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:19 INFO - Running setup.py install for mozrunner 04:42:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:19 INFO - Running setup.py install for mozscreenshot 04:42:19 INFO - Running setup.py install for moztest 04:42:19 INFO - Running setup.py install for mozversion 04:42:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:42:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:19 INFO - Cleaning up... 04:42:19 INFO - Return code: 0 04:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:19 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 0x7fe632521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, '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': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', '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 04:42:19 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 04:42:19 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 04:42:19 INFO - Using env: {'DISPLAY': ':0', 04:42:19 INFO - 'HOME': '/home/cltbld', 04:42:19 INFO - 'LANG': 'en_US.UTF-8', 04:42:19 INFO - 'LANGUAGE': 'en_US:en', 04:42:19 INFO - 'LOGNAME': 'cltbld', 04:42:19 INFO - 'MAIL': '/var/mail/cltbld', 04:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:19 INFO - 'MOZ_NO_REMOTE': '1', 04:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:19 INFO - 'NO_EM_RESTART': '1', 04:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:19 INFO - 'PWD': '/builds/slave/test', 04:42:19 INFO - 'SHELL': '/bin/bash', 04:42:19 INFO - 'SHLVL': '1', 04:42:19 INFO - 'TERM': 'linux', 04:42:19 INFO - 'TMOUT': '86400', 04:42:19 INFO - 'USER': 'cltbld', 04:42:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:19 INFO - '_': '/tools/buildbot/bin/python'} 04:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:20 INFO - Running setup.py (path:/tmp/pip-wrCseY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:20 INFO - Running setup.py (path:/tmp/pip-xjZ_7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:20 INFO - Running setup.py (path:/tmp/pip-0xwtLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:20 INFO - Running setup.py (path:/tmp/pip-IYtBQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:20 INFO - Running setup.py (path:/tmp/pip-hvteqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:20 INFO - Running setup.py (path:/tmp/pip-bFYbwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:20 INFO - Running setup.py (path:/tmp/pip-m_PBZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:20 INFO - Running setup.py (path:/tmp/pip-_E0UXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:20 INFO - Running setup.py (path:/tmp/pip-DyOuql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:20 INFO - Running setup.py (path:/tmp/pip-nVzruX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:20 INFO - Running setup.py (path:/tmp/pip-sDM3V1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:20 INFO - Running setup.py (path:/tmp/pip-ENlnC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:20 INFO - Running setup.py (path:/tmp/pip-56zObW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:20 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)) 04:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:21 INFO - Running setup.py (path:/tmp/pip-cN45gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:21 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)) 04:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:21 INFO - Running setup.py (path:/tmp/pip-4MaM32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:21 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)) 04:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:21 INFO - Running setup.py (path:/tmp/pip-LErog4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:21 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)) 04:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:21 INFO - Running setup.py (path:/tmp/pip-OWtPyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 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)) 04:42:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:23 INFO - Downloading blessings-1.6.tar.gz 04:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:23 INFO - Installing collected packages: blessings 04:42:23 INFO - Running setup.py install for blessings 04:42:23 INFO - Successfully installed blessings 04:42:23 INFO - Cleaning up... 04:42:23 INFO - Return code: 0 04:42:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:23 INFO - Reading from file tmpfile_stdout 04:42:23 INFO - Current package versions: 04:42:23 INFO - argparse == 1.2.1 04:42:23 INFO - blessings == 1.6 04:42:23 INFO - blobuploader == 1.2.4 04:42:23 INFO - docopt == 0.6.1 04:42:23 INFO - functools32 == 3.2.3-2 04:42:23 INFO - jsonschema == 2.5.1 04:42:23 INFO - manifestparser == 1.1 04:42:23 INFO - mozInstall == 1.12 04:42:23 INFO - mozcrash == 0.17 04:42:23 INFO - mozdebug == 0.1 04:42:23 INFO - mozdevice == 0.48 04:42:23 INFO - mozfile == 1.2 04:42:23 INFO - mozhttpd == 0.7 04:42:23 INFO - mozinfo == 0.9 04:42:23 INFO - mozleak == 0.1 04:42:23 INFO - mozlog == 3.2 04:42:23 INFO - moznetwork == 0.27 04:42:23 INFO - mozprocess == 0.22 04:42:23 INFO - mozprofile == 0.28 04:42:23 INFO - mozrunner == 6.11 04:42:23 INFO - mozscreenshot == 0.1 04:42:23 INFO - mozsystemmonitor == 0.3 04:42:23 INFO - moztest == 0.7 04:42:23 INFO - mozversion == 1.4 04:42:23 INFO - psutil == 3.1.1 04:42:23 INFO - requests == 1.2.3 04:42:23 INFO - wsgiref == 0.1.2 04:42:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:23 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 0x7fe632521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, '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': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', '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 04:42:23 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 04:42:23 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 04:42:23 INFO - Using env: {'DISPLAY': ':0', 04:42:23 INFO - 'HOME': '/home/cltbld', 04:42:23 INFO - 'LANG': 'en_US.UTF-8', 04:42:23 INFO - 'LANGUAGE': 'en_US:en', 04:42:23 INFO - 'LOGNAME': 'cltbld', 04:42:23 INFO - 'MAIL': '/var/mail/cltbld', 04:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:23 INFO - 'MOZ_NO_REMOTE': '1', 04:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:23 INFO - 'NO_EM_RESTART': '1', 04:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:23 INFO - 'PWD': '/builds/slave/test', 04:42:23 INFO - 'SHELL': '/bin/bash', 04:42:23 INFO - 'SHLVL': '1', 04:42:23 INFO - 'TERM': 'linux', 04:42:23 INFO - 'TMOUT': '86400', 04:42:23 INFO - 'USER': 'cltbld', 04:42:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:23 INFO - '_': '/tools/buildbot/bin/python'} 04:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:24 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)) 04:42:24 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)) 04:42:24 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)) 04:42:24 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)) 04:42:24 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)) 04:42:24 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)) 04:42:24 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)) 04:42:24 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)) 04:42:24 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)) 04:42:24 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)) 04:42:24 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)) 04:42:24 INFO - Cleaning up... 04:42:24 INFO - Return code: 0 04:42:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:24 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 0x7fe632521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, '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': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', '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 04:42:24 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 04:42:24 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 04:42:24 INFO - Using env: {'DISPLAY': ':0', 04:42:24 INFO - 'HOME': '/home/cltbld', 04:42:24 INFO - 'LANG': 'en_US.UTF-8', 04:42:24 INFO - 'LANGUAGE': 'en_US:en', 04:42:24 INFO - 'LOGNAME': 'cltbld', 04:42:24 INFO - 'MAIL': '/var/mail/cltbld', 04:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:24 INFO - 'MOZ_NO_REMOTE': '1', 04:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:24 INFO - 'NO_EM_RESTART': '1', 04:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:24 INFO - 'PWD': '/builds/slave/test', 04:42:24 INFO - 'SHELL': '/bin/bash', 04:42:24 INFO - 'SHLVL': '1', 04:42:24 INFO - 'TERM': 'linux', 04:42:24 INFO - 'TMOUT': '86400', 04:42:24 INFO - 'USER': 'cltbld', 04:42:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:24 INFO - '_': '/tools/buildbot/bin/python'} 04:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:42:24 INFO - Cleaning up... 04:42:24 INFO - Return code: 0 04:42:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:24 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 0x7fe632521f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, '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': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', '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 04:42:24 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 04:42:24 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 04:42:24 INFO - Using env: {'DISPLAY': ':0', 04:42:24 INFO - 'HOME': '/home/cltbld', 04:42:24 INFO - 'LANG': 'en_US.UTF-8', 04:42:24 INFO - 'LANGUAGE': 'en_US:en', 04:42:24 INFO - 'LOGNAME': 'cltbld', 04:42:24 INFO - 'MAIL': '/var/mail/cltbld', 04:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:24 INFO - 'MOZ_NO_REMOTE': '1', 04:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:24 INFO - 'NO_EM_RESTART': '1', 04:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:24 INFO - 'PWD': '/builds/slave/test', 04:42:24 INFO - 'SHELL': '/bin/bash', 04:42:24 INFO - 'SHLVL': '1', 04:42:24 INFO - 'TERM': 'linux', 04:42:24 INFO - 'TMOUT': '86400', 04:42:24 INFO - 'USER': 'cltbld', 04:42:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:24 INFO - '_': '/tools/buildbot/bin/python'} 04:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:24 INFO - Downloading/unpacking flake8 04:42:24 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 04:42:24 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 04:42:24 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 04:42:24 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 04:42:24 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 04:42:24 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 04:42:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:42:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:42:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:26 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 04:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:42:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:27 INFO - no previously-included directories found matching 'docs/_build' 04:42:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:42:27 INFO - Running setup.py install for pep8 04:42:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:27 INFO - no previously-included directories found matching 'docs/_build' 04:42:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:42:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:42:27 INFO - Cleaning up... 04:42:27 INFO - Return code: 0 04:42:27 INFO - Running post-action listener: _resource_record_post_action 04:42:27 INFO - Running post-action listener: _start_resource_monitoring 04:42:27 INFO - Starting resource monitoring. 04:42:27 INFO - ##### 04:42:27 INFO - ##### Finished create-virtualenv step (success) 04:42:27 INFO - ##### 04:42:27 INFO - ##### 04:42:27 INFO - ##### Running install step. 04:42:27 INFO - ##### 04:42:27 INFO - Running pre-action listener: _resource_record_pre_action 04:42:27 INFO - Running main action method: install 04:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:27 INFO - Reading from file tmpfile_stdout 04:42:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:27 INFO - Reading from file tmpfile_stdout 04:42:27 INFO - Output received: 04:42:27 INFO - Usage: mozinstall [options] installer 04:42:27 INFO - Options: 04:42:27 INFO - -h, --help show this help message and exit 04:42:27 INFO - -d DEST, --destination=DEST 04:42:27 INFO - Directory to install application into. [default: 04:42:27 INFO - "/builds/slave/test"] 04:42:27 INFO - --app=APP Application being installed. [default: firefox] 04:42:27 INFO - mkdir: /builds/slave/test/build/application 04:42:27 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'] 04:42:27 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 04:42:43 INFO - Reading from file tmpfile_stdout 04:42:43 INFO - Output received: 04:42:43 INFO - /builds/slave/test/build/application/firefox/firefox 04:42:43 INFO - Running post-action listener: _resource_record_post_action 04:42:43 INFO - ##### 04:42:43 INFO - ##### Finished install step (success) 04:42:43 INFO - ##### 04:42:43 INFO - ##### 04:42:43 INFO - ##### Running run-tests step. 04:42:43 INFO - ##### 04:42:43 INFO - Running pre-action listener: _resource_record_pre_action 04:42:43 INFO - Running main action method: run_tests 04:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:42:43 INFO - Python 2.7.3 04:42:43 INFO - Return code: 0 04:42:43 INFO - grabbing minidump binary from tooltool 04:42: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')]} 04:42:43 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 0x20be1c0>, '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 0x20bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bf550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:42:43 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 04:42:43 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 04:42:43 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 04:42:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:42:43 INFO - Return code: 0 04:42:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:42:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:42:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:42:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:42:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:42:44 INFO - Return code: 0 04:42:44 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/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 04:42:44 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/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 04:42:44 INFO - Using env: {'DISPLAY': ':0', 04:42:44 INFO - 'HOME': '/home/cltbld', 04:42:44 INFO - 'LANG': 'en_US.UTF-8', 04:42:44 INFO - 'LANGUAGE': 'en_US:en', 04:42:44 INFO - 'LOGNAME': 'cltbld', 04:42:44 INFO - 'MAIL': '/var/mail/cltbld', 04:42:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:44 INFO - 'MOZ_NO_REMOTE': '1', 04:42:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:42:44 INFO - 'NO_EM_RESTART': '1', 04:42:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:44 INFO - 'PWD': '/builds/slave/test', 04:42:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:44 INFO - 'SHELL': '/bin/bash', 04:42:44 INFO - 'SHLVL': '1', 04:42:44 INFO - 'TERM': 'linux', 04:42:44 INFO - 'TMOUT': '86400', 04:42:44 INFO - 'USER': 'cltbld', 04:42:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078', 04:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:44 INFO - '_': '/tools/buildbot/bin/python'} 04:42:44 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/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 04:42:45 INFO - mozversion application_buildid: 20160621031601 04:42:45 INFO - mozversion application_changeset: eb945fc547afc9a4254ef339335fe831c0f68db2 04:42:45 INFO - mozversion application_display_name: Nightly 04:42:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:42:45 INFO - mozversion application_name: Firefox 04:42:45 INFO - mozversion application_remotingname: firefox 04:42:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:42:45 INFO - mozversion application_vendor: Mozilla 04:42:45 INFO - mozversion application_version: 50.0a1 04:42:45 INFO - mozversion platform_buildid: 20160621031601 04:42:45 INFO - mozversion platform_changeset: eb945fc547afc9a4254ef339335fe831c0f68db2 04:42:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:42:45 INFO - mozversion platform_version: 50.0a1 04:42:45 INFO - using testdate: 1466509365 04:42:45 INFO - actual date: 1466509365 04:42:45 INFO - starting webserver on 'localhost:47959' 04:42:45 INFO - SUITE-START | Running 2 tests 04:42:45 INFO - TEST-START | dromaeo_css 04:42:45 INFO - operating with platform_type : linux_ 04:42:45 INFO - Initialising browser for dromaeo_css test... 04:42:45 INFO - TEST-INFO | started process 3365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNT_u9E/profile http://localhost:47959/getInfo.html) 04:42:51 INFO - PROCESS | 3365 | __metrics Screen width/height:1600/1200 04:42:51 INFO - PROCESS | 3365 | colorDepth:24 04:42:51 INFO - PROCESS | 3365 | Browser inner width/height: 1024/697 04:42:51 INFO - PROCESS | 3365 | __metrics 04:42:52 ERROR - PROCESS | 3365 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:42:53 INFO - TEST-INFO | 3365: exit 0 04:42:53 INFO - Browser initialized. 04:42:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:42:53 INFO - TEST-INFO | started process 3487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNT_u9E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:05 INFO - PROCESS | 3487 | RSS: Main: 185909248 04:43:05 INFO - PROCESS | 3487 | 04:43:55 INFO - PROCESS | 3487 | 1466509435152 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] 04:46:07 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:47959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47959/tests/dromaeo/cssquery-ext.html) 04:46:08 INFO - PROCESS | 3487 | RSS: Main: 189411328 04:46:08 INFO - PROCESS | 3487 | 04:49:10 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:47959/tests/dromaeo/cssquery-ext.html (next: http://localhost:47959/tests/dromaeo/cssquery-jquery.html) 04:49:11 INFO - PROCESS | 3487 | RSS: Main: 188534784 04:49:11 INFO - PROCESS | 3487 | 04:52:13 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:47959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47959/tests/dromaeo/cssquery-mootools.html) 04:52:13 INFO - PROCESS | 3487 | RSS: Main: 189444096 04:52:13 INFO - PROCESS | 3487 | 04:55:15 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:47959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47959/tests/dromaeo/cssquery-prototype.html) 04:55:16 INFO - PROCESS | 3487 | RSS: Main: 187117568 04:55:16 INFO - PROCESS | 3487 | 04:58:19 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:47959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47959/tests/dromaeo/cssquery-yui.html) 04:58:19 INFO - PROCESS | 3487 | RSS: Main: 189177856 04:58:19 INFO - PROCESS | 3487 | 05:01:22 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:47959/tests/dromaeo/cssquery-yui.html (next: http://localhost:47959/tests/dromaeo/cssquery-dojo.html) 05:01:22 INFO - PROCESS | 3487 | RSS: Main: 190095360 05:01:22 INFO - PROCESS | 3487 | 05:01:22 INFO - PROCESS | 3487 | __start_tp_report 05:01:22 INFO - PROCESS | 3487 | _x_x_mozilla_page_load 05:01:22 INFO - PROCESS | 3487 | _x_x_mozilla_page_load_details 05:01:22 INFO - PROCESS | 3487 | |i|pagename|runs| 05:01:22 INFO - PROCESS | 3487 | |0;dojo.html;2582.173704414587;2597.2597809624262;2601.0376160820497;2604.92185234443;2643.048502539086;4807.399075115611;4841.563694220159;4848;4858.927116093261;4884.706917584947;4689.57793798558;4793.376861008072;4800.015996720673;4813.807447702087;4825.638077144211;4390.978045109778;4418.491873434564;4502.212112880249;4548.431446069241;4557.74932378719;4211.894702632428;4516.774161291939;4527.411436513249;4614.630829533629;4634.467036290836;4319.092990472004;4377.4528183977;4417.801198946056;4426.247537918562;4481.170983368087;4418.204723149832;4421.4694236691485;4471.7987690554;4497.8425755098415;4504.729716217004;4449.666275029385;4468.642508599304;4487.52880947499;4487.955120448819;4517.932231016537;4766.833160839388;4790.832320868788;4819.614430845524;4863.1732605457155;4874.390701162355;5191.169412893956;5209.479052094798;5211;5219.660722053092;5274.446183150752;5061;5198.376194856603;5259.447757985395;5262.578993680497;5267.183586544092;4862.878428039327;4877.073356062337;4886;4904.8773780655765;4951.257311403282;5369.167778994262;5381.892362152735;5384.515393614515;5388.110961691355;5436.972815135978;4989.975050124726;5031.371078615173;5063.5695965843315;5152.510511501401;5162.096633089194;5041.168207245837;5190.039842629126;5213.296205012351;5217.530422261939;5244.554212891947;5128.1282182029145;5137.126688462896;5178.508041736104;5216.895662086737;5226.764795584208;4975.328330675313;5123.923141152885;5177.068127736969;5201.08980928336;5241.9737901310245;4440.866773996785;4474.910501789946;4475.440569928759;4510.233260345749;4519.706219095749;3863.362545180014;3884.1260716338597;3884.8251828667776;3911;3924.1170736584613;4376.387305777193;4451.732896026248;4542.909141817211;4559.817607295738;4606.769661516911;5161.612879034013;5187.06632806091;5217.58259339252;5221.660592061504;5271.262023316739;4467.508574056851;4480.731156130642;4481.574250446268;4484.39460672805;4536.8638940831825;4619.284010978304;4679.110968915895;4695.929561056587;4703.082898834763;4734.668573199911;4831.637627178046;4897.3878265216845;4915.655904086822;4922.138625740481;4953.90092198154;5227.242049902667;5240.423553409199;5246.501582349671;5246.816361427332;5263.263143159884;4717.457492388419;4848.733319667452;4868.440129385166;4876.658633895735;4894.583960363267;5163.432022477599;5188.118019936544;5190.065788158167;5200.765965531485;5202.4017238016595;5267.394249661184;5273;5290.497402746733;5292.311999440049;5313.309269794902;4899.1426500363;4917.680350777188;4995.275685025578;5048.823291184791;5056.443791182894;5010.699358038383;5027.899442011066;5056.62075344358;5068.2904393384215;5071.518205770446;4979.0788704089855;4991.700497970133;5006.199008158677;5006.249062640633;5024.547790698854;4990.575801056951;5092.898142037213;5108;5157.329547158845;5157.458466860926;4980.850574482772;4986.700797952134;5006.148954677787;5028.044671512401;5042.546170844642 05:01:22 INFO - PROCESS | 3487 | |1;ext.html;543.4262643271275;585.5959388022264;588.3586890289585;588.5615216663587;620.757904417277;34075;39048;39109.99999999996;39172.41241381378;39305.21389572214;38529.422058669144;38580.61419385812;38750.8062459688;38856.22287554247;38909;7796.649150788214;7977.042754869424;7994.320482758943;7997.360211183091;8000.559969201691;7884.093329267151;7973.162817904124;7979.601019949008;7979.720709775159;7981.241782030698;7951.204879512032;7958.124606293303;7983.081945576246;7983.281504664608;7998.440109192359;7883.2905038546805;7920.564368959705;7940.960295198544;7954.363650907942;7991.480553764016;7771.067471903351;7853;7855.685772569091;7892.684292628288;7904.130545639975;29947.10158695221;37806.43290350647;38137.80931095327;38253.42619860704;38389.80805095957;2906.985465072661;3010.548417737335;3059.479888418974;3472.965270347315;3523.453864650983;28197;30252.8487357564;30261.546076808645;30415.23961900948;30841;3533.94699079514;3539.80531070791;3540.7521473496868;3571.321448924696;3666.9816650916573;248723;255636;256743;257495;259104;31842.522362164586;56886.71556642273;58200;58317.70841145852;58398.4160158393;32874.8356258222;35115.64884351175;35218;35237;35339.82330088384;11583.478743456564;11658.883411165949;11707.76584468306;11740.70648233801;11756.23584467007;9974.251931105051;10088.142507886765;10137.949310253402;10147.289689721796;10154.847677284699;8031;8102.594870256464;8122.472039317426;8186.713465028814;8229.753107406787;3205.951910721341;3224.0650211438888;3232.5797646305828;3238.8380580970856;3267.5425440438357;917.6100157433198;939.1922946266205;951.7144856543148;962.4465932088937;972.4651441707033;27162.72837271602;28088.29779255535;28667;28862.567061494094;29027.6458531222;919.7332773495746;931.4830269200523;952.3286083311249;956.4834989105805;1009.8283291840405;13861.23763193034;14206.360713767905;14218.28908554568;14415.207163605892;14467.92766036163;180735;181925;183586;184347;184408;48268.7586562065;48523.272150917765;48674.51325486771;48699;48725;1156.2311063143084;1182.5506307603055;1192.8866757658009;1193.7910865598485;1196.6768972377408;25846.483070338865;27023;27058.72941270641;27108.32229194286;27464;41573.168536628495;42095.36856947209;42139.1572168561;42220.15559688728;42251.15497690091;371045;382337;383443;383822;384970;25434;25663.743362566882;25810.35474113162;25906.093286734875;25908;40423.7978810104;41940.95147621334;42370.78814605907;42610.36084458797;43017.78491107524;35059.29881402307;36430.453543196345;36514.26971460609;36530.452043219906;37035.62964370322;35504.644953551164;36022.27955440824;36542.4518632226;36704.08239794026;36763.816180918926;30018.099457016324;34732.65267347395;34823;35219.47170792389;36420.27159456849;31032.68967310298;32234.516482252315;32439.837800810845;32573.837130814194;32790.67209327972;25142.371440713396;25248.74751252464;25432.618510721983;25437.491250174524;25535.87232063828 05:01:22 INFO - PROCESS | 3487 | |2;jquery.html;365.4705059326718;367.0365291110834;373.0580284780928;387.78477944740655;388.3204392313451;16219.594510137238;16639.667206655875;16815.915920420397;17381;17389.391371301976;15786.605334866634;16341.509754707378;16632.584185395343;16688.41590544331;16778.244978975945;5190.273361729361;5325.893482130355;5400.108982017982;5406.351237851463;5411.296531450926;5273.050850846846;5286.471352864722;5330.653507521999;5347.331583552056;5357.517823395893;5210.973945130288;5258;5303.071962406563;5308.46915308468;5319.787208511655;5202.609804264657;5273.604479664003;5279.498447647467;5287.444818294081;5305.628605997582;4581.244094724367;4683.812647494096;4695.319178719101;4703.0593881223895;4703.553162449562;20141.5971680567;20633.48416289605;20720.274790382417;21022.789772102387;21050.684239736416;1961.5390383259924;2046.7543894732578;2159.470929622237;2354.7409784923643;2542.93642658935;12987.935060324638;13183.143095698844;13456.192628442324;13483.865161348458;13532.458701651922;1734.8785585009055;1821.3352126473874;1841.640880028395;1842.6775314320075;1847.3164928976364;63471.68264158696;64708;66176.6691166546;66568.66715666439;67179;9378.202852757455;9396.295277854188;9766.609335626637;10008.44953527563;10031.899681003242;13273.93363033198;13315.334233288297;13316.134451260637;13341.399637016164;13359.198448093146;6800.421964133104;6901;6907.516473846883;6998.790036298919;7039.190493093258;6419.51853610981;6513.316101809241;6543.247526534415;6565.244996825426;6685.331466853373;6085.695715214221;6155.353198124849;6219.689015549205;6231.283402408691;6258.780942666985;1707.6499317639855;1782.58109344304;1814.1745505795095;1855.5268406556243;1894.5831916978243;900.4957223954607;903.2548147778109;903.2728653434049;918.7749001494676;978.9853152202722;16678.33286668544;16921.979518438802;17763.20065597051;17825.286988520573;17895.642087158183;838.5639467476877;845.2266176448603;856.8286342731354;886.1227384889042;895.6104094718818;9685.17675997534;10112.797744045078;10230.335028223142;10296.382217067;10302.918193589716;369014;388982;395878;396658;399104;42913.570864291585;43676.56323436789;54056;55090.449095508535;65490;915.8168366326761;917.9678711245074;939.8355287824741;945.1824172091092;948.5304774136846;15573.520515551005;15647;15650.9217453912;15900.443484477988;16147.67704645924;33564.66435335615;34709.47935781016;34981.65018349886;35190.64809351976;35492.64507354997;44145.11709765851;46368.76815616035;46380.7680961593;46445.535544644124;49169.75415122901;7592.050993625797;7829.060512738508;8014.19858014194;8110.513369197867;8146.389020823581;11775.941120294343;12056.51773929033;12072.456739446921;12305.630831075083;12412.379381030732;10520.947395262974;10539.947300263757;10592.788144237225;11032.951869572378;11063.446827658423;9186.219171370241;10247.84628230592;10270.845937310796;10488.632897848538;10515.211359147941;10386.948065259625;10607.204459665401;10679.14566834667;10984.231103822656;11316.660500185008;7920.722774702857;7949.8410031797885;8114.107448180577;8118.918810811816;8168.060673022678;10521.316114452537;10525.73685657834;10677.199210059121;10719.517621706886;10994.670159895217 05:01:22 INFO - PROCESS | 3487 | |3;mootools.html;1366.972660546789;1415.2852809331287;1493.4399600149943;1666.3084819799783;1694.2375930831122;6817.659117044141;7540.698372065118;7599.430042746789;8139.104698483162;8150.8369832603385;7660.655270512826;7882.290593846553;7932.365410767139;7933.801654958629;7960.76117716468;2175.195177784222;2222.288867562381;2223.5108276179217;2223.5997520446394;2230.230570453191;2180.269609680751;2181.4655409424713;2207.139215705876;2216;2219.3341997400794;2187.7593464718866;2194.2100843696257;2204.371754050096;2209.823214142865;2214.413180507167;2143.8284937204985;2155.5150091229507;2160.967585486219;2166.73999120105;2166.945826354338;2160.459885028743;2201.636729939558;2201.9559608807895;2204.129368899292;2208.3374987503685;7901.446898717092;7960.40296977729;7995.240452157036;7997.280244777998;8021;4632.559906808848;4742.668013239075;4751.691140075918;4778.689385189951;4786.497417771154;2879.8704058317426;3008.293051132982;3070.7850450468477;3072.9692703072906;3077.2153100959335;920.8756817829574;940.191435365585;943.7074506902813;959.8944116147218;960.1406740966866;10633.308834925705;10641.467926603638;10659.360438373722;10735.785284294348;10758.731031724192;4164.146349998243;4241.809118589671;4310.116426132635;4314.525402205755;4316.352547117957;9150.267978561698;9160.267178625827;9182.265418766483;9185.127412895765;9214.170724634814;4653.557911998355;4665.46347170073;4668.906621867543;4671.579557839811;4675.719456832601;3794.051487128218;4215.97892010538;4217.662586993095;4365.956340436555;4377.956220437819;3597.1546686528645;3629.346717590859;3673.7612055216327;3714.294284086015;3856.46009558662;1186.1163433242118;1212.969675758113;1218.8293638890561;1231.5627952077064;1237.2576454127632;690.378659206718;697.5605368617839;829.8298848735994;838.0655569040598;854.6495936666062;5137.5376216139975;5183.300254465599;5195.246689230041;5260.079486089919;5279.762410691528;406.7132671466609;412.3876044074547;414.2667478562927;421.5068370007038;423.6949396434562;3373.578302712161;3445.397055515325;3473.6005359383994;3492.7729697569575;3500.8774692885627;9107.954460227656;9236.214921731727;9341.813163736688;9362.578683959238;9383.765405864908;9173.678921237724;9176.724698259062;9198.356115071882;9221.769455763659;9281.164695177466;6925.342092501204;6977.476689248225;7179.210286868441;7183.245759195313;7198.748043818546;5196.818111366084;5202.297689811827;5212.947870521246;5553.527950124285;5565.666060036411;8707;9097;9221.49281789508;9224.077592240723;9224.492652904155;8640.135986401561;8977.685780997634;8985.371024028254;9097;9264.675736349196;6520.967395162994;7104.786856394317;7375.704971801068;7488;7673.040869891263;7662.8084297893;7689.538627682357;7692.115406728298;7739.806504837424;7745.883811742716;6790.626515541692;6965.407940325129;7079.610621415872;7095.46783991213;7098;6821.420179284816;6915.308469153045;6951;6976.372126508639;7040.718371265092;6173.9073913892225;6208.286047104641;6262.15460912771;6331.113644089924;6417.133686952388;4542.227821270458;4579.450465944108;4605.654575906888;4670.509596492319;4672.135654903854;4548.6361091113295;4602.401687780567;4628.375169352094;4658.324542941323;4680.063987202505 05:01:22 INFO - PROCESS | 3487 | |4;prototype.html;299.7721731484072;300.2329049279091;301.9215004098934;318.15688425671965;321.5209338086252;4830.2754586812;4994.304214880989;5011.34852469179;5085.771140298686;5090.490950904908;5039.319691841601;5059.241113832918;5067.49325067494;5073.23901414788;5078.39059312883;3851.8074096295145;3861.2470568239205;3876.6898648108086;3895.0651843557484;3910.1788624388914;3835.846566137351;3925.7840818754958;3938.369860822269;3940.1780273135014;3966.682665386762;3909.9804500977457;3941.60583941605;3941.783201923893;3951.940720889189;3954.248692748383;3937.507811523545;3946.506686664167;3947.1513624570566;3954.62431069048;3954.923665075844;3240.287136829894;3378.679025492574;3401.489776533515;3532.8341647256602;3534.5581802274714;4863.635227357962;4888.926666100011;4892.046051020053;4896.632752543538;4942.283368911523;4395;4418.128216659165;4418.867433976954;4468.352088947085;4471.575200355961;5025.698458092526;5217.399999000126;5226.268322434862;5226.686398816083;5294.629375943686;3722.5532936047575;3737.4206997915367;3746.4754934309217;3747.2692824899154;3757.8684746034032;5533.667979921218;5555.777768889239;5576.525995290405;5622.8313150605545;5633.63381380209;3651.1967367179177;3890.9416358754643;3896.928344705229;3906.316394630985;3908.2378936107184;3852.4221366795205;3885.55316138642;3889.4554762333296;3889.747166434173;3892.4161375793856;4410.6030457259;4439.844605438859;4440.511543730187;4449.888752781207;4469.240229161051;5313.57491400687;5319.707416092152;5329.200619907045;5333.386660534011;5354.892902141935;1225.6445630766978;1330.1154732103237;1333.6265845563257;1334.099482849073;1336.5923393364922;846.4709556527171;859.1923591823665;860.9655613775379;861.2464093917822;873.5195642396657;4125.597296919062;4147.543770185277;4160.9375859362135;4163.105786866969;4197.853075142355;4757.476677565465;4787.688800227974;4795.112904112751;4839.733814640158;4867.780949857265;4160.126373461547;4160.188763191149;4197.446944630507;4241.766702831374;4258.488981322261;2469.4567195217023;2542.313575334649;2567.730388309238;2573.6139579063292;2577.690677118758;4472.428353696638;4508.391367165456;4530.462940753188;4534.9319760203625;4572.507983149192;4776.737279449594;4866.31871537985;4902.754862256873;4967.254911763264;4977.129002424634;4549.45406551216;4725.905481890343;5139.890366328393;5140.3293929473075;5156.819511317086;5474.206240095244;5487.75305111263;5510.724463776715;5532.612717109763;5581.637193582566;5192;5358.97320513395;5372.62391632582;5389.730513474389;5393.622446428869;5079.085764562415;5081.92377114351;5085.4914508548845;5094.133997220555;5102.36220472441;3806.3338915690197;3878.864239751595;3900.278448487039;3923.0976875318265;3927.273454410943;4927.778249978688;5540.196671482532;5544.63959842609;5563.972180139235;5578;5269.920951185812;5281.920771188358;5299.5230429261555;5302.3637163540625;5359.330083739533;5129.7691603877165;5254.369475662945;5296.920546191733;5359.973200134131;5394.649347792381;4978.850634480971;5206.193040078794;5229.294045303987;5245.511734696384;5256.266741294582;5287.127623942007;5324.866878327918;5328.893422131613;5354.678719276856;5381.542568881689;5249.553787928069;5263.05265052279;5263.815766448156;5279.155335146358;5288 05:01:22 INFO - PROCESS | 3487 | |5;yui.html;643.2955913274963;658.7595527632412;722.1442590530221;731.7768080735381;732.0922056649756;13012.674683132926;13694.589162325134;13917.860821391783;14010.299485025758;14163.221022843727;13178.736425271489;13483.528076517325;13498.055136140449;13529.932350338258;13591.456341746318;778.5095389904352;789.7986013566532;791.6951973490219;793.317746737805;793.7301317552032;628.8742251549686;776.8601651702692;803.052398170159;806.1656185847648;808.8786681997689;840.5503055865113;846.8306338732248;847.0682249525504;847.1189962439056;849.0109022988212;825.0676735289145;831.4595512916592;834.1241696218976;834.4784509681449;836.1471299274766;612.0727098445858;613.267145760816;613.9539534534928;614.183136428549;615.5137441421317;13332.400041998133;13361.398737056856;13422.597322080353;13427.395767190403;13432.395542200624;13187.472501099945;13476.191428514321;13603.183808971395;13634.659133521642;13862.653433664138;10501.107405870434;10513.106385957202;10530.578776848917;10562.841557376645;10703.678889633324;3370.208001119735;3379;3411.4541673332396;3420.4698271767916;3494.109002204447;57029.714851425895;57212;57327.71336143334;60552.39447605555;60618;10476.68569942903;10636.521356538975;10701;10727.624533141303;10849.783004340026;19580;19586.118624661925;19602.11790469432;19630.509237269183;19650.312239071565;6854.794356169323;6904.378605925391;7099;7228.313310235624;7232.0598322217775;3682.3187710273687;3841;3850.5186851643543;3930.390789427643;3961.485006949078;3012.4426981008583;3151.2121969507625;3155.731762800142;3163.1617621330365;3164.5095010273444;517.1621972404729;560.6495940037477;590.2769107842859;600.6576251536669;605.5942518512608;478.7414796010116;492.6649878082938;504.399764280505;548.4926443040172;549.5603517186235;8124.390670699721;8296.170382961776;8345.5409952452;8486.702965396182;8564.443311184878;563.8618538458104;577.9364269930304;580.12111650849;583.8657108864985;601.5849064145725;3759.342115129841;4149.278049609438;4451.06527629195;4621.8844528886375;4788.425388953278;52108.21837672438;53736;54079.45920540823;54272.185917211275;54322;73671.36957673835;75488;77231.61384193043;77364;77465;45877.770611146734;56569.5857603555;66174.66912665406;68445.65777171082;68982.3101768986;8578.957105214435;8709.12908709124;8727.825443491221;8944.284457243275;9022;40043.599564003984;41989.79005104955;42214.366784497644;42268.154636907704;42505.787471062446;57540;61867.38132618796;61978.69010654918;62550.37449625628;62664.37335626768;11080.833787493355;11266.380349080879;11512.30926144434;11567.421628918351;11743.825617438188;12543.3101179436;12594.118411711092;12908.677283067998;13241.470341186245;13253.337333133497;11575.131865109983;11756.58851940178;12271.527416710052;12441.502339906303;12493.437795299415;11838.230515016496;11894.107941904565;12033.518659253532;12074.879251207376;12181.269123852597;10871.945640271748;11316.49075791575;11731.41342932833;12224.572139975058;12693;10063.69808905734;10257.640982565574;10334.379937203792;10730.248882578144;10886.61896833607;10487.580496780043;10527.368357898551;10555.736106597089;10719.624813131502;10867.728306792078 05:01:22 INFO - PROCESS | 3487 | __end_tp_report 05:01:22 INFO - PROCESS | 3487 | __start_cc_report 05:01:22 INFO - PROCESS | 3487 | _x_x_mozilla_cycle_collect,402 05:01:22 INFO - PROCESS | 3487 | __end_cc_report 05:01:22 INFO - PROCESS | 3487 | __startTimestamp1466510482619__endTimestamp 05:01:22 INFO - PROCESS | 3487 | 05:01:22 INFO - PROCESS | 3487 | ------- Summary: start ------- 05:01:22 INFO - PROCESS | 3487 | Number of tests: 6 05:01:22 INFO - PROCESS | 3487 | 05:01:22 INFO - PROCESS | 3487 | [#0] dojo.html Cycles:165 Average:4805.44 Median:4915.66 stddev:518.40 (10.5%) stddev-sans-first:489.78 05:01:22 INFO - PROCESS | 3487 | Values: 2582.2 2597.3 2601.0 2604.9 2643.0 4807.4 4841.6 4848.0 4858.9 4884.7 4689.6 4793.4 4800.0 4813.8 4825.6 4391.0 4418.5 4502.2 4548.4 4557.7 4211.9 4516.8 4527.4 4614.6 4634.5 4319.1 4377.5 4417.8 4426.2 4481.2 4418.2 4421.5 4471.8 4497.8 4504.7 4449.7 4468.6 4487.5 4488.0 4517.9 4766.8 4790.8 4819.6 4863.2 4874.4 5191.2 5209.5 5211.0 5219.7 5274.4 5061.0 5198.4 5259.4 5262.6 5267.2 4862.9 4877.1 4886.0 4904.9 4951.3 5369.2 5381.9 5384.5 5388.1 5437.0 4990.0 5031.4 5063.6 5152.5 5162.1 5041.2 5190.0 5213.3 5217.5 5244.6 5128.1 5137.1 5178.5 5216.9 5226.8 4975.3 5123.9 5177.1 5201.1 5242.0 4440.9 4474.9 4475.4 4510.2 4519.7 3863.4 3884.1 3884.8 3911.0 3924.1 4376.4 4451.7 4542.9 4559.8 4606.8 5161.6 5187.1 5217.6 5221.7 5271.3 4467.5 4480.7 4481.6 4484.4 4536.9 4619.3 4679.1 4695.9 4703.1 4734.7 4831.6 4897.4 4915.7 4922.1 4953.9 5227.2 5240.4 5246.5 5246.8 5263.3 4717.5 4848.7 4868.4 4876.7 4894.6 5163.4 5188.1 5190.1 5200.8 5202.4 5267.4 5273.0 5290.5 5292.3 5313.3 4899.1 4917.7 4995.3 5048.8 5056.4 5010.7 5027.9 5056.6 5068.3 5071.5 4979.1 4991.7 5006.2 5006.2 5024.5 4990.6 5092.9 5108.0 5157.3 5157.5 4980.9 4986.7 5006.1 5028.0 5042.5 05:01:22 INFO - PROCESS | 3487 | 05:01:22 INFO - PROCESS | 3487 | [#1] ext.html Cycles:180 Average:42393.87 Median:36472.36 stddev:75326.75 (206.5%) stddev-sans-first:75472.53 05:01:22 INFO - PROCESS | 3487 | Values: 543.4 585.6 588.4 588.6 620.8 34075.0 39048.0 39110.0 39172.4 39305.2 38529.4 38580.6 38750.8 38856.2 38909.0 7796.6 7977.0 7994.3 7997.4 8000.6 7884.1 7973.2 7979.6 7979.7 7981.2 7951.2 7958.1 7983.1 7983.3 7998.4 7883.3 7920.6 7941.0 7954.4 7991.5 7771.1 7853.0 7855.7 7892.7 7904.1 29947.1 37806.4 38137.8 38253.4 38389.8 2907.0 3010.5 3059.5 3473.0 3523.5 28197.0 30252.8 30261.5 30415.2 30841.0 3533.9 3539.8 3540.8 3571.3 3667.0 248723.0 255636.0 256743.0 257495.0 259104.0 31842.5 56886.7 58200.0 58317.7 58398.4 32874.8 35115.6 35218.0 35237.0 35339.8 11583.5 11658.9 11707.8 11740.7 11756.2 9974.3 10088.1 10137.9 10147.3 10154.8 8031.0 8102.6 8122.5 8186.7 8229.8 3206.0 3224.1 3232.6 3238.8 3267.5 917.6 939.2 951.7 962.4 972.5 27162.7 28088.3 28667.0 28862.6 29027.6 919.7 931.5 952.3 956.5 1009.8 13861.2 14206.4 14218.3 14415.2 14467.9 180735.0 181925.0 183586.0 184347.0 184408.0 48268.8 48523.3 48674.5 48699.0 48725.0 1156.2 1182.6 1192.9 1193.8 1196.7 25846.5 27023.0 27058.7 27108.3 27464.0 41573.2 42095.4 42139.2 42220.2 42251.2 371045.0 382337.0 383443.0 383822.0 384970.0 25434.0 25663.7 25810.4 25906.1 25908.0 40423.8 41941.0 42370.8 42610.4 43017.8 35059.3 36430.5 36514.3 36530.5 37035.6 35504.6 36022.3 36542.5 36704.1 36763.8 30018.1 34732.7 34823.0 35219.5 36420.3 31032.7 32234.5 32439.8 32573.8 32790.7 25142.4 25248.7 25432.6 25437.5 25535.9 05:01:22 INFO - PROCESS | 3487 | 05:01:22 INFO - PROCESS | 3487 | [#2] jquery.html Cycles:180 Average:23550.18 Median:194685.16 stddev:63811.21 (32.8%) stddev-sans-first:63966.47 05:01:22 INFO - PROCESS | 3487 | Values: 365.5 367.0 373.1 387.8 388.3 16219.6 16639.7 16815.9 17381.0 17389.4 15786.6 16341.5 16632.6 16688.4 16778.2 5190.3 5325.9 5400.1 5406.4 5411.3 5273.1 5286.5 5330.7 5347.3 5357.5 5211.0 5258.0 5303.1 5308.5 5319.8 5202.6 5273.6 5279.5 5287.4 5305.6 4581.2 4683.8 4695.3 4703.1 4703.6 20141.6 20633.5 20720.3 21022.8 21050.7 1961.5 2046.8 2159.5 2354.7 2542.9 12987.9 13183.1 13456.2 13483.9 13532.5 1734.9 1821.3 1841.6 1842.7 1847.3 63471.7 64708.0 66176.7 66568.7 67179.0 9378.2 9396.3 9766.6 10008.4 10031.9 13273.9 13315.3 13316.1 13341.4 13359.2 6800.4 6901.0 6907.5 6998.8 7039.2 6419.5 6513.3 6543.2 6565.2 6685.3 6085.7 6155.4 6219.7 6231.3 6258.8 1707.6 1782.6 1814.2 1855.5 1894.6 900.5 903.3 903.3 918.8 979.0 16678.3 16922.0 17763.2 17825.3 17895.6 838.6 845.2 856.8 886.1 895.6 9685.2 10112.8 10230.3 10296.4 10302.9 369014.0 388982.0 395878.0 396658.0 399104.0 42913.6 43676.6 54056.0 55090.4 65490.0 915.8 918.0 939.8 945.2 948.5 15573.5 15647.0 15650.9 15900.4 16147.7 33564.7 34709.5 34981.7 35190.6 35492.6 44145.1 46368.8 46380.8 46445.5 49169.8 7592.1 7829.1 8014.2 8110.5 8146.4 11775.9 12056.5 12072.5 12305.6 12412.4 10520.9 10539.9 10592.8 11033.0 11063.4 9186.2 10247.8 10270.8 10488.6 10515.2 10386.9 10607.2 10679.1 10984.2 11316.7 7920.7 7949.8 8114.1 8118.9 8168.1 10521.3 10525.7 10677.2 10719.5 10994.7 05:01:22 INFO - PROCESS | 3487 | 05:01:22 INFO - PROCESS | 3487 | [#3] mootools.html Cycles:180 Average:5163.91 Median:5160.42 stddev:2891.66 (56.0%) stddev-sans-first:2885.69 05:01:22 INFO - PROCESS | 3487 | Values: 1367.0 1415.3 1493.4 1666.3 1694.2 6817.7 7540.7 7599.4 8139.1 8150.8 7660.7 7882.3 7932.4 7933.8 7960.8 2175.2 2222.3 2223.5 2223.6 2230.2 2180.3 2181.5 2207.1 2216.0 2219.3 2187.8 2194.2 2204.4 2209.8 2214.4 2143.8 2155.5 2161.0 2166.7 2166.9 2160.5 2201.6 2202.0 2204.1 2208.3 7901.4 7960.4 7995.2 7997.3 8021.0 4632.6 4742.7 4751.7 4778.7 4786.5 2879.9 3008.3 3070.8 3073.0 3077.2 920.9 940.2 943.7 959.9 960.1 10633.3 10641.5 10659.4 10735.8 10758.7 4164.1 4241.8 4310.1 4314.5 4316.4 9150.3 9160.3 9182.3 9185.1 9214.2 4653.6 4665.5 4668.9 4671.6 4675.7 3794.1 4216.0 4217.7 4366.0 4378.0 3597.2 3629.3 3673.8 3714.3 3856.5 1186.1 1213.0 1218.8 1231.6 1237.3 690.4 697.6 829.8 838.1 854.6 5137.5 5183.3 5195.2 5260.1 5279.8 406.7 412.4 414.3 421.5 423.7 3373.6 3445.4 3473.6 3492.8 3500.9 9108.0 9236.2 9341.8 9362.6 9383.8 9173.7 9176.7 9198.4 9221.8 9281.2 6925.3 6977.5 7179.2 7183.2 7198.7 5196.8 5202.3 5212.9 5553.5 5565.7 8707.0 9097.0 9221.5 9224.1 9224.5 8640.1 8977.7 8985.4 9097.0 9264.7 6521.0 7104.8 7375.7 7488.0 7673.0 7662.8 7689.5 7692.1 7739.8 7745.9 6790.6 6965.4 7079.6 7095.5 7098.0 6821.4 6915.3 6951.0 6976.4 7040.7 6173.9 6208.3 6262.2 6331.1 6417.1 4542.2 4579.5 4605.7 4670.5 4672.1 4548.6 4602.4 4628.4 4658.3 4680.1 05:01:22 INFO - PROCESS | 3487 | 05:01:22 INFO - PROCESS | 3487 | [#4] prototype.html Cycles:180 Average:4298.29 Median:4812.69 stddev:1267.72 (26.3%) stddev-sans-first:1235.24 05:01:22 INFO - PROCESS | 3487 | Values: 299.8 300.2 301.9 318.2 321.5 4830.3 4994.3 5011.3 5085.8 5090.5 5039.3 5059.2 5067.5 5073.2 5078.4 3851.8 3861.2 3876.7 3895.1 3910.2 3835.8 3925.8 3938.4 3940.2 3966.7 3910.0 3941.6 3941.8 3951.9 3954.2 3937.5 3946.5 3947.2 3954.6 3954.9 3240.3 3378.7 3401.5 3532.8 3534.6 4863.6 4888.9 4892.0 4896.6 4942.3 4395.0 4418.1 4418.9 4468.4 4471.6 5025.7 5217.4 5226.3 5226.7 5294.6 3722.6 3737.4 3746.5 3747.3 3757.9 5533.7 5555.8 5576.5 5622.8 5633.6 3651.2 3890.9 3896.9 3906.3 3908.2 3852.4 3885.6 3889.5 3889.7 3892.4 4410.6 4439.8 4440.5 4449.9 4469.2 5313.6 5319.7 5329.2 5333.4 5354.9 1225.6 1330.1 1333.6 1334.1 1336.6 846.5 859.2 861.0 861.2 873.5 4125.6 4147.5 4160.9 4163.1 4197.9 4757.5 4787.7 4795.1 4839.7 4867.8 4160.1 4160.2 4197.4 4241.8 4258.5 2469.5 2542.3 2567.7 2573.6 2577.7 4472.4 4508.4 4530.5 4534.9 4572.5 4776.7 4866.3 4902.8 4967.3 4977.1 4549.5 4725.9 5139.9 5140.3 5156.8 5474.2 5487.8 5510.7 5532.6 5581.6 5192.0 5359.0 5372.6 5389.7 5393.6 5079.1 5081.9 5085.5 5094.1 5102.4 3806.3 3878.9 3900.3 3923.1 3927.3 4927.8 5540.2 5544.6 5564.0 5578.0 5269.9 5281.9 5299.5 5302.4 5359.3 5129.8 5254.4 5296.9 5360.0 5394.6 4978.9 5206.2 5229.3 5245.5 5256.3 5287.1 5324.9 5328.9 5354.7 5381.5 5249.6 5263.1 5263.8 5279.2 5288.0 05:01:22 INFO - PROCESS | 3487 | 05:01:22 INFO - PROCESS | 3487 | [#5] yui.html Cycles:180 Average:15953.97 Median:42386.97 stddev:20370.93 (48.1%) stddev-sans-first:20395.63 05:01:22 INFO - PROCESS | 3487 | Values: 643.3 658.8 722.1 731.8 732.1 13012.7 13694.6 13917.9 14010.3 14163.2 13178.7 13483.5 13498.1 13529.9 13591.5 778.5 789.8 791.7 793.3 793.7 628.9 776.9 803.1 806.2 808.9 840.6 846.8 847.1 847.1 849.0 825.1 831.5 834.1 834.5 836.1 612.1 613.3 614.0 614.2 615.5 13332.4 13361.4 13422.6 13427.4 13432.4 13187.5 13476.2 13603.2 13634.7 13862.7 10501.1 10513.1 10530.6 10562.8 10703.7 3370.2 3379.0 3411.5 3420.5 3494.1 57029.7 57212.0 57327.7 60552.4 60618.0 10476.7 10636.5 10701.0 10727.6 10849.8 19580.0 19586.1 19602.1 19630.5 19650.3 6854.8 6904.4 7099.0 7228.3 7232.1 3682.3 3841.0 3850.5 3930.4 3961.5 3012.4 3151.2 3155.7 3163.2 3164.5 517.2 560.6 590.3 600.7 605.6 478.7 492.7 504.4 548.5 549.6 8124.4 8296.2 8345.5 8486.7 8564.4 563.9 577.9 580.1 583.9 601.6 3759.3 4149.3 4451.1 4621.9 4788.4 52108.2 53736.0 54079.5 54272.2 54322.0 73671.4 75488.0 77231.6 77364.0 77465.0 45877.8 56569.6 66174.7 68445.7 68982.3 8579.0 8709.1 8727.8 8944.3 9022.0 40043.6 41989.8 42214.4 42268.2 42505.8 57540.0 61867.4 61978.7 62550.4 62664.4 11080.8 11266.4 11512.3 11567.4 11743.8 12543.3 12594.1 12908.7 13241.5 13253.3 11575.1 11756.6 12271.5 12441.5 12493.4 11838.2 11894.1 12033.5 12074.9 12181.3 10871.9 11316.5 11731.4 12224.6 12693.0 10063.7 10257.6 10334.4 10730.2 10886.6 10487.6 10527.4 10555.7 10719.6 10867.7 05:01:22 INFO - PROCESS | 3487 | -------- Summary: end -------- 05:01:22 INFO - PROCESS | 3487 | 05:01:23 INFO - TEST-INFO | 3487: exit 0 05:01:23 INFO - TEST-OK | dromaeo_css | took 1117996ms 05:01:23 INFO - TEST-START | kraken 05:01:23 INFO - operating with platform_type : linux_ 05:01:23 INFO - Initialising browser for kraken test... 05:01:23 INFO - TEST-INFO | started process 3731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKrziNs/profile http://localhost:47959/getInfo.html) 05:01:28 INFO - PROCESS | 3731 | __metrics Screen width/height:1600/1200 05:01:28 INFO - PROCESS | 3731 | colorDepth:24 05:01:28 INFO - PROCESS | 3731 | Browser inner width/height: 1024/697 05:01:28 INFO - PROCESS | 3731 | __metrics 05:01:28 ERROR - PROCESS | 3731 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:01:29 INFO - TEST-INFO | 3731: exit 0 05:01:29 INFO - Browser initialized. 05:01:29 INFO - Running cycle 1/1 for kraken test... 05:01:29 INFO - TEST-INFO | started process 3851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKrziNs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:41 INFO - PROCESS | 3851 | RSS: Main: 186327040 05:01:41 INFO - PROCESS | 3851 | 05:01:44 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47959/tests/kraken/driver.html?testName=audio-beat-detection) 05:01:45 INFO - PROCESS | 3851 | RSS: Main: 191254528 05:01:45 INFO - PROCESS | 3851 | 05:01:48 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47959/tests/kraken/driver.html?testName=audio-dft) 05:01:49 INFO - PROCESS | 3851 | RSS: Main: 190930944 05:01:49 INFO - PROCESS | 3851 | 05:01:51 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47959/tests/kraken/driver.html?testName=audio-fft) 05:01:52 INFO - PROCESS | 3851 | RSS: Main: 187277312 05:01:52 INFO - PROCESS | 3851 | 05:01:54 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47959/tests/kraken/driver.html?testName=audio-oscillator) 05:01:55 INFO - PROCESS | 3851 | RSS: Main: 186986496 05:01:55 INFO - PROCESS | 3851 | 05:01:57 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:01:58 INFO - PROCESS | 3851 | RSS: Main: 187617280 05:01:58 INFO - PROCESS | 3851 | 05:02:01 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47959/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:01 INFO - PROCESS | 3851 | RSS: Main: 187961344 05:02:01 INFO - PROCESS | 3851 | 05:02:05 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47959/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:06 INFO - PROCESS | 3851 | RSS: Main: 184827904 05:02:06 INFO - PROCESS | 3851 | 05:02:09 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47959/tests/kraken/driver.html?testName=json-parse-financial) 05:02:09 INFO - PROCESS | 3851 | RSS: Main: 186179584 05:02:09 INFO - PROCESS | 3851 | 05:02:11 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:12 INFO - PROCESS | 3851 | RSS: Main: 186384384 05:02:12 INFO - PROCESS | 3851 | 05:02:13 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47959/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:14 INFO - PROCESS | 3851 | RSS: Main: 186511360 05:02:14 INFO - PROCESS | 3851 | 05:02:16 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:17 INFO - PROCESS | 3851 | RSS: Main: 187219968 05:02:17 INFO - PROCESS | 3851 | 05:02:20 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:02:20 INFO - PROCESS | 3851 | RSS: Main: 188215296 05:02:20 INFO - PROCESS | 3851 | 05:02:23 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:02:24 INFO - PROCESS | 3851 | RSS: Main: 188162048 05:02:24 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | Cycle 1(1): loaded http://localhost:47959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47959/tests/kraken/driver.html?testName=ai-astar) 05:02:26 INFO - PROCESS | 3851 | RSS: Main: 189497344 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | __start_tp_report 05:02:26 INFO - PROCESS | 3851 | _x_x_mozilla_page_load 05:02:26 INFO - PROCESS | 3851 | _x_x_mozilla_page_load_details 05:02:26 INFO - PROCESS | 3851 | |i|pagename|runs| 05:02:26 INFO - PROCESS | 3851 | |0;ai-astar;114;110;114;116;115;114;115;114;115;112 05:02:26 INFO - PROCESS | 3851 | |1;audio-beat-detection;156;135;155;182;133;158;161;133;186;144 05:02:26 INFO - PROCESS | 3851 | |2;audio-dft;163;163;173;165;163;163;162;164;160;162 05:02:26 INFO - PROCESS | 3851 | |3;audio-fft;77;76;79;154;78;77;77;76;165;75 05:02:26 INFO - PROCESS | 3851 | |4;audio-oscillator;87;87;139;86;90;88;139;86;87;131 05:02:26 INFO - PROCESS | 3851 | |5;imaging-gaussian-blur;118;118;118;118;118;119;118;117;119;120 05:02:26 INFO - PROCESS | 3851 | |6;imaging-darkroom;149;147;147;148;147;148;147;148;148;147 05:02:26 INFO - PROCESS | 3851 | |7;imaging-desaturate;95;96;95;96;96;96;100;96;96;95 05:02:26 INFO - PROCESS | 3851 | |8;json-parse-financial;65;63;65;62;64;63;66;62;67;64 05:02:26 INFO - PROCESS | 3851 | |9;json-stringify-tinderbox;65;65;65;64;64;65;65;65;65;64 05:02:26 INFO - PROCESS | 3851 | |10;stanford-crypto-aes;83;83;84;83;91;88;90;85;115;85 05:02:26 INFO - PROCESS | 3851 | |11;stanford-crypto-ccm;134;132;133;141;150;134;136;142;136;134 05:02:26 INFO - PROCESS | 3851 | |12;stanford-crypto-pbkdf2;173;174;171;170;173;172;174;173;173;172 05:02:26 INFO - PROCESS | 3851 | |13;stanford-crypto-sha256-iterative;67;70;70;73;69;68;71;67;68;68 05:02:26 INFO - PROCESS | 3851 | __end_tp_report 05:02:26 INFO - PROCESS | 3851 | __start_cc_report 05:02:26 INFO - PROCESS | 3851 | _x_x_mozilla_cycle_collect,978 05:02:26 INFO - PROCESS | 3851 | __end_cc_report 05:02:26 INFO - PROCESS | 3851 | __startTimestamp1466510546591__endTimestamp 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | ------- Summary: start ------- 05:02:26 INFO - PROCESS | 3851 | Number of tests: 14 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.50 stddev:1.73 (1.5%) stddev-sans-first:1.83 05:02:26 INFO - PROCESS | 3851 | Values: 114.0 110.0 114.0 116.0 115.0 114.0 115.0 114.0 115.0 112.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:157.00 stddev:18.92 (12.0%) stddev-sans-first:20.05 05:02:26 INFO - PROCESS | 3851 | Values: 156.0 135.0 155.0 182.0 133.0 158.0 161.0 133.0 186.0 144.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.49 (2.1%) stddev-sans-first:3.69 05:02:26 INFO - PROCESS | 3851 | Values: 163.0 163.0 173.0 165.0 163.0 163.0 162.0 164.0 160.0 162.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#3] audio-fft Cycles:10 Average:93.40 Median:77.00 stddev:34.95 (45.4%) stddev-sans-first:36.56 05:02:26 INFO - PROCESS | 3851 | Values: 77.0 76.0 79.0 154.0 78.0 77.0 77.0 76.0 165.0 75.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:87.00 stddev:23.82 (27.4%) stddev-sans-first:24.64 05:02:26 INFO - PROCESS | 3851 | Values: 87.0 87.0 139.0 86.0 90.0 88.0 139.0 86.0 87.0 131.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 05:02:26 INFO - PROCESS | 3851 | Values: 118.0 118.0 118.0 118.0 118.0 119.0 118.0 117.0 119.0 120.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 05:02:26 INFO - PROCESS | 3851 | Values: 149.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 148.0 147.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.45 (1.5%) stddev-sans-first:1.48 05:02:26 INFO - PROCESS | 3851 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 100.0 96.0 96.0 95.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.50 stddev:1.66 (2.6%) stddev-sans-first:1.73 05:02:26 INFO - PROCESS | 3851 | Values: 65.0 63.0 65.0 62.0 64.0 63.0 66.0 62.0 67.0 64.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 05:02:26 INFO - PROCESS | 3851 | Values: 65.0 65.0 65.0 64.0 64.0 65.0 65.0 65.0 65.0 64.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:85.00 stddev:9.70 (11.4%) stddev-sans-first:10.06 05:02:26 INFO - PROCESS | 3851 | Values: 83.0 83.0 84.0 83.0 91.0 88.0 90.0 85.0 115.0 85.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:136.00 stddev:5.57 (4.1%) stddev-sans-first:5.79 05:02:26 INFO - PROCESS | 3851 | Values: 134.0 132.0 133.0 141.0 150.0 134.0 136.0 142.0 136.0 134.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:1.27 (0.7%) stddev-sans-first:1.33 05:02:26 INFO - PROCESS | 3851 | Values: 173.0 174.0 171.0 170.0 173.0 172.0 174.0 173.0 173.0 172.0 05:02:26 INFO - PROCESS | 3851 | 05:02:26 INFO - PROCESS | 3851 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.91 (2.8%) stddev-sans-first:1.87 05:02:26 INFO - PROCESS | 3851 | Values: 67.0 70.0 70.0 73.0 69.0 68.0 71.0 67.0 68.0 68.0 05:02:26 INFO - PROCESS | 3851 | -------- Summary: end -------- 05:02:26 INFO - PROCESS | 3851 | 05:02:27 INFO - TEST-INFO | 3851: exit 0 05:02:27 INFO - TEST-OK | kraken | took 64303ms 05:02:27 INFO - SUITE-END | took 1182s 05:02:27 INFO - Completed test suite (00:19:42) 05:02:27 INFO - javascript benchmark 05:02:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6369.496426778166, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.173704414587, 2597.2597809624262, 2601.0376160820497, 2604.92185234443, 2643.048502539086, 4807.399075115611, 4841.563694220159, 4848.0, 4858.927116093261, 4884.706917584947, 4689.57793798558, 4793.376861008072, 4800.015996720673, 4813.807447702087, 4825.638077144211, 4390.978045109778, 4418.491873434564, 4502.212112880249, 4548.431446069241, 4557.74932378719, 4211.894702632428, 4516.774161291939, 4527.411436513249, 4614.630829533629, 4634.467036290836, 4319.092990472004, 4377.4528183977, 4417.801198946056, 4426.247537918562, 4481.170983368087, 4418.204723149832, 4421.4694236691485, 4471.7987690554, 4497.8425755098415, 4504.729716217004, 4449.666275029385, 4468.642508599304, 4487.52880947499, 4487.955120448819, 4517.932231016537, 4766.833160839388, 4790.832320868788, 4819.614430845524, 4863.1732605457155, 4874.390701162355, 5191.169412893956, 5209.479052094798, 5211.0, 5219.660722053092, 5274.446183150752, 5061.0, 5198.376194856603, 5259.447757985395, 5262.578993680497, 5267.183586544092, 4862.878428039327, 4877.073356062337, 4886.0, 4904.8773780655765, 4951.257311403282, 5369.167778994262, 5381.892362152735, 5384.515393614515, 5388.110961691355, 5436.972815135978, 4989.975050124726, 5031.371078615173, 5063.5695965843315, 5152.510511501401, 5162.096633089194, 5041.168207245837, 5190.039842629126, 5213.296205012351, 5217.530422261939, 5244.554212891947, 5128.1282182029145, 5137.126688462896, 5178.508041736104, 5216.895662086737, 5226.764795584208, 4975.328330675313, 5123.923141152885, 5177.068127736969, 5201.08980928336, 5241.9737901310245, 4440.866773996785, 4474.910501789946, 4475.440569928759, 4510.233260345749, 4519.706219095749, 3863.362545180014, 3884.1260716338597, 3884.8251828667776, 3911.0, 3924.1170736584613, 4376.387305777193, 4451.732896026248, 4542.909141817211, 4559.817607295738, 4606.769661516911, 5161.612879034013, 5187.06632806091, 5217.58259339252, 5221.660592061504, 5271.262023316739, 4467.508574056851, 4480.731156130642, 4481.574250446268, 4484.39460672805, 4536.8638940831825, 4619.284010978304, 4679.110968915895, 4695.929561056587, 4703.082898834763, 4734.668573199911, 4831.637627178046, 4897.3878265216845, 4915.655904086822, 4922.138625740481, 4953.90092198154, 5227.242049902667, 5240.423553409199, 5246.501582349671, 5246.816361427332, 5263.263143159884, 4717.457492388419, 4848.733319667452, 4868.440129385166, 4876.658633895735, 4894.583960363267, 5163.432022477599, 5188.118019936544, 5190.065788158167, 5200.765965531485, 5202.4017238016595, 5267.394249661184, 5273.0, 5290.497402746733, 5292.311999440049, 5313.309269794902, 4899.1426500363, 4917.680350777188, 4995.275685025578, 5048.823291184791, 5056.443791182894, 5010.699358038383, 5027.899442011066, 5056.62075344358, 5068.2904393384215, 5071.518205770446, 4979.0788704089855, 4991.700497970133, 5006.199008158677, 5006.249062640633, 5024.547790698854, 4990.575801056951, 5092.898142037213, 5108.0, 5157.329547158845, 5157.458466860926, 4980.850574482772, 4986.700797952134, 5006.148954677787, 5028.044671512401, 5042.546170844642], "value": 4770.710773917256, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.4262643271275, 585.5959388022264, 588.3586890289585, 588.5615216663587, 620.757904417277, 34075.0, 39048.0, 39109.99999999996, 39172.41241381378, 39305.21389572214, 38529.422058669144, 38580.61419385812, 38750.8062459688, 38856.22287554247, 38909.0, 7796.649150788214, 7977.042754869424, 7994.320482758943, 7997.360211183091, 8000.559969201691, 7884.093329267151, 7973.162817904124, 7979.601019949008, 7979.720709775159, 7981.241782030698, 7951.204879512032, 7958.124606293303, 7983.081945576246, 7983.281504664608, 7998.440109192359, 7883.2905038546805, 7920.564368959705, 7940.960295198544, 7954.363650907942, 7991.480553764016, 7771.067471903351, 7853.0, 7855.685772569091, 7892.684292628288, 7904.130545639975, 29947.10158695221, 37806.43290350647, 38137.80931095327, 38253.42619860704, 38389.80805095957, 2906.985465072661, 3010.548417737335, 3059.479888418974, 3472.965270347315, 3523.453864650983, 28197.0, 30252.8487357564, 30261.546076808645, 30415.23961900948, 30841.0, 3533.94699079514, 3539.80531070791, 3540.7521473496868, 3571.321448924696, 3666.9816650916573, 248723.0, 255636.0, 256743.0, 257495.0, 259104.0, 31842.522362164586, 56886.71556642273, 58200.0, 58317.70841145852, 58398.4160158393, 32874.8356258222, 35115.64884351175, 35218.0, 35237.0, 35339.82330088384, 11583.478743456564, 11658.883411165949, 11707.76584468306, 11740.70648233801, 11756.23584467007, 9974.251931105051, 10088.142507886765, 10137.949310253402, 10147.289689721796, 10154.847677284699, 8031.0, 8102.594870256464, 8122.472039317426, 8186.713465028814, 8229.753107406787, 3205.951910721341, 3224.0650211438888, 3232.5797646305828, 3238.8380580970856, 3267.5425440438357, 917.6100157433198, 939.1922946266205, 951.7144856543148, 962.4465932088937, 972.4651441707033, 27162.72837271602, 28088.29779255535, 28667.0, 28862.567061494094, 29027.6458531222, 919.7332773495746, 931.4830269200523, 952.3286083311249, 956.4834989105805, 1009.8283291840405, 13861.23763193034, 14206.360713767905, 14218.28908554568, 14415.207163605892, 14467.92766036163, 180735.0, 181925.0, 183586.0, 184347.0, 184408.0, 48268.7586562065, 48523.272150917765, 48674.51325486771, 48699.0, 48725.0, 1156.2311063143084, 1182.5506307603055, 1192.8866757658009, 1193.7910865598485, 1196.6768972377408, 25846.483070338865, 27023.0, 27058.72941270641, 27108.32229194286, 27464.0, 41573.168536628495, 42095.36856947209, 42139.1572168561, 42220.15559688728, 42251.15497690091, 371045.0, 382337.0, 383443.0, 383822.0, 384970.0, 25434.0, 25663.743362566882, 25810.35474113162, 25906.093286734875, 25908.0, 40423.7978810104, 41940.95147621334, 42370.78814605907, 42610.36084458797, 43017.78491107524, 35059.29881402307, 36430.453543196345, 36514.26971460609, 36530.452043219906, 37035.62964370322, 35504.644953551164, 36022.27955440824, 36542.4518632226, 36704.08239794026, 36763.816180918926, 30018.099457016324, 34732.65267347395, 34823.0, 35219.47170792389, 36420.27159456849, 31032.68967310298, 32234.516482252315, 32439.837800810845, 32573.837130814194, 32790.67209327972, 25142.371440713396, 25248.74751252464, 25432.618510721983, 25437.491250174524, 25535.87232063828], "value": 16174.084606134862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.4705059326718, 367.0365291110834, 373.0580284780928, 387.78477944740655, 388.3204392313451, 16219.594510137238, 16639.667206655875, 16815.915920420397, 17381.0, 17389.391371301976, 15786.605334866634, 16341.509754707378, 16632.584185395343, 16688.41590544331, 16778.244978975945, 5190.273361729361, 5325.893482130355, 5400.108982017982, 5406.351237851463, 5411.296531450926, 5273.050850846846, 5286.471352864722, 5330.653507521999, 5347.331583552056, 5357.517823395893, 5210.973945130288, 5258.0, 5303.071962406563, 5308.46915308468, 5319.787208511655, 5202.609804264657, 5273.604479664003, 5279.498447647467, 5287.444818294081, 5305.628605997582, 4581.244094724367, 4683.812647494096, 4695.319178719101, 4703.0593881223895, 4703.553162449562, 20141.5971680567, 20633.48416289605, 20720.274790382417, 21022.789772102387, 21050.684239736416, 1961.5390383259924, 2046.7543894732578, 2159.470929622237, 2354.7409784923643, 2542.93642658935, 12987.935060324638, 13183.143095698844, 13456.192628442324, 13483.865161348458, 13532.458701651922, 1734.8785585009055, 1821.3352126473874, 1841.640880028395, 1842.6775314320075, 1847.3164928976364, 63471.68264158696, 64708.0, 66176.6691166546, 66568.66715666439, 67179.0, 9378.202852757455, 9396.295277854188, 9766.609335626637, 10008.44953527563, 10031.899681003242, 13273.93363033198, 13315.334233288297, 13316.134451260637, 13341.399637016164, 13359.198448093146, 6800.421964133104, 6901.0, 6907.516473846883, 6998.790036298919, 7039.190493093258, 6419.51853610981, 6513.316101809241, 6543.247526534415, 6565.244996825426, 6685.331466853373, 6085.695715214221, 6155.353198124849, 6219.689015549205, 6231.283402408691, 6258.780942666985, 1707.6499317639855, 1782.58109344304, 1814.1745505795095, 1855.5268406556243, 1894.5831916978243, 900.4957223954607, 903.2548147778109, 903.2728653434049, 918.7749001494676, 978.9853152202722, 16678.33286668544, 16921.979518438802, 17763.20065597051, 17825.286988520573, 17895.642087158183, 838.5639467476877, 845.2266176448603, 856.8286342731354, 886.1227384889042, 895.6104094718818, 9685.17675997534, 10112.797744045078, 10230.335028223142, 10296.382217067, 10302.918193589716, 369014.0, 388982.0, 395878.0, 396658.0, 399104.0, 42913.570864291585, 43676.56323436789, 54056.0, 55090.449095508535, 65490.0, 915.8168366326761, 917.9678711245074, 939.8355287824741, 945.1824172091092, 948.5304774136846, 15573.520515551005, 15647.0, 15650.9217453912, 15900.443484477988, 16147.67704645924, 33564.66435335615, 34709.47935781016, 34981.65018349886, 35190.64809351976, 35492.64507354997, 44145.11709765851, 46368.76815616035, 46380.7680961593, 46445.535544644124, 49169.75415122901, 7592.050993625797, 7829.060512738508, 8014.19858014194, 8110.513369197867, 8146.389020823581, 11775.941120294343, 12056.51773929033, 12072.456739446921, 12305.630831075083, 12412.379381030732, 10520.947395262974, 10539.947300263757, 10592.788144237225, 11032.951869572378, 11063.446827658423, 9186.219171370241, 10247.84628230592, 10270.845937310796, 10488.632897848538, 10515.211359147941, 10386.948065259625, 10607.204459665401, 10679.14566834667, 10984.231103822656, 11316.660500185008, 7920.722774702857, 7949.8410031797885, 8114.107448180577, 8118.918810811816, 8168.060673022678, 10521.316114452537, 10525.73685657834, 10677.199210059121, 10719.517621706886, 10994.670159895217], "value": 8303.4769569901, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.972660546789, 1415.2852809331287, 1493.4399600149943, 1666.3084819799783, 1694.2375930831122, 6817.659117044141, 7540.698372065118, 7599.430042746789, 8139.104698483162, 8150.8369832603385, 7660.655270512826, 7882.290593846553, 7932.365410767139, 7933.801654958629, 7960.76117716468, 2175.195177784222, 2222.288867562381, 2223.5108276179217, 2223.5997520446394, 2230.230570453191, 2180.269609680751, 2181.4655409424713, 2207.139215705876, 2216.0, 2219.3341997400794, 2187.7593464718866, 2194.2100843696257, 2204.371754050096, 2209.823214142865, 2214.413180507167, 2143.8284937204985, 2155.5150091229507, 2160.967585486219, 2166.73999120105, 2166.945826354338, 2160.459885028743, 2201.636729939558, 2201.9559608807895, 2204.129368899292, 2208.3374987503685, 7901.446898717092, 7960.40296977729, 7995.240452157036, 7997.280244777998, 8021.0, 4632.559906808848, 4742.668013239075, 4751.691140075918, 4778.689385189951, 4786.497417771154, 2879.8704058317426, 3008.293051132982, 3070.7850450468477, 3072.9692703072906, 3077.2153100959335, 920.8756817829574, 940.191435365585, 943.7074506902813, 959.8944116147218, 960.1406740966866, 10633.308834925705, 10641.467926603638, 10659.360438373722, 10735.785284294348, 10758.731031724192, 4164.146349998243, 4241.809118589671, 4310.116426132635, 4314.525402205755, 4316.352547117957, 9150.267978561698, 9160.267178625827, 9182.265418766483, 9185.127412895765, 9214.170724634814, 4653.557911998355, 4665.46347170073, 4668.906621867543, 4671.579557839811, 4675.719456832601, 3794.051487128218, 4215.97892010538, 4217.662586993095, 4365.956340436555, 4377.956220437819, 3597.1546686528645, 3629.346717590859, 3673.7612055216327, 3714.294284086015, 3856.46009558662, 1186.1163433242118, 1212.969675758113, 1218.8293638890561, 1231.5627952077064, 1237.2576454127632, 690.378659206718, 697.5605368617839, 829.8298848735994, 838.0655569040598, 854.6495936666062, 5137.5376216139975, 5183.300254465599, 5195.246689230041, 5260.079486089919, 5279.762410691528, 406.7132671466609, 412.3876044074547, 414.2667478562927, 421.5068370007038, 423.6949396434562, 3373.578302712161, 3445.397055515325, 3473.6005359383994, 3492.7729697569575, 3500.8774692885627, 9107.954460227656, 9236.214921731727, 9341.813163736688, 9362.578683959238, 9383.765405864908, 9173.678921237724, 9176.724698259062, 9198.356115071882, 9221.769455763659, 9281.164695177466, 6925.342092501204, 6977.476689248225, 7179.210286868441, 7183.245759195313, 7198.748043818546, 5196.818111366084, 5202.297689811827, 5212.947870521246, 5553.527950124285, 5565.666060036411, 8707.0, 9097.0, 9221.49281789508, 9224.077592240723, 9224.492652904155, 8640.135986401561, 8977.685780997634, 8985.371024028254, 9097.0, 9264.675736349196, 6520.967395162994, 7104.786856394317, 7375.704971801068, 7488.0, 7673.040869891263, 7662.8084297893, 7689.538627682357, 7692.115406728298, 7739.806504837424, 7745.883811742716, 6790.626515541692, 6965.407940325129, 7079.610621415872, 7095.46783991213, 7098.0, 6821.420179284816, 6915.308469153045, 6951.0, 6976.372126508639, 7040.718371265092, 6173.9073913892225, 6208.286047104641, 6262.15460912771, 6331.113644089924, 6417.133686952388, 4542.227821270458, 4579.450465944108, 4605.654575906888, 4670.509596492319, 4672.135654903854, 4548.6361091113295, 4602.401687780567, 4628.375169352094, 4658.324542941323, 4680.063987202505], "value": 4090.2523438394364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.7721731484072, 300.2329049279091, 301.9215004098934, 318.15688425671965, 321.5209338086252, 4830.2754586812, 4994.304214880989, 5011.34852469179, 5085.771140298686, 5090.490950904908, 5039.319691841601, 5059.241113832918, 5067.49325067494, 5073.23901414788, 5078.39059312883, 3851.8074096295145, 3861.2470568239205, 3876.6898648108086, 3895.0651843557484, 3910.1788624388914, 3835.846566137351, 3925.7840818754958, 3938.369860822269, 3940.1780273135014, 3966.682665386762, 3909.9804500977457, 3941.60583941605, 3941.783201923893, 3951.940720889189, 3954.248692748383, 3937.507811523545, 3946.506686664167, 3947.1513624570566, 3954.62431069048, 3954.923665075844, 3240.287136829894, 3378.679025492574, 3401.489776533515, 3532.8341647256602, 3534.5581802274714, 4863.635227357962, 4888.926666100011, 4892.046051020053, 4896.632752543538, 4942.283368911523, 4395.0, 4418.128216659165, 4418.867433976954, 4468.352088947085, 4471.575200355961, 5025.698458092526, 5217.399999000126, 5226.268322434862, 5226.686398816083, 5294.629375943686, 3722.5532936047575, 3737.4206997915367, 3746.4754934309217, 3747.2692824899154, 3757.8684746034032, 5533.667979921218, 5555.777768889239, 5576.525995290405, 5622.8313150605545, 5633.63381380209, 3651.1967367179177, 3890.9416358754643, 3896.928344705229, 3906.316394630985, 3908.2378936107184, 3852.4221366795205, 3885.55316138642, 3889.4554762333296, 3889.747166434173, 3892.4161375793856, 4410.6030457259, 4439.844605438859, 4440.511543730187, 4449.888752781207, 4469.240229161051, 5313.57491400687, 5319.707416092152, 5329.200619907045, 5333.386660534011, 5354.892902141935, 1225.6445630766978, 1330.1154732103237, 1333.6265845563257, 1334.099482849073, 1336.5923393364922, 846.4709556527171, 859.1923591823665, 860.9655613775379, 861.2464093917822, 873.5195642396657, 4125.597296919062, 4147.543770185277, 4160.9375859362135, 4163.105786866969, 4197.853075142355, 4757.476677565465, 4787.688800227974, 4795.112904112751, 4839.733814640158, 4867.780949857265, 4160.126373461547, 4160.188763191149, 4197.446944630507, 4241.766702831374, 4258.488981322261, 2469.4567195217023, 2542.313575334649, 2567.730388309238, 2573.6139579063292, 2577.690677118758, 4472.428353696638, 4508.391367165456, 4530.462940753188, 4534.9319760203625, 4572.507983149192, 4776.737279449594, 4866.31871537985, 4902.754862256873, 4967.254911763264, 4977.129002424634, 4549.45406551216, 4725.905481890343, 5139.890366328393, 5140.3293929473075, 5156.819511317086, 5474.206240095244, 5487.75305111263, 5510.724463776715, 5532.612717109763, 5581.637193582566, 5192.0, 5358.97320513395, 5372.62391632582, 5389.730513474389, 5393.622446428869, 5079.085764562415, 5081.92377114351, 5085.4914508548845, 5094.133997220555, 5102.36220472441, 3806.3338915690197, 3878.864239751595, 3900.278448487039, 3923.0976875318265, 3927.273454410943, 4927.778249978688, 5540.196671482532, 5544.63959842609, 5563.972180139235, 5578.0, 5269.920951185812, 5281.920771188358, 5299.5230429261555, 5302.3637163540625, 5359.330083739533, 5129.7691603877165, 5254.369475662945, 5296.920546191733, 5359.973200134131, 5394.649347792381, 4978.850634480971, 5206.193040078794, 5229.294045303987, 5245.511734696384, 5256.266741294582, 5287.127623942007, 5324.866878327918, 5328.893422131613, 5354.678719276856, 5381.542568881689, 5249.553787928069, 5263.05265052279, 5263.815766448156, 5279.155335146358, 5288.0], "value": 3894.8735883705194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.2955913274963, 658.7595527632412, 722.1442590530221, 731.7768080735381, 732.0922056649756, 13012.674683132926, 13694.589162325134, 13917.860821391783, 14010.299485025758, 14163.221022843727, 13178.736425271489, 13483.528076517325, 13498.055136140449, 13529.932350338258, 13591.456341746318, 778.5095389904352, 789.7986013566532, 791.6951973490219, 793.317746737805, 793.7301317552032, 628.8742251549686, 776.8601651702692, 803.052398170159, 806.1656185847648, 808.8786681997689, 840.5503055865113, 846.8306338732248, 847.0682249525504, 847.1189962439056, 849.0109022988212, 825.0676735289145, 831.4595512916592, 834.1241696218976, 834.4784509681449, 836.1471299274766, 612.0727098445858, 613.267145760816, 613.9539534534928, 614.183136428549, 615.5137441421317, 13332.400041998133, 13361.398737056856, 13422.597322080353, 13427.395767190403, 13432.395542200624, 13187.472501099945, 13476.191428514321, 13603.183808971395, 13634.659133521642, 13862.653433664138, 10501.107405870434, 10513.106385957202, 10530.578776848917, 10562.841557376645, 10703.678889633324, 3370.208001119735, 3379.0, 3411.4541673332396, 3420.4698271767916, 3494.109002204447, 57029.714851425895, 57212.0, 57327.71336143334, 60552.39447605555, 60618.0, 10476.68569942903, 10636.521356538975, 10701.0, 10727.624533141303, 10849.783004340026, 19580.0, 19586.118624661925, 19602.11790469432, 19630.509237269183, 19650.312239071565, 6854.794356169323, 6904.378605925391, 7099.0, 7228.313310235624, 7232.0598322217775, 3682.3187710273687, 3841.0, 3850.5186851643543, 3930.390789427643, 3961.485006949078, 3012.4426981008583, 3151.2121969507625, 3155.731762800142, 3163.1617621330365, 3164.5095010273444, 517.1621972404729, 560.6495940037477, 590.2769107842859, 600.6576251536669, 605.5942518512608, 478.7414796010116, 492.6649878082938, 504.399764280505, 548.4926443040172, 549.5603517186235, 8124.390670699721, 8296.170382961776, 8345.5409952452, 8486.702965396182, 8564.443311184878, 563.8618538458104, 577.9364269930304, 580.12111650849, 583.8657108864985, 601.5849064145725, 3759.342115129841, 4149.278049609438, 4451.06527629195, 4621.8844528886375, 4788.425388953278, 52108.21837672438, 53736.0, 54079.45920540823, 54272.185917211275, 54322.0, 73671.36957673835, 75488.0, 77231.61384193043, 77364.0, 77465.0, 45877.770611146734, 56569.5857603555, 66174.66912665406, 68445.65777171082, 68982.3101768986, 8578.957105214435, 8709.12908709124, 8727.825443491221, 8944.284457243275, 9022.0, 40043.599564003984, 41989.79005104955, 42214.366784497644, 42268.154636907704, 42505.787471062446, 57540.0, 61867.38132618796, 61978.69010654918, 62550.37449625628, 62664.37335626768, 11080.833787493355, 11266.380349080879, 11512.30926144434, 11567.421628918351, 11743.825617438188, 12543.3101179436, 12594.118411711092, 12908.677283067998, 13241.470341186245, 13253.337333133497, 11575.131865109983, 11756.58851940178, 12271.527416710052, 12441.502339906303, 12493.437795299415, 11838.230515016496, 11894.107941904565, 12033.518659253532, 12074.879251207376, 12181.269123852597, 10871.945640271748, 11316.49075791575, 11731.41342932833, 12224.572139975058, 12693.0, 10063.69808905734, 10257.640982565574, 10334.379937203792, 10730.248882578144, 10886.61896833607, 10487.580496780043, 10527.368357898551, 10555.736106597089, 10719.624813131502, 10867.728306792078], "value": 6541.52781284069, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 116.0, 115.0, 114.0, 115.0, 114.0, 115.0, 112.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 135.0, 155.0, 182.0, 133.0, 158.0, 161.0, 133.0, 186.0, 144.0], "value": 154.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 173.0, 165.0, 163.0, 163.0, 162.0, 164.0, 160.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 79.0, 154.0, 78.0, 77.0, 77.0, 76.0, 165.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 139.0, 86.0, 90.0, 88.0, 139.0, 86.0, 87.0, 131.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 117.0, 119.0, 120.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 100.0, 96.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 62.0, 64.0, 63.0, 66.0, 62.0, 67.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 83.0, 91.0, 88.0, 90.0, 85.0, 115.0, 85.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 133.0, 141.0, 150.0, 134.0, 136.0, 142.0, 136.0, 134.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 171.0, 170.0, 173.0, 172.0, 174.0, 173.0, 173.0, 172.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 70.0, 73.0, 69.0, 68.0, 71.0, 67.0, 68.0, 68.0], "value": 69.1, "unit": "score"}]}]} 05:02:27 INFO - Return code: 0 05:02:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:02:27 ERROR - # TBPL SUCCESS # 05:02:27 INFO - Running post-action listener: _resource_record_post_action 05:02:27 INFO - ##### 05:02:27 INFO - ##### Finished run-tests step (success) 05:02:27 INFO - ##### 05:02:27 INFO - Running post-run listener: _resource_record_post_run 05:02:27 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 7786496; Write bytes: 298606592; Read time: 1564; Write time: 192144 05:02:27 INFO - TinderboxPrint: CPU usage
13.5% 05:02:27 INFO - TinderboxPrint: I/O read bytes / time
7,786,496 / 1,564 05:02:27 INFO - TinderboxPrint: I/O write bytes / time
298,606,592 / 192,144 05:02:27 INFO - TinderboxPrint: CPU idle
8,282.6 (86.5%) 05:02:27 INFO - TinderboxPrint: CPU user
1,234.2 (12.9%) 05:02:27 INFO - TinderboxPrint: Swap in / out
0 / 0 05:02:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1437696; Read time: 0; Write time: 128 05:02:28 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 6025216; Write bytes: 287125504; Read time: 1520; Write time: 186664 05:02:28 INFO - Running post-run listener: _upload_blobber_files 05:02:28 INFO - Blob upload gear active. 05:02:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:02:28 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:02:28 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:02:28 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:02:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:02:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:02:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:02:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:29 INFO - (blobuploader) - INFO - Done attempting. 05:02:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:02:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:02:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:30 INFO - (blobuploader) - INFO - Done attempting. 05:02:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:02:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:34 INFO - (blobuploader) - INFO - Done attempting. 05:02:34 INFO - (blobuploader) - INFO - Iteration through files over. 05:02:34 INFO - Return code: 0 05:02:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:02:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:02:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/433bc6e1af97e09aa2fddc6ba082d135c5e59f19e80e367c7b3e18602864b6ef9c8d2137907841b63bece306f5cbd9018a8d79e0d14f3dd3182ebda662032c72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/849ffae27062cb122b6e2228e5ccaa235c71d055e5b35f3dbe603630c5dc8332b3f4d2d2f39300bc08dd2de48097635901ae7aa4aeb9b3877e114fce2212f33b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ca9bafdb35b0928f9c4ffd3779814d1654d152d9e5e072b882b313048104501a4dbb47b9a9178c37cd84dbb50a5cfa33c99d1ea357c1d215011983a188ac545"} 05:02:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:02:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:02:34 INFO - Contents: 05:02:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/433bc6e1af97e09aa2fddc6ba082d135c5e59f19e80e367c7b3e18602864b6ef9c8d2137907841b63bece306f5cbd9018a8d79e0d14f3dd3182ebda662032c72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/849ffae27062cb122b6e2228e5ccaa235c71d055e5b35f3dbe603630c5dc8332b3f4d2d2f39300bc08dd2de48097635901ae7aa4aeb9b3877e114fce2212f33b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ca9bafdb35b0928f9c4ffd3779814d1654d152d9e5e072b882b313048104501a4dbb47b9a9178c37cd84dbb50a5cfa33c99d1ea357c1d215011983a188ac545"} 05:02:34 INFO - Running post-run listener: copy_logs_to_upload_dir 05:02:34 INFO - Copying logs to upload dir... 05:02:34 INFO - mkdir: /builds/slave/test/build/upload/logs 05:02:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.130862 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-21 05:02:34.421976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 05:02:34.426881) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078 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/433bc6e1af97e09aa2fddc6ba082d135c5e59f19e80e367c7b3e18602864b6ef9c8d2137907841b63bece306f5cbd9018a8d79e0d14f3dd3182ebda662032c72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/849ffae27062cb122b6e2228e5ccaa235c71d055e5b35f3dbe603630c5dc8332b3f4d2d2f39300bc08dd2de48097635901ae7aa4aeb9b3877e114fce2212f33b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ca9bafdb35b0928f9c4ffd3779814d1654d152d9e5e072b882b313048104501a4dbb47b9a9178c37cd84dbb50a5cfa33c99d1ea357c1d215011983a188ac545"} build_url:https://queue.taskcluster.net/v1/task/e3LGWn7QQgmAdIpKgU1sOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/e3LGWn7QQgmAdIpKgU1sOw/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/433bc6e1af97e09aa2fddc6ba082d135c5e59f19e80e367c7b3e18602864b6ef9c8d2137907841b63bece306f5cbd9018a8d79e0d14f3dd3182ebda662032c72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/849ffae27062cb122b6e2228e5ccaa235c71d055e5b35f3dbe603630c5dc8332b3f4d2d2f39300bc08dd2de48097635901ae7aa4aeb9b3877e114fce2212f33b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0ca9bafdb35b0928f9c4ffd3779814d1654d152d9e5e072b882b313048104501a4dbb47b9a9178c37cd84dbb50a5cfa33c99d1ea357c1d215011983a188ac545"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 05:02:34.454678) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:02:34.454999) ========= 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=6d15e502d8e29d5d2676d664000001c3-1466508599.321457-277107078 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 05:02:34.537247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 05:02:34.540608) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 05:02:34.540896) ========= ========= Total master_lag: 0.19 =========