builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1466694697.92 results: success (0) buildid: 20160623053004 builduid: ec09f4010edb4e879ae2822395415733 revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:37.917529) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:37.918007) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:37.918317) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:37.933302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:37.933566) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 08:11:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.4M=0s 2016-06-23 08:11:38 (66.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100156 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:38.048201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:38.048512) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023382 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:38.097890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:38.098250) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --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 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 08:11:38,230 truncating revision to first 12 chars 2016-06-23 08:11:38,230 Setting DEBUG logging. 2016-06-23 08:11:38,230 attempt 1/10 2016-06-23 08:11:38,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3cdc8b1b2bb5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 08:11:38,609 unpacking tar archive at: fx-team-3cdc8b1b2bb5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.782373 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:39.002884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:39.003231) ========= script_repo_revision: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:39.003617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:39.003879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 08:11:39.014623) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-23 08:11:39.014905) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:11:39 INFO - MultiFileLogger online at 20160623 08:11:39 in /builds/slave/test 08:11:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:11:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:11:39 INFO - {'append_to_log': False, 08:11:39 INFO - 'base_work_dir': '/builds/slave/test', 08:11:39 INFO - 'blob_upload_branch': 'Fx-Team', 08:11:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:11:39 INFO - 'branch': 'Fx-Team', 08:11:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:11:39 INFO - 'config_files': ('talos/linux_config.py',), 08:11:39 INFO - 'default_actions': ('clobber', 08:11:39 INFO - 'read-buildbot-config', 08:11:39 INFO - 'download-and-extract', 08:11:39 INFO - 'populate-webroot', 08:11:39 INFO - 'create-virtualenv', 08:11:39 INFO - 'install', 08:11:39 INFO - 'run-tests'), 08:11:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:11:39 INFO - 'download_minidump_stackwalk': True, 08:11:39 INFO - 'download_symbols': 'ondemand', 08:11:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:11:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:11:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:11:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:11:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:11:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:11:39 INFO - 'installer_path': 'installer.exe', 08:11:39 INFO - 'log_level': 'info', 08:11:39 INFO - 'log_name': 'talos', 08:11:39 INFO - 'log_to_console': True, 08:11:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:11:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:11:39 INFO - 'opt_config_files': (), 08:11:39 INFO - 'pip_index': False, 08:11:39 INFO - 'sps_profile': False, 08:11:39 INFO - 'sps_profile_interval': 0, 08:11:39 INFO - 'suite': 'dromaeojs-e10s', 08:11:39 INFO - 'system_bits': '32', 08:11:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:11:39 INFO - 'title': 'talos-linux64-ix-067', 08:11:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:11:39 INFO - 'use_talos_json': True, 08:11:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:11:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:11:39 INFO - 'work_dir': 'build'} 08:11:39 INFO - ##### 08:11:39 INFO - ##### Running clobber step. 08:11:39 INFO - ##### 08:11:39 INFO - Running pre-action listener: _resource_record_pre_action 08:11:39 INFO - Running main action method: clobber 08:11:39 INFO - rmtree: /builds/slave/test/build 08:11:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:11:39 INFO - Running post-action listener: _resource_record_post_action 08:11:39 INFO - ##### 08:11:39 INFO - ##### Finished clobber step (success) 08:11:39 INFO - ##### 08:11:39 INFO - ##### 08:11:39 INFO - ##### Running read-buildbot-config step. 08:11:39 INFO - ##### 08:11:39 INFO - Running pre-action listener: _resource_record_pre_action 08:11:39 INFO - Running main action method: read_buildbot_config 08:11:39 INFO - Using buildbot properties: 08:11:39 INFO - { 08:11:39 INFO - "project": "", 08:11:39 INFO - "product": "firefox", 08:11:39 INFO - "script_repo_revision": "production", 08:11:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:11:39 INFO - "repository": "", 08:11:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:11:39 INFO - "buildid": "20160623053004", 08:11:39 INFO - "pgo_build": "True", 08:11:39 INFO - "basedir": "/builds/slave/test", 08:11:39 INFO - "buildnumber": 860, 08:11:39 INFO - "slavename": "talos-linux64-ix-067", 08:11:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:11:39 INFO - "platform": "ubuntu64_hw", 08:11:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:11:39 INFO - "branch": "fx-team", 08:11:39 INFO - "repo_path": "integration/fx-team", 08:11:39 INFO - "revision": "3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e", 08:11:39 INFO - "stage_platform": "linux64-pgo", 08:11:39 INFO - "builduid": "ec09f4010edb4e879ae2822395415733", 08:11:39 INFO - "slavebuilddir": "test" 08:11:39 INFO - } 08:11:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:11:39 INFO - Running post-action listener: _resource_record_post_action 08:11:39 INFO - ##### 08:11:39 INFO - ##### Finished read-buildbot-config step (success) 08:11:39 INFO - ##### 08:11:39 INFO - ##### 08:11:39 INFO - ##### Running download-and-extract step. 08:11:39 INFO - ##### 08:11:39 INFO - Running pre-action listener: _resource_record_pre_action 08:11:39 INFO - Running main action method: download_and_extract 08:11:39 INFO - mkdir: /builds/slave/test/build/tests 08:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:39 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:11:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:11:40 INFO - Downloaded 1361 bytes. 08:11:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:11:40 INFO - Using the following test package requirements: 08:11:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:11:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:11:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:40 INFO - u'jsshell-linux-x86_64.zip'], 08:11:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:11:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:11:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:11:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:11:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:11:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:40 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:11:42 INFO - Downloaded 24276007 bytes. 08:11:42 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'] 08:11:42 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 08:11:43 INFO - Return code: 0 08:11:43 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 08:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:43 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:11:44 INFO - Downloaded 24276007 bytes. 08:11:44 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'] 08:11:44 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 08:11:46 INFO - Return code: 0 08:11:46 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')]} 08:11:46 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:11:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:11:47 INFO - Downloaded 14405384 bytes. 08:11:47 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'] 08:11:47 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 08:11:47 INFO - Return code: 0 08:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:47 INFO - https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:11:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:11:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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 08:11:48 INFO - Downloaded 60160978 bytes. 08:11:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:48 INFO - mkdir: /builds/slave/test/properties 08:11:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:48 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:48 INFO - Contents: 08:11:48 INFO - build_url:https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:11:49 INFO - Running post-action listener: _resource_record_post_action 08:11:49 INFO - Running post-action listener: set_extra_try_arguments 08:11:49 INFO - ##### 08:11:49 INFO - ##### Finished download-and-extract step (success) 08:11:49 INFO - ##### 08:11:49 INFO - ##### 08:11:49 INFO - ##### Running populate-webroot step. 08:11:49 INFO - ##### 08:11:49 INFO - Running pre-action listener: _resource_record_pre_action 08:11:49 INFO - Running main action method: populate_webroot 08:11:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:49 INFO - '--tppagecycles', 08:11:49 INFO - '7'], 08:11:49 INFO - 'tests': ['tsvgm']}}, 08:11:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:49 INFO - 'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:49 INFO - 'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['damp', 'tps']}, 08:11:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:49 INFO - 'tests': ['damp', 'tps']}, 08:11:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['dromaeo_dom']}, 08:11:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['basic_compositor_video']}, 08:11:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:11:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['a11yr', 08:11:49 INFO - 'ts_paint', 08:11:49 INFO - 'tpaint', 08:11:49 INFO - 'sessionrestore', 08:11:49 INFO - 'sessionrestore_no_auto_restore', 08:11:49 INFO - 'tabpaint']}, 08:11:49 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:49 INFO - 'ts_paint', 08:11:49 INFO - 'tpaint', 08:11:49 INFO - 'sessionrestore', 08:11:49 INFO - 'sessionrestore_no_auto_restore', 08:11:49 INFO - 'tabpaint']}, 08:11:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:49 INFO - 'ts_paint', 08:11:49 INFO - 'tpaint', 08:11:49 INFO - 'sessionrestore', 08:11:49 INFO - 'sessionrestore_no_auto_restore', 08:11:49 INFO - 'tabpaint']}, 08:11:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:49 INFO - 'ts_paint', 08:11:49 INFO - 'tpaint', 08:11:49 INFO - 'sessionrestore', 08:11:49 INFO - 'sessionrestore_no_auto_restore', 08:11:49 INFO - 'tabpaint']}, 08:11:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['a11yr', 08:11:49 INFO - 'ts_paint', 08:11:49 INFO - 'tpaint', 08:11:49 INFO - 'sessionrestore', 08:11:49 INFO - 'sessionrestore_no_auto_restore', 08:11:49 INFO - 'tabpaint']}, 08:11:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['a11yr', 08:11:49 INFO - 'ts_paint', 08:11:49 INFO - 'tpaint', 08:11:49 INFO - 'sessionrestore', 08:11:49 INFO - 'sessionrestore_no_auto_restore', 08:11:49 INFO - 'tabpaint']}, 08:11:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['tsvgx', 08:11:49 INFO - 'tsvgr_opacity', 08:11:49 INFO - 'tart', 08:11:49 INFO - 'tscrollx', 08:11:49 INFO - 'cart']}, 08:11:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:49 INFO - 'tsvgr_opacity', 08:11:49 INFO - 'tart', 08:11:49 INFO - 'tscrollx', 08:11:49 INFO - 'cart']}, 08:11:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:49 INFO - 'talos_options': ['--disable-e10s'], 08:11:49 INFO - 'tests': ['tp5o']}, 08:11:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:49 INFO - 'tests': ['tp5o']}, 08:11:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:49 INFO - 'talos_options': ['--disable-e10s', 08:11:49 INFO - '--xperf_path', 08:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:49 INFO - 'tests': ['tp5n']}, 08:11:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:49 INFO - 'talos_options': ['--xperf_path', 08:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:49 INFO - 'tests': ['tp5n']}}, 08:11:49 INFO - 'talos.zip': {'path': '', 08:11:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:49 INFO - Running post-action listener: _resource_record_post_action 08:11:49 INFO - ##### 08:11:49 INFO - ##### Finished populate-webroot step (success) 08:11:49 INFO - ##### 08:11:49 INFO - ##### 08:11:49 INFO - ##### Running create-virtualenv step. 08:11:49 INFO - ##### 08:11:49 INFO - Running pre-action listener: _resource_record_pre_action 08:11:49 INFO - Running main action method: create_virtualenv 08:11:49 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:49 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 08:11:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:49 INFO - Using real prefix '/usr' 08:11:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:52 INFO - Installing pip.................done. 08:11:52 INFO - Return code: 0 08:11:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11:52 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')]} 08:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:52 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')]} 08:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:52 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 0x7f3e6faf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28200f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', '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 08:11:52 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 08:11:52 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 08:11:52 INFO - Using env: {'DISPLAY': ':0', 08:11:52 INFO - 'HOME': '/home/cltbld', 08:11:52 INFO - 'LANG': 'en_US.UTF-8', 08:11:52 INFO - 'LANGUAGE': 'en_US:en', 08:11:52 INFO - 'LOGNAME': 'cltbld', 08:11:52 INFO - 'MAIL': '/var/mail/cltbld', 08:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:52 INFO - 'MOZ_NO_REMOTE': '1', 08:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:52 INFO - 'NO_EM_RESTART': '1', 08:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:52 INFO - 'PWD': '/builds/slave/test', 08:11:52 INFO - 'SHELL': '/bin/bash', 08:11:52 INFO - 'SHLVL': '1', 08:11:52 INFO - 'TERM': 'linux', 08:11:52 INFO - 'TMOUT': '86400', 08:11:52 INFO - 'USER': 'cltbld', 08:11:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:52 INFO - '_': '/tools/buildbot/bin/python'} 08:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:52 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 08:11:52 INFO - Cleaning up... 08:11:52 INFO - Return code: 0 08:11:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11:52 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')]} 08:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:52 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')]} 08:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:52 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 0x7f3e6faf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28200f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', '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 08:11:52 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 08:11:52 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 08:11:52 INFO - Using env: {'DISPLAY': ':0', 08:11:52 INFO - 'HOME': '/home/cltbld', 08:11:52 INFO - 'LANG': 'en_US.UTF-8', 08:11:52 INFO - 'LANGUAGE': 'en_US:en', 08:11:52 INFO - 'LOGNAME': 'cltbld', 08:11:52 INFO - 'MAIL': '/var/mail/cltbld', 08:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:52 INFO - 'MOZ_NO_REMOTE': '1', 08:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:52 INFO - 'NO_EM_RESTART': '1', 08:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:52 INFO - 'PWD': '/builds/slave/test', 08:11:52 INFO - 'SHELL': '/bin/bash', 08:11:52 INFO - 'SHLVL': '1', 08:11:52 INFO - 'TERM': 'linux', 08:11:52 INFO - 'TMOUT': '86400', 08:11:52 INFO - 'USER': 'cltbld', 08:11:52 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:52 INFO - '_': '/tools/buildbot/bin/python'} 08:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:52 INFO - Downloading/unpacking psutil>=3.1.1 08:11:52 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 08:11:52 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 08:11:52 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 08:11:52 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 08:11:52 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 08:11:52 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 08:11:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:54 INFO - Installing collected packages: psutil 08:11:54 INFO - Running setup.py install for psutil 08:11:54 INFO - building 'psutil._psutil_linux' extension 08:11:54 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 08:11:54 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 08:11:54 INFO - building 'psutil._psutil_posix' extension 08:11:54 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 08:11:54 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 08:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:55 INFO - Successfully installed psutil 08:11:55 INFO - Cleaning up... 08:11:55 INFO - Return code: 0 08:11:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:11:55 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')]} 08:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:55 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')]} 08:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:55 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 0x7f3e6faf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28200f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', '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 08:11:55 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 08:11:55 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 08:11:55 INFO - Using env: {'DISPLAY': ':0', 08:11:55 INFO - 'HOME': '/home/cltbld', 08:11:55 INFO - 'LANG': 'en_US.UTF-8', 08:11:55 INFO - 'LANGUAGE': 'en_US:en', 08:11:55 INFO - 'LOGNAME': 'cltbld', 08:11:55 INFO - 'MAIL': '/var/mail/cltbld', 08:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:55 INFO - 'MOZ_NO_REMOTE': '1', 08:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:55 INFO - 'NO_EM_RESTART': '1', 08:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:55 INFO - 'PWD': '/builds/slave/test', 08:11:55 INFO - 'SHELL': '/bin/bash', 08:11:55 INFO - 'SHLVL': '1', 08:11:55 INFO - 'TERM': 'linux', 08:11:55 INFO - 'TMOUT': '86400', 08:11:55 INFO - 'USER': 'cltbld', 08:11:55 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:55 INFO - '_': '/tools/buildbot/bin/python'} 08:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:57 INFO - Installing collected packages: mozsystemmonitor 08:11:57 INFO - Running setup.py install for mozsystemmonitor 08:11:57 INFO - Successfully installed mozsystemmonitor 08:11:57 INFO - Cleaning up... 08:11:57 INFO - Return code: 0 08:11:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e6faf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28200f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', '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 08:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:11:57 INFO - Using env: {'DISPLAY': ':0', 08:11:57 INFO - 'HOME': '/home/cltbld', 08:11:57 INFO - 'LANG': 'en_US.UTF-8', 08:11:57 INFO - 'LANGUAGE': 'en_US:en', 08:11:57 INFO - 'LOGNAME': 'cltbld', 08:11:57 INFO - 'MAIL': '/var/mail/cltbld', 08:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:57 INFO - 'MOZ_NO_REMOTE': '1', 08:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:57 INFO - 'NO_EM_RESTART': '1', 08:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:57 INFO - 'PWD': '/builds/slave/test', 08:11:57 INFO - 'SHELL': '/bin/bash', 08:11:57 INFO - 'SHLVL': '1', 08:11:57 INFO - 'TERM': 'linux', 08:11:57 INFO - 'TMOUT': '86400', 08:11:57 INFO - 'USER': 'cltbld', 08:11:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:57 INFO - '_': '/tools/buildbot/bin/python'} 08:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:57 INFO - Downloading/unpacking jsonschema==2.5.1 08:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:59 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:59 INFO - warning: no files found matching '*.txt' 08:11:59 INFO - no previously-included directories found matching 'build' 08:11:59 INFO - no previously-included directories found matching 'dist' 08:11:59 INFO - no previously-included directories found matching '.git*' 08:11:59 INFO - Installing collected packages: jsonschema, functools32 08:11:59 INFO - Running setup.py install for functools32 08:11:59 INFO - warning: no files found matching '*.txt' 08:11:59 INFO - no previously-included directories found matching 'build' 08:11:59 INFO - no previously-included directories found matching 'dist' 08:11:59 INFO - no previously-included directories found matching '.git*' 08:11:59 INFO - Successfully installed jsonschema functools32 08:11:59 INFO - Cleaning up... 08:11:59 INFO - Return code: 0 08:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:59 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')]} 08:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:59 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')]} 08:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:59 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 0x7f3e6faf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28200f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', '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 08:11:59 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 08:11:59 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 08:11:59 INFO - Using env: {'DISPLAY': ':0', 08:11:59 INFO - 'HOME': '/home/cltbld', 08:11:59 INFO - 'LANG': 'en_US.UTF-8', 08:11:59 INFO - 'LANGUAGE': 'en_US:en', 08:11:59 INFO - 'LOGNAME': 'cltbld', 08:11:59 INFO - 'MAIL': '/var/mail/cltbld', 08:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:59 INFO - 'MOZ_NO_REMOTE': '1', 08:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:59 INFO - 'NO_EM_RESTART': '1', 08:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:59 INFO - 'PWD': '/builds/slave/test', 08:11:59 INFO - 'SHELL': '/bin/bash', 08:11:59 INFO - 'SHLVL': '1', 08:11:59 INFO - 'TERM': 'linux', 08:11:59 INFO - 'TMOUT': '86400', 08:11:59 INFO - 'USER': 'cltbld', 08:11:59 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:59 INFO - '_': '/tools/buildbot/bin/python'} 08:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:00 INFO - Downloading/unpacking blobuploader==1.2.4 08:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:02 INFO - Downloading blobuploader-1.2.4.tar.gz 08:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:12:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:12:02 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 08:12:02 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 08:12:02 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 08:12:02 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 08:12:02 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 08:12:02 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 08:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:12:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:12:02 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 08:12:02 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 08:12:02 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 08:12:02 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 08:12:02 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 08:12:02 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 08:12:02 INFO - Downloading docopt-0.6.1.tar.gz 08:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:12:02 INFO - Installing collected packages: blobuploader, requests, docopt 08:12:02 INFO - Running setup.py install for blobuploader 08:12:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:12:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:12:02 INFO - Running setup.py install for requests 08:12:03 INFO - Running setup.py install for docopt 08:12:03 INFO - Successfully installed blobuploader requests docopt 08:12:03 INFO - Cleaning up... 08:12:03 INFO - Return code: 0 08:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12: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')]} 08:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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')]} 08:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:03 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 0x7f3e6faf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28200f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', '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 08:12:03 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 08:12:03 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 08:12:03 INFO - Using env: {'DISPLAY': ':0', 08:12:03 INFO - 'HOME': '/home/cltbld', 08:12:03 INFO - 'LANG': 'en_US.UTF-8', 08:12:03 INFO - 'LANGUAGE': 'en_US:en', 08:12:03 INFO - 'LOGNAME': 'cltbld', 08:12:03 INFO - 'MAIL': '/var/mail/cltbld', 08:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:03 INFO - 'MOZ_NO_REMOTE': '1', 08:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:03 INFO - 'NO_EM_RESTART': '1', 08:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:03 INFO - 'PWD': '/builds/slave/test', 08:12:03 INFO - 'SHELL': '/bin/bash', 08:12:03 INFO - 'SHLVL': '1', 08:12:03 INFO - 'TERM': 'linux', 08:12:03 INFO - 'TMOUT': '86400', 08:12:03 INFO - 'USER': 'cltbld', 08:12:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:03 INFO - '_': '/tools/buildbot/bin/python'} 08:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:03 INFO - Running setup.py (path:/tmp/pip-sLQfRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:03 INFO - Running setup.py (path:/tmp/pip-JVhXcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:03 INFO - Running setup.py (path:/tmp/pip-3q8KZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:03 INFO - Running setup.py (path:/tmp/pip-uyQp1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:03 INFO - Running setup.py (path:/tmp/pip-tvkqa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:03 INFO - Running setup.py (path:/tmp/pip-BbDQBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:04 INFO - Running setup.py (path:/tmp/pip-2oaemM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:04 INFO - Running setup.py (path:/tmp/pip-3imuLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:04 INFO - Running setup.py (path:/tmp/pip-PCW9Jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:04 INFO - Running setup.py (path:/tmp/pip-kUcog6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:04 INFO - Running setup.py (path:/tmp/pip-iOJKiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:04 INFO - Running setup.py (path:/tmp/pip-sBmjsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:04 INFO - Running setup.py (path:/tmp/pip-NhLjQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:04 INFO - Running setup.py (path:/tmp/pip-1Wd_HF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:04 INFO - Running setup.py (path:/tmp/pip-WYpzQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:04 INFO - Running setup.py (path:/tmp/pip-MBGVjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:04 INFO - Running setup.py (path:/tmp/pip-dpQcxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:12:04 INFO - Running setup.py install for manifestparser 08:12:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:12:04 INFO - Running setup.py install for mozcrash 08:12:05 INFO - Running setup.py install for mozdebug 08:12:05 INFO - Running setup.py install for mozdevice 08:12:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:12:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:12:05 INFO - Running setup.py install for mozfile 08:12:05 INFO - Running setup.py install for mozhttpd 08:12:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:12:05 INFO - Running setup.py install for mozinfo 08:12:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:12:05 INFO - Running setup.py install for mozInstall 08:12:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:12:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:12:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:12:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:12:05 INFO - Running setup.py install for mozleak 08:12:05 INFO - Running setup.py install for mozlog 08:12:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:12:05 INFO - Running setup.py install for moznetwork 08:12:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:12:05 INFO - Running setup.py install for mozprocess 08:12:06 INFO - Running setup.py install for mozprofile 08:12:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:12:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:12:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:12:06 INFO - Running setup.py install for mozrunner 08:12:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:12:06 INFO - Running setup.py install for mozscreenshot 08:12:06 INFO - Running setup.py install for moztest 08:12:06 INFO - Running setup.py install for mozversion 08:12:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:12:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:12:06 INFO - Cleaning up... 08:12:06 INFO - Return code: 0 08:12:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:06 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 0x7f3e6faf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28200f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', '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 08:12:06 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 08:12:06 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 08:12:06 INFO - Using env: {'DISPLAY': ':0', 08:12:06 INFO - 'HOME': '/home/cltbld', 08:12:06 INFO - 'LANG': 'en_US.UTF-8', 08:12:06 INFO - 'LANGUAGE': 'en_US:en', 08:12:06 INFO - 'LOGNAME': 'cltbld', 08:12:06 INFO - 'MAIL': '/var/mail/cltbld', 08:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:06 INFO - 'MOZ_NO_REMOTE': '1', 08:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:06 INFO - 'NO_EM_RESTART': '1', 08:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:06 INFO - 'PWD': '/builds/slave/test', 08:12:06 INFO - 'SHELL': '/bin/bash', 08:12:06 INFO - 'SHLVL': '1', 08:12:06 INFO - 'TERM': 'linux', 08:12:06 INFO - 'TMOUT': '86400', 08:12:06 INFO - 'USER': 'cltbld', 08:12:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:06 INFO - '_': '/tools/buildbot/bin/python'} 08:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:06 INFO - Running setup.py (path:/tmp/pip-r0RIY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:06 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)) 08:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:06 INFO - Running setup.py (path:/tmp/pip-BzZOwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:07 INFO - Running setup.py (path:/tmp/pip-6IIZuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:07 INFO - Running setup.py (path:/tmp/pip-uChZs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:07 INFO - Running setup.py (path:/tmp/pip-zVyStW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:07 INFO - Running setup.py (path:/tmp/pip-B4eQ2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:07 INFO - Running setup.py (path:/tmp/pip-wWQfko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:07 INFO - Running setup.py (path:/tmp/pip-FCtXKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:07 INFO - Running setup.py (path:/tmp/pip-GztSUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:07 INFO - Running setup.py (path:/tmp/pip-2mlgVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:07 INFO - Running setup.py (path:/tmp/pip-0Gdp0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:07 INFO - Running setup.py (path:/tmp/pip-aKxXn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:07 INFO - Running setup.py (path:/tmp/pip-PWkTCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:07 INFO - Running setup.py (path:/tmp/pip-KP0uQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:07 INFO - Running setup.py (path:/tmp/pip-6MLlgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:07 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)) 08:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:07 INFO - Running setup.py (path:/tmp/pip-UGvEo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:08 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)) 08:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:08 INFO - Running setup.py (path:/tmp/pip-xRIaqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 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)) 08:12:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:09 INFO - Downloading blessings-1.6.tar.gz 08:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:12:10 INFO - Installing collected packages: blessings 08:12:10 INFO - Running setup.py install for blessings 08:12:10 INFO - Successfully installed blessings 08:12:10 INFO - Cleaning up... 08:12:10 INFO - Return code: 0 08:12:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:10 INFO - Reading from file tmpfile_stdout 08:12:10 INFO - Current package versions: 08:12:10 INFO - argparse == 1.2.1 08:12:10 INFO - blessings == 1.6 08:12:10 INFO - blobuploader == 1.2.4 08:12:10 INFO - docopt == 0.6.1 08:12:10 INFO - functools32 == 3.2.3-2 08:12:10 INFO - jsonschema == 2.5.1 08:12:10 INFO - manifestparser == 1.1 08:12:10 INFO - mozInstall == 1.12 08:12:10 INFO - mozcrash == 0.17 08:12:10 INFO - mozdebug == 0.1 08:12:10 INFO - mozdevice == 0.48 08:12:10 INFO - mozfile == 1.2 08:12:10 INFO - mozhttpd == 0.7 08:12:10 INFO - mozinfo == 0.9 08:12:10 INFO - mozleak == 0.1 08:12:10 INFO - mozlog == 3.2 08:12:10 INFO - moznetwork == 0.27 08:12:10 INFO - mozprocess == 0.22 08:12:10 INFO - mozprofile == 0.28 08:12:10 INFO - mozrunner == 6.11 08:12:10 INFO - mozscreenshot == 0.1 08:12:10 INFO - mozsystemmonitor == 0.3 08:12:10 INFO - moztest == 0.7 08:12:10 INFO - mozversion == 1.4 08:12:10 INFO - psutil == 3.1.1 08:12:10 INFO - requests == 1.2.3 08:12:10 INFO - wsgiref == 0.1.2 08:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12: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')]} 08:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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')]} 08:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:10 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 0x7f3e6faf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28200f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', '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 08:12:10 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 08:12:10 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 08:12:10 INFO - Using env: {'DISPLAY': ':0', 08:12:10 INFO - 'HOME': '/home/cltbld', 08:12:10 INFO - 'LANG': 'en_US.UTF-8', 08:12:10 INFO - 'LANGUAGE': 'en_US:en', 08:12:10 INFO - 'LOGNAME': 'cltbld', 08:12:10 INFO - 'MAIL': '/var/mail/cltbld', 08:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:10 INFO - 'MOZ_NO_REMOTE': '1', 08:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:10 INFO - 'NO_EM_RESTART': '1', 08:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:10 INFO - 'PWD': '/builds/slave/test', 08:12:10 INFO - 'SHELL': '/bin/bash', 08:12:10 INFO - 'SHLVL': '1', 08:12:10 INFO - 'TERM': 'linux', 08:12:10 INFO - 'TMOUT': '86400', 08:12:10 INFO - 'USER': 'cltbld', 08:12:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:10 INFO - '_': '/tools/buildbot/bin/python'} 08:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:10 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)) 08:12:10 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)) 08:12:10 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)) 08:12:10 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)) 08:12:10 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)) 08:12:10 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)) 08:12:10 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)) 08:12:10 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)) 08:12:10 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)) 08:12:10 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)) 08:12:10 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)) 08:12:10 INFO - Cleaning up... 08:12:10 INFO - Return code: 0 08:12:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:12: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')]} 08:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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')]} 08:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e6faf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28200f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', '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 08:12: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'] in /builds/slave/test/build 08:12: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 08:12:10 INFO - Using env: {'DISPLAY': ':0', 08:12:10 INFO - 'HOME': '/home/cltbld', 08:12:10 INFO - 'LANG': 'en_US.UTF-8', 08:12:10 INFO - 'LANGUAGE': 'en_US:en', 08:12:10 INFO - 'LOGNAME': 'cltbld', 08:12:10 INFO - 'MAIL': '/var/mail/cltbld', 08:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:10 INFO - 'MOZ_NO_REMOTE': '1', 08:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:10 INFO - 'NO_EM_RESTART': '1', 08:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:10 INFO - 'PWD': '/builds/slave/test', 08:12:10 INFO - 'SHELL': '/bin/bash', 08:12:10 INFO - 'SHLVL': '1', 08:12:10 INFO - 'TERM': 'linux', 08:12:10 INFO - 'TMOUT': '86400', 08:12:10 INFO - 'USER': 'cltbld', 08:12:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:10 INFO - '_': '/tools/buildbot/bin/python'} 08:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:12:10 INFO - Cleaning up... 08:12:10 INFO - Return code: 0 08:12:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:12: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')]} 08:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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')]} 08:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e6faf9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28200f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', '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 08:12: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', 'flake8'] in /builds/slave/test/build 08:12: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 flake8 08:12:10 INFO - Using env: {'DISPLAY': ':0', 08:12:10 INFO - 'HOME': '/home/cltbld', 08:12:10 INFO - 'LANG': 'en_US.UTF-8', 08:12:10 INFO - 'LANGUAGE': 'en_US:en', 08:12:10 INFO - 'LOGNAME': 'cltbld', 08:12:10 INFO - 'MAIL': '/var/mail/cltbld', 08:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:10 INFO - 'MOZ_NO_REMOTE': '1', 08:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:10 INFO - 'NO_EM_RESTART': '1', 08:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:10 INFO - 'PWD': '/builds/slave/test', 08:12:10 INFO - 'SHELL': '/bin/bash', 08:12:10 INFO - 'SHLVL': '1', 08:12:10 INFO - 'TERM': 'linux', 08:12:10 INFO - 'TMOUT': '86400', 08:12:10 INFO - 'USER': 'cltbld', 08:12:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:10 INFO - '_': '/tools/buildbot/bin/python'} 08:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:11 INFO - Downloading/unpacking flake8 08:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:12:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:12:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:12:13 INFO - no previously-included directories found matching 'docs/_build' 08:12:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:12:13 INFO - Running setup.py install for pep8 08:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:12:13 INFO - no previously-included directories found matching 'docs/_build' 08:12:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:12:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:12:13 INFO - Cleaning up... 08:12:13 INFO - Return code: 0 08:12:13 INFO - Running post-action listener: _resource_record_post_action 08:12:13 INFO - Running post-action listener: _start_resource_monitoring 08:12:14 INFO - Starting resource monitoring. 08:12:14 INFO - ##### 08:12:14 INFO - ##### Finished create-virtualenv step (success) 08:12:14 INFO - ##### 08:12:14 INFO - ##### 08:12:14 INFO - ##### Running install step. 08:12:14 INFO - ##### 08:12:14 INFO - Running pre-action listener: _resource_record_pre_action 08:12:14 INFO - Running main action method: install 08:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:14 INFO - Reading from file tmpfile_stdout 08:12:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:12:14 INFO - Reading from file tmpfile_stdout 08:12:14 INFO - Output received: 08:12:14 INFO - Usage: mozinstall [options] installer 08:12:14 INFO - Options: 08:12:14 INFO - -h, --help show this help message and exit 08:12:14 INFO - -d DEST, --destination=DEST 08:12:14 INFO - Directory to install application into. [default: 08:12:14 INFO - "/builds/slave/test"] 08:12:14 INFO - --app=APP Application being installed. [default: firefox] 08:12:14 INFO - mkdir: /builds/slave/test/build/application 08:12:14 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'] 08:12:14 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 08:12:31 INFO - Reading from file tmpfile_stdout 08:12:31 INFO - Output received: 08:12:31 INFO - /builds/slave/test/build/application/firefox/firefox 08:12:31 INFO - Running post-action listener: _resource_record_post_action 08:12:31 INFO - ##### 08:12:31 INFO - ##### Finished install step (success) 08:12:31 INFO - ##### 08:12:31 INFO - ##### 08:12:31 INFO - ##### Running run-tests step. 08:12:31 INFO - ##### 08:12:31 INFO - Running pre-action listener: _resource_record_pre_action 08:12:31 INFO - Running main action method: run_tests 08:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:12:31 INFO - Python 2.7.3 08:12:31 INFO - Return code: 0 08:12:31 INFO - grabbing minidump binary from tooltool 08:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:31 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 0x28b2050>, '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 0x281e170>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281e620>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:12:31 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 08:12:31 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 08:12:31 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 08:12:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:31 INFO - Return code: 0 08:12:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:12:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:12:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:12:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:12:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:12:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:12:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:12:32 INFO - Return code: 0 08:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:12:32 INFO - Using env: {'DISPLAY': ':0', 08:12:32 INFO - 'HOME': '/home/cltbld', 08:12:32 INFO - 'LANG': 'en_US.UTF-8', 08:12:32 INFO - 'LANGUAGE': 'en_US:en', 08:12:32 INFO - 'LOGNAME': 'cltbld', 08:12:32 INFO - 'MAIL': '/var/mail/cltbld', 08:12:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:12:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:32 INFO - 'MOZ_NO_REMOTE': '1', 08:12:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:32 INFO - 'NO_EM_RESTART': '1', 08:12:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:32 INFO - 'PWD': '/builds/slave/test', 08:12:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:12:32 INFO - 'SHELL': '/bin/bash', 08:12:32 INFO - 'SHLVL': '1', 08:12:32 INFO - 'TERM': 'linux', 08:12:32 INFO - 'TMOUT': '86400', 08:12:32 INFO - 'USER': 'cltbld', 08:12:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279', 08:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:32 INFO - '_': '/tools/buildbot/bin/python'} 08:12:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:12:32 INFO - mozversion application_buildid: 20160623053004 08:12:32 INFO - mozversion application_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 08:12:32 INFO - mozversion application_display_name: Nightly 08:12:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:32 INFO - mozversion application_name: Firefox 08:12:32 INFO - mozversion application_remotingname: firefox 08:12:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:12:32 INFO - mozversion application_vendor: Mozilla 08:12:32 INFO - mozversion application_version: 50.0a1 08:12:32 INFO - mozversion platform_buildid: 20160623053004 08:12:32 INFO - mozversion platform_changeset: 3cdc8b1b2bb598901f17ed9d2f90a51fe156c62e 08:12:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:12:32 INFO - mozversion platform_version: 50.0a1 08:12:32 INFO - using testdate: 1466694752 08:12:32 INFO - actual date: 1466694752 08:12:32 INFO - starting webserver on 'localhost:39460' 08:12:32 INFO - SUITE-START | Running 2 tests 08:12:32 INFO - TEST-START | dromaeo_css 08:12:32 INFO - operating with platform_type : linux_ 08:12:32 INFO - Initialising browser for dromaeo_css test... 08:12:32 INFO - TEST-INFO | started process 14789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdN6SNj/profile http://localhost:39460/getInfo.html) 08:12:36 INFO - PROCESS | 14789 | __metrics Screen width/height:1600/1200 08:12:36 INFO - PROCESS | 14789 | colorDepth:24 08:12:36 INFO - PROCESS | 14789 | Browser inner width/height: 1024/697 08:12:36 INFO - PROCESS | 14789 | __metrics 08:12:37 ERROR - PROCESS | 14789 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:12:38 INFO - TEST-INFO | 14789: exit 0 08:12:38 INFO - Browser initialized. 08:12:38 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:38 INFO - TEST-INFO | started process 14908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdN6SNj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:50 INFO - PROCESS | 14908 | RSS: Main: 185364480 08:12:50 INFO - PROCESS | 14908 | 08:13:39 INFO - PROCESS | 14908 | 1466694819662 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] 08:15:47 INFO - PROCESS | 14908 | Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39460/tests/dromaeo/cssquery-ext.html) 08:15:48 INFO - PROCESS | 14908 | RSS: Main: 189313024 08:15:48 INFO - PROCESS | 14908 | 08:18:50 INFO - PROCESS | 14908 | Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-ext.html (next: http://localhost:39460/tests/dromaeo/cssquery-jquery.html) 08:18:50 INFO - PROCESS | 14908 | RSS: Main: 187887616 08:18:50 INFO - PROCESS | 14908 | 08:21:52 INFO - PROCESS | 14908 | Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39460/tests/dromaeo/cssquery-mootools.html) 08:21:53 INFO - PROCESS | 14908 | RSS: Main: 189214720 08:21:53 INFO - PROCESS | 14908 | 08:24:54 INFO - PROCESS | 14908 | Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39460/tests/dromaeo/cssquery-prototype.html) 08:24:55 INFO - PROCESS | 14908 | RSS: Main: 186880000 08:24:55 INFO - PROCESS | 14908 | 08:27:58 INFO - PROCESS | 14908 | Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39460/tests/dromaeo/cssquery-yui.html) 08:27:58 INFO - PROCESS | 14908 | RSS: Main: 188985344 08:27:58 INFO - PROCESS | 14908 | 08:31:00 INFO - PROCESS | 14908 | Cycle 1(1): loaded http://localhost:39460/tests/dromaeo/cssquery-yui.html (next: http://localhost:39460/tests/dromaeo/cssquery-dojo.html) 08:31:01 INFO - PROCESS | 14908 | RSS: Main: 189939712 08:31:01 INFO - PROCESS | 14908 | 08:31:01 INFO - PROCESS | 14908 | __start_tp_report 08:31:01 INFO - PROCESS | 14908 | _x_x_mozilla_page_load 08:31:01 INFO - PROCESS | 14908 | _x_x_mozilla_page_load_details 08:31:01 INFO - PROCESS | 14908 | |i|pagename|runs| 08:31:01 INFO - PROCESS | 14908 | |0;dojo.html;3118;3125.9531107033386;3136.9372612547763;3166.081836267482;3175.079227024163;5267.341582302212;5292.655977361469;5316.282301889249;5376.285303925608;5431.565474762019;5184.092783762845;5285.497877701622;5311.867203319919;5360.437154098822;5372.409035006146;4807.855764327067;4831.782569784351;4915.3855768029;4962.280469331945;5018.7992480300745;657.4926721046456;4858.587020103296;4933.629977751665;4941.4811444798315;4983.800647974077;4852.369192005052;4855.708657480544;4858.902821943541;4889.779959901813;4921.434035085975;4773.355596994396;4858.489858564835;4887.877803054952;4896.681715688469;4947.876303092416;4830.3237546743485;4869.805207791684;4875.926861097087;4876.60987121033;4889.804407823683;5286.444923283077;5332.066888294533;5344.011357898762;5382.91925621116;5387.865303367408;5529.834104976857;5682.488576028136;5714.599978001542;5753.309602847643;5768.134779783024;5715.457031581993;5719.170720245541;5807.361190269067;5817.447342502455;5870.530357571384;5396.1905714143195;5414.133738601805;5415.512603865632;5416.214648875891;5438.021156191884;5715.828525144169;5740.1102829061565;5801.158831969426;5857.589968702235;5892.6759028253;5598.328200615871;5601.887962240732;5603.551715862721;5646.20953066571;5720.256366672306;5694.772209111672;5711.200431939532;5731.914021289684;5732.283464566929;5739.512141467939;5466.781328746885;5612.719364031782;5653.349864765522;5663.1505274208375;5685.516731077904;5518.972405138029;5682.7442765075675;5687.60186786921;5699.886002279931;5744;4359.585839345257;4365.825366985348;4391.956080439219;4392.956070439254;4394.956050439455;3875.457435958968;3881.80590970456;3882.3594106972596;3905.258000979805;3925.371940489565;5425.972870135624;5446.618736688473;5457.426970168154;5465.344158700981;5469.07025805614;5712.714364281769;5753.654780713086;5762.567807414461;5776.075827867521;5783.045797443375;5305.549028332558;5396.541293989976;5438.184272359178;5462.0987537056735;5468.863278418072;4945.703257804471;4955.975220123876;4958.752062396866;4962.15643340633;4993.201087825931;5692.516136128475;5917.6745279010065;5932.58471906971;5936.821895343147;5937;5602.439756024365;5635.436456354331;5667.3765885753355;5690.317161940594;5712.228849105318;5848.0350742127075;5854.385289544536;5859.091840764689;5865.208196893364;5874.676892770939;5456.427075157051;5563.276774019351;5578.693171875586;5624.943750562442;5626.85932851682;5717.342505611908;5760.683162426107;5779.537636989115;5801.158831969426;5806.970965145148;5612.438756124355;5638.154276858504;5641.012822756084;5642.746076426489;5646.491815736604;5441.156620723794;5573.498385145356;5595.496405323541;5602;5607.5513958884;5274.1034024215205;5417.431169727122;5422.566194704493;5550.167474878801;5578.386377498553;5638.126090455986;5645.350784659817;5652.689102099424;5699.0311647020935;5708.743106560298;5402.405735369028;5451.127819548853;5502.8349149525575;5555.361133469541;5566.053770859045 08:31:01 INFO - PROCESS | 14908 | |1;ext.html;562.7815778838814;583.6118980877717;599.5713065158411;601.5247954116248;615.2094558492336;28581.14256572301;31440.05679829606;36198.27603447933;37025;37099;38161.04597385067;38275.80862095692;38323.616763832426;38369.42445863314;38383.808080959556;8522.573871306426;8672.436291641023;8713.433626814236;8723.38936274461;8742.4754514729;8361.372897032716;8450.535220562866;8452.408331416804;8470.364722645796;8481.74554763355;8608.784780380478;8628.827423451527;8631.611577479029;8651.091635378289;8655.740327790145;8525.701600443987;8549.316054715639;8569.185927336894;8617.224449799485;8637.265832404253;8519.190676885686;8544.957275213646;8592.226699597066;8605.010423801281;8616.65533378664;36147.09632259188;36413;36476.81761591175;36572.0856978575;36633.63366366329;3158.8578513966927;3250.73994080473;3277.0332751838264;3527.5237842891393;3605.549306336708;29801;29846.85076574625;30240.69759302423;30255.546166807515;31087.22281942947;4358.084802191512;4407.559244075567;4411.580899814545;4436.489803672586;4439.445069366329;323927;327172;329160;330916;331781.3410932954;28048.158555243375;47265.76367118143;47540.52459475361;47618.5238147621;47731;29528.557071643943;30805.075847724605;30862.691373086433;30884.382312353628;31083.378332433676;13426.530071447452;13634.250116243702;13638.386272617756;13709.245991470565;13739.450421983009;10582.735431614272;10602;10611.787764244671;10675.46622668879;10737.83893241602;7607.695692172362;7633.732819351296;7676.078870535572;7749.496282741604;7760.223977602194;2714.4571085782923;2744.7118052604187;2759.572266298727;2776.750092491645;2785.3175971887017;809.6518497046327;850.8638617821119;863;877.1228771228771;879.5821984557411;28384.8580757099;29145.417091658048;29357.412851742847;29652.40695186084;29706.25734356615;939.1594522901964;995.9053889880449;1008.6089849753058;1012.2408193854609;1075.3225467955137;15546.533603991898;15600.843991560167;15606.219689015505;15613.843861561467;15880.20598970047;564472;568511;569024;571251;571800;47329.29006064912;48127.278090828666;48391.5160848387;48436.515634843905;48617.75691121522;1160.3270103340042;1160.9013233875046;1166.1836714300025;1170.8946194842506;1193.659806955031;28863.7113628861;29968.400631987675;30073.849630751705;30265.697343026288;30473.085807425814;43796.78101609471;44457.333140003575;45892.77053614711;46177.30734038925;50265;453251;456638;457322;459260;461634;37669.81165094267;37913.43129852999;38206.61793382142;38321.23357532889;38734.6442874498;41964;42344.153116936875;42463;42724.572754272056;42754.358684620376;34875.65124348825;36179;36297.45553816748;36796.63203368039;37655.43516847304;34103.31793364069;35747.82126089353;36486.45270321;36576;36841.263174736894;31148.53277200889;32895.67104328926;32948.67051329456;36616.63383366239;36883.63116368802;32555.51166732548;33419.331613368086;33531.66468335383;33747;33755;25669.743302567484;25776.355591110372;25817.483650327264;26238.212853614423;26356.28684135525 08:31:01 INFO - PROCESS | 14908 | |2;jquery.html;357.1446385905756;365.0884198516828;366.0811363477671;379.84616230426684;383.8618097484905;16269.593260168487;16792.49622511325;17582.20880060397;17672.469825905213;17798.644027119466;14889.702205955875;15790.763138552931;16605.50183494497;16659.91670041651;16757.078360690157;5301.6818990860575;5500.257465242181;5504.64219825712;5546.972265138668;5551.1118221084635;4003.4395184674167;5412.269343638617;5857.7364018619055;6104.2674879014585;6154.199954005973;6144.600600960924;6195.039768835838;6204.379562043805;6210.937890621104;6229.6573688447115;4962.305277261186;5224.92162617561;5241.213817927303;5286.973565132188;5306.177542480922;4909;5130.358705161855;5164.741762911877;5169.534741873212;5175.171972484384;10828;11007.889921100847;11108.00027997476;11115.277506962022;12225;2102.7792081831494;2107.8933559881034;2123.702681624574;2153.8599991000533;2213.236433430464;8169.5098294102545;8285.337173026144;8378.078411374743;8483.321334293241;8496.150384961516;1802.540352210178;1812.429084838285;1827.826356496144;1904.0955546115622;1919.1747548554117;82263.5886820562;83435.3748279925;84634.57682711547;85245.14754852497;85816;10053.447060411747;10203.897961020442;10374.481275936323;10742.83885741699;10944.890551094546;13698.246596437291;13701.725965480833;13771.517996870061;13795.862041379658;13797.448102076005;7473.663685134182;7525.661345239478;7571.962140189264;7584.81037974044;7902.841943161105;7162.928370716226;7290.45321600882;7326.3040011198855;7399.963000184965;7465.552066876005;4056.14820887611;4161.375793630979;4197.349410841324;4197.76912269822;4367.755189770964;1519.5593277949492;1629.983700163007;1689.873259505542;1693.6612677464557;1703.3442124782048;351.8733256027828;379.45927053948014;389.0778854115707;851.5571902610608;857.9318748158582;10092.293539452316;10487;16963.491095267163;18807.905960470383;18924.43226703201;843.8481073406846;865.1478293880523;878.991210087891;882.7395918204145;933.2487347685178;9877.555510002067;10204.336718113298;10261.333013354108;10281.691549253534;10289.845652315222;553186;601359;611434;612522;628767;95293.52353238189;95395;95670.52164739132;95799;96816.51591741997;930.5858892792643;940.4357385568604;977.3988996766938;977.7555611097225;1026.9127124194379;17229;17351.944924611107;17958.461246162635;18095.36666216676;18222.271109156016;42591;42712.35931460968;44263.336049958634;44314.77842610766;44397;52902.4709752913;61064.38935610587;61399;61724.382756171864;63531.729365411506;8088.797780055545;8152.592370381339;8385.496870187808;8402.32781377476;8533.189347012023;12965.805512917124;13728.176309421468;13892.305384730926;13971.720565588428;14054.648633784238;12067.698307542381;12086.576969806014;12213.389330533615;12215.45030473613;12444.253344799341;12032.819507707216;12113.878861211275;12122.09084318662;12124.636260911833;12250;12204.08469364819;12361.876381236072;12430.689232769253;12432.937835310766;12495.250284982567;8150;8282.627281772455;8283.751487455385;8339.499630022217;8752.081031491856;11110.888891110986;11837.585684501;12110.091743119125;12242.143049986415;12301.569445069379 08:31:01 INFO - PROCESS | 14908 | |3;mootools.html;1206.9336186509745;1222.1689251309112;1239.0273635196372;1393.9651508712286;1412.0680350968362;7359.227281135484;7567.2432756724365;7976.7606971790865;8046.718364857224;8054.395920305986;8024.558649274288;8336.16638336166;8353.540555269457;8354.791130221733;8369.455985360948;2188.3544354415444;2215.3575463115676;2216.1689366487567;2218.7559368469456;2228.54314865453;2173.6848157017303;2191.8904054797276;2244.62963611004;2246.472079061419;2252.7071480707486;2178.4662757624405;2179.7929196726286;2195.681626164205;2200.966985495219;2236.4073520517077;2156.040561949933;2201.6037113319594;2222.0889435331437;2222.344408399526;2239.1267405711787;2215.501512159767;2227.0757635581213;2233.4304752288226;2237.865728056322;2240.327901629521;8202.38482113844;8207.917920820775;8233.300169485601;8286.378521610903;8323.334133269324;4884.65807393479;4967.155583550769;4997.450280469146;5025.296458495814;5037.748112594356;3129.3741251749743;3179.9364012719616;3192.377486390155;3206.679332066798;3300.620428650712;946.2713710442921;951.5622813505796;970.8834939807198;981.6122631560565;983.5426526665063;11736.295822250693;11888.821667674905;11975.041996640248;11980.760384792342;12011.579594714143;4172;4275.230458517497;4337.978310108492;4365.563443655673;4388.495323037828;9911.553980070914;10122.493875306352;10183.847242291371;10197.439140847324;10203.183745300357;4888.120138375127;4889.828855990095;4895.31465594817;4896.46138924718;4897.8285759998225;3837.3860182370686;4404.713693609905;4443.688941774045;4549.954500455019;4552.044070745114;3626.5104210931186;3678.981605092011;3755.6244375562774;3777.33896568105;3888.922221555553;1181.7931861924128;1185.2118341302937;1187.145255416099;1189.5420263198557;1189.6728399690155;859.1022381611107;860.1570460948305;864.3560547392233;886.1891369397058;886.4814083760944;5755.827325180251;5800.332961709458;5872.737361467305;5977.44980110106;6089.543284253698;874.1302404107953;891.6611687558686;909.2135302962889;911.9407238529475;918.7060140754894;3880.359740642819;3967.1668949520345;4026.859059932888;4035.051762835731;4087.2438598859308;9629.566669499889;9941;10101.898981010243;10152.086312231935;10189.592416303412;9849.950750246202;9955.303128780915;9994.400335979719;10035.799284014425;10088.899111008795;7744.0707115145415;7868.881966770388;7889.2110788920645;7922.168172341821;7926.048874135141;5547.916781248366;5572.35917869434;5600.775968961359;5737.196792449144;5754.108113242454;9512.048795120432;9877.654282100379;9879.703608891745;10000.199984001409;10049.69850904474;9891.208703303575;10165.796684066425;10234.590616375262;10351.120154786626;10383.53274102652;6782.389584937379;6789.93210067893;7366.852662946818;7383.372413344926;7565.356944659546;8164.632591533514;8227.83544329122;8231.34149268045;8231.711890083818;8279.296259817984;7179.066721326194;7398.519096258726;7416.666250018654;7481.513701609378;7536.020317358708;7045;7226;7246.60143692102;7267.672954716944;7394.149672787698;6048.939510604838;6089.117078023751;6090.086487026804;6098.176746139392;6107.206063211754;4733.502982186958;4957.702537847741;5062.139436295765;5106.7701953412925;5212.661177023481;4918.778654960463;4935.284383764262;5036.622253331088;5040.521150490697;5059.165237735732 08:31:01 INFO - PROCESS | 14908 | |4;prototype.html;299.45648647704417;301.434809731753;301.9471592471317;305.34198801582596;308.2171284936262;5592.916106258409;5598.048331783596;5606.635568688032;5664.376918538957;5674.971625141879;5580.637258578189;5587.552995760339;5600.131979543167;5601.551875849932;5615.241942337783;4062.2281766464425;4085.0808568072243;4200.495940487146;4203.747775133486;4208.389783481409;4196.895077623069;4208.284591619432;4209.368594710802;4248.83004679814;4271.188474189894;4172.645325147366;4244.578066347777;4246.787660616972;4256.6375661507855;4257.936130958038;4102.815373308208;4225.809838557257;4251.638610718092;4278.016056307036;4282.2506061439435;3675.3384390809642;3682.5396825396824;3695.4087346024507;3704.2961837250837;3719.386301260316;5395.5953303502;5433.646812957185;5461.69960652164;5485.0949593317455;5488.4785945335125;4755.262934245163;4898.501764100334;4898.779554920037;4942.555170034678;4991.575716064139;5800.723840755028;5800.9709951450395;5861.706914654293;5867.618604790675;5881.176635271023;4135.29699951009;4140.420341152241;4144.3990621359735;4154.2759754701765;4168.333066709312;5978.282606087298;6067.211262535842;6100.267967843843;6133.509319254449;6146.385361463863;4118.19695159447;4138.772367519815;4152.958470415318;4163.479565054368;4182.832686692498;4212.72617279882;4219.3249080147025;4232.64022558086;4251.234777739975;4265.722728022669;4738.64460165489;4833.709977401367;4840.531329022154;4904.166291730415;4904.337914381585;5789.131630255495;5844.013035567928;5845.678487683133;5850.882982340415;5896.882062358729;1455.5051282563768;1473.359088796377;1473.7199932012884;1474.402866838932;1480.6224412774673;931.6925414613162;933.5752232734226;933.6825479337058;953.9713808585753;987.7975015121883;5521.365043020104;5536.916946245809;5541.5289700375915;5547.306586676666;5552.3892371839065;5938.524918006549;5940.34656187819;5942.227510423617;5960.791372301948;5972.343042265347;5326.307580014573;5520.254765606672;5572.554195664337;5588.91616625751;5642.633228840113;3139.5290706393766;3149.4173577888164;3157.289609837814;3198.104530731399;3220.5491231227647;5822;6034.426729460694;6045.244344456943;6080.2399700037495;6129.969350153221;5992.40075992406;6011.909821352683;6029.336772954972;6030.005049166838;6041.426064523863;5963.970180149072;5965.13505541694;5991.55063370249;6039.214902062704;6087.908681369783;5796.869610425926;5850.297964244318;5934.9406505934385;5958.463738263577;5964.612300200473;5746.655200687972;5862.970685146547;5871.794487192928;5901.7639294427745;5951.191237607848;5921.2006379138265;6014.63912165254;6035.758569657164;6116.327204007466;6122.846928826815;4098.549159592502;4109.260333140063;4114.362273847559;4148.439960605279;4161.417401563844;5953.434423729739;5977.760889564369;5984.640921544721;6018.1875446815875;6029.879402412015;5645.125005624135;5837.270341207349;5840.737166827418;5856.795012174553;5901.259128557172;5801.419858014334;5825.300963884361;5830.842588242377;5838.766449342149;5840.445157710011;5597.328320601554;5626.874625074919;5699.857503562278;5781.439011466797;5792.913106303325;5823.213866128019;5852.795152169653;5879.559033072451;5903.380145084704;5906.995810712275;5607.43925607436;5752.194692742935;5783.016887129114;5800.70872005547;5806.593538452268 08:31:01 INFO - PROCESS | 14908 | |5;yui.html;553.8338498450469;574.6006525464802;588.7174156404925;590.3181824992133;604.3412680178607;12671.176373535714;13057.020723445745;13109.410076546554;13195.406206720696;13439.596812095653;12889.355532223399;13330.266835324053;13420.597382078553;13786.034977551575;13788.931055344734;576.9884602307951;585.2479563760558;591.4381337729175;592.0645380299117;596.9850753731148;598.437468779346;598.5690302981847;598.7186022569385;600.7777122464672;601.5698775375605;621.3599992008216;622.0265284829228;622.8536293970914;624.9125122482856;625.9874802503947;623.0156352962331;623.4949690750507;624.3693869192149;624.4224092714244;624.9500039996813;448.6119506626777;448.63212166023874;449.7234200966382;450.2862962204909;451.3703383779609;13394;13400.128991615515;13415.597532074053;13428.865711342956;13466.124701894345;12127.878721212852;12561.246325220516;12578.119531632788;12579.622611321674;12848.421821017982;11305.830412543819;11544.884551154464;11571.942140289244;11617.825732614017;11716.88283117175;3638.462035926948;3681.1717363593243;3725.590185079639;3731.365667836474;3772.2832661794446;77012.84480732738;77141.61429192818;77628.61185694035;77981.61009194917;78629.60685196595;10308.381497110047;10335.689929302132;10375.221858360654;10462.319949203278;10465.058144767008;17367.392141274995;17412.303507859797;17429.12854357277;17432.825671743372;17536.82463175352;8199.262066414052;8221.671133154727;8350.916490835014;8353.791155221046;8396.286315663116;4559.361689363492;4698.95301046992;4769.189237829577;4829.589484893823;4957.702537847741;3074.8462576871066;3117.1272043827767;3166.7149956503563;3180.2367431816197;3185.761067919915;549.9807506737245;552.582799986016;556.7717235933329;563.3352643880261;569.4561693582618;547.4826289156708;603.9063945088518;607.3804719186405;609.2171559545963;624.5035197018382;9474.95262523683;9540.666076687283;9660.420374777535;9754.219662426989;9983.402655575073;516.3193804167411;565.0422533805242;601.362555690969;625.956183067181;649.5258461323166;4375.365571992043;4496.955030449719;4538.727676339364;4579.839705610288;4581.037982023746;63454.682726586994;63778.36221637817;70292.64853675698;110648;111212;96991;97316.51341743387;97323.51338243263;97687;98779.50610246902;52476;52601.473985260425;75084;80203.99999999884;82152.58923705462;8435.367347449088;8760.824783504167;8767.912320876709;8769.473831570127;8855.51294678773;45168.54831451643;46051.085657718126;49120.263196051375;49357.25964110613;51517.742411287705;71367.64316178385;73360.26639733535;74532;74634;74869.25130748622;11803.291802491878;11824.467898944396;11849.111316651113;11862.288262704265;11994.460249288628;13792;14123;14201.715965680422;14285.28573571338;14341.211233382264;12206.206596571194;12237.75524489523;13171.73656526845;13287;13364.532241371506;12458.314792686127;12566.560170393992;12810.231386116862;13041.413136409074;13476.191428514321;12918.612441626767;13011.349432528146;13132.737345253232;13176.80234796498;13412.262325572186;10509.78980420372;10809.67570972872;10945.398003109587;11021;11059.281146725438;11298.322100673657;11391.392992064748;11552.537898483966;11619.36093514831;11679.299242045505 08:31:01 INFO - PROCESS | 14908 | __end_tp_report 08:31:01 INFO - PROCESS | 14908 | __start_cc_report 08:31:01 INFO - PROCESS | 14908 | _x_x_mozilla_cycle_collect,345 08:31:01 INFO - PROCESS | 14908 | __end_cc_report 08:31:01 INFO - PROCESS | 14908 | __startTimestamp1466695861234__endTimestamp 08:31:01 INFO - PROCESS | 14908 | 08:31:01 INFO - PROCESS | 14908 | ------- Summary: start ------- 08:31:01 INFO - PROCESS | 14908 | Number of tests: 6 08:31:01 INFO - PROCESS | 14908 | 08:31:01 INFO - PROCESS | 14908 | [#0] dojo.html Cycles:165 Average:5287.47 Median:5502.83 stddev:691.42 (12.6%) stddev-sans-first:672.27 08:31:01 INFO - PROCESS | 14908 | Values: 3118.0 3126.0 3136.9 3166.1 3175.1 5267.3 5292.7 5316.3 5376.3 5431.6 5184.1 5285.5 5311.9 5360.4 5372.4 4807.9 4831.8 4915.4 4962.3 5018.8 657.5 4858.6 4933.6 4941.5 4983.8 4852.4 4855.7 4858.9 4889.8 4921.4 4773.4 4858.5 4887.9 4896.7 4947.9 4830.3 4869.8 4875.9 4876.6 4889.8 5286.4 5332.1 5344.0 5382.9 5387.9 5529.8 5682.5 5714.6 5753.3 5768.1 5715.5 5719.2 5807.4 5817.4 5870.5 5396.2 5414.1 5415.5 5416.2 5438.0 5715.8 5740.1 5801.2 5857.6 5892.7 5598.3 5601.9 5603.6 5646.2 5720.3 5694.8 5711.2 5731.9 5732.3 5739.5 5466.8 5612.7 5653.3 5663.2 5685.5 5519.0 5682.7 5687.6 5699.9 5744.0 4359.6 4365.8 4392.0 4393.0 4395.0 3875.5 3881.8 3882.4 3905.3 3925.4 5426.0 5446.6 5457.4 5465.3 5469.1 5712.7 5753.7 5762.6 5776.1 5783.0 5305.5 5396.5 5438.2 5462.1 5468.9 4945.7 4956.0 4958.8 4962.2 4993.2 5692.5 5917.7 5932.6 5936.8 5937.0 5602.4 5635.4 5667.4 5690.3 5712.2 5848.0 5854.4 5859.1 5865.2 5874.7 5456.4 5563.3 5578.7 5624.9 5626.9 5717.3 5760.7 5779.5 5801.2 5807.0 5612.4 5638.2 5641.0 5642.7 5646.5 5441.2 5573.5 5595.5 5602.0 5607.6 5274.1 5417.4 5422.6 5550.2 5578.4 5638.1 5645.4 5652.7 5699.0 5708.7 5402.4 5451.1 5502.8 5555.4 5566.1 08:31:01 INFO - PROCESS | 14908 | 08:31:01 INFO - PROCESS | 14908 | [#1] ext.html Cycles:180 Average:57586.51 Median:36954.32 stddev:123456.05 (334.1%) stddev-sans-first:123728.13 08:31:01 INFO - PROCESS | 14908 | Values: 562.8 583.6 599.6 601.5 615.2 28581.1 31440.1 36198.3 37025.0 37099.0 38161.0 38275.8 38323.6 38369.4 38383.8 8522.6 8672.4 8713.4 8723.4 8742.5 8361.4 8450.5 8452.4 8470.4 8481.7 8608.8 8628.8 8631.6 8651.1 8655.7 8525.7 8549.3 8569.2 8617.2 8637.3 8519.2 8545.0 8592.2 8605.0 8616.7 36147.1 36413.0 36476.8 36572.1 36633.6 3158.9 3250.7 3277.0 3527.5 3605.5 29801.0 29846.9 30240.7 30255.5 31087.2 4358.1 4407.6 4411.6 4436.5 4439.4 323927.0 327172.0 329160.0 330916.0 331781.3 28048.2 47265.8 47540.5 47618.5 47731.0 29528.6 30805.1 30862.7 30884.4 31083.4 13426.5 13634.3 13638.4 13709.2 13739.5 10582.7 10602.0 10611.8 10675.5 10737.8 7607.7 7633.7 7676.1 7749.5 7760.2 2714.5 2744.7 2759.6 2776.8 2785.3 809.7 850.9 863.0 877.1 879.6 28384.9 29145.4 29357.4 29652.4 29706.3 939.2 995.9 1008.6 1012.2 1075.3 15546.5 15600.8 15606.2 15613.8 15880.2 564472.0 568511.0 569024.0 571251.0 571800.0 47329.3 48127.3 48391.5 48436.5 48617.8 1160.3 1160.9 1166.2 1170.9 1193.7 28863.7 29968.4 30073.8 30265.7 30473.1 43796.8 44457.3 45892.8 46177.3 50265.0 453251.0 456638.0 457322.0 459260.0 461634.0 37669.8 37913.4 38206.6 38321.2 38734.6 41964.0 42344.2 42463.0 42724.6 42754.4 34875.7 36179.0 36297.5 36796.6 37655.4 34103.3 35747.8 36486.5 36576.0 36841.3 31148.5 32895.7 32948.7 36616.6 36883.6 32555.5 33419.3 33531.7 33747.0 33755.0 25669.7 25776.4 25817.5 26238.2 26356.3 08:31:01 INFO - PROCESS | 14908 | 08:31:01 INFO - PROCESS | 14908 | [#2] jquery.html Cycles:180 Average:31656.02 Median:4179.36 stddev:99028.37 (2369.5%) stddev-sans-first:99278.28 08:31:01 INFO - PROCESS | 14908 | Values: 357.1 365.1 366.1 379.8 383.9 16269.6 16792.5 17582.2 17672.5 17798.6 14889.7 15790.8 16605.5 16659.9 16757.1 5301.7 5500.3 5504.6 5547.0 5551.1 4003.4 5412.3 5857.7 6104.3 6154.2 6144.6 6195.0 6204.4 6210.9 6229.7 4962.3 5224.9 5241.2 5287.0 5306.2 4909.0 5130.4 5164.7 5169.5 5175.2 10828.0 11007.9 11108.0 11115.3 12225.0 2102.8 2107.9 2123.7 2153.9 2213.2 8169.5 8285.3 8378.1 8483.3 8496.2 1802.5 1812.4 1827.8 1904.1 1919.2 82263.6 83435.4 84634.6 85245.1 85816.0 10053.4 10203.9 10374.5 10742.8 10944.9 13698.2 13701.7 13771.5 13795.9 13797.4 7473.7 7525.7 7572.0 7584.8 7902.8 7162.9 7290.5 7326.3 7400.0 7465.6 4056.1 4161.4 4197.3 4197.8 4367.8 1519.6 1630.0 1689.9 1693.7 1703.3 351.9 379.5 389.1 851.6 857.9 10092.3 10487.0 16963.5 18807.9 18924.4 843.8 865.1 879.0 882.7 933.2 9877.6 10204.3 10261.3 10281.7 10289.8 553186.0 601359.0 611434.0 612522.0 628767.0 95293.5 95395.0 95670.5 95799.0 96816.5 930.6 940.4 977.4 977.8 1026.9 17229.0 17351.9 17958.5 18095.4 18222.3 42591.0 42712.4 44263.3 44314.8 44397.0 52902.5 61064.4 61399.0 61724.4 63531.7 8088.8 8152.6 8385.5 8402.3 8533.2 12965.8 13728.2 13892.3 13971.7 14054.6 12067.7 12086.6 12213.4 12215.5 12444.3 12032.8 12113.9 12122.1 12124.6 12250.0 12204.1 12361.9 12430.7 12432.9 12495.3 8150.0 8282.6 8283.8 8339.5 8752.1 11110.9 11837.6 12110.1 12242.1 12301.6 08:31:01 INFO - PROCESS | 14908 | 08:31:01 INFO - PROCESS | 14908 | [#3] mootools.html Cycles:180 Average:5493.71 Median:4982.30 stddev:3154.26 (63.3%) stddev-sans-first:3146.65 08:31:01 INFO - PROCESS | 14908 | Values: 1206.9 1222.2 1239.0 1394.0 1412.1 7359.2 7567.2 7976.8 8046.7 8054.4 8024.6 8336.2 8353.5 8354.8 8369.5 2188.4 2215.4 2216.2 2218.8 2228.5 2173.7 2191.9 2244.6 2246.5 2252.7 2178.5 2179.8 2195.7 2201.0 2236.4 2156.0 2201.6 2222.1 2222.3 2239.1 2215.5 2227.1 2233.4 2237.9 2240.3 8202.4 8207.9 8233.3 8286.4 8323.3 4884.7 4967.2 4997.5 5025.3 5037.7 3129.4 3179.9 3192.4 3206.7 3300.6 946.3 951.6 970.9 981.6 983.5 11736.3 11888.8 11975.0 11980.8 12011.6 4172.0 4275.2 4338.0 4365.6 4388.5 9911.6 10122.5 10183.8 10197.4 10203.2 4888.1 4889.8 4895.3 4896.5 4897.8 3837.4 4404.7 4443.7 4550.0 4552.0 3626.5 3679.0 3755.6 3777.3 3888.9 1181.8 1185.2 1187.1 1189.5 1189.7 859.1 860.2 864.4 886.2 886.5 5755.8 5800.3 5872.7 5977.4 6089.5 874.1 891.7 909.2 911.9 918.7 3880.4 3967.2 4026.9 4035.1 4087.2 9629.6 9941.0 10101.9 10152.1 10189.6 9850.0 9955.3 9994.4 10035.8 10088.9 7744.1 7868.9 7889.2 7922.2 7926.0 5547.9 5572.4 5600.8 5737.2 5754.1 9512.0 9877.7 9879.7 10000.2 10049.7 9891.2 10165.8 10234.6 10351.1 10383.5 6782.4 6789.9 7366.9 7383.4 7565.4 8164.6 8227.8 8231.3 8231.7 8279.3 7179.1 7398.5 7416.7 7481.5 7536.0 7045.0 7226.0 7246.6 7267.7 7394.1 6048.9 6089.1 6090.1 6098.2 6107.2 4733.5 4957.7 5062.1 5106.8 5212.7 4918.8 4935.3 5036.6 5040.5 5059.2 08:31:01 INFO - PROCESS | 14908 | 08:31:01 INFO - PROCESS | 14908 | [#4] prototype.html Cycles:180 Average:4864.76 Median:5604.09 stddev:1453.82 (25.9%) stddev-sans-first:1416.94 08:31:01 INFO - PROCESS | 14908 | Values: 299.5 301.4 301.9 305.3 308.2 5592.9 5598.0 5606.6 5664.4 5675.0 5580.6 5587.6 5600.1 5601.6 5615.2 4062.2 4085.1 4200.5 4203.7 4208.4 4196.9 4208.3 4209.4 4248.8 4271.2 4172.6 4244.6 4246.8 4256.6 4257.9 4102.8 4225.8 4251.6 4278.0 4282.3 3675.3 3682.5 3695.4 3704.3 3719.4 5395.6 5433.6 5461.7 5485.1 5488.5 4755.3 4898.5 4898.8 4942.6 4991.6 5800.7 5801.0 5861.7 5867.6 5881.2 4135.3 4140.4 4144.4 4154.3 4168.3 5978.3 6067.2 6100.3 6133.5 6146.4 4118.2 4138.8 4153.0 4163.5 4182.8 4212.7 4219.3 4232.6 4251.2 4265.7 4738.6 4833.7 4840.5 4904.2 4904.3 5789.1 5844.0 5845.7 5850.9 5896.9 1455.5 1473.4 1473.7 1474.4 1480.6 931.7 933.6 933.7 954.0 987.8 5521.4 5536.9 5541.5 5547.3 5552.4 5938.5 5940.3 5942.2 5960.8 5972.3 5326.3 5520.3 5572.6 5588.9 5642.6 3139.5 3149.4 3157.3 3198.1 3220.5 5822.0 6034.4 6045.2 6080.2 6130.0 5992.4 6011.9 6029.3 6030.0 6041.4 5964.0 5965.1 5991.6 6039.2 6087.9 5796.9 5850.3 5934.9 5958.5 5964.6 5746.7 5863.0 5871.8 5901.8 5951.2 5921.2 6014.6 6035.8 6116.3 6122.8 4098.5 4109.3 4114.4 4148.4 4161.4 5953.4 5977.8 5984.6 6018.2 6029.9 5645.1 5837.3 5840.7 5856.8 5901.3 5801.4 5825.3 5830.8 5838.8 5840.4 5597.3 5626.9 5699.9 5781.4 5792.9 5823.2 5852.8 5879.6 5903.4 5907.0 5607.4 5752.2 5783.0 5800.7 5806.6 08:31:01 INFO - PROCESS | 14908 | 08:31:01 INFO - PROCESS | 14908 | [#5] yui.html Cycles:180 Average:18801.36 Median:4549.04 stddev:26766.59 (588.4%) stddev-sans-first:26806.61 08:31:01 INFO - PROCESS | 14908 | Values: 553.8 574.6 588.7 590.3 604.3 12671.2 13057.0 13109.4 13195.4 13439.6 12889.4 13330.3 13420.6 13786.0 13788.9 577.0 585.2 591.4 592.1 597.0 598.4 598.6 598.7 600.8 601.6 621.4 622.0 622.9 624.9 626.0 623.0 623.5 624.4 624.4 625.0 448.6 448.6 449.7 450.3 451.4 13394.0 13400.1 13415.6 13428.9 13466.1 12127.9 12561.2 12578.1 12579.6 12848.4 11305.8 11544.9 11571.9 11617.8 11716.9 3638.5 3681.2 3725.6 3731.4 3772.3 77012.8 77141.6 77628.6 77981.6 78629.6 10308.4 10335.7 10375.2 10462.3 10465.1 17367.4 17412.3 17429.1 17432.8 17536.8 8199.3 8221.7 8350.9 8353.8 8396.3 4559.4 4699.0 4769.2 4829.6 4957.7 3074.8 3117.1 3166.7 3180.2 3185.8 550.0 552.6 556.8 563.3 569.5 547.5 603.9 607.4 609.2 624.5 9475.0 9540.7 9660.4 9754.2 9983.4 516.3 565.0 601.4 626.0 649.5 4375.4 4497.0 4538.7 4579.8 4581.0 63454.7 63778.4 70292.6 110648.0 111212.0 96991.0 97316.5 97323.5 97687.0 98779.5 52476.0 52601.5 75084.0 80204.0 82152.6 8435.4 8760.8 8767.9 8769.5 8855.5 45168.5 46051.1 49120.3 49357.3 51517.7 71367.6 73360.3 74532.0 74634.0 74869.3 11803.3 11824.5 11849.1 11862.3 11994.5 13792.0 14123.0 14201.7 14285.3 14341.2 12206.2 12237.8 13171.7 13287.0 13364.5 12458.3 12566.6 12810.2 13041.4 13476.2 12918.6 13011.3 13132.7 13176.8 13412.3 10509.8 10809.7 10945.4 11021.0 11059.3 11298.3 11391.4 11552.5 11619.4 11679.3 08:31:01 INFO - PROCESS | 14908 | -------- Summary: end -------- 08:31:01 INFO - PROCESS | 14908 | 08:31:01 INFO - TEST-INFO | 14908: exit 0 08:31:01 INFO - TEST-OK | dromaeo_css | took 1109429ms 08:31:01 INFO - TEST-START | kraken 08:31:01 INFO - operating with platform_type : linux_ 08:31:01 INFO - Initialising browser for kraken test... 08:31:01 INFO - TEST-INFO | started process 15142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxLn9U8/profile http://localhost:39460/getInfo.html) 08:31:06 INFO - PROCESS | 15142 | __metrics Screen width/height:1600/1200 08:31:06 INFO - PROCESS | 15142 | colorDepth:24 08:31:06 INFO - PROCESS | 15142 | Browser inner width/height: 1024/697 08:31:06 INFO - PROCESS | 15142 | __metrics 08:31:06 ERROR - PROCESS | 15142 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:31:07 INFO - TEST-INFO | 15142: exit 0 08:31:07 INFO - Browser initialized. 08:31:07 INFO - Running cycle 1/1 for kraken test... 08:31:07 INFO - TEST-INFO | started process 15261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxLn9U8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:19 INFO - PROCESS | 15261 | RSS: Main: 185405440 08:31:19 INFO - PROCESS | 15261 | 08:31:22 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39460/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:22 INFO - PROCESS | 15261 | RSS: Main: 191180800 08:31:22 INFO - PROCESS | 15261 | 08:31:25 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39460/tests/kraken/driver.html?testName=audio-dft) 08:31:26 INFO - PROCESS | 15261 | RSS: Main: 190316544 08:31:26 INFO - PROCESS | 15261 | 08:31:29 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39460/tests/kraken/driver.html?testName=audio-fft) 08:31:29 INFO - PROCESS | 15261 | RSS: Main: 185135104 08:31:29 INFO - PROCESS | 15261 | 08:31:32 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39460/tests/kraken/driver.html?testName=audio-oscillator) 08:31:32 INFO - PROCESS | 15261 | RSS: Main: 186273792 08:31:32 INFO - PROCESS | 15261 | 08:31:34 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:35 INFO - PROCESS | 15261 | RSS: Main: 186331136 08:31:35 INFO - PROCESS | 15261 | 08:31:38 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39460/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:39 INFO - PROCESS | 15261 | RSS: Main: 186888192 08:31:39 INFO - PROCESS | 15261 | 08:31:42 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39460/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:43 INFO - PROCESS | 15261 | RSS: Main: 184446976 08:31:43 INFO - PROCESS | 15261 | 08:31:46 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39460/tests/kraken/driver.html?testName=json-parse-financial) 08:31:46 INFO - PROCESS | 15261 | RSS: Main: 185638912 08:31:46 INFO - PROCESS | 15261 | 08:31:48 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:49 INFO - PROCESS | 15261 | RSS: Main: 186449920 08:31:49 INFO - PROCESS | 15261 | 08:31:50 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:51 INFO - PROCESS | 15261 | RSS: Main: 186195968 08:31:51 INFO - PROCESS | 15261 | 08:31:53 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:54 INFO - PROCESS | 15261 | RSS: Main: 186613760 08:31:54 INFO - PROCESS | 15261 | 08:31:56 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:57 INFO - PROCESS | 15261 | RSS: Main: 186880000 08:31:57 INFO - PROCESS | 15261 | 08:32:00 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:32:00 INFO - PROCESS | 15261 | RSS: Main: 186871808 08:32:00 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | Cycle 1(1): loaded http://localhost:39460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39460/tests/kraken/driver.html?testName=ai-astar) 08:32:02 INFO - PROCESS | 15261 | RSS: Main: 187731968 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | __start_tp_report 08:32:02 INFO - PROCESS | 15261 | _x_x_mozilla_page_load 08:32:02 INFO - PROCESS | 15261 | _x_x_mozilla_page_load_details 08:32:02 INFO - PROCESS | 15261 | |i|pagename|runs| 08:32:02 INFO - PROCESS | 15261 | |0;ai-astar;110;109;106;111;111;112;112;111;110;109 08:32:02 INFO - PROCESS | 15261 | |1;audio-beat-detection;167;142;168;180;133;156;162;129;184;138 08:32:02 INFO - PROCESS | 15261 | |2;audio-dft;160;162;160;163;164;170;162;161;160;164 08:32:02 INFO - PROCESS | 15261 | |3;audio-fft;76;76;75;160;76;74;75;76;165;76 08:32:02 INFO - PROCESS | 15261 | |4;audio-oscillator;86;86;138;86;86;86;134;86;85;140 08:32:02 INFO - PROCESS | 15261 | |5;imaging-gaussian-blur;117;118;118;117;118;118;117;119;117;119 08:32:02 INFO - PROCESS | 15261 | |6;imaging-darkroom;147;147;148;150;148;148;148;150;150;149 08:32:02 INFO - PROCESS | 15261 | |7;imaging-desaturate;96;96;96;97;96;96;96;96;96;97 08:32:02 INFO - PROCESS | 15261 | |8;json-parse-financial;57;57;55;54;55;54;55;55;55;57 08:32:02 INFO - PROCESS | 15261 | |9;json-stringify-tinderbox;64;64;64;64;64;63;63;64;64;63 08:32:02 INFO - PROCESS | 15261 | |10;stanford-crypto-aes;78;79;81;78;79;82;81;80;90;81 08:32:02 INFO - PROCESS | 15261 | |11;stanford-crypto-ccm;122;126;138;131;128;122;121;122;133;124 08:32:02 INFO - PROCESS | 15261 | |12;stanford-crypto-pbkdf2;158;166;160;160;165;161;158;162;159;164 08:32:02 INFO - PROCESS | 15261 | |13;stanford-crypto-sha256-iterative;63;62;64;62;69;63;62;62;66;63 08:32:02 INFO - PROCESS | 15261 | __end_tp_report 08:32:02 INFO - PROCESS | 15261 | __start_cc_report 08:32:02 INFO - PROCESS | 15261 | _x_x_mozilla_cycle_collect,892 08:32:02 INFO - PROCESS | 15261 | __end_cc_report 08:32:02 INFO - PROCESS | 15261 | __startTimestamp1466695922741__endTimestamp 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | ------- Summary: start ------- 08:32:02 INFO - PROCESS | 15261 | Number of tests: 14 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.79 (1.6%) stddev-sans-first:1.90 08:32:02 INFO - PROCESS | 15261 | Values: 110.0 109.0 106.0 111.0 111.0 112.0 112.0 111.0 110.0 109.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:164.50 stddev:19.55 (11.9%) stddev-sans-first:20.32 08:32:02 INFO - PROCESS | 15261 | Values: 167.0 142.0 168.0 180.0 133.0 156.0 162.0 129.0 184.0 138.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:3.03 (1.9%) stddev-sans-first:3.06 08:32:02 INFO - PROCESS | 15261 | Values: 160.0 162.0 160.0 163.0 164.0 170.0 162.0 161.0 160.0 164.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.00 stddev:36.71 (48.3%) stddev-sans-first:38.42 08:32:02 INFO - PROCESS | 15261 | Values: 76.0 76.0 75.0 160.0 76.0 74.0 75.0 76.0 165.0 76.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:86.00 stddev:24.91 (29.0%) stddev-sans-first:25.80 08:32:02 INFO - PROCESS | 15261 | Values: 86.0 86.0 138.0 86.0 86.0 86.0 134.0 86.0 85.0 140.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 08:32:02 INFO - PROCESS | 15261 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 117.0 119.0 117.0 119.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:1.18 (0.8%) stddev-sans-first:1.12 08:32:02 INFO - PROCESS | 15261 | Values: 147.0 147.0 148.0 150.0 148.0 148.0 148.0 150.0 150.0 149.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:32:02 INFO - PROCESS | 15261 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:1.17 (2.1%) stddev-sans-first:1.09 08:32:02 INFO - PROCESS | 15261 | Values: 57.0 57.0 55.0 54.0 55.0 54.0 55.0 55.0 55.0 57.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 08:32:02 INFO - PROCESS | 15261 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 63.0 64.0 64.0 63.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:3.48 (4.3%) stddev-sans-first:3.53 08:32:02 INFO - PROCESS | 15261 | Values: 78.0 79.0 81.0 78.0 79.0 82.0 81.0 80.0 90.0 81.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:127.00 stddev:5.72 (4.5%) stddev-sans-first:5.80 08:32:02 INFO - PROCESS | 15261 | Values: 122.0 126.0 138.0 131.0 128.0 122.0 121.0 122.0 133.0 124.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.50 stddev:2.87 (1.8%) stddev-sans-first:2.78 08:32:02 INFO - PROCESS | 15261 | Values: 158.0 166.0 160.0 160.0 165.0 161.0 158.0 162.0 159.0 164.0 08:32:02 INFO - PROCESS | 15261 | 08:32:02 INFO - PROCESS | 15261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:2.27 (3.6%) stddev-sans-first:2.40 08:32:02 INFO - PROCESS | 15261 | Values: 63.0 62.0 64.0 62.0 69.0 63.0 62.0 62.0 66.0 63.0 08:32:02 INFO - PROCESS | 15261 | -------- Summary: end -------- 08:32:02 INFO - PROCESS | 15261 | 08:32:03 INFO - TEST-INFO | 15261: exit 0 08:32:03 INFO - TEST-OK | kraken | took 61783ms 08:32:03 INFO - SUITE-END | took 1171s 08:32:03 INFO - Completed test suite (00:19:31) 08:32:03 INFO - javascript benchmark 08:32:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6812.227635429717, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.0, 3125.9531107033386, 3136.9372612547763, 3166.081836267482, 3175.079227024163, 5267.341582302212, 5292.655977361469, 5316.282301889249, 5376.285303925608, 5431.565474762019, 5184.092783762845, 5285.497877701622, 5311.867203319919, 5360.437154098822, 5372.409035006146, 4807.855764327067, 4831.782569784351, 4915.3855768029, 4962.280469331945, 5018.7992480300745, 657.4926721046456, 4858.587020103296, 4933.629977751665, 4941.4811444798315, 4983.800647974077, 4852.369192005052, 4855.708657480544, 4858.902821943541, 4889.779959901813, 4921.434035085975, 4773.355596994396, 4858.489858564835, 4887.877803054952, 4896.681715688469, 4947.876303092416, 4830.3237546743485, 4869.805207791684, 4875.926861097087, 4876.60987121033, 4889.804407823683, 5286.444923283077, 5332.066888294533, 5344.011357898762, 5382.91925621116, 5387.865303367408, 5529.834104976857, 5682.488576028136, 5714.599978001542, 5753.309602847643, 5768.134779783024, 5715.457031581993, 5719.170720245541, 5807.361190269067, 5817.447342502455, 5870.530357571384, 5396.1905714143195, 5414.133738601805, 5415.512603865632, 5416.214648875891, 5438.021156191884, 5715.828525144169, 5740.1102829061565, 5801.158831969426, 5857.589968702235, 5892.6759028253, 5598.328200615871, 5601.887962240732, 5603.551715862721, 5646.20953066571, 5720.256366672306, 5694.772209111672, 5711.200431939532, 5731.914021289684, 5732.283464566929, 5739.512141467939, 5466.781328746885, 5612.719364031782, 5653.349864765522, 5663.1505274208375, 5685.516731077904, 5518.972405138029, 5682.7442765075675, 5687.60186786921, 5699.886002279931, 5744.0, 4359.585839345257, 4365.825366985348, 4391.956080439219, 4392.956070439254, 4394.956050439455, 3875.457435958968, 3881.80590970456, 3882.3594106972596, 3905.258000979805, 3925.371940489565, 5425.972870135624, 5446.618736688473, 5457.426970168154, 5465.344158700981, 5469.07025805614, 5712.714364281769, 5753.654780713086, 5762.567807414461, 5776.075827867521, 5783.045797443375, 5305.549028332558, 5396.541293989976, 5438.184272359178, 5462.0987537056735, 5468.863278418072, 4945.703257804471, 4955.975220123876, 4958.752062396866, 4962.15643340633, 4993.201087825931, 5692.516136128475, 5917.6745279010065, 5932.58471906971, 5936.821895343147, 5937.0, 5602.439756024365, 5635.436456354331, 5667.3765885753355, 5690.317161940594, 5712.228849105318, 5848.0350742127075, 5854.385289544536, 5859.091840764689, 5865.208196893364, 5874.676892770939, 5456.427075157051, 5563.276774019351, 5578.693171875586, 5624.943750562442, 5626.85932851682, 5717.342505611908, 5760.683162426107, 5779.537636989115, 5801.158831969426, 5806.970965145148, 5612.438756124355, 5638.154276858504, 5641.012822756084, 5642.746076426489, 5646.491815736604, 5441.156620723794, 5573.498385145356, 5595.496405323541, 5602.0, 5607.5513958884, 5274.1034024215205, 5417.431169727122, 5422.566194704493, 5550.167474878801, 5578.386377498553, 5638.126090455986, 5645.350784659817, 5652.689102099424, 5699.0311647020935, 5708.743106560298, 5402.405735369028, 5451.127819548853, 5502.8349149525575, 5555.361133469541, 5566.053770859045], "value": 5244.223283360927, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.7815778838814, 583.6118980877717, 599.5713065158411, 601.5247954116248, 615.2094558492336, 28581.14256572301, 31440.05679829606, 36198.27603447933, 37025.0, 37099.0, 38161.04597385067, 38275.80862095692, 38323.616763832426, 38369.42445863314, 38383.808080959556, 8522.573871306426, 8672.436291641023, 8713.433626814236, 8723.38936274461, 8742.4754514729, 8361.372897032716, 8450.535220562866, 8452.408331416804, 8470.364722645796, 8481.74554763355, 8608.784780380478, 8628.827423451527, 8631.611577479029, 8651.091635378289, 8655.740327790145, 8525.701600443987, 8549.316054715639, 8569.185927336894, 8617.224449799485, 8637.265832404253, 8519.190676885686, 8544.957275213646, 8592.226699597066, 8605.010423801281, 8616.65533378664, 36147.09632259188, 36413.0, 36476.81761591175, 36572.0856978575, 36633.63366366329, 3158.8578513966927, 3250.73994080473, 3277.0332751838264, 3527.5237842891393, 3605.549306336708, 29801.0, 29846.85076574625, 30240.69759302423, 30255.546166807515, 31087.22281942947, 4358.084802191512, 4407.559244075567, 4411.580899814545, 4436.489803672586, 4439.445069366329, 323927.0, 327172.0, 329160.0, 330916.0, 331781.3410932954, 28048.158555243375, 47265.76367118143, 47540.52459475361, 47618.5238147621, 47731.0, 29528.557071643943, 30805.075847724605, 30862.691373086433, 30884.382312353628, 31083.378332433676, 13426.530071447452, 13634.250116243702, 13638.386272617756, 13709.245991470565, 13739.450421983009, 10582.735431614272, 10602.0, 10611.787764244671, 10675.46622668879, 10737.83893241602, 7607.695692172362, 7633.732819351296, 7676.078870535572, 7749.496282741604, 7760.223977602194, 2714.4571085782923, 2744.7118052604187, 2759.572266298727, 2776.750092491645, 2785.3175971887017, 809.6518497046327, 850.8638617821119, 863.0, 877.1228771228771, 879.5821984557411, 28384.8580757099, 29145.417091658048, 29357.412851742847, 29652.40695186084, 29706.25734356615, 939.1594522901964, 995.9053889880449, 1008.6089849753058, 1012.2408193854609, 1075.3225467955137, 15546.533603991898, 15600.843991560167, 15606.219689015505, 15613.843861561467, 15880.20598970047, 564472.0, 568511.0, 569024.0, 571251.0, 571800.0, 47329.29006064912, 48127.278090828666, 48391.5160848387, 48436.515634843905, 48617.75691121522, 1160.3270103340042, 1160.9013233875046, 1166.1836714300025, 1170.8946194842506, 1193.659806955031, 28863.7113628861, 29968.400631987675, 30073.849630751705, 30265.697343026288, 30473.085807425814, 43796.78101609471, 44457.333140003575, 45892.77053614711, 46177.30734038925, 50265.0, 453251.0, 456638.0, 457322.0, 459260.0, 461634.0, 37669.81165094267, 37913.43129852999, 38206.61793382142, 38321.23357532889, 38734.6442874498, 41964.0, 42344.153116936875, 42463.0, 42724.572754272056, 42754.358684620376, 34875.65124348825, 36179.0, 36297.45553816748, 36796.63203368039, 37655.43516847304, 34103.31793364069, 35747.82126089353, 36486.45270321, 36576.0, 36841.263174736894, 31148.53277200889, 32895.67104328926, 32948.67051329456, 36616.63383366239, 36883.63116368802, 32555.51166732548, 33419.331613368086, 33531.66468335383, 33747.0, 33755.0, 25669.743302567484, 25776.355591110372, 25817.483650327264, 26238.212853614423, 26356.28684135525], "value": 17335.487702278184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.1446385905756, 365.0884198516828, 366.0811363477671, 379.84616230426684, 383.8618097484905, 16269.593260168487, 16792.49622511325, 17582.20880060397, 17672.469825905213, 17798.644027119466, 14889.702205955875, 15790.763138552931, 16605.50183494497, 16659.91670041651, 16757.078360690157, 5301.6818990860575, 5500.257465242181, 5504.64219825712, 5546.972265138668, 5551.1118221084635, 4003.4395184674167, 5412.269343638617, 5857.7364018619055, 6104.2674879014585, 6154.199954005973, 6144.600600960924, 6195.039768835838, 6204.379562043805, 6210.937890621104, 6229.6573688447115, 4962.305277261186, 5224.92162617561, 5241.213817927303, 5286.973565132188, 5306.177542480922, 4909.0, 5130.358705161855, 5164.741762911877, 5169.534741873212, 5175.171972484384, 10828.0, 11007.889921100847, 11108.00027997476, 11115.277506962022, 12225.0, 2102.7792081831494, 2107.8933559881034, 2123.702681624574, 2153.8599991000533, 2213.236433430464, 8169.5098294102545, 8285.337173026144, 8378.078411374743, 8483.321334293241, 8496.150384961516, 1802.540352210178, 1812.429084838285, 1827.826356496144, 1904.0955546115622, 1919.1747548554117, 82263.5886820562, 83435.3748279925, 84634.57682711547, 85245.14754852497, 85816.0, 10053.447060411747, 10203.897961020442, 10374.481275936323, 10742.83885741699, 10944.890551094546, 13698.246596437291, 13701.725965480833, 13771.517996870061, 13795.862041379658, 13797.448102076005, 7473.663685134182, 7525.661345239478, 7571.962140189264, 7584.81037974044, 7902.841943161105, 7162.928370716226, 7290.45321600882, 7326.3040011198855, 7399.963000184965, 7465.552066876005, 4056.14820887611, 4161.375793630979, 4197.349410841324, 4197.76912269822, 4367.755189770964, 1519.5593277949492, 1629.983700163007, 1689.873259505542, 1693.6612677464557, 1703.3442124782048, 351.8733256027828, 379.45927053948014, 389.0778854115707, 851.5571902610608, 857.9318748158582, 10092.293539452316, 10487.0, 16963.491095267163, 18807.905960470383, 18924.43226703201, 843.8481073406846, 865.1478293880523, 878.991210087891, 882.7395918204145, 933.2487347685178, 9877.555510002067, 10204.336718113298, 10261.333013354108, 10281.691549253534, 10289.845652315222, 553186.0, 601359.0, 611434.0, 612522.0, 628767.0, 95293.52353238189, 95395.0, 95670.52164739132, 95799.0, 96816.51591741997, 930.5858892792643, 940.4357385568604, 977.3988996766938, 977.7555611097225, 1026.9127124194379, 17229.0, 17351.944924611107, 17958.461246162635, 18095.36666216676, 18222.271109156016, 42591.0, 42712.35931460968, 44263.336049958634, 44314.77842610766, 44397.0, 52902.4709752913, 61064.38935610587, 61399.0, 61724.382756171864, 63531.729365411506, 8088.797780055545, 8152.592370381339, 8385.496870187808, 8402.32781377476, 8533.189347012023, 12965.805512917124, 13728.176309421468, 13892.305384730926, 13971.720565588428, 14054.648633784238, 12067.698307542381, 12086.576969806014, 12213.389330533615, 12215.45030473613, 12444.253344799341, 12032.819507707216, 12113.878861211275, 12122.09084318662, 12124.636260911833, 12250.0, 12204.08469364819, 12361.876381236072, 12430.689232769253, 12432.937835310766, 12495.250284982567, 8150.0, 8282.627281772455, 8283.751487455385, 8339.499630022217, 8752.081031491856, 11110.888891110986, 11837.585684501, 12110.091743119125, 12242.143049986415, 12301.569445069379], "value": 8562.218788075788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1206.9336186509745, 1222.1689251309112, 1239.0273635196372, 1393.9651508712286, 1412.0680350968362, 7359.227281135484, 7567.2432756724365, 7976.7606971790865, 8046.718364857224, 8054.395920305986, 8024.558649274288, 8336.16638336166, 8353.540555269457, 8354.791130221733, 8369.455985360948, 2188.3544354415444, 2215.3575463115676, 2216.1689366487567, 2218.7559368469456, 2228.54314865453, 2173.6848157017303, 2191.8904054797276, 2244.62963611004, 2246.472079061419, 2252.7071480707486, 2178.4662757624405, 2179.7929196726286, 2195.681626164205, 2200.966985495219, 2236.4073520517077, 2156.040561949933, 2201.6037113319594, 2222.0889435331437, 2222.344408399526, 2239.1267405711787, 2215.501512159767, 2227.0757635581213, 2233.4304752288226, 2237.865728056322, 2240.327901629521, 8202.38482113844, 8207.917920820775, 8233.300169485601, 8286.378521610903, 8323.334133269324, 4884.65807393479, 4967.155583550769, 4997.450280469146, 5025.296458495814, 5037.748112594356, 3129.3741251749743, 3179.9364012719616, 3192.377486390155, 3206.679332066798, 3300.620428650712, 946.2713710442921, 951.5622813505796, 970.8834939807198, 981.6122631560565, 983.5426526665063, 11736.295822250693, 11888.821667674905, 11975.041996640248, 11980.760384792342, 12011.579594714143, 4172.0, 4275.230458517497, 4337.978310108492, 4365.563443655673, 4388.495323037828, 9911.553980070914, 10122.493875306352, 10183.847242291371, 10197.439140847324, 10203.183745300357, 4888.120138375127, 4889.828855990095, 4895.31465594817, 4896.46138924718, 4897.8285759998225, 3837.3860182370686, 4404.713693609905, 4443.688941774045, 4549.954500455019, 4552.044070745114, 3626.5104210931186, 3678.981605092011, 3755.6244375562774, 3777.33896568105, 3888.922221555553, 1181.7931861924128, 1185.2118341302937, 1187.145255416099, 1189.5420263198557, 1189.6728399690155, 859.1022381611107, 860.1570460948305, 864.3560547392233, 886.1891369397058, 886.4814083760944, 5755.827325180251, 5800.332961709458, 5872.737361467305, 5977.44980110106, 6089.543284253698, 874.1302404107953, 891.6611687558686, 909.2135302962889, 911.9407238529475, 918.7060140754894, 3880.359740642819, 3967.1668949520345, 4026.859059932888, 4035.051762835731, 4087.2438598859308, 9629.566669499889, 9941.0, 10101.898981010243, 10152.086312231935, 10189.592416303412, 9849.950750246202, 9955.303128780915, 9994.400335979719, 10035.799284014425, 10088.899111008795, 7744.0707115145415, 7868.881966770388, 7889.2110788920645, 7922.168172341821, 7926.048874135141, 5547.916781248366, 5572.35917869434, 5600.775968961359, 5737.196792449144, 5754.108113242454, 9512.048795120432, 9877.654282100379, 9879.703608891745, 10000.199984001409, 10049.69850904474, 9891.208703303575, 10165.796684066425, 10234.590616375262, 10351.120154786626, 10383.53274102652, 6782.389584937379, 6789.93210067893, 7366.852662946818, 7383.372413344926, 7565.356944659546, 8164.632591533514, 8227.83544329122, 8231.34149268045, 8231.711890083818, 8279.296259817984, 7179.066721326194, 7398.519096258726, 7416.666250018654, 7481.513701609378, 7536.020317358708, 7045.0, 7226.0, 7246.60143692102, 7267.672954716944, 7394.149672787698, 6048.939510604838, 6089.117078023751, 6090.086487026804, 6098.176746139392, 6107.206063211754, 4733.502982186958, 4957.702537847741, 5062.139436295765, 5106.7701953412925, 5212.661177023481, 4918.778654960463, 4935.284383764262, 5036.622253331088, 5040.521150490697, 5059.165237735732], "value": 4367.589616136985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.45648647704417, 301.434809731753, 301.9471592471317, 305.34198801582596, 308.2171284936262, 5592.916106258409, 5598.048331783596, 5606.635568688032, 5664.376918538957, 5674.971625141879, 5580.637258578189, 5587.552995760339, 5600.131979543167, 5601.551875849932, 5615.241942337783, 4062.2281766464425, 4085.0808568072243, 4200.495940487146, 4203.747775133486, 4208.389783481409, 4196.895077623069, 4208.284591619432, 4209.368594710802, 4248.83004679814, 4271.188474189894, 4172.645325147366, 4244.578066347777, 4246.787660616972, 4256.6375661507855, 4257.936130958038, 4102.815373308208, 4225.809838557257, 4251.638610718092, 4278.016056307036, 4282.2506061439435, 3675.3384390809642, 3682.5396825396824, 3695.4087346024507, 3704.2961837250837, 3719.386301260316, 5395.5953303502, 5433.646812957185, 5461.69960652164, 5485.0949593317455, 5488.4785945335125, 4755.262934245163, 4898.501764100334, 4898.779554920037, 4942.555170034678, 4991.575716064139, 5800.723840755028, 5800.9709951450395, 5861.706914654293, 5867.618604790675, 5881.176635271023, 4135.29699951009, 4140.420341152241, 4144.3990621359735, 4154.2759754701765, 4168.333066709312, 5978.282606087298, 6067.211262535842, 6100.267967843843, 6133.509319254449, 6146.385361463863, 4118.19695159447, 4138.772367519815, 4152.958470415318, 4163.479565054368, 4182.832686692498, 4212.72617279882, 4219.3249080147025, 4232.64022558086, 4251.234777739975, 4265.722728022669, 4738.64460165489, 4833.709977401367, 4840.531329022154, 4904.166291730415, 4904.337914381585, 5789.131630255495, 5844.013035567928, 5845.678487683133, 5850.882982340415, 5896.882062358729, 1455.5051282563768, 1473.359088796377, 1473.7199932012884, 1474.402866838932, 1480.6224412774673, 931.6925414613162, 933.5752232734226, 933.6825479337058, 953.9713808585753, 987.7975015121883, 5521.365043020104, 5536.916946245809, 5541.5289700375915, 5547.306586676666, 5552.3892371839065, 5938.524918006549, 5940.34656187819, 5942.227510423617, 5960.791372301948, 5972.343042265347, 5326.307580014573, 5520.254765606672, 5572.554195664337, 5588.91616625751, 5642.633228840113, 3139.5290706393766, 3149.4173577888164, 3157.289609837814, 3198.104530731399, 3220.5491231227647, 5822.0, 6034.426729460694, 6045.244344456943, 6080.2399700037495, 6129.969350153221, 5992.40075992406, 6011.909821352683, 6029.336772954972, 6030.005049166838, 6041.426064523863, 5963.970180149072, 5965.13505541694, 5991.55063370249, 6039.214902062704, 6087.908681369783, 5796.869610425926, 5850.297964244318, 5934.9406505934385, 5958.463738263577, 5964.612300200473, 5746.655200687972, 5862.970685146547, 5871.794487192928, 5901.7639294427745, 5951.191237607848, 5921.2006379138265, 6014.63912165254, 6035.758569657164, 6116.327204007466, 6122.846928826815, 4098.549159592502, 4109.260333140063, 4114.362273847559, 4148.439960605279, 4161.417401563844, 5953.434423729739, 5977.760889564369, 5984.640921544721, 6018.1875446815875, 6029.879402412015, 5645.125005624135, 5837.270341207349, 5840.737166827418, 5856.795012174553, 5901.259128557172, 5801.419858014334, 5825.300963884361, 5830.842588242377, 5838.766449342149, 5840.445157710011, 5597.328320601554, 5626.874625074919, 5699.857503562278, 5781.439011466797, 5792.913106303325, 5823.213866128019, 5852.795152169653, 5879.559033072451, 5903.380145084704, 5906.995810712275, 5607.43925607436, 5752.194692742935, 5783.016887129114, 5800.70872005547, 5806.593538452268], "value": 4385.463500353696, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.8338498450469, 574.6006525464802, 588.7174156404925, 590.3181824992133, 604.3412680178607, 12671.176373535714, 13057.020723445745, 13109.410076546554, 13195.406206720696, 13439.596812095653, 12889.355532223399, 13330.266835324053, 13420.597382078553, 13786.034977551575, 13788.931055344734, 576.9884602307951, 585.2479563760558, 591.4381337729175, 592.0645380299117, 596.9850753731148, 598.437468779346, 598.5690302981847, 598.7186022569385, 600.7777122464672, 601.5698775375605, 621.3599992008216, 622.0265284829228, 622.8536293970914, 624.9125122482856, 625.9874802503947, 623.0156352962331, 623.4949690750507, 624.3693869192149, 624.4224092714244, 624.9500039996813, 448.6119506626777, 448.63212166023874, 449.7234200966382, 450.2862962204909, 451.3703383779609, 13394.0, 13400.128991615515, 13415.597532074053, 13428.865711342956, 13466.124701894345, 12127.878721212852, 12561.246325220516, 12578.119531632788, 12579.622611321674, 12848.421821017982, 11305.830412543819, 11544.884551154464, 11571.942140289244, 11617.825732614017, 11716.88283117175, 3638.462035926948, 3681.1717363593243, 3725.590185079639, 3731.365667836474, 3772.2832661794446, 77012.84480732738, 77141.61429192818, 77628.61185694035, 77981.61009194917, 78629.60685196595, 10308.381497110047, 10335.689929302132, 10375.221858360654, 10462.319949203278, 10465.058144767008, 17367.392141274995, 17412.303507859797, 17429.12854357277, 17432.825671743372, 17536.82463175352, 8199.262066414052, 8221.671133154727, 8350.916490835014, 8353.791155221046, 8396.286315663116, 4559.361689363492, 4698.95301046992, 4769.189237829577, 4829.589484893823, 4957.702537847741, 3074.8462576871066, 3117.1272043827767, 3166.7149956503563, 3180.2367431816197, 3185.761067919915, 549.9807506737245, 552.582799986016, 556.7717235933329, 563.3352643880261, 569.4561693582618, 547.4826289156708, 603.9063945088518, 607.3804719186405, 609.2171559545963, 624.5035197018382, 9474.95262523683, 9540.666076687283, 9660.420374777535, 9754.219662426989, 9983.402655575073, 516.3193804167411, 565.0422533805242, 601.362555690969, 625.956183067181, 649.5258461323166, 4375.365571992043, 4496.955030449719, 4538.727676339364, 4579.839705610288, 4581.037982023746, 63454.682726586994, 63778.36221637817, 70292.64853675698, 110648.0, 111212.0, 96991.0, 97316.51341743387, 97323.51338243263, 97687.0, 98779.50610246902, 52476.0, 52601.473985260425, 75084.0, 80203.99999999884, 82152.58923705462, 8435.367347449088, 8760.824783504167, 8767.912320876709, 8769.473831570127, 8855.51294678773, 45168.54831451643, 46051.085657718126, 49120.263196051375, 49357.25964110613, 51517.742411287705, 71367.64316178385, 73360.26639733535, 74532.0, 74634.0, 74869.25130748622, 11803.291802491878, 11824.467898944396, 11849.111316651113, 11862.288262704265, 11994.460249288628, 13792.0, 14123.0, 14201.715965680422, 14285.28573571338, 14341.211233382264, 12206.206596571194, 12237.75524489523, 13171.73656526845, 13287.0, 13364.532241371506, 12458.314792686127, 12566.560170393992, 12810.231386116862, 13041.413136409074, 13476.191428514321, 12918.612441626767, 13011.349432528146, 13132.737345253232, 13176.80234796498, 13412.262325572186, 10509.78980420372, 10809.67570972872, 10945.398003109587, 11021.0, 11059.281146725438, 11298.322100673657, 11391.392992064748, 11552.537898483966, 11619.36093514831, 11679.299242045505], "value": 6702.467223785669, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 106.0, 111.0, 111.0, 112.0, 112.0, 111.0, 110.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 142.0, 168.0, 180.0, 133.0, 156.0, 162.0, 129.0, 184.0, 138.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 163.0, 164.0, 170.0, 162.0, 161.0, 160.0, 164.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 160.0, 76.0, 74.0, 75.0, 76.0, 165.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 138.0, 86.0, 86.0, 86.0, 134.0, 86.0, 85.0, 140.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0, 117.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 150.0, 148.0, 148.0, 148.0, 150.0, 150.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 54.0, 55.0, 54.0, 55.0, 55.0, 55.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 81.0, 78.0, 79.0, 82.0, 81.0, 80.0, 90.0, 81.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 126.0, 138.0, 131.0, 128.0, 122.0, 121.0, 122.0, 133.0, 124.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 166.0, 160.0, 160.0, 165.0, 161.0, 158.0, 162.0, 159.0, 164.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 62.0, 69.0, 63.0, 62.0, 62.0, 66.0, 63.0], "value": 63.6, "unit": "score"}]}]} 08:32:04 INFO - Return code: 0 08:32:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:32:04 ERROR - # TBPL SUCCESS # 08:32:04 INFO - Running post-action listener: _resource_record_post_action 08:32:04 INFO - ##### 08:32:04 INFO - ##### Finished run-tests step (success) 08:32:04 INFO - ##### 08:32:04 INFO - Running post-run listener: _resource_record_post_run 08:32:04 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 558874624; Read time: 24; Write time: 508968 08:32:04 INFO - TinderboxPrint: CPU usage
13.5% 08:32:04 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 08:32:04 INFO - TinderboxPrint: I/O write bytes / time
558,874,624 / 508,968 08:32:04 INFO - TinderboxPrint: CPU idle
8,214.2 (86.5%) 08:32:04 INFO - TinderboxPrint: CPU user
1,222.3 (12.9%) 08:32:04 INFO - TinderboxPrint: Swap in / out
0 / 0 08:32:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263901184; Read time: 0; Write time: 301712 08:32:04 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294973440; Read time: 24; Write time: 207256 08:32:04 INFO - Running post-run listener: _upload_blobber_files 08:32:04 INFO - Blob upload gear active. 08:32:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:32:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:32:05 INFO - (blobuploader) - INFO - Open directory for files ... 08:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:05 INFO - (blobuploader) - INFO - Done attempting. 08:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:09 INFO - (blobuploader) - INFO - Done attempting. 08:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:10 INFO - (blobuploader) - INFO - Done attempting. 08:32:10 INFO - (blobuploader) - INFO - Iteration through files over. 08:32:10 INFO - Return code: 0 08:32:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:32:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:32:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc4783de7c3406a5b0380a1d0a504e000ccf167f4edd11ceccde45e395a26831352257ddccde42dde5f960caef3aef005530e88ef9ac57cae17499204d54ed74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/593763ea4cc722f05ac468f65033c07b7a1681a93cb96797b22915990797db41d5bf5b56449bc230c6e02180222264970121c161d00c4ecabc3cb8d392b0ff20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaa53ecd19c6a23e20a03a73acf6ae6b4959bb47015b26dd1e817cc438140bcabf2059ae7c309d4f51e497e9abea599baa0356fee0c610811b7ef7a45383f302"} 08:32:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:32:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:32:10 INFO - Contents: 08:32:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc4783de7c3406a5b0380a1d0a504e000ccf167f4edd11ceccde45e395a26831352257ddccde42dde5f960caef3aef005530e88ef9ac57cae17499204d54ed74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/593763ea4cc722f05ac468f65033c07b7a1681a93cb96797b22915990797db41d5bf5b56449bc230c6e02180222264970121c161d00c4ecabc3cb8d392b0ff20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaa53ecd19c6a23e20a03a73acf6ae6b4959bb47015b26dd1e817cc438140bcabf2059ae7c309d4f51e497e9abea599baa0356fee0c610811b7ef7a45383f302"} 08:32:10 INFO - Running post-run listener: copy_logs_to_upload_dir 08:32:10 INFO - Copying logs to upload dir... 08:32:10 INFO - mkdir: /builds/slave/test/build/upload/logs 08:32:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.518625 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-23 08:32:10.534933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:32:10.538509) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279 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/sha512/fc4783de7c3406a5b0380a1d0a504e000ccf167f4edd11ceccde45e395a26831352257ddccde42dde5f960caef3aef005530e88ef9ac57cae17499204d54ed74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/593763ea4cc722f05ac468f65033c07b7a1681a93cb96797b22915990797db41d5bf5b56449bc230c6e02180222264970121c161d00c4ecabc3cb8d392b0ff20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaa53ecd19c6a23e20a03a73acf6ae6b4959bb47015b26dd1e817cc438140bcabf2059ae7c309d4f51e497e9abea599baa0356fee0c610811b7ef7a45383f302"} build_url:https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.012051 build_url: 'https://queue.taskcluster.net/v1/task/BMsEFDhgRJmaLt9_sc-bEA/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/sha512/fc4783de7c3406a5b0380a1d0a504e000ccf167f4edd11ceccde45e395a26831352257ddccde42dde5f960caef3aef005530e88ef9ac57cae17499204d54ed74", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/593763ea4cc722f05ac468f65033c07b7a1681a93cb96797b22915990797db41d5bf5b56449bc230c6e02180222264970121c161d00c4ecabc3cb8d392b0ff20", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eaa53ecd19c6a23e20a03a73acf6ae6b4959bb47015b26dd1e817cc438140bcabf2059ae7c309d4f51e497e9abea599baa0356fee0c610811b7ef7a45383f302"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 08:32:10.565902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:32:10.566279) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1466694697.54102-357681279 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 08:32:10.651498) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:32:10.651870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 08:32:10.652231) ========= ========= Total master_lag: 0.26 =========