builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1466583774.17 results: success (0) buildid: 20160622002201 builduid: ca91bf14d7034b1e9e61c1b839a6aef8 revision: a1746be133dff55de7588c846aaafbc30534b8bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:54.166951) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:54.167926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:54.168494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:54.184457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:54.184793) ========= 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=eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 01:22:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-06-22 01:22:55 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123862 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:54.324352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:54.325034) ========= 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=eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014393 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:54.376650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:54.377220) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a1746be133dff55de7588c846aaafbc30534b8bd --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 a1746be133dff55de7588c846aaafbc30534b8bd --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=eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 01:22:55,328 truncating revision to first 12 chars 2016-06-22 01:22:55,328 Setting DEBUG logging. 2016-06-22 01:22:55,328 attempt 1/10 2016-06-22 01:22:55,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a1746be133df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 01:22:55,635 unpacking tar archive at: fx-team-a1746be133df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655564 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:55.051117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:55.051950) ========= script_repo_revision: a1746be133dff55de7588c846aaafbc30534b8bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:55.053004) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:55.053752) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 01:22:55.065835) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-22 01:22:55.066602) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:22:56 INFO - MultiFileLogger online at 20160622 01:22:56 in /builds/slave/test 01:22:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:22:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:22:56 INFO - {'append_to_log': False, 01:22:56 INFO - 'base_work_dir': '/builds/slave/test', 01:22:56 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:22:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:22:56 INFO - 'branch': 'Fx-Team-Non-PGO', 01:22:56 INFO - 'buildbot_json_path': 'buildprops.json', 01:22:56 INFO - 'config_files': ('talos/linux_config.py',), 01:22:56 INFO - 'default_actions': ('clobber', 01:22:56 INFO - 'read-buildbot-config', 01:22:56 INFO - 'download-and-extract', 01:22:56 INFO - 'populate-webroot', 01:22:56 INFO - 'create-virtualenv', 01:22:56 INFO - 'install', 01:22:56 INFO - 'run-tests'), 01:22:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:22:56 INFO - 'download_minidump_stackwalk': True, 01:22:56 INFO - 'download_symbols': 'ondemand', 01:22:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:22:56 INFO - 'tooltool.py': '/tools/tooltool.py', 01:22:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:22:56 INFO - '/tools/misc-python/virtualenv.py')}, 01:22:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:22:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:22:56 INFO - 'installer_path': 'installer.exe', 01:22:56 INFO - 'log_level': 'info', 01:22:56 INFO - 'log_name': 'talos', 01:22:56 INFO - 'log_to_console': True, 01:22:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:22:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:22:56 INFO - 'opt_config_files': (), 01:22:56 INFO - 'pip_index': False, 01:22:56 INFO - 'sps_profile': False, 01:22:56 INFO - 'sps_profile_interval': 0, 01:22:56 INFO - 'suite': 'dromaeojs-e10s', 01:22:56 INFO - 'system_bits': '32', 01:22:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:22:56 INFO - 'title': 'talos-linux64-ix-010', 01:22:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:22:56 INFO - 'use_talos_json': True, 01:22:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:22:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:22:56 INFO - 'work_dir': 'build'} 01:22:56 INFO - ##### 01:22:56 INFO - ##### Running clobber step. 01:22:56 INFO - ##### 01:22:56 INFO - Running pre-action listener: _resource_record_pre_action 01:22:56 INFO - Running main action method: clobber 01:22:56 INFO - rmtree: /builds/slave/test/build 01:22:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:22:56 INFO - Running post-action listener: _resource_record_post_action 01:22:56 INFO - ##### 01:22:56 INFO - ##### Finished clobber step (success) 01:22:56 INFO - ##### 01:22:56 INFO - ##### 01:22:56 INFO - ##### Running read-buildbot-config step. 01:22:56 INFO - ##### 01:22:56 INFO - Running pre-action listener: _resource_record_pre_action 01:22:56 INFO - Running main action method: read_buildbot_config 01:22:56 INFO - Using buildbot properties: 01:22:56 INFO - { 01:22:56 INFO - "project": "", 01:22:56 INFO - "product": "firefox", 01:22:56 INFO - "script_repo_revision": "production", 01:22:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:22:56 INFO - "repository": "", 01:22:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:22:56 INFO - "buildid": "20160622002201", 01:22:56 INFO - "pgo_build": "False", 01:22:56 INFO - "basedir": "/builds/slave/test", 01:22:56 INFO - "buildnumber": 1378, 01:22:56 INFO - "slavename": "talos-linux64-ix-010", 01:22:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:22:56 INFO - "platform": "ubuntu64_hw", 01:22:56 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:22:56 INFO - "branch": "fx-team", 01:22:56 INFO - "repo_path": "integration/fx-team", 01:22:56 INFO - "revision": "a1746be133dff55de7588c846aaafbc30534b8bd", 01:22:56 INFO - "stage_platform": "linux64", 01:22:56 INFO - "builduid": "ca91bf14d7034b1e9e61c1b839a6aef8", 01:22:56 INFO - "slavebuilddir": "test" 01:22:56 INFO - } 01:22:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:22:56 INFO - Running post-action listener: _resource_record_post_action 01:22:56 INFO - ##### 01:22:56 INFO - ##### Finished read-buildbot-config step (success) 01:22:56 INFO - ##### 01:22:56 INFO - ##### 01:22:56 INFO - ##### Running download-and-extract step. 01:22:56 INFO - ##### 01:22:56 INFO - Running pre-action listener: _resource_record_pre_action 01:22:56 INFO - Running main action method: download_and_extract 01:22:56 INFO - mkdir: /builds/slave/test/build/tests 01:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:22:56 INFO - https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:22:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:22:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:22:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:22:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:22:57 INFO - Downloaded 1361 bytes. 01:22:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:22:57 INFO - Using the following test package requirements: 01:22:57 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:22:57 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:22:57 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:22:57 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:57 INFO - u'jsshell-linux-x86_64.zip'], 01:22:57 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:22:57 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:22:57 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:22:57 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:22:57 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:22:57 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:22:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:22:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:22: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')]} 01:22:57 INFO - https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:22:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:22:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:22:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:22:58 INFO - Downloaded 22701903 bytes. 01:22:58 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'] 01:22:58 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 01:22:59 INFO - Return code: 0 01:22:59 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 01:22: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')]} 01:22:59 INFO - https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:22:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:22:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:22:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:22:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:23:00 INFO - Downloaded 22701903 bytes. 01:23:00 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'] 01:23:00 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 01:23:02 INFO - Return code: 0 01:23:02 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')]} 01:23:02 INFO - https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:23:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:23:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:23:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:23:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:23:03 INFO - Downloaded 14405384 bytes. 01:23:03 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'] 01:23:03 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 01:23:03 INFO - Return code: 0 01:23: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')]} 01:23:03 INFO - https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:23:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:23:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:23:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:23:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:23:04 INFO - Downloaded 56243482 bytes. 01:23:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:23:04 INFO - mkdir: /builds/slave/test/properties 01:23:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:23:04 INFO - Writing to file /builds/slave/test/properties/build_url 01:23:04 INFO - Contents: 01:23:04 INFO - build_url:https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:23:05 INFO - Running post-action listener: _resource_record_post_action 01:23:05 INFO - Running post-action listener: set_extra_try_arguments 01:23:05 INFO - ##### 01:23:05 INFO - ##### Finished download-and-extract step (success) 01:23:05 INFO - ##### 01:23:05 INFO - ##### 01:23:05 INFO - ##### Running populate-webroot step. 01:23:05 INFO - ##### 01:23:05 INFO - Running pre-action listener: _resource_record_pre_action 01:23:05 INFO - Running main action method: populate_webroot 01:23:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:23:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:23:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:23:05 INFO - '--tppagecycles', 01:23:05 INFO - '7'], 01:23:05 INFO - 'tests': ['tsvgm']}}, 01:23:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:23:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:23:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:23:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:23:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:05 INFO - 'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:23:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:23:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:05 INFO - 'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['damp', 'tps']}, 01:23:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:05 INFO - 'tests': ['damp', 'tps']}, 01:23:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['dromaeo_dom']}, 01:23:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:23:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['basic_compositor_video']}, 01:23:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:23:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['a11yr', 01:23:05 INFO - 'ts_paint', 01:23:05 INFO - 'tpaint', 01:23:05 INFO - 'sessionrestore', 01:23:05 INFO - 'sessionrestore_no_auto_restore', 01:23:05 INFO - 'tabpaint']}, 01:23:05 INFO - 'other-e10s': {'tests': ['a11yr', 01:23:05 INFO - 'ts_paint', 01:23:05 INFO - 'tpaint', 01:23:05 INFO - 'sessionrestore', 01:23:05 INFO - 'sessionrestore_no_auto_restore', 01:23:05 INFO - 'tabpaint']}, 01:23:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:23:05 INFO - 'ts_paint', 01:23:05 INFO - 'tpaint', 01:23:05 INFO - 'sessionrestore', 01:23:05 INFO - 'sessionrestore_no_auto_restore', 01:23:05 INFO - 'tabpaint']}, 01:23:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:23:05 INFO - 'ts_paint', 01:23:05 INFO - 'tpaint', 01:23:05 INFO - 'sessionrestore', 01:23:05 INFO - 'sessionrestore_no_auto_restore', 01:23:05 INFO - 'tabpaint']}, 01:23:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['a11yr', 01:23:05 INFO - 'ts_paint', 01:23:05 INFO - 'tpaint', 01:23:05 INFO - 'sessionrestore', 01:23:05 INFO - 'sessionrestore_no_auto_restore', 01:23:05 INFO - 'tabpaint']}, 01:23:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['a11yr', 01:23:05 INFO - 'ts_paint', 01:23:05 INFO - 'tpaint', 01:23:05 INFO - 'sessionrestore', 01:23:05 INFO - 'sessionrestore_no_auto_restore', 01:23:05 INFO - 'tabpaint']}, 01:23:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['tsvgx', 01:23:05 INFO - 'tsvgr_opacity', 01:23:05 INFO - 'tart', 01:23:05 INFO - 'tscrollx', 01:23:05 INFO - 'cart']}, 01:23:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:23:05 INFO - 'tsvgr_opacity', 01:23:05 INFO - 'tart', 01:23:05 INFO - 'tscrollx', 01:23:05 INFO - 'cart']}, 01:23:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:05 INFO - 'talos_options': ['--disable-e10s'], 01:23:05 INFO - 'tests': ['tp5o']}, 01:23:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:05 INFO - 'tests': ['tp5o']}, 01:23:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:05 INFO - 'talos_options': ['--disable-e10s', 01:23:05 INFO - '--xperf_path', 01:23:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:23:05 INFO - 'tests': ['tp5n']}, 01:23:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:23:05 INFO - 'talos_options': ['--xperf_path', 01:23:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:23:05 INFO - 'tests': ['tp5n']}}, 01:23:05 INFO - 'talos.zip': {'path': '', 01:23:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:23:05 INFO - Running post-action listener: _resource_record_post_action 01:23:05 INFO - ##### 01:23:05 INFO - ##### Finished populate-webroot step (success) 01:23:05 INFO - ##### 01:23:05 INFO - ##### 01:23:05 INFO - ##### Running create-virtualenv step. 01:23:05 INFO - ##### 01:23:05 INFO - Running pre-action listener: _resource_record_pre_action 01:23:05 INFO - Running main action method: create_virtualenv 01:23:05 INFO - Creating virtualenv /builds/slave/test/build/venv 01:23:05 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 01:23:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:23:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:23:05 INFO - Using real prefix '/usr' 01:23:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:23:06 INFO - Installing distribute.............................................................................................................................................................................................done. 01:23:08 INFO - Installing pip.................done. 01:23:08 INFO - Return code: 0 01:23:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c6caf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', '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 01:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:23:08 INFO - Using env: {'DISPLAY': ':0', 01:23:08 INFO - 'HOME': '/home/cltbld', 01:23:08 INFO - 'LANG': 'en_US.UTF-8', 01:23:08 INFO - 'LANGUAGE': 'en_US:en', 01:23:08 INFO - 'LOGNAME': 'cltbld', 01:23:08 INFO - 'MAIL': '/var/mail/cltbld', 01:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:08 INFO - 'MOZ_NO_REMOTE': '1', 01:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:08 INFO - 'NO_EM_RESTART': '1', 01:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:08 INFO - 'PWD': '/builds/slave/test', 01:23:08 INFO - 'SHELL': '/bin/bash', 01:23:08 INFO - 'SHLVL': '1', 01:23:08 INFO - 'TERM': 'linux', 01:23:08 INFO - 'TMOUT': '86400', 01:23:08 INFO - 'USER': 'cltbld', 01:23:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:08 INFO - '_': '/tools/buildbot/bin/python'} 01:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:08 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 01:23:08 INFO - Cleaning up... 01:23:08 INFO - Return code: 0 01:23:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1c6caf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', '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 01:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:23:08 INFO - Using env: {'DISPLAY': ':0', 01:23:08 INFO - 'HOME': '/home/cltbld', 01:23:08 INFO - 'LANG': 'en_US.UTF-8', 01:23:08 INFO - 'LANGUAGE': 'en_US:en', 01:23:08 INFO - 'LOGNAME': 'cltbld', 01:23:08 INFO - 'MAIL': '/var/mail/cltbld', 01:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:08 INFO - 'MOZ_NO_REMOTE': '1', 01:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:08 INFO - 'NO_EM_RESTART': '1', 01:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:08 INFO - 'PWD': '/builds/slave/test', 01:23:08 INFO - 'SHELL': '/bin/bash', 01:23:08 INFO - 'SHLVL': '1', 01:23:08 INFO - 'TERM': 'linux', 01:23:08 INFO - 'TMOUT': '86400', 01:23:08 INFO - 'USER': 'cltbld', 01:23:08 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:08 INFO - '_': '/tools/buildbot/bin/python'} 01:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:08 INFO - Downloading/unpacking psutil>=3.1.1 01:23: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 01:23: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 01:23: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 01:23: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 01:23: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 01:23: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 01:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:23:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:23:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:23:11 INFO - Installing collected packages: psutil 01:23:11 INFO - Running setup.py install for psutil 01:23:11 INFO - building 'psutil._psutil_linux' extension 01:23:11 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 01:23:11 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 01:23:11 INFO - building 'psutil._psutil_posix' extension 01:23:11 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 01:23:12 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 01:23:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:23:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:23:12 INFO - Successfully installed psutil 01:23:12 INFO - Cleaning up... 01:23:12 INFO - Return code: 0 01:23:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:12 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 0x7f1c6caf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', '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 01:23:12 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 01:23:12 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 01:23:12 INFO - Using env: {'DISPLAY': ':0', 01:23:12 INFO - 'HOME': '/home/cltbld', 01:23:12 INFO - 'LANG': 'en_US.UTF-8', 01:23:12 INFO - 'LANGUAGE': 'en_US:en', 01:23:12 INFO - 'LOGNAME': 'cltbld', 01:23:12 INFO - 'MAIL': '/var/mail/cltbld', 01:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:12 INFO - 'MOZ_NO_REMOTE': '1', 01:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:12 INFO - 'NO_EM_RESTART': '1', 01:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:12 INFO - 'PWD': '/builds/slave/test', 01:23:12 INFO - 'SHELL': '/bin/bash', 01:23:12 INFO - 'SHLVL': '1', 01:23:12 INFO - 'TERM': 'linux', 01:23:12 INFO - 'TMOUT': '86400', 01:23:12 INFO - 'USER': 'cltbld', 01:23:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:12 INFO - '_': '/tools/buildbot/bin/python'} 01:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:23:14 INFO - Installing collected packages: mozsystemmonitor 01:23:14 INFO - Running setup.py install for mozsystemmonitor 01:23:14 INFO - Successfully installed mozsystemmonitor 01:23:14 INFO - Cleaning up... 01:23:14 INFO - Return code: 0 01:23:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:23:14 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')]} 01:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:14 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')]} 01:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:14 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 0x7f1c6caf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', '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 01:23:14 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 01:23:14 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 01:23:14 INFO - Using env: {'DISPLAY': ':0', 01:23:14 INFO - 'HOME': '/home/cltbld', 01:23:14 INFO - 'LANG': 'en_US.UTF-8', 01:23:14 INFO - 'LANGUAGE': 'en_US:en', 01:23:14 INFO - 'LOGNAME': 'cltbld', 01:23:14 INFO - 'MAIL': '/var/mail/cltbld', 01:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:14 INFO - 'MOZ_NO_REMOTE': '1', 01:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:14 INFO - 'NO_EM_RESTART': '1', 01:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:14 INFO - 'PWD': '/builds/slave/test', 01:23:14 INFO - 'SHELL': '/bin/bash', 01:23:14 INFO - 'SHLVL': '1', 01:23:14 INFO - 'TERM': 'linux', 01:23:14 INFO - 'TMOUT': '86400', 01:23:14 INFO - 'USER': 'cltbld', 01:23:14 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:14 INFO - '_': '/tools/buildbot/bin/python'} 01:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:14 INFO - Downloading/unpacking jsonschema==2.5.1 01:23:14 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 01:23:14 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 01:23:14 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 01:23:14 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 01:23:14 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 01:23:14 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 01:23:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:23:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:16 INFO - Downloading functools32-3.2.3-2.tar.gz 01:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:23:16 INFO - warning: no files found matching '*.txt' 01:23:16 INFO - no previously-included directories found matching 'build' 01:23:16 INFO - no previously-included directories found matching 'dist' 01:23:16 INFO - no previously-included directories found matching '.git*' 01:23:16 INFO - Installing collected packages: jsonschema, functools32 01:23:16 INFO - Running setup.py install for functools32 01:23:17 INFO - warning: no files found matching '*.txt' 01:23:17 INFO - no previously-included directories found matching 'build' 01:23:17 INFO - no previously-included directories found matching 'dist' 01:23:17 INFO - no previously-included directories found matching '.git*' 01:23:17 INFO - Successfully installed jsonschema functools32 01:23:17 INFO - Cleaning up... 01:23:17 INFO - Return code: 0 01:23:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:17 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 0x7f1c6caf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', '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 01:23:17 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 01:23:17 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 01:23:17 INFO - Using env: {'DISPLAY': ':0', 01:23:17 INFO - 'HOME': '/home/cltbld', 01:23:17 INFO - 'LANG': 'en_US.UTF-8', 01:23:17 INFO - 'LANGUAGE': 'en_US:en', 01:23:17 INFO - 'LOGNAME': 'cltbld', 01:23:17 INFO - 'MAIL': '/var/mail/cltbld', 01:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:17 INFO - 'MOZ_NO_REMOTE': '1', 01:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:17 INFO - 'NO_EM_RESTART': '1', 01:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:17 INFO - 'PWD': '/builds/slave/test', 01:23:17 INFO - 'SHELL': '/bin/bash', 01:23:17 INFO - 'SHLVL': '1', 01:23:17 INFO - 'TERM': 'linux', 01:23:17 INFO - 'TMOUT': '86400', 01:23:17 INFO - 'USER': 'cltbld', 01:23:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:17 INFO - '_': '/tools/buildbot/bin/python'} 01:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:17 INFO - Downloading/unpacking blobuploader==1.2.4 01:23:17 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 01:23:17 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 01:23:17 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 01:23:17 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 01:23:17 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 01:23:17 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 01:23:19 INFO - Downloading blobuploader-1.2.4.tar.gz 01:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:23:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:23:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:23:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:23:19 INFO - Downloading docopt-0.6.1.tar.gz 01:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:23:20 INFO - Installing collected packages: blobuploader, requests, docopt 01:23:20 INFO - Running setup.py install for blobuploader 01:23:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:23:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:23:20 INFO - Running setup.py install for requests 01:23:20 INFO - Running setup.py install for docopt 01:23:20 INFO - Successfully installed blobuploader requests docopt 01:23:20 INFO - Cleaning up... 01:23:20 INFO - Return code: 0 01:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:20 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 0x7f1c6caf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', '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 01:23:20 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 01:23:20 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 01:23:20 INFO - Using env: {'DISPLAY': ':0', 01:23:20 INFO - 'HOME': '/home/cltbld', 01:23:20 INFO - 'LANG': 'en_US.UTF-8', 01:23:20 INFO - 'LANGUAGE': 'en_US:en', 01:23:20 INFO - 'LOGNAME': 'cltbld', 01:23:20 INFO - 'MAIL': '/var/mail/cltbld', 01:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:20 INFO - 'MOZ_NO_REMOTE': '1', 01:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:20 INFO - 'NO_EM_RESTART': '1', 01:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:20 INFO - 'PWD': '/builds/slave/test', 01:23:20 INFO - 'SHELL': '/bin/bash', 01:23:20 INFO - 'SHLVL': '1', 01:23:20 INFO - 'TERM': 'linux', 01:23:20 INFO - 'TMOUT': '86400', 01:23:20 INFO - 'USER': 'cltbld', 01:23:20 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:20 INFO - '_': '/tools/buildbot/bin/python'} 01:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:23:20 INFO - Running setup.py (path:/tmp/pip-ZzPSeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:23:20 INFO - Running setup.py (path:/tmp/pip-jp7CnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:23:20 INFO - Running setup.py (path:/tmp/pip-vVgrrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:23:21 INFO - Running setup.py (path:/tmp/pip-fwOIOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:23:21 INFO - Running setup.py (path:/tmp/pip-4jVzzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:23:21 INFO - Running setup.py (path:/tmp/pip-zc0thw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:23:21 INFO - Running setup.py (path:/tmp/pip-5olj8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:23:21 INFO - Running setup.py (path:/tmp/pip-8GotSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:23:21 INFO - Running setup.py (path:/tmp/pip-Zx6eir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:23:21 INFO - Running setup.py (path:/tmp/pip-i1bbHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:23:21 INFO - Running setup.py (path:/tmp/pip-zT5Xsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:23:21 INFO - Running setup.py (path:/tmp/pip-oj4wu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:23:21 INFO - Running setup.py (path:/tmp/pip-ST1XuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:23:21 INFO - Running setup.py (path:/tmp/pip-zA6vSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:23:21 INFO - Running setup.py (path:/tmp/pip-eKmTYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:23:21 INFO - Running setup.py (path:/tmp/pip-H8aZfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:23:22 INFO - Running setup.py (path:/tmp/pip-rM_zOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:23:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:23:22 INFO - Running setup.py install for manifestparser 01:23:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:23:22 INFO - Running setup.py install for mozcrash 01:23:22 INFO - Running setup.py install for mozdebug 01:23:22 INFO - Running setup.py install for mozdevice 01:23:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:23:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:23:22 INFO - Running setup.py install for mozfile 01:23:22 INFO - Running setup.py install for mozhttpd 01:23:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:23:22 INFO - Running setup.py install for mozinfo 01:23:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:23:22 INFO - Running setup.py install for mozInstall 01:23:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:23:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:23:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:23:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:23:22 INFO - Running setup.py install for mozleak 01:23:22 INFO - Running setup.py install for mozlog 01:23:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:23:23 INFO - Running setup.py install for moznetwork 01:23:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:23:23 INFO - Running setup.py install for mozprocess 01:23:23 INFO - Running setup.py install for mozprofile 01:23:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:23:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:23:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:23:23 INFO - Running setup.py install for mozrunner 01:23:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:23:23 INFO - Running setup.py install for mozscreenshot 01:23:23 INFO - Running setup.py install for moztest 01:23:23 INFO - Running setup.py install for mozversion 01:23:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:23:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:23:23 INFO - Cleaning up... 01:23:23 INFO - Return code: 0 01:23:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:23 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 0x7f1c6caf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', '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 01:23:23 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 01:23:23 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 01:23:23 INFO - Using env: {'DISPLAY': ':0', 01:23:23 INFO - 'HOME': '/home/cltbld', 01:23:23 INFO - 'LANG': 'en_US.UTF-8', 01:23:23 INFO - 'LANGUAGE': 'en_US:en', 01:23:23 INFO - 'LOGNAME': 'cltbld', 01:23:23 INFO - 'MAIL': '/var/mail/cltbld', 01:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:23 INFO - 'MOZ_NO_REMOTE': '1', 01:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:23 INFO - 'NO_EM_RESTART': '1', 01:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:23 INFO - 'PWD': '/builds/slave/test', 01:23:23 INFO - 'SHELL': '/bin/bash', 01:23:23 INFO - 'SHLVL': '1', 01:23:23 INFO - 'TERM': 'linux', 01:23:23 INFO - 'TMOUT': '86400', 01:23:23 INFO - 'USER': 'cltbld', 01:23:23 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:23 INFO - '_': '/tools/buildbot/bin/python'} 01:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:23:24 INFO - Running setup.py (path:/tmp/pip-TXuypp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:23:24 INFO - Running setup.py (path:/tmp/pip-8e5ZvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:23:24 INFO - Running setup.py (path:/tmp/pip-th9TTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:23:24 INFO - Running setup.py (path:/tmp/pip-bPwq9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:23:24 INFO - Running setup.py (path:/tmp/pip-B9lyWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:23:24 INFO - Running setup.py (path:/tmp/pip-WFgEoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:23:24 INFO - Running setup.py (path:/tmp/pip-RET7i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:23:24 INFO - Running setup.py (path:/tmp/pip-ggERBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:23:24 INFO - Running setup.py (path:/tmp/pip-tQWt6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:23:24 INFO - Running setup.py (path:/tmp/pip-YiXK4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:23:24 INFO - Running setup.py (path:/tmp/pip-TaABb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:23:24 INFO - Running setup.py (path:/tmp/pip-HqNibD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:23:24 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)) 01:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:23:24 INFO - Running setup.py (path:/tmp/pip-yUC_LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:23:25 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)) 01:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:23:25 INFO - Running setup.py (path:/tmp/pip-q06FM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:23:25 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)) 01:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:23:25 INFO - Running setup.py (path:/tmp/pip-ylYo4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:23:25 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)) 01:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:23:25 INFO - Running setup.py (path:/tmp/pip-1yMQnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:23:25 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)) 01:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:23:25 INFO - Running setup.py (path:/tmp/pip-md58pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:23:25 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)) 01:23:25 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)) 01:23:25 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)) 01:23:25 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)) 01:23:25 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)) 01:23:25 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)) 01:23:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:23:25 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 01:23:25 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 01:23:25 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 01:23:25 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 01:23:25 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 01:23:25 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 01:23:27 INFO - Downloading blessings-1.6.tar.gz 01:23:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:23:27 INFO - Installing collected packages: blessings 01:23:27 INFO - Running setup.py install for blessings 01:23:27 INFO - Successfully installed blessings 01:23:27 INFO - Cleaning up... 01:23:27 INFO - Return code: 0 01:23:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:23:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:23:27 INFO - Reading from file tmpfile_stdout 01:23:27 INFO - Current package versions: 01:23:27 INFO - argparse == 1.2.1 01:23:27 INFO - blessings == 1.6 01:23:27 INFO - blobuploader == 1.2.4 01:23:27 INFO - docopt == 0.6.1 01:23:27 INFO - functools32 == 3.2.3-2 01:23:27 INFO - jsonschema == 2.5.1 01:23:27 INFO - manifestparser == 1.1 01:23:27 INFO - mozInstall == 1.12 01:23:27 INFO - mozcrash == 0.17 01:23:27 INFO - mozdebug == 0.1 01:23:27 INFO - mozdevice == 0.48 01:23:27 INFO - mozfile == 1.2 01:23:27 INFO - mozhttpd == 0.7 01:23:27 INFO - mozinfo == 0.9 01:23:27 INFO - mozleak == 0.1 01:23:27 INFO - mozlog == 3.2 01:23:27 INFO - moznetwork == 0.27 01:23:27 INFO - mozprocess == 0.22 01:23:27 INFO - mozprofile == 0.28 01:23:27 INFO - mozrunner == 6.11 01:23:27 INFO - mozscreenshot == 0.1 01:23:27 INFO - mozsystemmonitor == 0.3 01:23:27 INFO - moztest == 0.7 01:23:27 INFO - mozversion == 1.4 01:23:27 INFO - psutil == 3.1.1 01:23:27 INFO - requests == 1.2.3 01:23:27 INFO - wsgiref == 0.1.2 01:23:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:27 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 0x7f1c6caf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', '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 01:23:27 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 01:23:27 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 01:23:27 INFO - Using env: {'DISPLAY': ':0', 01:23:27 INFO - 'HOME': '/home/cltbld', 01:23:27 INFO - 'LANG': 'en_US.UTF-8', 01:23:27 INFO - 'LANGUAGE': 'en_US:en', 01:23:27 INFO - 'LOGNAME': 'cltbld', 01:23:27 INFO - 'MAIL': '/var/mail/cltbld', 01:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:27 INFO - 'MOZ_NO_REMOTE': '1', 01:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:27 INFO - 'NO_EM_RESTART': '1', 01:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:27 INFO - 'PWD': '/builds/slave/test', 01:23:27 INFO - 'SHELL': '/bin/bash', 01:23:27 INFO - 'SHLVL': '1', 01:23:27 INFO - 'TERM': 'linux', 01:23:27 INFO - 'TMOUT': '86400', 01:23:27 INFO - 'USER': 'cltbld', 01:23:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:27 INFO - '_': '/tools/buildbot/bin/python'} 01:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:27 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)) 01:23:27 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)) 01:23:27 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)) 01:23:27 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)) 01:23:27 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)) 01:23:27 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)) 01:23:27 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)) 01:23:27 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)) 01:23:27 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)) 01:23:27 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)) 01:23:27 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)) 01:23:27 INFO - Cleaning up... 01:23:27 INFO - Return code: 0 01:23:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:27 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 0x7f1c6caf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', '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 01:23:27 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 01:23:27 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 01:23:27 INFO - Using env: {'DISPLAY': ':0', 01:23:27 INFO - 'HOME': '/home/cltbld', 01:23:27 INFO - 'LANG': 'en_US.UTF-8', 01:23:27 INFO - 'LANGUAGE': 'en_US:en', 01:23:27 INFO - 'LOGNAME': 'cltbld', 01:23:27 INFO - 'MAIL': '/var/mail/cltbld', 01:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:27 INFO - 'MOZ_NO_REMOTE': '1', 01:23:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:27 INFO - 'NO_EM_RESTART': '1', 01:23:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:27 INFO - 'PWD': '/builds/slave/test', 01:23:27 INFO - 'SHELL': '/bin/bash', 01:23:27 INFO - 'SHLVL': '1', 01:23:27 INFO - 'TERM': 'linux', 01:23:27 INFO - 'TMOUT': '86400', 01:23:27 INFO - 'USER': 'cltbld', 01:23:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:27 INFO - '_': '/tools/buildbot/bin/python'} 01:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:23:28 INFO - Cleaning up... 01:23:28 INFO - Return code: 0 01:23:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:23:28 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 0x7f1c6caf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', '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 01:23:28 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 01:23:28 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 01:23:28 INFO - Using env: {'DISPLAY': ':0', 01:23:28 INFO - 'HOME': '/home/cltbld', 01:23:28 INFO - 'LANG': 'en_US.UTF-8', 01:23:28 INFO - 'LANGUAGE': 'en_US:en', 01:23:28 INFO - 'LOGNAME': 'cltbld', 01:23:28 INFO - 'MAIL': '/var/mail/cltbld', 01:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:28 INFO - 'MOZ_NO_REMOTE': '1', 01:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:28 INFO - 'NO_EM_RESTART': '1', 01:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:28 INFO - 'PWD': '/builds/slave/test', 01:23:28 INFO - 'SHELL': '/bin/bash', 01:23:28 INFO - 'SHLVL': '1', 01:23:28 INFO - 'TERM': 'linux', 01:23:28 INFO - 'TMOUT': '86400', 01:23:28 INFO - 'USER': 'cltbld', 01:23:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:28 INFO - '_': '/tools/buildbot/bin/python'} 01:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:23:28 INFO - Downloading/unpacking flake8 01:23:28 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 01:23:28 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 01:23:28 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 01:23:28 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 01:23:28 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 01:23:28 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 01:23:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:23:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:23:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 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 01:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:23:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:23:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:23:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:23:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:23:30 INFO - no previously-included directories found matching 'docs/_build' 01:23:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:23:30 INFO - Running setup.py install for pep8 01:23:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:23:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:23:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:23:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:23:31 INFO - no previously-included directories found matching 'docs/_build' 01:23:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:23:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:23:31 INFO - Cleaning up... 01:23:31 INFO - Return code: 0 01:23:31 INFO - Running post-action listener: _resource_record_post_action 01:23:31 INFO - Running post-action listener: _start_resource_monitoring 01:23:31 INFO - Starting resource monitoring. 01:23:31 INFO - ##### 01:23:31 INFO - ##### Finished create-virtualenv step (success) 01:23:31 INFO - ##### 01:23:31 INFO - ##### 01:23:31 INFO - ##### Running install step. 01:23:31 INFO - ##### 01:23:31 INFO - Running pre-action listener: _resource_record_pre_action 01:23:31 INFO - Running main action method: install 01:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:23:31 INFO - Reading from file tmpfile_stdout 01:23:31 INFO - Detecting whether we're running mozinstall >=1.0... 01:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:23:31 INFO - Reading from file tmpfile_stdout 01:23:31 INFO - Output received: 01:23:31 INFO - Usage: mozinstall [options] installer 01:23:31 INFO - Options: 01:23:31 INFO - -h, --help show this help message and exit 01:23:31 INFO - -d DEST, --destination=DEST 01:23:31 INFO - Directory to install application into. [default: 01:23:31 INFO - "/builds/slave/test"] 01:23:31 INFO - --app=APP Application being installed. [default: firefox] 01:23:31 INFO - mkdir: /builds/slave/test/build/application 01:23:31 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'] 01:23:31 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 01:23:47 INFO - Reading from file tmpfile_stdout 01:23:47 INFO - Output received: 01:23:47 INFO - /builds/slave/test/build/application/firefox/firefox 01:23:47 INFO - Running post-action listener: _resource_record_post_action 01:23:47 INFO - ##### 01:23:47 INFO - ##### Finished install step (success) 01:23:47 INFO - ##### 01:23:47 INFO - ##### 01:23:47 INFO - ##### Running run-tests step. 01:23:47 INFO - ##### 01:23:47 INFO - Running pre-action listener: _resource_record_pre_action 01:23:47 INFO - Running main action method: run_tests 01:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:23:47 INFO - Python 2.7.3 01:23:47 INFO - Return code: 0 01:23:47 INFO - grabbing minidump binary from tooltool 01:23: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')]} 01:23:47 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 0x2bfe2e0>, '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 0x2b6a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:23:47 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 01:23:47 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 01:23:47 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 01:23:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:23:47 INFO - Return code: 0 01:23:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:23:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:23:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:23:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:23:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:23:48 INFO - Return code: 0 01:23:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 01:23:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 01:23:48 INFO - Using env: {'DISPLAY': ':0', 01:23:48 INFO - 'HOME': '/home/cltbld', 01:23:48 INFO - 'LANG': 'en_US.UTF-8', 01:23:48 INFO - 'LANGUAGE': 'en_US:en', 01:23:48 INFO - 'LOGNAME': 'cltbld', 01:23:48 INFO - 'MAIL': '/var/mail/cltbld', 01:23:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:23:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:23:48 INFO - 'MOZ_NO_REMOTE': '1', 01:23:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:23:48 INFO - 'NO_EM_RESTART': '1', 01:23:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:23:48 INFO - 'PWD': '/builds/slave/test', 01:23:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:23:48 INFO - 'SHELL': '/bin/bash', 01:23:48 INFO - 'SHLVL': '1', 01:23:48 INFO - 'TERM': 'linux', 01:23:48 INFO - 'TMOUT': '86400', 01:23:48 INFO - 'USER': 'cltbld', 01:23:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293', 01:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:23:48 INFO - '_': '/tools/buildbot/bin/python'} 01:23:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 01:23:48 INFO - mozversion application_buildid: 20160622002201 01:23:48 INFO - mozversion application_changeset: a1746be133dff55de7588c846aaafbc30534b8bd 01:23:48 INFO - mozversion application_display_name: Nightly 01:23:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:23:48 INFO - mozversion application_name: Firefox 01:23:48 INFO - mozversion application_remotingname: firefox 01:23:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:23:48 INFO - mozversion application_vendor: Mozilla 01:23:48 INFO - mozversion application_version: 50.0a1 01:23:48 INFO - mozversion platform_buildid: 20160622002201 01:23:48 INFO - mozversion platform_changeset: a1746be133dff55de7588c846aaafbc30534b8bd 01:23:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:23:48 INFO - mozversion platform_version: 50.0a1 01:23:48 INFO - using testdate: 1466583828 01:23:48 INFO - actual date: 1466583828 01:23:48 INFO - starting webserver on 'localhost:33859' 01:23:48 INFO - SUITE-START | Running 2 tests 01:23:48 INFO - TEST-START | dromaeo_css 01:23:48 INFO - operating with platform_type : linux_ 01:23:48 INFO - Initialising browser for dromaeo_css test... 01:23:48 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCpFW_u/profile http://localhost:33859/getInfo.html) 01:23:54 INFO - PROCESS | 1931 | __metrics Screen width/height:1600/1200 01:23:54 INFO - PROCESS | 1931 | colorDepth:24 01:23:54 INFO - PROCESS | 1931 | Browser inner width/height: 1024/697 01:23:54 INFO - PROCESS | 1931 | __metrics 01:23:55 ERROR - PROCESS | 1931 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 01:23:56 INFO - TEST-INFO | 1931: exit 0 01:23:56 INFO - Browser initialized. 01:23:56 INFO - Running cycle 1/1 for dromaeo_css test... 01:23:56 INFO - TEST-INFO | started process 2050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCpFW_u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:24:08 INFO - PROCESS | 2050 | RSS: Main: 186023936 01:24:08 INFO - PROCESS | 2050 | 01:24:57 INFO - PROCESS | 2050 | 1466583897842 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] 01:27:10 INFO - PROCESS | 2050 | Cycle 1(1): loaded http://localhost:33859/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33859/tests/dromaeo/cssquery-ext.html) 01:27:11 INFO - PROCESS | 2050 | RSS: Main: 188899328 01:27:11 INFO - PROCESS | 2050 | 01:30:13 INFO - PROCESS | 2050 | Cycle 1(1): loaded http://localhost:33859/tests/dromaeo/cssquery-ext.html (next: http://localhost:33859/tests/dromaeo/cssquery-jquery.html) 01:30:14 INFO - PROCESS | 2050 | RSS: Main: 187617280 01:30:14 INFO - PROCESS | 2050 | 01:33:16 INFO - PROCESS | 2050 | Cycle 1(1): loaded http://localhost:33859/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33859/tests/dromaeo/cssquery-mootools.html) 01:33:16 INFO - PROCESS | 2050 | RSS: Main: 189091840 01:33:16 INFO - PROCESS | 2050 | 01:36:18 INFO - PROCESS | 2050 | Cycle 1(1): loaded http://localhost:33859/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33859/tests/dromaeo/cssquery-prototype.html) 01:36:19 INFO - PROCESS | 2050 | RSS: Main: 186683392 01:36:19 INFO - PROCESS | 2050 | 01:39:21 INFO - PROCESS | 2050 | Cycle 1(1): loaded http://localhost:33859/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33859/tests/dromaeo/cssquery-yui.html) 01:39:22 INFO - PROCESS | 2050 | RSS: Main: 189153280 01:39:22 INFO - PROCESS | 2050 | 01:42:25 INFO - PROCESS | 2050 | Cycle 1(1): loaded http://localhost:33859/tests/dromaeo/cssquery-yui.html (next: http://localhost:33859/tests/dromaeo/cssquery-dojo.html) 01:42:25 INFO - PROCESS | 2050 | RSS: Main: 189661184 01:42:25 INFO - PROCESS | 2050 | 01:42:25 INFO - PROCESS | 2050 | __start_tp_report 01:42:25 INFO - PROCESS | 2050 | _x_x_mozilla_page_load 01:42:25 INFO - PROCESS | 2050 | _x_x_mozilla_page_load_details 01:42:25 INFO - PROCESS | 2050 | |i|pagename|runs| 01:42:25 INFO - PROCESS | 2050 | |0;dojo.html;2616.3851494898695;2698.204029811206;2700.0549807567354;2708.593710943357;2714.5656694928816;4803.5676789088975;4824.5899098576665;4835.008823191246;4891.633127515442;4972.726500042505;4818.819389249638;4871.050145221674;4894.730789806559;4901.240307752304;4929.65492415531;4450.821967121319;4489.842855500058;4606.193916064692;4607.262837945929;4635.443746750378;555.3560846885188;4410.911781764363;4427.11457708458;4445.555444455561;4505.36924830524;4471.575200355961;4506.369108324837;4511.70673906195;4518.661100417482;4562.543745625444;4512.503624601324;4516.390287311204;4525.049739554697;4527.796249168795;4583.702059366164;4338.501072376685;4371.825126994916;4418.116376724636;4479.238529449969;4494.056248187884;4834.830780922686;4878.512148785093;4935.3090567320605;4947.529984651453;5003.874903127451;5182.974085129588;5307.575393968474;5322.787088516455;5333.35999680037;5383.784648614051;5235.136202526579;5315.415304316522;5317.016351974897;5318.414974352818;5374.6506477078865;4902;4923.90152196954;4935.629827762932;4943;4956.975215123974;5176.068307704574;5357.785688572491;5364.9731751341;5371;5407.729613519308;5155.7679904404395;5175.120229560984;5178.326817513699;5192.714400707921;5247.658902171423;5298.15229563268;5307.761150748225;5309.309789727388;5314.867128321745;5356.678599284055;5027.798888044437;5108.361454818148;5119.411267704261;5145.871353216199;5212.087884620177;5118.667286626432;5156.432792392834;5176.689398636094;5182.196759502283;5185.637005409661;4415.028693687384;4415.845445409395;4438.400815889813;4472.642188624902;4477.283634618446;3792.75347102443;3850.1914597934187;3863.4011728182177;3876.2247550490015;3907.355286377716;4485.192665320274;4495.842645507457;4515.616172625298;4546.954530454719;4607.792649330788;5334.226537152092;5336.332958380202;5341.7062061586985;5347.0909945309395;5349.679019258857;4385.057212699285;4507.81968721254;4546.681732278708;4562.520935301812;4576.519465456146;4720.881977950578;4725.5983241424865;4755.738434386142;4790.640701947368;4823.445303790109;4799.352087468147;4950.257461380822;4961.404631444249;4963.032208719265;5022.924656130088;5223.947760522498;5278.709670968134;5296.947030529645;5300.893982120413;5311.628186027096;4924.532169443897;4943.233798761198;4944.851654450372;4945.035718034948;5001.599872010303;5003.8749031273055;5139.383274006994;5204.895902082013;5207.661502002357;5209.6874187548865;5213.452587478412;5229.320188375486;5272.261883336259;5278.4721527846905;5310.814121505883;5098.796048158032;5099.107656160083;5117.130087884994;5147.433782283871;5147.794088236578;4926.5073492650445;5051.898962020812;5061.7469126544265;5063.797448102035;5129;5028.321176641253;5049.141645920129;5066.9239961401345;5075.7969681212335;5108.489151084862;5187.844364669066;5193.922091168711;5200.193969934666;5200.4279529251;5223.16429371314;4928.2853986171085;5018.698878067327;5028.64799464034;5062.569681577107;5064.7467626619255 01:42:25 INFO - PROCESS | 2050 | |1;ext.html;521.0035057354539;567.7189791053428;588.6468119128521;589.4311988930682;622.9501639868811;37150.07124821881;38741;41616.791916040376;41619.16761664769;41776.58223417765;42045.57954420455;42579.36130958038;42587.36118958218;42783;42826;7660.923390766105;7826.7651970440975;7842.098158711736;7853.253940875607;7855.607219639024;7801.453898227126;7877.645505952217;7882.684692612289;7917.683292668286;7920.207979202091;7930.920690793105;7943.960280198591;7976.840463190732;7977.840443191133;8000.799980000488;7897.723579674713;7956.403269754734;7973.840523189504;7974.681012759483;7979.122296547375;7855.057393112806;7877.645505952189;7912.960435197787;7917.881231781528;7920.247576480225;30858;39611.20777584461;40106.197876042315;40137;40325;2935.4716151092794;3100.0699790063118;3247.431699452586;3520.8415621297104;3640.453931910208;28482.857585712147;28969.420611587862;29541.852290738625;29652.258693532618;30389.392212155853;3220.5974253218346;3297.670232976683;3432.3306955143757;3497.387957107496;3508.5438892944007;268961;269704;271398;271406;271554.999999998;32592.837035814668;33672.66327336744;33743.493847592305;57873.42126578765;58988;34700;34711;34840;34852.65147348545;34878.302433951176;14131.64670883236;14270.643233919234;14288.42846286137;14290.785638215435;14373.6406589834;11465.598704045486;11491.77016459666;11519.596814111466;11581.247218930743;11581.363025033705;8005.759827205193;8045.718399855977;8053.838923221503;8078.798030049178;8134.06458257308;3158.7473002159772;3165.3511030238747;3185.5062465317915;3230.5800245968344;3232.143481977278;889.4307643108416;892.9285657147412;902.4224496322358;936.6908920056366;958.6596758150896;28630.85684571564;28839.279018024718;28983.710162898522;29118.544072796274;29723.702762972527;1000.4542981094081;1011.1708399112804;1030.2736570717625;1076.5347354557975;1076.8438576406534;15107.773383399257;15521.301541430663;15584.766228506582;15691.450799221973;15783.605409864846;373022;378660;378976;379533;381032;51292.74353628208;52005.2199217012;52267.21599176015;52278.47721522736;52344;1170.6897672116895;1197.1560050164612;1219.030870457988;1229.0474881966547;1237.004211609645;29048.854755726086;29506.55740163942;29613.703862961094;29672.55491167591;30046.699533005263;43585.56414435942;43624;43818.342724858514;44214.33678494889;44477.33284000678;304323;309939;310332;310807;311998;26400;26625.20124396271;26625.866870666297;26823.195304140907;26836.731632683423;44167;44500;45384;45483.54516454793;45605.31592026056;37454.81272593619;37637.623623764506;37930.620693792705;38117.23765524619;39406;38252.80873595614;38906;38954.2209155821;38978.415323770736;39397.80301098476;36949.261014780095;37252.813735931144;37445.063873403386;37751;38156.427653584666;32896.83551582227;33461;34491.4826277601;34596;34633.65366346304;26347.73652263453;26700.829745713538;26744.063957761384;26797.464050719267;26855.86572067127 01:42:25 INFO - PROCESS | 2050 | |2;jquery.html;371.66178777312643;374.6384738727128;375.6056141051895;384.4790309131125;398.5257543523207;15996;16400.753988690165;17133.571660708487;17296.740548891776;17348.132593370345;15632.452864149756;16564.00615963043;16569.585760355996;16604;17298.221580028898;4596.839110631128;4784.449788274341;4822.590079843218;4824.6381521385865;4827.2759086137185;3438.673326034023;4556.681032327739;5147.459516750743;5429.782808687648;5431.185322201662;5416.729163541827;5423.972880135613;5439.972800135994;5445.646033007842;5484.670919744808;5299.125644268691;5334.657891469018;5430.5927055471;5442.8911421771545;5462.644928079662;5233.947660523384;5285.577153827723;5293.735313234323;5294.100002999499;5313.973430132824;11882.643520694393;11956.2228455151;11979.760404791943;12071.818922716166;12245.204061735958;1993.1529100132386;2257.492064285539;2370.885683728662;2409.5301416223842;2440.9023639054417;8827.205551500332;9177.541122943892;9443.622255109787;9652.131308182297;9751.804963900753;1721.5482956671792;1726.214572369569;1741.1555395633109;1764.162023039059;1826.7990521042675;64948;68203.65898170527;69697;69731.65134174348;70305;9232.769180770534;9304.395214311047;9449.43303401798;9667.0848306436;10003.549840257207;12707.872921270853;13076.215427074407;13078;13096.541621043218;13199.274039927705;7345.265473452612;7394.7781566553085;7430.331270185709;7465.178830328659;7545.811354716176;7085.078939737904;7101.644917754195;7169.856602867913;7210.584454207794;7279.59962202084;4224.831006759757;4230.132822771325;4328.394024836525;4344.370066340363;4361.1495758327455;1560.9921950390176;1655.2964989879254;1678.2867281405354;1798.1818272685896;1869.5045812859603;829.9128591497927;838.4131108224267;863.628639684929;869.8651708985118;879.7052987249215;16581.91709041447;17109.14454277306;17331.220095095752;17332.39336623212;17531.386401475887;836.7698882807276;872.7250915961451;872.8690696395464;874.6239117179674;909.4861403307243;9410.341276110606;9810.460424676568;10005.149562287286;10063.69808905734;10584.253598156218;409656;417974;418080;420375;424476;78817.60591197008;81063.59468202622;81892.18107818965;83854.58072709598;84155;924.0713083351324;924.2836801478774;929.9767505812409;961.3943215774018;966.5891995901713;15908;16051.438199662956;16159.43441979525;16189.838101618832;16373.590660233589;37430.438543421325;37768.62231377651;38467.6153238464;38474.422883657324;39355;47409.52590474051;53789.46210538001;53832.19251711149;53847.73076134594;53850.461495384545;6609.4712423007;6939.375456208965;7253.492255542062;7352.852942941005;7873.645685944031;8457.87313190315;11203.775924481628;11209.15931305139;11816.231944923553;11989.22070065443;10318.226133039901;10502.68491945243;10690.679279621623;10786.73033174177;10846.24076314682;10309.278350515391;10829.566817327219;10904.836427453436;11181.776364472827;11227.793209568403;10512.211584131373;10740.194485413469;10761.838572421577;10937.781244375226;11238.719032024264;7884.093329267208;7907.209279072047;7935.40484463656;8060.596970151586;8102.270795628422;9992.700218993441;10295.279330446796;10457.058864702214;10866.511007004861;11012.889871101186 01:42:25 INFO - PROCESS | 2050 | |3;mootools.html;1381.1574939287036;1412.28679516844;1510.1995942150663;1656.8011838579357;1693.305744644695;6838.726450941969;7518.173000969889;7569.280918312751;8034.718784842532;8056.476329038608;7331.340179383855;7560.735374261902;7581.924180758191;7589.468737188399;7590.278923502272;2202.933911982639;2235.9888200558976;2247.9438014049697;2249.2352600115955;2262.061244583496;2167.967480487794;2182.138055468089;2221.8777967211795;2223.0885337011828;2225.7662945390744;2205.44863784054;2218.667199920009;2223.321886824518;2224.4550085229143;2226.7773222677765;2148.3340164548886;2163.8268938484885;2166.815820655246;2170.815480684144;2186.3440967709703;2144.0673307111456;2164.0261882153095;2168.761436242012;2174.325958952714;2174.521605246859;7972.880406793903;8079.919200807975;8121.634526446265;8139.633716482714;8144.470609410429;4626.074785042972;4808.855734327975;4815.036992601459;4816.325714399987;4821.541953514446;2879.078694817659;2993.0721476342405;3034.37795251975;3034.51447768356;3040.3159289159985;891.242443922667;932.8227636749064;945.791925776335;952.7284723853669;959.8464245720721;10866.945665271702;10879.619213327574;10887.673369798918;10948.726281842937;10976.067034302094;4169.937450938239;4235.8729238122905;4271.594198551133;4307.289297265916;4333.263345231318;9396.248300135972;9410.341276110743;9423;9445.197158241626;9455.858162127573;4697.718136911796;4702.741349225757;4768.713877167381;4771.880702982384;4779.139754844162;3777.7544459610035;4130.194612050621;4159.521655009713;4268.423762791983;4272.33778764292;3662.304162209172;3698.2973235085246;3764.416515440111;3808.124131449782;3812.1803812180515;1190.2560899437851;1210.2859313005192;1219.85361756588;1222.8715984821642;1254.6988722706485;730.2733779889045;849.0278630967507;857.2199298638209;868.2923417414787;882.1751662195867;5420.295361603045;5440.782368705287;5521.69630670317;5527.50252477279;5533.3083364579425;359.31371081234715;364.34781740684406;364.87594217966017;365.81891963477716;370.87390287301906;3801.5628202756484;3811.6950643948417;3846.5961074087377;3863.459115723801;3867.8613089771575;9430.10414010668;9601.039896010483;9808.117269445642;9885;9898;9691.563879625433;9704.9029509704;9738.805223895624;9767.267454940766;9799.069088436587;6910.617876424735;7264.673089710976;7441.255874412515;7494.887576686354;7511.173770885308;5574.832755017356;5700.401457846866;5789.363170051207;5860.267466566679;5907.763689452374;8890.288776897962;8982.550872456482;9128.680496182602;9131.086891310815;9235.861462078208;9180.632774688938;9274.860877086983;9312.906870931203;9331.813363732552;9337.299702522203;6154.353792851686;6700.162479690039;6937.445004399535;6953.6523173842115;7076.716931322895;7793.454458188099;7795.532268063935;7841.294283514511;7842.098158711821;7905.802354941173;6813.8977915330315;6953.687084081127;7017.473689473208;7101.680424381018;7104.11198600175;6854.177498699988;6921;6925.792226233221;6928.064711264116;6963.442924566124;5891.086881533369;6179.104029915727;6185.505159587312;6362.554621176659;6403.199600049994;4644.698094623838;4751.833685821118;4768.976155119341;4771.403574553181;4827.08285425768;4632.3977882875015;4648.976755116203;4686.27362758773;4713.646476514344;4715.929261061156 01:42:25 INFO - PROCESS | 2050 | |4;prototype.html;294.8304724783249;301.5386458718161;304.2894840547321;310.83525731362374;311.70543836074916;5082.288479612853;5121.999999999991;5126.179811230199;5127.410347810003;5148.330717006788;4991.900161996767;4998.050370429616;5021.924671129936;5023.874403139924;5039.44566097729;3962.286788378091;3973.9999999999927;3983.58172391899;3997.1805779815213;4022.798860057;3658.1586235165796;3902.6292502212386;3935.704822138351;3989.1423343981037;4001.8194632583313;3878.631530004645;3882.592327805582;3882.7087968402343;3896.6687831534214;3908.1011367385518;3888.9222215555674;3910.7458015229204;3919.4512768212617;3925;3944.980275098635;3247.382997230542;3261.5596894419423;3333.7833040852265;3429.605595356541;3432.502287168347;4987.301777751118;5009.624278179114;5016.068813506826;5028.396592408898;5040.269160971675;4476.4180656514445;4481.977590112061;4484.349769283435;4513.7743112844555;4521.751303678297;4999.200127979542;5193.792248310063;5230.293910322096;5245.79016839326;5324.307839980816;3747.2692824899154;3752.3808571585655;3755.962440375589;3762.1535154590274;3768.321702093622;5533.861653458655;5550.58370622205;5551.500364967173;5558.722063896789;5565.749541270652;3611.530501034901;3811.961880381161;3816.3130636485143;3827.3876179811655;3839.214765134226;3869.438931354994;3875.147467557133;3881.010342362736;3907.277153726513;3914.5889681583026;4459.353393757887;4462.620677242406;4481.901934026119;4489.685721999494;4498.840556532882;5238.842834714965;5271.920921186185;5320;5332.653377530448;5342.759575819097;1335.9666008349868;1336.9598912032461;1343.6439343573766;1343.9059265851492;1348.8381394232754;837.6095681169352;838.9874151887726;855.4738835616051;857.5026484638895;863.1713554987283;4129.587041295907;4139.77231252284;4203.285441474956;4216.241076606179;4222.543222588202;4856.660033797601;4864.221724524059;4906.712502623251;4923.90152196954;4924.778384972685;4192.895177620523;4207.516135644379;4212.49450065994;4225.345071513859;4232.25935461293;2451.6199989001734;2579.4841031793717;2777.180946480059;2818.8872445102375;2929.370185410147;5109.821156259513;5113.488651134857;5118;5129.204973229155;5138.177891537336;5509.531689806411;5553.251140685386;5585.357683866408;5596.488947984021;5597.944020559742;4914.287428322945;5098.056859481007;5107.565856902131;5109.335786347751;5111.5655169310285;5390.434004429479;5402.135658294654;5450;5450.509454149145;5496.258005169251;5074.3657042869645;5274.551663108678;5308.230306605444;5318.175682769177;5354.223637572608;5075.390953085654;5083.491650834887;5085.694858308513;5115.693058416358;5118.745907252747;3829.46387505755;3891.2023035278266;3906.277338692351;3911.941320880132;3921.509811273591;5194.68831870089;5556.138798486241;5557.944420555905;5578.907909533925;5602.299712535933;5241.528262456397;5251.606129540376;5269.78920843162;5279.762410691451;5303.840884773463;5216.122196009509;5303.893922121459;5308.885134121878;5313.149896016619;5313.654612450178;4997.250412438163;5167.199084141964;5172.19830926207;5176.689398636094;5216.417873152814;5292.894142117059;5326.493983071602;5344;5350.475114592323;5351.973240133774;5172.844814655567;5178.585713143015;5191.870203244949;5232.5552328052545;5252.264682944315 01:42:25 INFO - PROCESS | 2050 | |5;yui.html;640.1517988665023;686.52629685517;716.9962053125623;720.9891851622224;760.7223363472333;11310.3779292139;12211.145219834627;12257.509699612016;12576.496940122406;13224.93387533061;14763.409463621443;14778.482753103644;14901.403943842233;14928.850711492882;15027.924860375682;625.3215261441342;775.503677646304;797.2824457987799;801.4470015689155;801.7394346837301;796.5220867479524;799.856025915335;801.5551368990208;801.8957535520403;801.9599020049003;837.9371547133959;841.4068082002204;841.4404421059987;843.0220943705303;844.0588743550927;827.9420440569163;833.2126140796888;834.5368320582074;835.0980940584154;837.2213841127749;606.6087373644019;608.248812716295;613.5337143770722;613.5643692977991;613.8250598579383;12439.875601243963;12613.621591352274;12642.367881605884;12674.556390526379;12696.746065078647;13007.934960325232;13416.262105584188;13510.32448377587;13511.189328640314;13525.256110913895;10860.511276992554;10866.67399978002;11068.833967490495;11099.500522476508;11296;3315.7678962472637;3345.364380767671;3369.898903032913;3403.9489407658907;3479.5476588043393;69220.6538967307;69955;72065.27934720638;72392;72398.27601723968;10505.31715438494;10725.51735171919;10732.517036733365;10805.081568066802;10947.781044379068;20120.094595743227;20132;20154.496137596383;20158.39524814258;20232.79767202309;6772.864542709118;6887.690053947585;6902.137232845895;6935.202451718117;7123.608201548861;3654.397024490929;3747.194353214072;3748.5876553579083;3792.8940478442423;3901.219756048745;3079.59965204522;3187.6015498062743;3198.4722520784276;3205.775595708278;3226.9838650807064;517.4566704959777;526.9130593452114;531.388902761827;533.6317940620959;539.8812261302508;586.3257254157668;587.8536853136316;609.2384519350811;623.1525125828869;634.4099987012123;8334.874791903016;8649.394542382099;8785.648574057093;8883.779055236191;8920.598573064228;523.2622002975786;542.5659472422126;574.4973148495067;583.7168973048068;586.14130299112;4182.456280683492;4268.317069268902;4293.0769884474985;4297.8495752648505;4344.413504176896;59972.700136499036;60729.08906366408;103961.48019259855;109984.4500777491;111758.44120779507;63737.681311594075;89590.55204724065;90127;91321;92581.5370923141;75929.62035189789;79086.60456697564;80603.59698201471;82041.17958820454;84373;8062.7581172564915;8112.472689275178;8202.753917382488;8215.096339402542;8312.04411492686;46001;46206.30690539577;47665.5233447675;48156;48164;63439.92480601633;69583;70709.29290707027;71402;71746.64126679333;10088.89911100909;10121;10168.186545076524;10323.63867264642;10732.83900741474;11200.271982321448;11256.83114753263;11766.352850593299;12082.39588020613;12410.94506966918;10927.508262128064;11091.611793587186;11238;11507.482163302839;11594.478248479007;10555.736106597396;10619.30974486656;10622.256442048982;10670.62652807148;10698.679039628823;10889.782204356026;10942.835857462303;12267.509299627915;12268.693282668004;12298.385080745747;10273.640422585173;10312.587496500357;10846.511906964048;11038.392888391216;11074.944625276821;10654.627088052192;10730.624428144978;11039.613613523488;11148.331100134017;11203.159763017644 01:42:25 INFO - PROCESS | 2050 | __end_tp_report 01:42:25 INFO - PROCESS | 2050 | __start_cc_report 01:42:25 INFO - PROCESS | 2050 | _x_x_mozilla_cycle_collect,413 01:42:25 INFO - PROCESS | 2050 | __end_cc_report 01:42:25 INFO - PROCESS | 2050 | __startTimestamp1466584945299__endTimestamp 01:42:25 INFO - PROCESS | 2050 | 01:42:25 INFO - PROCESS | 2050 | ------- Summary: start ------- 01:42:25 INFO - PROCESS | 2050 | Number of tests: 6 01:42:25 INFO - PROCESS | 2050 | 01:42:25 INFO - PROCESS | 2050 | [#0] dojo.html Cycles:165 Average:4825.06 Median:4972.73 stddev:619.75 (12.5%) stddev-sans-first:596.94 01:42:25 INFO - PROCESS | 2050 | Values: 2616.4 2698.2 2700.1 2708.6 2714.6 4803.6 4824.6 4835.0 4891.6 4972.7 4818.8 4871.1 4894.7 4901.2 4929.7 4450.8 4489.8 4606.2 4607.3 4635.4 555.4 4410.9 4427.1 4445.6 4505.4 4471.6 4506.4 4511.7 4518.7 4562.5 4512.5 4516.4 4525.0 4527.8 4583.7 4338.5 4371.8 4418.1 4479.2 4494.1 4834.8 4878.5 4935.3 4947.5 5003.9 5183.0 5307.6 5322.8 5333.4 5383.8 5235.1 5315.4 5317.0 5318.4 5374.7 4902.0 4923.9 4935.6 4943.0 4957.0 5176.1 5357.8 5365.0 5371.0 5407.7 5155.8 5175.1 5178.3 5192.7 5247.7 5298.2 5307.8 5309.3 5314.9 5356.7 5027.8 5108.4 5119.4 5145.9 5212.1 5118.7 5156.4 5176.7 5182.2 5185.6 4415.0 4415.8 4438.4 4472.6 4477.3 3792.8 3850.2 3863.4 3876.2 3907.4 4485.2 4495.8 4515.6 4547.0 4607.8 5334.2 5336.3 5341.7 5347.1 5349.7 4385.1 4507.8 4546.7 4562.5 4576.5 4720.9 4725.6 4755.7 4790.6 4823.4 4799.4 4950.3 4961.4 4963.0 5022.9 5223.9 5278.7 5296.9 5300.9 5311.6 4924.5 4943.2 4944.9 4945.0 5001.6 5003.9 5139.4 5204.9 5207.7 5209.7 5213.5 5229.3 5272.3 5278.5 5310.8 5098.8 5099.1 5117.1 5147.4 5147.8 4926.5 5051.9 5061.7 5063.8 5129.0 5028.3 5049.1 5066.9 5075.8 5108.5 5187.8 5193.9 5200.2 5200.4 5223.2 4928.3 5018.7 5028.6 5062.6 5064.7 01:42:25 INFO - PROCESS | 2050 | 01:42:25 INFO - PROCESS | 2050 | [#1] ext.html Cycles:180 Average:46969.90 Median:37201.44 stddev:84894.19 (228.2%) stddev-sans-first:85060.71 01:42:25 INFO - PROCESS | 2050 | Values: 521.0 567.7 588.6 589.4 623.0 37150.1 38741.0 41616.8 41619.2 41776.6 42045.6 42579.4 42587.4 42783.0 42826.0 7660.9 7826.8 7842.1 7853.3 7855.6 7801.5 7877.6 7882.7 7917.7 7920.2 7930.9 7944.0 7976.8 7977.8 8000.8 7897.7 7956.4 7973.8 7974.7 7979.1 7855.1 7877.6 7913.0 7917.9 7920.2 30858.0 39611.2 40106.2 40137.0 40325.0 2935.5 3100.1 3247.4 3520.8 3640.5 28482.9 28969.4 29541.9 29652.3 30389.4 3220.6 3297.7 3432.3 3497.4 3508.5 268961.0 269704.0 271398.0 271406.0 271555.0 32592.8 33672.7 33743.5 57873.4 58988.0 34700.0 34711.0 34840.0 34852.7 34878.3 14131.6 14270.6 14288.4 14290.8 14373.6 11465.6 11491.8 11519.6 11581.2 11581.4 8005.8 8045.7 8053.8 8078.8 8134.1 3158.7 3165.4 3185.5 3230.6 3232.1 889.4 892.9 902.4 936.7 958.7 28630.9 28839.3 28983.7 29118.5 29723.7 1000.5 1011.2 1030.3 1076.5 1076.8 15107.8 15521.3 15584.8 15691.5 15783.6 373022.0 378660.0 378976.0 379533.0 381032.0 51292.7 52005.2 52267.2 52278.5 52344.0 1170.7 1197.2 1219.0 1229.0 1237.0 29048.9 29506.6 29613.7 29672.6 30046.7 43585.6 43624.0 43818.3 44214.3 44477.3 304323.0 309939.0 310332.0 310807.0 311998.0 26400.0 26625.2 26625.9 26823.2 26836.7 44167.0 44500.0 45384.0 45483.5 45605.3 37454.8 37637.6 37930.6 38117.2 39406.0 38252.8 38906.0 38954.2 38978.4 39397.8 36949.3 37252.8 37445.1 37751.0 38156.4 32896.8 33461.0 34491.5 34596.0 34633.7 26347.7 26700.8 26744.1 26797.5 26855.9 01:42:25 INFO - PROCESS | 2050 | 01:42:25 INFO - PROCESS | 2050 | [#2] jquery.html Cycles:180 Average:25070.02 Median:4336.38 stddev:69021.97 (1591.7%) stddev-sans-first:69190.69 01:42:25 INFO - PROCESS | 2050 | Values: 371.7 374.6 375.6 384.5 398.5 15996.0 16400.8 17133.6 17296.7 17348.1 15632.5 16564.0 16569.6 16604.0 17298.2 4596.8 4784.4 4822.6 4824.6 4827.3 3438.7 4556.7 5147.5 5429.8 5431.2 5416.7 5424.0 5440.0 5445.6 5484.7 5299.1 5334.7 5430.6 5442.9 5462.6 5233.9 5285.6 5293.7 5294.1 5314.0 11882.6 11956.2 11979.8 12071.8 12245.2 1993.2 2257.5 2370.9 2409.5 2440.9 8827.2 9177.5 9443.6 9652.1 9751.8 1721.5 1726.2 1741.2 1764.2 1826.8 64948.0 68203.7 69697.0 69731.7 70305.0 9232.8 9304.4 9449.4 9667.1 10003.5 12707.9 13076.2 13078.0 13096.5 13199.3 7345.3 7394.8 7430.3 7465.2 7545.8 7085.1 7101.6 7169.9 7210.6 7279.6 4224.8 4230.1 4328.4 4344.4 4361.1 1561.0 1655.3 1678.3 1798.2 1869.5 829.9 838.4 863.6 869.9 879.7 16581.9 17109.1 17331.2 17332.4 17531.4 836.8 872.7 872.9 874.6 909.5 9410.3 9810.5 10005.1 10063.7 10584.3 409656.0 417974.0 418080.0 420375.0 424476.0 78817.6 81063.6 81892.2 83854.6 84155.0 924.1 924.3 930.0 961.4 966.6 15908.0 16051.4 16159.4 16189.8 16373.6 37430.4 37768.6 38467.6 38474.4 39355.0 47409.5 53789.5 53832.2 53847.7 53850.5 6609.5 6939.4 7253.5 7352.9 7873.6 8457.9 11203.8 11209.2 11816.2 11989.2 10318.2 10502.7 10690.7 10786.7 10846.2 10309.3 10829.6 10904.8 11181.8 11227.8 10512.2 10740.2 10761.8 10937.8 11238.7 7884.1 7907.2 7935.4 8060.6 8102.3 9992.7 10295.3 10457.1 10866.5 11012.9 01:42:25 INFO - PROCESS | 2050 | 01:42:25 INFO - PROCESS | 2050 | [#3] mootools.html Cycles:180 Average:5236.07 Median:5430.54 stddev:2949.84 (54.3%) stddev-sans-first:2943.89 01:42:25 INFO - PROCESS | 2050 | Values: 1381.2 1412.3 1510.2 1656.8 1693.3 6838.7 7518.2 7569.3 8034.7 8056.5 7331.3 7560.7 7581.9 7589.5 7590.3 2202.9 2236.0 2247.9 2249.2 2262.1 2168.0 2182.1 2221.9 2223.1 2225.8 2205.4 2218.7 2223.3 2224.5 2226.8 2148.3 2163.8 2166.8 2170.8 2186.3 2144.1 2164.0 2168.8 2174.3 2174.5 7972.9 8079.9 8121.6 8139.6 8144.5 4626.1 4808.9 4815.0 4816.3 4821.5 2879.1 2993.1 3034.4 3034.5 3040.3 891.2 932.8 945.8 952.7 959.8 10866.9 10879.6 10887.7 10948.7 10976.1 4169.9 4235.9 4271.6 4307.3 4333.3 9396.2 9410.3 9423.0 9445.2 9455.9 4697.7 4702.7 4768.7 4771.9 4779.1 3777.8 4130.2 4159.5 4268.4 4272.3 3662.3 3698.3 3764.4 3808.1 3812.2 1190.3 1210.3 1219.9 1222.9 1254.7 730.3 849.0 857.2 868.3 882.2 5420.3 5440.8 5521.7 5527.5 5533.3 359.3 364.3 364.9 365.8 370.9 3801.6 3811.7 3846.6 3863.5 3867.9 9430.1 9601.0 9808.1 9885.0 9898.0 9691.6 9704.9 9738.8 9767.3 9799.1 6910.6 7264.7 7441.3 7494.9 7511.2 5574.8 5700.4 5789.4 5860.3 5907.8 8890.3 8982.6 9128.7 9131.1 9235.9 9180.6 9274.9 9312.9 9331.8 9337.3 6154.4 6700.2 6937.4 6953.7 7076.7 7793.5 7795.5 7841.3 7842.1 7905.8 6813.9 6953.7 7017.5 7101.7 7104.1 6854.2 6921.0 6925.8 6928.1 6963.4 5891.1 6179.1 6185.5 6362.6 6403.2 4644.7 4751.8 4769.0 4771.4 4827.1 4632.4 4649.0 4686.3 4713.6 4715.9 01:42:25 INFO - PROCESS | 2050 | 01:42:25 INFO - PROCESS | 2050 | [#4] prototype.html Cycles:180 Average:4342.61 Median:5004.41 stddev:1281.71 (25.6%) stddev-sans-first:1248.78 01:42:25 INFO - PROCESS | 2050 | Values: 294.8 301.5 304.3 310.8 311.7 5082.3 5122.0 5126.2 5127.4 5148.3 4991.9 4998.1 5021.9 5023.9 5039.4 3962.3 3974.0 3983.6 3997.2 4022.8 3658.2 3902.6 3935.7 3989.1 4001.8 3878.6 3882.6 3882.7 3896.7 3908.1 3888.9 3910.7 3919.5 3925.0 3945.0 3247.4 3261.6 3333.8 3429.6 3432.5 4987.3 5009.6 5016.1 5028.4 5040.3 4476.4 4482.0 4484.3 4513.8 4521.8 4999.2 5193.8 5230.3 5245.8 5324.3 3747.3 3752.4 3756.0 3762.2 3768.3 5533.9 5550.6 5551.5 5558.7 5565.7 3611.5 3812.0 3816.3 3827.4 3839.2 3869.4 3875.1 3881.0 3907.3 3914.6 4459.4 4462.6 4481.9 4489.7 4498.8 5238.8 5271.9 5320.0 5332.7 5342.8 1336.0 1337.0 1343.6 1343.9 1348.8 837.6 839.0 855.5 857.5 863.2 4129.6 4139.8 4203.3 4216.2 4222.5 4856.7 4864.2 4906.7 4923.9 4924.8 4192.9 4207.5 4212.5 4225.3 4232.3 2451.6 2579.5 2777.2 2818.9 2929.4 5109.8 5113.5 5118.0 5129.2 5138.2 5509.5 5553.3 5585.4 5596.5 5597.9 4914.3 5098.1 5107.6 5109.3 5111.6 5390.4 5402.1 5450.0 5450.5 5496.3 5074.4 5274.6 5308.2 5318.2 5354.2 5075.4 5083.5 5085.7 5115.7 5118.7 3829.5 3891.2 3906.3 3911.9 3921.5 5194.7 5556.1 5557.9 5578.9 5602.3 5241.5 5251.6 5269.8 5279.8 5303.8 5216.1 5303.9 5308.9 5313.1 5313.7 4997.3 5167.2 5172.2 5176.7 5216.4 5292.9 5326.5 5344.0 5350.5 5352.0 5172.8 5178.6 5191.9 5232.6 5252.3 01:42:25 INFO - PROCESS | 2050 | 01:42:25 INFO - PROCESS | 2050 | [#5] yui.html Cycles:180 Average:18337.21 Median:4295.46 stddev:26382.38 (614.2%) stddev-sans-first:26422.92 01:42:25 INFO - PROCESS | 2050 | Values: 640.2 686.5 717.0 721.0 760.7 11310.4 12211.1 12257.5 12576.5 13224.9 14763.4 14778.5 14901.4 14928.9 15027.9 625.3 775.5 797.3 801.4 801.7 796.5 799.9 801.6 801.9 802.0 837.9 841.4 841.4 843.0 844.1 827.9 833.2 834.5 835.1 837.2 606.6 608.2 613.5 613.6 613.8 12439.9 12613.6 12642.4 12674.6 12696.7 13007.9 13416.3 13510.3 13511.2 13525.3 10860.5 10866.7 11068.8 11099.5 11296.0 3315.8 3345.4 3369.9 3403.9 3479.5 69220.7 69955.0 72065.3 72392.0 72398.3 10505.3 10725.5 10732.5 10805.1 10947.8 20120.1 20132.0 20154.5 20158.4 20232.8 6772.9 6887.7 6902.1 6935.2 7123.6 3654.4 3747.2 3748.6 3792.9 3901.2 3079.6 3187.6 3198.5 3205.8 3227.0 517.5 526.9 531.4 533.6 539.9 586.3 587.9 609.2 623.2 634.4 8334.9 8649.4 8785.6 8883.8 8920.6 523.3 542.6 574.5 583.7 586.1 4182.5 4268.3 4293.1 4297.8 4344.4 59972.7 60729.1 103961.5 109984.5 111758.4 63737.7 89590.6 90127.0 91321.0 92581.5 75929.6 79086.6 80603.6 82041.2 84373.0 8062.8 8112.5 8202.8 8215.1 8312.0 46001.0 46206.3 47665.5 48156.0 48164.0 63439.9 69583.0 70709.3 71402.0 71746.6 10088.9 10121.0 10168.2 10323.6 10732.8 11200.3 11256.8 11766.4 12082.4 12410.9 10927.5 11091.6 11238.0 11507.5 11594.5 10555.7 10619.3 10622.3 10670.6 10698.7 10889.8 10942.8 12267.5 12268.7 12298.4 10273.6 10312.6 10846.5 11038.4 11074.9 10654.6 10730.6 11039.6 11148.3 11203.2 01:42:25 INFO - PROCESS | 2050 | -------- Summary: end -------- 01:42:25 INFO - PROCESS | 2050 | 01:42:26 INFO - TEST-INFO | 2050: exit 0 01:42:26 INFO - TEST-OK | dromaeo_css | took 1117259ms 01:42:26 INFO - TEST-START | kraken 01:42:26 INFO - operating with platform_type : linux_ 01:42:26 INFO - Initialising browser for kraken test... 01:42:26 INFO - TEST-INFO | started process 2287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHhpJJa/profile http://localhost:33859/getInfo.html) 01:42:31 INFO - PROCESS | 2287 | __metrics Screen width/height:1600/1200 01:42:31 INFO - PROCESS | 2287 | colorDepth:24 01:42:31 INFO - PROCESS | 2287 | Browser inner width/height: 1024/697 01:42:31 INFO - PROCESS | 2287 | __metrics 01:42:32 ERROR - PROCESS | 2287 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 01:42:33 INFO - TEST-INFO | 2287: exit 0 01:42:33 INFO - Browser initialized. 01:42:33 INFO - Running cycle 1/1 for kraken test... 01:42:33 INFO - TEST-INFO | started process 2479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHhpJJa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:42:45 INFO - PROCESS | 2479 | RSS: Main: 185876480 01:42:45 INFO - PROCESS | 2479 | 01:42:48 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33859/tests/kraken/driver.html?testName=audio-beat-detection) 01:42:49 INFO - PROCESS | 2479 | RSS: Main: 190980096 01:42:49 INFO - PROCESS | 2479 | 01:42:51 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33859/tests/kraken/driver.html?testName=audio-dft) 01:42:52 INFO - PROCESS | 2479 | RSS: Main: 190328832 01:42:52 INFO - PROCESS | 2479 | 01:42:55 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33859/tests/kraken/driver.html?testName=audio-fft) 01:42:56 INFO - PROCESS | 2479 | RSS: Main: 186327040 01:42:56 INFO - PROCESS | 2479 | 01:42:58 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33859/tests/kraken/driver.html?testName=audio-oscillator) 01:42:59 INFO - PROCESS | 2479 | RSS: Main: 187240448 01:42:59 INFO - PROCESS | 2479 | 01:43:01 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33859/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:43:01 INFO - PROCESS | 2479 | RSS: Main: 187686912 01:43:01 INFO - PROCESS | 2479 | 01:43:05 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33859/tests/kraken/driver.html?testName=imaging-darkroom) 01:43:05 INFO - PROCESS | 2479 | RSS: Main: 187719680 01:43:05 INFO - PROCESS | 2479 | 01:43:09 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33859/tests/kraken/driver.html?testName=imaging-desaturate) 01:43:10 INFO - PROCESS | 2479 | RSS: Main: 183984128 01:43:10 INFO - PROCESS | 2479 | 01:43:12 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33859/tests/kraken/driver.html?testName=json-parse-financial) 01:43:13 INFO - PROCESS | 2479 | RSS: Main: 186007552 01:43:13 INFO - PROCESS | 2479 | 01:43:15 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33859/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:43:15 INFO - PROCESS | 2479 | RSS: Main: 186621952 01:43:15 INFO - PROCESS | 2479 | 01:43:17 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33859/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:43:18 INFO - PROCESS | 2479 | RSS: Main: 186384384 01:43:18 INFO - PROCESS | 2479 | 01:43:20 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33859/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:43:21 INFO - PROCESS | 2479 | RSS: Main: 187015168 01:43:21 INFO - PROCESS | 2479 | 01:43:24 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:43:24 INFO - PROCESS | 2479 | RSS: Main: 187260928 01:43:24 INFO - PROCESS | 2479 | 01:43:27 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:43:28 INFO - PROCESS | 2479 | RSS: Main: 186564608 01:43:28 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | Cycle 1(1): loaded http://localhost:33859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33859/tests/kraken/driver.html?testName=ai-astar) 01:43:30 INFO - PROCESS | 2479 | RSS: Main: 187768832 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | __start_tp_report 01:43:30 INFO - PROCESS | 2479 | _x_x_mozilla_page_load 01:43:30 INFO - PROCESS | 2479 | _x_x_mozilla_page_load_details 01:43:30 INFO - PROCESS | 2479 | |i|pagename|runs| 01:43:30 INFO - PROCESS | 2479 | |0;ai-astar;117;110;114;115;119;113;114;113;113;114 01:43:30 INFO - PROCESS | 2479 | |1;audio-beat-detection;164;135;155;190;136;162;167;132;207;137 01:43:30 INFO - PROCESS | 2479 | |2;audio-dft;165;168;167;163;162;164;162;163;164;163 01:43:30 INFO - PROCESS | 2479 | |3;audio-fft;75;76;79;167;78;76;76;77;163;76 01:43:30 INFO - PROCESS | 2479 | |4;audio-oscillator;86;88;150;88;91;89;139;88;88;132 01:43:30 INFO - PROCESS | 2479 | |5;imaging-gaussian-blur;119;119;118;119;117;118;119;118;118;118 01:43:30 INFO - PROCESS | 2479 | |6;imaging-darkroom;148;148;147;148;151;148;148;148;148;148 01:43:30 INFO - PROCESS | 2479 | |7;imaging-desaturate;94;96;95;95;95;97;95;97;95;96 01:43:30 INFO - PROCESS | 2479 | |8;json-parse-financial;65;64;65;67;64;63;65;65;65;63 01:43:30 INFO - PROCESS | 2479 | |9;json-stringify-tinderbox;66;66;67;66;68;66;65;67;66;66 01:43:30 INFO - PROCESS | 2479 | |10;stanford-crypto-aes;88;90;83;87;87;84;85;86;114;91 01:43:30 INFO - PROCESS | 2479 | |11;stanford-crypto-ccm;150;133;142;141;142;138;149;134;162;139 01:43:30 INFO - PROCESS | 2479 | |12;stanford-crypto-pbkdf2;174;171;173;171;170;172;176;171;168;175 01:43:30 INFO - PROCESS | 2479 | |13;stanford-crypto-sha256-iterative;70;70;70;69;68;67;67;67;69;68 01:43:30 INFO - PROCESS | 2479 | __end_tp_report 01:43:30 INFO - PROCESS | 2479 | __start_cc_report 01:43:30 INFO - PROCESS | 2479 | _x_x_mozilla_cycle_collect,964 01:43:30 INFO - PROCESS | 2479 | __end_cc_report 01:43:30 INFO - PROCESS | 2479 | __startTimestamp1466585010390__endTimestamp 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | ------- Summary: start ------- 01:43:30 INFO - PROCESS | 2479 | Number of tests: 14 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:2.44 (2.1%) stddev-sans-first:2.37 01:43:30 INFO - PROCESS | 2479 | Values: 117.0 110.0 114.0 115.0 119.0 113.0 114.0 113.0 113.0 114.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#1] audio-beat-detection Cycles:10 Average:158.50 Median:163.00 stddev:25.15 (15.4%) stddev-sans-first:26.60 01:43:30 INFO - PROCESS | 2479 | Values: 164.0 135.0 155.0 190.0 136.0 162.0 167.0 132.0 207.0 137.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.02 (1.2%) stddev-sans-first:2.12 01:43:30 INFO - PROCESS | 2479 | Values: 165.0 168.0 167.0 163.0 162.0 164.0 162.0 163.0 164.0 163.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:37.29 (49.1%) stddev-sans-first:38.89 01:43:30 INFO - PROCESS | 2479 | Values: 75.0 76.0 79.0 167.0 78.0 76.0 76.0 77.0 163.0 76.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:88.00 stddev:25.53 (29.0%) stddev-sans-first:26.25 01:43:30 INFO - PROCESS | 2479 | Values: 86.0 88.0 150.0 88.0 91.0 89.0 139.0 88.0 88.0 132.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 01:43:30 INFO - PROCESS | 2479 | Values: 119.0 119.0 118.0 119.0 117.0 118.0 119.0 118.0 118.0 118.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 01:43:30 INFO - PROCESS | 2479 | Values: 148.0 148.0 147.0 148.0 151.0 148.0 148.0 148.0 148.0 148.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:0.87 01:43:30 INFO - PROCESS | 2479 | Values: 94.0 96.0 95.0 95.0 95.0 97.0 95.0 97.0 95.0 96.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 01:43:30 INFO - PROCESS | 2479 | Values: 65.0 64.0 65.0 67.0 64.0 63.0 65.0 65.0 65.0 63.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 01:43:30 INFO - PROCESS | 2479 | Values: 66.0 66.0 67.0 66.0 68.0 66.0 65.0 67.0 66.0 66.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:87.00 stddev:8.96 (10.3%) stddev-sans-first:9.49 01:43:30 INFO - PROCESS | 2479 | Values: 88.0 90.0 83.0 87.0 87.0 84.0 85.0 86.0 114.0 91.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:142.00 stddev:8.65 (6.1%) stddev-sans-first:8.80 01:43:30 INFO - PROCESS | 2479 | Values: 150.0 133.0 142.0 141.0 142.0 138.0 149.0 134.0 162.0 139.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.50 stddev:2.42 (1.4%) stddev-sans-first:2.47 01:43:30 INFO - PROCESS | 2479 | Values: 174.0 171.0 173.0 171.0 170.0 172.0 176.0 171.0 168.0 175.0 01:43:30 INFO - PROCESS | 2479 | 01:43:30 INFO - PROCESS | 2479 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.27 (1.8%) stddev-sans-first:1.22 01:43:30 INFO - PROCESS | 2479 | Values: 70.0 70.0 70.0 69.0 68.0 67.0 67.0 67.0 69.0 68.0 01:43:30 INFO - PROCESS | 2479 | -------- Summary: end -------- 01:43:30 INFO - PROCESS | 2479 | 01:43:31 INFO - TEST-INFO | 2479: exit 0 01:43:31 INFO - TEST-OK | kraken | took 65275ms 01:43:31 INFO - SUITE-END | took 1182s 01:43:31 INFO - Completed test suite (00:19:42) 01:43:31 INFO - javascript benchmark 01:43:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6450.191119152868, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.3851494898695, 2698.204029811206, 2700.0549807567354, 2708.593710943357, 2714.5656694928816, 4803.5676789088975, 4824.5899098576665, 4835.008823191246, 4891.633127515442, 4972.726500042505, 4818.819389249638, 4871.050145221674, 4894.730789806559, 4901.240307752304, 4929.65492415531, 4450.821967121319, 4489.842855500058, 4606.193916064692, 4607.262837945929, 4635.443746750378, 555.3560846885188, 4410.911781764363, 4427.11457708458, 4445.555444455561, 4505.36924830524, 4471.575200355961, 4506.369108324837, 4511.70673906195, 4518.661100417482, 4562.543745625444, 4512.503624601324, 4516.390287311204, 4525.049739554697, 4527.796249168795, 4583.702059366164, 4338.501072376685, 4371.825126994916, 4418.116376724636, 4479.238529449969, 4494.056248187884, 4834.830780922686, 4878.512148785093, 4935.3090567320605, 4947.529984651453, 5003.874903127451, 5182.974085129588, 5307.575393968474, 5322.787088516455, 5333.35999680037, 5383.784648614051, 5235.136202526579, 5315.415304316522, 5317.016351974897, 5318.414974352818, 5374.6506477078865, 4902.0, 4923.90152196954, 4935.629827762932, 4943.0, 4956.975215123974, 5176.068307704574, 5357.785688572491, 5364.9731751341, 5371.0, 5407.729613519308, 5155.7679904404395, 5175.120229560984, 5178.326817513699, 5192.714400707921, 5247.658902171423, 5298.15229563268, 5307.761150748225, 5309.309789727388, 5314.867128321745, 5356.678599284055, 5027.798888044437, 5108.361454818148, 5119.411267704261, 5145.871353216199, 5212.087884620177, 5118.667286626432, 5156.432792392834, 5176.689398636094, 5182.196759502283, 5185.637005409661, 4415.028693687384, 4415.845445409395, 4438.400815889813, 4472.642188624902, 4477.283634618446, 3792.75347102443, 3850.1914597934187, 3863.4011728182177, 3876.2247550490015, 3907.355286377716, 4485.192665320274, 4495.842645507457, 4515.616172625298, 4546.954530454719, 4607.792649330788, 5334.226537152092, 5336.332958380202, 5341.7062061586985, 5347.0909945309395, 5349.679019258857, 4385.057212699285, 4507.81968721254, 4546.681732278708, 4562.520935301812, 4576.519465456146, 4720.881977950578, 4725.5983241424865, 4755.738434386142, 4790.640701947368, 4823.445303790109, 4799.352087468147, 4950.257461380822, 4961.404631444249, 4963.032208719265, 5022.924656130088, 5223.947760522498, 5278.709670968134, 5296.947030529645, 5300.893982120413, 5311.628186027096, 4924.532169443897, 4943.233798761198, 4944.851654450372, 4945.035718034948, 5001.599872010303, 5003.8749031273055, 5139.383274006994, 5204.895902082013, 5207.661502002357, 5209.6874187548865, 5213.452587478412, 5229.320188375486, 5272.261883336259, 5278.4721527846905, 5310.814121505883, 5098.796048158032, 5099.107656160083, 5117.130087884994, 5147.433782283871, 5147.794088236578, 4926.5073492650445, 5051.898962020812, 5061.7469126544265, 5063.797448102035, 5129.0, 5028.321176641253, 5049.141645920129, 5066.9239961401345, 5075.7969681212335, 5108.489151084862, 5187.844364669066, 5193.922091168711, 5200.193969934666, 5200.4279529251, 5223.16429371314, 4928.2853986171085, 5018.698878067327, 5028.64799464034, 5062.569681577107, 5064.7467626619255], "value": 4786.103371320508, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.0035057354539, 567.7189791053428, 588.6468119128521, 589.4311988930682, 622.9501639868811, 37150.07124821881, 38741.0, 41616.791916040376, 41619.16761664769, 41776.58223417765, 42045.57954420455, 42579.36130958038, 42587.36118958218, 42783.0, 42826.0, 7660.923390766105, 7826.7651970440975, 7842.098158711736, 7853.253940875607, 7855.607219639024, 7801.453898227126, 7877.645505952217, 7882.684692612289, 7917.683292668286, 7920.207979202091, 7930.920690793105, 7943.960280198591, 7976.840463190732, 7977.840443191133, 8000.799980000488, 7897.723579674713, 7956.403269754734, 7973.840523189504, 7974.681012759483, 7979.122296547375, 7855.057393112806, 7877.645505952189, 7912.960435197787, 7917.881231781528, 7920.247576480225, 30858.0, 39611.20777584461, 40106.197876042315, 40137.0, 40325.0, 2935.4716151092794, 3100.0699790063118, 3247.431699452586, 3520.8415621297104, 3640.453931910208, 28482.857585712147, 28969.420611587862, 29541.852290738625, 29652.258693532618, 30389.392212155853, 3220.5974253218346, 3297.670232976683, 3432.3306955143757, 3497.387957107496, 3508.5438892944007, 268961.0, 269704.0, 271398.0, 271406.0, 271554.999999998, 32592.837035814668, 33672.66327336744, 33743.493847592305, 57873.42126578765, 58988.0, 34700.0, 34711.0, 34840.0, 34852.65147348545, 34878.302433951176, 14131.64670883236, 14270.643233919234, 14288.42846286137, 14290.785638215435, 14373.6406589834, 11465.598704045486, 11491.77016459666, 11519.596814111466, 11581.247218930743, 11581.363025033705, 8005.759827205193, 8045.718399855977, 8053.838923221503, 8078.798030049178, 8134.06458257308, 3158.7473002159772, 3165.3511030238747, 3185.5062465317915, 3230.5800245968344, 3232.143481977278, 889.4307643108416, 892.9285657147412, 902.4224496322358, 936.6908920056366, 958.6596758150896, 28630.85684571564, 28839.279018024718, 28983.710162898522, 29118.544072796274, 29723.702762972527, 1000.4542981094081, 1011.1708399112804, 1030.2736570717625, 1076.5347354557975, 1076.8438576406534, 15107.773383399257, 15521.301541430663, 15584.766228506582, 15691.450799221973, 15783.605409864846, 373022.0, 378660.0, 378976.0, 379533.0, 381032.0, 51292.74353628208, 52005.2199217012, 52267.21599176015, 52278.47721522736, 52344.0, 1170.6897672116895, 1197.1560050164612, 1219.030870457988, 1229.0474881966547, 1237.004211609645, 29048.854755726086, 29506.55740163942, 29613.703862961094, 29672.55491167591, 30046.699533005263, 43585.56414435942, 43624.0, 43818.342724858514, 44214.33678494889, 44477.33284000678, 304323.0, 309939.0, 310332.0, 310807.0, 311998.0, 26400.0, 26625.20124396271, 26625.866870666297, 26823.195304140907, 26836.731632683423, 44167.0, 44500.0, 45384.0, 45483.54516454793, 45605.31592026056, 37454.81272593619, 37637.623623764506, 37930.620693792705, 38117.23765524619, 39406.0, 38252.80873595614, 38906.0, 38954.2209155821, 38978.415323770736, 39397.80301098476, 36949.261014780095, 37252.813735931144, 37445.063873403386, 37751.0, 38156.427653584666, 32896.83551582227, 33461.0, 34491.4826277601, 34596.0, 34633.65366346304, 26347.73652263453, 26700.829745713538, 26744.063957761384, 26797.464050719267, 26855.86572067127], "value": 16916.384896543066, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.66178777312643, 374.6384738727128, 375.6056141051895, 384.4790309131125, 398.5257543523207, 15996.0, 16400.753988690165, 17133.571660708487, 17296.740548891776, 17348.132593370345, 15632.452864149756, 16564.00615963043, 16569.585760355996, 16604.0, 17298.221580028898, 4596.839110631128, 4784.449788274341, 4822.590079843218, 4824.6381521385865, 4827.2759086137185, 3438.673326034023, 4556.681032327739, 5147.459516750743, 5429.782808687648, 5431.185322201662, 5416.729163541827, 5423.972880135613, 5439.972800135994, 5445.646033007842, 5484.670919744808, 5299.125644268691, 5334.657891469018, 5430.5927055471, 5442.8911421771545, 5462.644928079662, 5233.947660523384, 5285.577153827723, 5293.735313234323, 5294.100002999499, 5313.973430132824, 11882.643520694393, 11956.2228455151, 11979.760404791943, 12071.818922716166, 12245.204061735958, 1993.1529100132386, 2257.492064285539, 2370.885683728662, 2409.5301416223842, 2440.9023639054417, 8827.205551500332, 9177.541122943892, 9443.622255109787, 9652.131308182297, 9751.804963900753, 1721.5482956671792, 1726.214572369569, 1741.1555395633109, 1764.162023039059, 1826.7990521042675, 64948.0, 68203.65898170527, 69697.0, 69731.65134174348, 70305.0, 9232.769180770534, 9304.395214311047, 9449.43303401798, 9667.0848306436, 10003.549840257207, 12707.872921270853, 13076.215427074407, 13078.0, 13096.541621043218, 13199.274039927705, 7345.265473452612, 7394.7781566553085, 7430.331270185709, 7465.178830328659, 7545.811354716176, 7085.078939737904, 7101.644917754195, 7169.856602867913, 7210.584454207794, 7279.59962202084, 4224.831006759757, 4230.132822771325, 4328.394024836525, 4344.370066340363, 4361.1495758327455, 1560.9921950390176, 1655.2964989879254, 1678.2867281405354, 1798.1818272685896, 1869.5045812859603, 829.9128591497927, 838.4131108224267, 863.628639684929, 869.8651708985118, 879.7052987249215, 16581.91709041447, 17109.14454277306, 17331.220095095752, 17332.39336623212, 17531.386401475887, 836.7698882807276, 872.7250915961451, 872.8690696395464, 874.6239117179674, 909.4861403307243, 9410.341276110606, 9810.460424676568, 10005.149562287286, 10063.69808905734, 10584.253598156218, 409656.0, 417974.0, 418080.0, 420375.0, 424476.0, 78817.60591197008, 81063.59468202622, 81892.18107818965, 83854.58072709598, 84155.0, 924.0713083351324, 924.2836801478774, 929.9767505812409, 961.3943215774018, 966.5891995901713, 15908.0, 16051.438199662956, 16159.43441979525, 16189.838101618832, 16373.590660233589, 37430.438543421325, 37768.62231377651, 38467.6153238464, 38474.422883657324, 39355.0, 47409.52590474051, 53789.46210538001, 53832.19251711149, 53847.73076134594, 53850.461495384545, 6609.4712423007, 6939.375456208965, 7253.492255542062, 7352.852942941005, 7873.645685944031, 8457.87313190315, 11203.775924481628, 11209.15931305139, 11816.231944923553, 11989.22070065443, 10318.226133039901, 10502.68491945243, 10690.679279621623, 10786.73033174177, 10846.24076314682, 10309.278350515391, 10829.566817327219, 10904.836427453436, 11181.776364472827, 11227.793209568403, 10512.211584131373, 10740.194485413469, 10761.838572421577, 10937.781244375226, 11238.719032024264, 7884.093329267208, 7907.209279072047, 7935.40484463656, 8060.596970151586, 8102.270795628422, 9992.700218993441, 10295.279330446796, 10457.058864702214, 10866.511007004861, 11012.889871101186], "value": 8152.668756079379, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.1574939287036, 1412.28679516844, 1510.1995942150663, 1656.8011838579357, 1693.305744644695, 6838.726450941969, 7518.173000969889, 7569.280918312751, 8034.718784842532, 8056.476329038608, 7331.340179383855, 7560.735374261902, 7581.924180758191, 7589.468737188399, 7590.278923502272, 2202.933911982639, 2235.9888200558976, 2247.9438014049697, 2249.2352600115955, 2262.061244583496, 2167.967480487794, 2182.138055468089, 2221.8777967211795, 2223.0885337011828, 2225.7662945390744, 2205.44863784054, 2218.667199920009, 2223.321886824518, 2224.4550085229143, 2226.7773222677765, 2148.3340164548886, 2163.8268938484885, 2166.815820655246, 2170.815480684144, 2186.3440967709703, 2144.0673307111456, 2164.0261882153095, 2168.761436242012, 2174.325958952714, 2174.521605246859, 7972.880406793903, 8079.919200807975, 8121.634526446265, 8139.633716482714, 8144.470609410429, 4626.074785042972, 4808.855734327975, 4815.036992601459, 4816.325714399987, 4821.541953514446, 2879.078694817659, 2993.0721476342405, 3034.37795251975, 3034.51447768356, 3040.3159289159985, 891.242443922667, 932.8227636749064, 945.791925776335, 952.7284723853669, 959.8464245720721, 10866.945665271702, 10879.619213327574, 10887.673369798918, 10948.726281842937, 10976.067034302094, 4169.937450938239, 4235.8729238122905, 4271.594198551133, 4307.289297265916, 4333.263345231318, 9396.248300135972, 9410.341276110743, 9423.0, 9445.197158241626, 9455.858162127573, 4697.718136911796, 4702.741349225757, 4768.713877167381, 4771.880702982384, 4779.139754844162, 3777.7544459610035, 4130.194612050621, 4159.521655009713, 4268.423762791983, 4272.33778764292, 3662.304162209172, 3698.2973235085246, 3764.416515440111, 3808.124131449782, 3812.1803812180515, 1190.2560899437851, 1210.2859313005192, 1219.85361756588, 1222.8715984821642, 1254.6988722706485, 730.2733779889045, 849.0278630967507, 857.2199298638209, 868.2923417414787, 882.1751662195867, 5420.295361603045, 5440.782368705287, 5521.69630670317, 5527.50252477279, 5533.3083364579425, 359.31371081234715, 364.34781740684406, 364.87594217966017, 365.81891963477716, 370.87390287301906, 3801.5628202756484, 3811.6950643948417, 3846.5961074087377, 3863.459115723801, 3867.8613089771575, 9430.10414010668, 9601.039896010483, 9808.117269445642, 9885.0, 9898.0, 9691.563879625433, 9704.9029509704, 9738.805223895624, 9767.267454940766, 9799.069088436587, 6910.617876424735, 7264.673089710976, 7441.255874412515, 7494.887576686354, 7511.173770885308, 5574.832755017356, 5700.401457846866, 5789.363170051207, 5860.267466566679, 5907.763689452374, 8890.288776897962, 8982.550872456482, 9128.680496182602, 9131.086891310815, 9235.861462078208, 9180.632774688938, 9274.860877086983, 9312.906870931203, 9331.813363732552, 9337.299702522203, 6154.353792851686, 6700.162479690039, 6937.445004399535, 6953.6523173842115, 7076.716931322895, 7793.454458188099, 7795.532268063935, 7841.294283514511, 7842.098158711821, 7905.802354941173, 6813.8977915330315, 6953.687084081127, 7017.473689473208, 7101.680424381018, 7104.11198600175, 6854.177498699988, 6921.0, 6925.792226233221, 6928.064711264116, 6963.442924566124, 5891.086881533369, 6179.104029915727, 6185.505159587312, 6362.554621176659, 6403.199600049994, 4644.698094623838, 4751.833685821118, 4768.976155119341, 4771.403574553181, 4827.08285425768, 4632.3977882875015, 4648.976755116203, 4686.27362758773, 4713.646476514344, 4715.929261061156], "value": 4128.974983566239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.8304724783249, 301.5386458718161, 304.2894840547321, 310.83525731362374, 311.70543836074916, 5082.288479612853, 5121.999999999991, 5126.179811230199, 5127.410347810003, 5148.330717006788, 4991.900161996767, 4998.050370429616, 5021.924671129936, 5023.874403139924, 5039.44566097729, 3962.286788378091, 3973.9999999999927, 3983.58172391899, 3997.1805779815213, 4022.798860057, 3658.1586235165796, 3902.6292502212386, 3935.704822138351, 3989.1423343981037, 4001.8194632583313, 3878.631530004645, 3882.592327805582, 3882.7087968402343, 3896.6687831534214, 3908.1011367385518, 3888.9222215555674, 3910.7458015229204, 3919.4512768212617, 3925.0, 3944.980275098635, 3247.382997230542, 3261.5596894419423, 3333.7833040852265, 3429.605595356541, 3432.502287168347, 4987.301777751118, 5009.624278179114, 5016.068813506826, 5028.396592408898, 5040.269160971675, 4476.4180656514445, 4481.977590112061, 4484.349769283435, 4513.7743112844555, 4521.751303678297, 4999.200127979542, 5193.792248310063, 5230.293910322096, 5245.79016839326, 5324.307839980816, 3747.2692824899154, 3752.3808571585655, 3755.962440375589, 3762.1535154590274, 3768.321702093622, 5533.861653458655, 5550.58370622205, 5551.500364967173, 5558.722063896789, 5565.749541270652, 3611.530501034901, 3811.961880381161, 3816.3130636485143, 3827.3876179811655, 3839.214765134226, 3869.438931354994, 3875.147467557133, 3881.010342362736, 3907.277153726513, 3914.5889681583026, 4459.353393757887, 4462.620677242406, 4481.901934026119, 4489.685721999494, 4498.840556532882, 5238.842834714965, 5271.920921186185, 5320.0, 5332.653377530448, 5342.759575819097, 1335.9666008349868, 1336.9598912032461, 1343.6439343573766, 1343.9059265851492, 1348.8381394232754, 837.6095681169352, 838.9874151887726, 855.4738835616051, 857.5026484638895, 863.1713554987283, 4129.587041295907, 4139.77231252284, 4203.285441474956, 4216.241076606179, 4222.543222588202, 4856.660033797601, 4864.221724524059, 4906.712502623251, 4923.90152196954, 4924.778384972685, 4192.895177620523, 4207.516135644379, 4212.49450065994, 4225.345071513859, 4232.25935461293, 2451.6199989001734, 2579.4841031793717, 2777.180946480059, 2818.8872445102375, 2929.370185410147, 5109.821156259513, 5113.488651134857, 5118.0, 5129.204973229155, 5138.177891537336, 5509.531689806411, 5553.251140685386, 5585.357683866408, 5596.488947984021, 5597.944020559742, 4914.287428322945, 5098.056859481007, 5107.565856902131, 5109.335786347751, 5111.5655169310285, 5390.434004429479, 5402.135658294654, 5450.0, 5450.509454149145, 5496.258005169251, 5074.3657042869645, 5274.551663108678, 5308.230306605444, 5318.175682769177, 5354.223637572608, 5075.390953085654, 5083.491650834887, 5085.694858308513, 5115.693058416358, 5118.745907252747, 3829.46387505755, 3891.2023035278266, 3906.277338692351, 3911.941320880132, 3921.509811273591, 5194.68831870089, 5556.138798486241, 5557.944420555905, 5578.907909533925, 5602.299712535933, 5241.528262456397, 5251.606129540376, 5269.78920843162, 5279.762410691451, 5303.840884773463, 5216.122196009509, 5303.893922121459, 5308.885134121878, 5313.149896016619, 5313.654612450178, 4997.250412438163, 5167.199084141964, 5172.19830926207, 5176.689398636094, 5216.417873152814, 5292.894142117059, 5326.493983071602, 5344.0, 5350.475114592323, 5351.973240133774, 5172.844814655567, 5178.585713143015, 5191.870203244949, 5232.5552328052545, 5252.264682944315], "value": 3931.9548284613206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.1517988665023, 686.52629685517, 716.9962053125623, 720.9891851622224, 760.7223363472333, 11310.3779292139, 12211.145219834627, 12257.509699612016, 12576.496940122406, 13224.93387533061, 14763.409463621443, 14778.482753103644, 14901.403943842233, 14928.850711492882, 15027.924860375682, 625.3215261441342, 775.503677646304, 797.2824457987799, 801.4470015689155, 801.7394346837301, 796.5220867479524, 799.856025915335, 801.5551368990208, 801.8957535520403, 801.9599020049003, 837.9371547133959, 841.4068082002204, 841.4404421059987, 843.0220943705303, 844.0588743550927, 827.9420440569163, 833.2126140796888, 834.5368320582074, 835.0980940584154, 837.2213841127749, 606.6087373644019, 608.248812716295, 613.5337143770722, 613.5643692977991, 613.8250598579383, 12439.875601243963, 12613.621591352274, 12642.367881605884, 12674.556390526379, 12696.746065078647, 13007.934960325232, 13416.262105584188, 13510.32448377587, 13511.189328640314, 13525.256110913895, 10860.511276992554, 10866.67399978002, 11068.833967490495, 11099.500522476508, 11296.0, 3315.7678962472637, 3345.364380767671, 3369.898903032913, 3403.9489407658907, 3479.5476588043393, 69220.6538967307, 69955.0, 72065.27934720638, 72392.0, 72398.27601723968, 10505.31715438494, 10725.51735171919, 10732.517036733365, 10805.081568066802, 10947.781044379068, 20120.094595743227, 20132.0, 20154.496137596383, 20158.39524814258, 20232.79767202309, 6772.864542709118, 6887.690053947585, 6902.137232845895, 6935.202451718117, 7123.608201548861, 3654.397024490929, 3747.194353214072, 3748.5876553579083, 3792.8940478442423, 3901.219756048745, 3079.59965204522, 3187.6015498062743, 3198.4722520784276, 3205.775595708278, 3226.9838650807064, 517.4566704959777, 526.9130593452114, 531.388902761827, 533.6317940620959, 539.8812261302508, 586.3257254157668, 587.8536853136316, 609.2384519350811, 623.1525125828869, 634.4099987012123, 8334.874791903016, 8649.394542382099, 8785.648574057093, 8883.779055236191, 8920.598573064228, 523.2622002975786, 542.5659472422126, 574.4973148495067, 583.7168973048068, 586.14130299112, 4182.456280683492, 4268.317069268902, 4293.0769884474985, 4297.8495752648505, 4344.413504176896, 59972.700136499036, 60729.08906366408, 103961.48019259855, 109984.4500777491, 111758.44120779507, 63737.681311594075, 89590.55204724065, 90127.0, 91321.0, 92581.5370923141, 75929.62035189789, 79086.60456697564, 80603.59698201471, 82041.17958820454, 84373.0, 8062.7581172564915, 8112.472689275178, 8202.753917382488, 8215.096339402542, 8312.04411492686, 46001.0, 46206.30690539577, 47665.5233447675, 48156.0, 48164.0, 63439.92480601633, 69583.0, 70709.29290707027, 71402.0, 71746.64126679333, 10088.89911100909, 10121.0, 10168.186545076524, 10323.63867264642, 10732.83900741474, 11200.271982321448, 11256.83114753263, 11766.352850593299, 12082.39588020613, 12410.94506966918, 10927.508262128064, 11091.611793587186, 11238.0, 11507.482163302839, 11594.478248479007, 10555.736106597396, 10619.30974486656, 10622.256442048982, 10670.62652807148, 10698.679039628823, 10889.782204356026, 10942.835857462303, 12267.509299627915, 12268.693282668004, 12298.385080745747, 10273.640422585173, 10312.587496500357, 10846.511906964048, 11038.392888391216, 11074.944625276821, 10654.627088052192, 10730.624428144978, 11039.613613523488, 11148.331100134017, 11203.159763017644], "value": 6719.691646404267, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.9999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 110.0, 114.0, 115.0, 119.0, 113.0, 114.0, 113.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 135.0, 155.0, 190.0, 136.0, 162.0, 167.0, 132.0, 207.0, 137.0], "value": 158.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 167.0, 163.0, 162.0, 164.0, 162.0, 163.0, 164.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 79.0, 167.0, 78.0, 76.0, 76.0, 77.0, 163.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 150.0, 88.0, 91.0, 89.0, 139.0, 88.0, 88.0, 132.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 119.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 151.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 97.0, 95.0, 97.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 67.0, 64.0, 63.0, 65.0, 65.0, 65.0, 63.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 68.0, 66.0, 65.0, 67.0, 66.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 83.0, 87.0, 87.0, 84.0, 85.0, 86.0, 114.0, 91.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 133.0, 142.0, 141.0, 142.0, 138.0, 149.0, 134.0, 162.0, 139.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 173.0, 171.0, 170.0, 172.0, 176.0, 171.0, 168.0, 175.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 69.0, 68.0, 67.0, 67.0, 67.0, 69.0, 68.0], "value": 68.5, "unit": "score"}]}]} 01:43:31 INFO - Return code: 0 01:43:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:43:31 ERROR - # TBPL SUCCESS # 01:43:31 INFO - Running post-action listener: _resource_record_post_action 01:43:31 INFO - ##### 01:43:31 INFO - ##### Finished run-tests step (success) 01:43:31 INFO - ##### 01:43:31 INFO - Running post-run listener: _resource_record_post_run 01:43:31 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550051840; Read time: 16; Write time: 653416 01:43:31 INFO - TinderboxPrint: CPU usage
13.5% 01:43:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:43:31 INFO - TinderboxPrint: I/O write bytes / time
550,051,840 / 653,416 01:43:31 INFO - TinderboxPrint: CPU idle
8,279.2 (86.5%) 01:43:31 INFO - TinderboxPrint: CPU user
1,233.9 (12.9%) 01:43:31 INFO - TinderboxPrint: Swap in / out
0 / 0 01:43:31 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 253673472; Read time: 0; Write time: 410172 01:43:31 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296378368; Read time: 16; Write time: 243244 01:43:32 INFO - Running post-run listener: _upload_blobber_files 01:43:32 INFO - Blob upload gear active. 01:43:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:43:32 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 01:43:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:43:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:43:32 INFO - (blobuploader) - INFO - Open directory for files ... 01:43:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:43:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:43:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:43:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:43:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:43:36 INFO - (blobuploader) - INFO - Done attempting. 01:43:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:43:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:43:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:43:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:43:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:43:37 INFO - (blobuploader) - INFO - Done attempting. 01:43:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:43:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:43:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:43:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:43:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:43:38 INFO - (blobuploader) - INFO - Done attempting. 01:43:38 INFO - (blobuploader) - INFO - Iteration through files over. 01:43:38 INFO - Return code: 0 01:43:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:43:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:43:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65b01a115f7d477325e2fe1def69213744efe9682cec8321a7452074bd171e64f0219ef355ab41cc78a6850505cd61bb432b4ccec197bc368ae125b6c7af6fd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97b99e93c59bd316efc9851d2fd3f2c94b22644c9fc64c37107149e389e82571ba0fc59593a8171fed48e2df3f1f6bbed9e9e6c0ac4d01960c24667e8171d889", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d52a7fe358c328bc7a82517bf2b15bc63e8cf1ae20abb248dd9e242974e566b8727aee663e1e66006286d29a38380cf68641739791fe52fe47084c00164d6848"} 01:43:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:43:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:43:38 INFO - Contents: 01:43:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65b01a115f7d477325e2fe1def69213744efe9682cec8321a7452074bd171e64f0219ef355ab41cc78a6850505cd61bb432b4ccec197bc368ae125b6c7af6fd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97b99e93c59bd316efc9851d2fd3f2c94b22644c9fc64c37107149e389e82571ba0fc59593a8171fed48e2df3f1f6bbed9e9e6c0ac4d01960c24667e8171d889", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d52a7fe358c328bc7a82517bf2b15bc63e8cf1ae20abb248dd9e242974e566b8727aee663e1e66006286d29a38380cf68641739791fe52fe47084c00164d6848"} 01:43:38 INFO - Running post-run listener: copy_logs_to_upload_dir 01:43:38 INFO - Copying logs to upload dir... 01:43:38 INFO - mkdir: /builds/slave/test/build/upload/logs 01:43:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.250507 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-22 01:43:37.331412) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 01:43:37.334996) ========= 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=eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65b01a115f7d477325e2fe1def69213744efe9682cec8321a7452074bd171e64f0219ef355ab41cc78a6850505cd61bb432b4ccec197bc368ae125b6c7af6fd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97b99e93c59bd316efc9851d2fd3f2c94b22644c9fc64c37107149e389e82571ba0fc59593a8171fed48e2df3f1f6bbed9e9e6c0ac4d01960c24667e8171d889", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d52a7fe358c328bc7a82517bf2b15bc63e8cf1ae20abb248dd9e242974e566b8727aee663e1e66006286d29a38380cf68641739791fe52fe47084c00164d6848"} build_url:https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011483 build_url: 'https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65b01a115f7d477325e2fe1def69213744efe9682cec8321a7452074bd171e64f0219ef355ab41cc78a6850505cd61bb432b4ccec197bc368ae125b6c7af6fd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97b99e93c59bd316efc9851d2fd3f2c94b22644c9fc64c37107149e389e82571ba0fc59593a8171fed48e2df3f1f6bbed9e9e6c0ac4d01960c24667e8171d889", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d52a7fe358c328bc7a82517bf2b15bc63e8cf1ae20abb248dd9e242974e566b8727aee663e1e66006286d29a38380cf68641739791fe52fe47084c00164d6848"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 01:43:37.360797) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:43:37.361190) ========= 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=eca2ab57546de7b41f256b19000001ef-1466583774.366403-2050977293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:43:37.445222) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 01:43:37.445554) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 01:43:37.445836) ========= ========= Total master_lag: 0.18 =========