builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1466072905.39 results: success (0) buildid: 20160616023926 builduid: 915e0878fd51455b8783ce1dcde32337 revision: 2dbae52b1ab8e0caac12fcc233de8828ff810b73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:25.394583) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:25.395074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:25.395392) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:25.410383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:25.410704) ========= 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-1466072872.144675-767667780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 03:28:25-- 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% 113M=0s 2016-06-16 03:28:25 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:25.548548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:25.548879) ========= 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-1466072872.144675-767667780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016151 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:25.598717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:25.599093) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2dbae52b1ab8e0caac12fcc233de8828ff810b73 --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 2dbae52b1ab8e0caac12fcc233de8828ff810b73 --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-1466072872.144675-767667780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 03:28:25,787 truncating revision to first 12 chars 2016-06-16 03:28:25,787 Setting DEBUG logging. 2016-06-16 03:28:25,787 attempt 1/10 2016-06-16 03:28:25,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2dbae52b1ab8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 03:28:26,121 unpacking tar archive at: fx-team-2dbae52b1ab8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.659537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:26.272615) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:26.272960) ========= script_repo_revision: 2dbae52b1ab8e0caac12fcc233de8828ff810b73 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:26.273420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:26.273724) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 03:28:26.283131) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-16 03:28:26.283430) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:26 INFO - MultiFileLogger online at 20160616 03:28:26 in /builds/slave/test 03:28:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:28:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:26 INFO - {'append_to_log': False, 03:28:26 INFO - 'base_work_dir': '/builds/slave/test', 03:28:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:28:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:26 INFO - 'branch': 'Fx-Team-Non-PGO', 03:28:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:26 INFO - 'config_files': ('talos/linux_config.py',), 03:28:26 INFO - 'default_actions': ('clobber', 03:28:26 INFO - 'read-buildbot-config', 03:28:26 INFO - 'download-and-extract', 03:28:26 INFO - 'populate-webroot', 03:28:26 INFO - 'create-virtualenv', 03:28:26 INFO - 'install', 03:28:26 INFO - 'run-tests'), 03:28:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:26 INFO - 'download_minidump_stackwalk': True, 03:28:26 INFO - 'download_symbols': 'ondemand', 03:28:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:26 INFO - 'installer_path': 'installer.exe', 03:28:26 INFO - 'log_level': 'info', 03:28:26 INFO - 'log_name': 'talos', 03:28:26 INFO - 'log_to_console': True, 03:28:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:26 INFO - 'opt_config_files': (), 03:28:26 INFO - 'pip_index': False, 03:28:26 INFO - 'sps_profile': False, 03:28:26 INFO - 'sps_profile_interval': 0, 03:28:26 INFO - 'suite': 'dromaeojs', 03:28:26 INFO - 'system_bits': '32', 03:28:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:26 INFO - 'title': 'talos-linux64-ix-010', 03:28:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:26 INFO - 'use_talos_json': True, 03:28:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:26 INFO - 'work_dir': 'build'} 03:28:26 INFO - ##### 03:28:26 INFO - ##### Running clobber step. 03:28:26 INFO - ##### 03:28:26 INFO - Running pre-action listener: _resource_record_pre_action 03:28:26 INFO - Running main action method: clobber 03:28:26 INFO - rmtree: /builds/slave/test/build 03:28:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:27 INFO - Running post-action listener: _resource_record_post_action 03:28:27 INFO - ##### 03:28:27 INFO - ##### Finished clobber step (success) 03:28:27 INFO - ##### 03:28:27 INFO - ##### 03:28:27 INFO - ##### Running read-buildbot-config step. 03:28:27 INFO - ##### 03:28:27 INFO - Running pre-action listener: _resource_record_pre_action 03:28:27 INFO - Running main action method: read_buildbot_config 03:28:27 INFO - Using buildbot properties: 03:28:27 INFO - { 03:28:27 INFO - "project": "", 03:28:27 INFO - "product": "firefox", 03:28:27 INFO - "script_repo_revision": "production", 03:28:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:28:27 INFO - "repository": "", 03:28:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:28:27 INFO - "buildid": "20160616023926", 03:28:27 INFO - "pgo_build": "False", 03:28:27 INFO - "basedir": "/builds/slave/test", 03:28:27 INFO - "buildnumber": 1866, 03:28:27 INFO - "slavename": "talos-linux64-ix-010", 03:28:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:28:27 INFO - "platform": "ubuntu64_hw", 03:28:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:28:27 INFO - "branch": "fx-team", 03:28:27 INFO - "repo_path": "integration/fx-team", 03:28:27 INFO - "revision": "2dbae52b1ab8e0caac12fcc233de8828ff810b73", 03:28:27 INFO - "stage_platform": "linux64", 03:28:27 INFO - "builduid": "915e0878fd51455b8783ce1dcde32337", 03:28:27 INFO - "slavebuilddir": "test" 03:28:27 INFO - } 03:28:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:28:27 INFO - Running post-action listener: _resource_record_post_action 03:28:27 INFO - ##### 03:28:27 INFO - ##### Finished read-buildbot-config step (success) 03:28:27 INFO - ##### 03:28:27 INFO - ##### 03:28:27 INFO - ##### Running download-and-extract step. 03:28:27 INFO - ##### 03:28:27 INFO - Running pre-action listener: _resource_record_pre_action 03:28:27 INFO - Running main action method: download_and_extract 03:28:27 INFO - mkdir: /builds/slave/test/build/tests 03:28: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')]} 03:28:27 INFO - https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/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 03:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/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 03:28:27 INFO - Downloaded 1361 bytes. 03:28:27 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:28:27 INFO - Using the following test package requirements: 03:28:27 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:28:27 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:28:27 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:28:27 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:27 INFO - u'jsshell-linux-x86_64.zip'], 03:28:27 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:28:27 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:28:27 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:28:27 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:28:27 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:28:27 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:27 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:28:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:28: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')]} 03:28:27 INFO - https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/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 03:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/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 03:28:28 INFO - Downloaded 22654315 bytes. 03:28:28 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'] 03:28:28 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 03:28:30 INFO - Return code: 0 03:28:30 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 03:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:30 INFO - https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:28:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:28:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/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 03:28:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/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 03:28:31 INFO - Downloaded 22654315 bytes. 03:28:31 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'] 03:28:31 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 03:28:32 INFO - Return code: 0 03:28:32 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')]} 03:28:32 INFO - https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:28:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:28:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:28:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/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 03:28:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/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 03:28:33 INFO - Downloaded 14405384 bytes. 03:28:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:28:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:28:33 INFO - Return code: 0 03:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:33 INFO - https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:28:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:28:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:28:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/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 03:28:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JktiOVXwRDGd6TW0r-BqBg/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 03:28:35 INFO - Downloaded 55445863 bytes. 03:28:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:28:35 INFO - mkdir: /builds/slave/test/properties 03:28:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:35 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:35 INFO - Contents: 03:28:35 INFO - build_url:https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:28:35 INFO - Running post-action listener: _resource_record_post_action 03:28:35 INFO - Running post-action listener: set_extra_try_arguments 03:28:35 INFO - ##### 03:28:35 INFO - ##### Finished download-and-extract step (success) 03:28:35 INFO - ##### 03:28:35 INFO - ##### 03:28:35 INFO - ##### Running populate-webroot step. 03:28:35 INFO - ##### 03:28:35 INFO - Running pre-action listener: _resource_record_pre_action 03:28:35 INFO - Running main action method: populate_webroot 03:28:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:36 INFO - '--tppagecycles', 03:28:36 INFO - '7'], 03:28:36 INFO - 'tests': ['tsvgm']}}, 03:28:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:36 INFO - 'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:36 INFO - 'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['damp', 'tps']}, 03:28:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:36 INFO - 'tests': ['damp', 'tps']}, 03:28:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['dromaeo_dom']}, 03:28:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['basic_compositor_video']}, 03:28:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:28:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['a11yr', 03:28:36 INFO - 'ts_paint', 03:28:36 INFO - 'tpaint', 03:28:36 INFO - 'sessionrestore', 03:28:36 INFO - 'sessionrestore_no_auto_restore', 03:28:36 INFO - 'tabpaint']}, 03:28:36 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:36 INFO - 'ts_paint', 03:28:36 INFO - 'tpaint', 03:28:36 INFO - 'sessionrestore', 03:28:36 INFO - 'sessionrestore_no_auto_restore', 03:28:36 INFO - 'tabpaint']}, 03:28:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:36 INFO - 'ts_paint', 03:28:36 INFO - 'tpaint', 03:28:36 INFO - 'sessionrestore', 03:28:36 INFO - 'sessionrestore_no_auto_restore', 03:28:36 INFO - 'tabpaint']}, 03:28:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:36 INFO - 'ts_paint', 03:28:36 INFO - 'tpaint', 03:28:36 INFO - 'sessionrestore', 03:28:36 INFO - 'sessionrestore_no_auto_restore', 03:28:36 INFO - 'tabpaint']}, 03:28:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['a11yr', 03:28:36 INFO - 'ts_paint', 03:28:36 INFO - 'tpaint', 03:28:36 INFO - 'sessionrestore', 03:28:36 INFO - 'sessionrestore_no_auto_restore', 03:28:36 INFO - 'tabpaint']}, 03:28:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['a11yr', 03:28:36 INFO - 'ts_paint', 03:28:36 INFO - 'tpaint', 03:28:36 INFO - 'sessionrestore', 03:28:36 INFO - 'sessionrestore_no_auto_restore', 03:28:36 INFO - 'tabpaint']}, 03:28:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['tsvgx', 03:28:36 INFO - 'tsvgr_opacity', 03:28:36 INFO - 'tart', 03:28:36 INFO - 'tscrollx', 03:28:36 INFO - 'cart']}, 03:28:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:36 INFO - 'tsvgr_opacity', 03:28:36 INFO - 'tart', 03:28:36 INFO - 'tscrollx', 03:28:36 INFO - 'cart']}, 03:28:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:36 INFO - 'talos_options': ['--disable-e10s'], 03:28:36 INFO - 'tests': ['tp5o']}, 03:28:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:36 INFO - 'tests': ['tp5o']}, 03:28:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:36 INFO - 'talos_options': ['--disable-e10s', 03:28:36 INFO - '--xperf_path', 03:28:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:36 INFO - 'tests': ['tp5n']}, 03:28:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:36 INFO - 'talos_options': ['--xperf_path', 03:28:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:36 INFO - 'tests': ['tp5n']}}, 03:28:36 INFO - 'talos.zip': {'path': '', 03:28:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:36 INFO - Running post-action listener: _resource_record_post_action 03:28:36 INFO - ##### 03:28:36 INFO - ##### Finished populate-webroot step (success) 03:28:36 INFO - ##### 03:28:36 INFO - ##### 03:28:36 INFO - ##### Running create-virtualenv step. 03:28:36 INFO - ##### 03:28:36 INFO - Running pre-action listener: _resource_record_pre_action 03:28:36 INFO - Running main action method: create_virtualenv 03:28:36 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:28:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:36 INFO - Using real prefix '/usr' 03:28:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:36 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:38 INFO - Installing pip.................done. 03:28:38 INFO - Return code: 0 03:28:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb5b063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, '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-1466072872.144675-767667780', '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 03:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:28:38 INFO - Using env: {'DISPLAY': ':0', 03:28:38 INFO - 'HOME': '/home/cltbld', 03:28:38 INFO - 'LANG': 'en_US.UTF-8', 03:28:38 INFO - 'LANGUAGE': 'en_US:en', 03:28:38 INFO - 'LOGNAME': 'cltbld', 03:28:38 INFO - 'MAIL': '/var/mail/cltbld', 03:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:38 INFO - 'MOZ_NO_REMOTE': '1', 03:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:38 INFO - 'NO_EM_RESTART': '1', 03:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:38 INFO - 'PWD': '/builds/slave/test', 03:28:38 INFO - 'SHELL': '/bin/bash', 03:28:38 INFO - 'SHLVL': '1', 03:28:38 INFO - 'TERM': 'linux', 03:28:38 INFO - 'TMOUT': '86400', 03:28:38 INFO - 'USER': 'cltbld', 03:28:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:38 INFO - '_': '/tools/buildbot/bin/python'} 03:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:38 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 03:28:38 INFO - Cleaning up... 03:28:38 INFO - Return code: 0 03:28:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdb5b063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, '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-1466072872.144675-767667780', '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 03:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:28:38 INFO - Using env: {'DISPLAY': ':0', 03:28:38 INFO - 'HOME': '/home/cltbld', 03:28:38 INFO - 'LANG': 'en_US.UTF-8', 03:28:38 INFO - 'LANGUAGE': 'en_US:en', 03:28:38 INFO - 'LOGNAME': 'cltbld', 03:28:38 INFO - 'MAIL': '/var/mail/cltbld', 03:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:38 INFO - 'MOZ_NO_REMOTE': '1', 03:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:38 INFO - 'NO_EM_RESTART': '1', 03:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:38 INFO - 'PWD': '/builds/slave/test', 03:28:38 INFO - 'SHELL': '/bin/bash', 03:28:38 INFO - 'SHLVL': '1', 03:28:38 INFO - 'TERM': 'linux', 03:28:38 INFO - 'TMOUT': '86400', 03:28:38 INFO - 'USER': 'cltbld', 03:28:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:38 INFO - '_': '/tools/buildbot/bin/python'} 03:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:39 INFO - Downloading/unpacking psutil>=3.1.1 03:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:41 INFO - Installing collected packages: psutil 03:28:41 INFO - Running setup.py install for psutil 03:28:41 INFO - building 'psutil._psutil_linux' extension 03:28:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:28:41 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 03:28:41 INFO - building 'psutil._psutil_posix' extension 03:28:41 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 03:28:41 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 03:28:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:41 INFO - Successfully installed psutil 03:28:41 INFO - Cleaning up... 03:28:41 INFO - Return code: 0 03:28:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:41 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')]} 03:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:41 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')]} 03:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:41 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 0x7fdb5b063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, '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-1466072872.144675-767667780', '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 03:28:41 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 03:28:41 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 03:28:41 INFO - Using env: {'DISPLAY': ':0', 03:28:41 INFO - 'HOME': '/home/cltbld', 03:28:41 INFO - 'LANG': 'en_US.UTF-8', 03:28:41 INFO - 'LANGUAGE': 'en_US:en', 03:28:41 INFO - 'LOGNAME': 'cltbld', 03:28:41 INFO - 'MAIL': '/var/mail/cltbld', 03:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:41 INFO - 'MOZ_NO_REMOTE': '1', 03:28:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:41 INFO - 'NO_EM_RESTART': '1', 03:28:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:41 INFO - 'PWD': '/builds/slave/test', 03:28:41 INFO - 'SHELL': '/bin/bash', 03:28:41 INFO - 'SHLVL': '1', 03:28:41 INFO - 'TERM': 'linux', 03:28:41 INFO - 'TMOUT': '86400', 03:28:41 INFO - 'USER': 'cltbld', 03:28:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:41 INFO - '_': '/tools/buildbot/bin/python'} 03:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:43 INFO - Installing collected packages: mozsystemmonitor 03:28:43 INFO - Running setup.py install for mozsystemmonitor 03:28:43 INFO - Successfully installed mozsystemmonitor 03:28:43 INFO - Cleaning up... 03:28:43 INFO - Return code: 0 03:28:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdb5b063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, '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-1466072872.144675-767667780', '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 03:28:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:28:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:28:43 INFO - Using env: {'DISPLAY': ':0', 03:28:43 INFO - 'HOME': '/home/cltbld', 03:28:43 INFO - 'LANG': 'en_US.UTF-8', 03:28:43 INFO - 'LANGUAGE': 'en_US:en', 03:28:43 INFO - 'LOGNAME': 'cltbld', 03:28:43 INFO - 'MAIL': '/var/mail/cltbld', 03:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:43 INFO - 'MOZ_NO_REMOTE': '1', 03:28:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:43 INFO - 'NO_EM_RESTART': '1', 03:28:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:43 INFO - 'PWD': '/builds/slave/test', 03:28:43 INFO - 'SHELL': '/bin/bash', 03:28:43 INFO - 'SHLVL': '1', 03:28:43 INFO - 'TERM': 'linux', 03:28:43 INFO - 'TMOUT': '86400', 03:28:43 INFO - 'USER': 'cltbld', 03:28:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:43 INFO - '_': '/tools/buildbot/bin/python'} 03:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:44 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:46 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:46 INFO - warning: no files found matching '*.txt' 03:28:46 INFO - no previously-included directories found matching 'build' 03:28:46 INFO - no previously-included directories found matching 'dist' 03:28:46 INFO - no previously-included directories found matching '.git*' 03:28:46 INFO - Installing collected packages: jsonschema, functools32 03:28:46 INFO - Running setup.py install for functools32 03:28:46 INFO - warning: no files found matching '*.txt' 03:28:46 INFO - no previously-included directories found matching 'build' 03:28:46 INFO - no previously-included directories found matching 'dist' 03:28:46 INFO - no previously-included directories found matching '.git*' 03:28:46 INFO - Successfully installed jsonschema functools32 03:28:46 INFO - Cleaning up... 03:28:46 INFO - Return code: 0 03:28:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:46 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 0x7fdb5b063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, '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-1466072872.144675-767667780', '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 03:28:46 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 03:28:46 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 03:28:46 INFO - Using env: {'DISPLAY': ':0', 03:28:46 INFO - 'HOME': '/home/cltbld', 03:28:46 INFO - 'LANG': 'en_US.UTF-8', 03:28:46 INFO - 'LANGUAGE': 'en_US:en', 03:28:46 INFO - 'LOGNAME': 'cltbld', 03:28:46 INFO - 'MAIL': '/var/mail/cltbld', 03:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:46 INFO - 'MOZ_NO_REMOTE': '1', 03:28:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:46 INFO - 'NO_EM_RESTART': '1', 03:28:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:46 INFO - 'PWD': '/builds/slave/test', 03:28:46 INFO - 'SHELL': '/bin/bash', 03:28:46 INFO - 'SHLVL': '1', 03:28:46 INFO - 'TERM': 'linux', 03:28:46 INFO - 'TMOUT': '86400', 03:28:46 INFO - 'USER': 'cltbld', 03:28:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:46 INFO - '_': '/tools/buildbot/bin/python'} 03:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:46 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:48 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:48 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 03:28:48 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 03:28:48 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 03:28:48 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 03:28:48 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 03:28:48 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 03:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:49 INFO - Downloading docopt-0.6.1.tar.gz 03:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:49 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:49 INFO - Running setup.py install for blobuploader 03:28:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:49 INFO - Running setup.py install for requests 03:28:49 INFO - Running setup.py install for docopt 03:28:49 INFO - Successfully installed blobuploader requests docopt 03:28:49 INFO - Cleaning up... 03:28:49 INFO - Return code: 0 03:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:49 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')]} 03:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:49 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')]} 03:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:49 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 0x7fdb5b063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, '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-1466072872.144675-767667780', '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 03:28:49 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 03:28:49 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 03:28:49 INFO - Using env: {'DISPLAY': ':0', 03:28:49 INFO - 'HOME': '/home/cltbld', 03:28:49 INFO - 'LANG': 'en_US.UTF-8', 03:28:49 INFO - 'LANGUAGE': 'en_US:en', 03:28:49 INFO - 'LOGNAME': 'cltbld', 03:28:49 INFO - 'MAIL': '/var/mail/cltbld', 03:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:49 INFO - 'MOZ_NO_REMOTE': '1', 03:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:49 INFO - 'NO_EM_RESTART': '1', 03:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:49 INFO - 'PWD': '/builds/slave/test', 03:28:49 INFO - 'SHELL': '/bin/bash', 03:28:49 INFO - 'SHLVL': '1', 03:28:49 INFO - 'TERM': 'linux', 03:28:49 INFO - 'TMOUT': '86400', 03:28:49 INFO - 'USER': 'cltbld', 03:28:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:49 INFO - '_': '/tools/buildbot/bin/python'} 03:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:50 INFO - Running setup.py (path:/tmp/pip-uzk0iZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:50 INFO - Running setup.py (path:/tmp/pip-80fqzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:50 INFO - Running setup.py (path:/tmp/pip-0G0jDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:50 INFO - Running setup.py (path:/tmp/pip-XolD1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:50 INFO - Running setup.py (path:/tmp/pip-Zkoc7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:50 INFO - Running setup.py (path:/tmp/pip-bmO7GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:50 INFO - Running setup.py (path:/tmp/pip-_X6x17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:50 INFO - Running setup.py (path:/tmp/pip-CZ4g00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:50 INFO - Running setup.py (path:/tmp/pip-3jQcbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:50 INFO - Running setup.py (path:/tmp/pip-73ZjsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:50 INFO - Running setup.py (path:/tmp/pip-Px1pOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:50 INFO - Running setup.py (path:/tmp/pip-iBivPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:51 INFO - Running setup.py (path:/tmp/pip-gxMBFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:51 INFO - Running setup.py (path:/tmp/pip-t6CjPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:51 INFO - Running setup.py (path:/tmp/pip-iIPBgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:51 INFO - Running setup.py (path:/tmp/pip-U9O3Nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:51 INFO - Running setup.py (path:/tmp/pip-ZrmkoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:51 INFO - Running setup.py install for manifestparser 03:28:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:51 INFO - Running setup.py install for mozcrash 03:28:51 INFO - Running setup.py install for mozdebug 03:28:51 INFO - Running setup.py install for mozdevice 03:28:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:51 INFO - Running setup.py install for mozfile 03:28:51 INFO - Running setup.py install for mozhttpd 03:28:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Running setup.py install for mozinfo 03:28:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Running setup.py install for mozInstall 03:28:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Running setup.py install for mozleak 03:28:52 INFO - Running setup.py install for mozlog 03:28:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Running setup.py install for moznetwork 03:28:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Running setup.py install for mozprocess 03:28:52 INFO - Running setup.py install for mozprofile 03:28:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Running setup.py install for mozrunner 03:28:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:52 INFO - Running setup.py install for mozscreenshot 03:28:53 INFO - Running setup.py install for moztest 03:28:53 INFO - Running setup.py install for mozversion 03:28:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:53 INFO - Cleaning up... 03:28:53 INFO - Return code: 0 03:28:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb5b063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, '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-1466072872.144675-767667780', '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 03:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:53 INFO - Using env: {'DISPLAY': ':0', 03:28:53 INFO - 'HOME': '/home/cltbld', 03:28:53 INFO - 'LANG': 'en_US.UTF-8', 03:28:53 INFO - 'LANGUAGE': 'en_US:en', 03:28:53 INFO - 'LOGNAME': 'cltbld', 03:28:53 INFO - 'MAIL': '/var/mail/cltbld', 03:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:53 INFO - 'MOZ_NO_REMOTE': '1', 03:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:53 INFO - 'NO_EM_RESTART': '1', 03:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:53 INFO - 'PWD': '/builds/slave/test', 03:28:53 INFO - 'SHELL': '/bin/bash', 03:28:53 INFO - 'SHLVL': '1', 03:28:53 INFO - 'TERM': 'linux', 03:28:53 INFO - 'TMOUT': '86400', 03:28:53 INFO - 'USER': 'cltbld', 03:28:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:53 INFO - '_': '/tools/buildbot/bin/python'} 03:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:53 INFO - Running setup.py (path:/tmp/pip-fB1zm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:53 INFO - Running setup.py (path:/tmp/pip-3hsPdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:53 INFO - Running setup.py (path:/tmp/pip-Fl6zeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:53 INFO - Running setup.py (path:/tmp/pip-Nb4t7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:53 INFO - Running setup.py (path:/tmp/pip-EK1VMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:53 INFO - Running setup.py (path:/tmp/pip-eFyH37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:53 INFO - Running setup.py (path:/tmp/pip-tx1FOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:53 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)) 03:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:53 INFO - Running setup.py (path:/tmp/pip-aKKreG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:54 INFO - Running setup.py (path:/tmp/pip-0LlKyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:54 INFO - Running setup.py (path:/tmp/pip-DCLcCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:54 INFO - Running setup.py (path:/tmp/pip-679atJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:54 INFO - Running setup.py (path:/tmp/pip-6aKd6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:54 INFO - Running setup.py (path:/tmp/pip-d9BF6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:54 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)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:54 INFO - Running setup.py (path:/tmp/pip-u1iT10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:54 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)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:54 INFO - Running setup.py (path:/tmp/pip-pvzk3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:54 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)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:54 INFO - Running setup.py (path:/tmp/pip-1O9wPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:54 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)) 03:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:54 INFO - Running setup.py (path:/tmp/pip-NVENx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:54 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)) 03:28:54 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)) 03:28:54 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)) 03:28:54 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)) 03:28:54 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)) 03:28:54 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)) 03:28:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:56 INFO - Downloading blessings-1.6.tar.gz 03:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:56 INFO - Installing collected packages: blessings 03:28:56 INFO - Running setup.py install for blessings 03:28:56 INFO - Successfully installed blessings 03:28:56 INFO - Cleaning up... 03:28:56 INFO - Return code: 0 03:28:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:57 INFO - Reading from file tmpfile_stdout 03:28:57 INFO - Current package versions: 03:28:57 INFO - argparse == 1.2.1 03:28:57 INFO - blessings == 1.6 03:28:57 INFO - blobuploader == 1.2.4 03:28:57 INFO - docopt == 0.6.1 03:28:57 INFO - functools32 == 3.2.3-2 03:28:57 INFO - jsonschema == 2.5.1 03:28:57 INFO - manifestparser == 1.1 03:28:57 INFO - mozInstall == 1.12 03:28:57 INFO - mozcrash == 0.17 03:28:57 INFO - mozdebug == 0.1 03:28:57 INFO - mozdevice == 0.48 03:28:57 INFO - mozfile == 1.2 03:28:57 INFO - mozhttpd == 0.7 03:28:57 INFO - mozinfo == 0.9 03:28:57 INFO - mozleak == 0.1 03:28:57 INFO - mozlog == 3.2 03:28:57 INFO - moznetwork == 0.27 03:28:57 INFO - mozprocess == 0.22 03:28:57 INFO - mozprofile == 0.28 03:28:57 INFO - mozrunner == 6.11 03:28:57 INFO - mozscreenshot == 0.1 03:28:57 INFO - mozsystemmonitor == 0.3 03:28:57 INFO - moztest == 0.7 03:28:57 INFO - mozversion == 1.4 03:28:57 INFO - psutil == 3.1.1 03:28:57 INFO - requests == 1.2.3 03:28:57 INFO - wsgiref == 0.1.2 03:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb5b063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, '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-1466072872.144675-767667780', '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 03:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:57 INFO - Using env: {'DISPLAY': ':0', 03:28:57 INFO - 'HOME': '/home/cltbld', 03:28:57 INFO - 'LANG': 'en_US.UTF-8', 03:28:57 INFO - 'LANGUAGE': 'en_US:en', 03:28:57 INFO - 'LOGNAME': 'cltbld', 03:28:57 INFO - 'MAIL': '/var/mail/cltbld', 03:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:57 INFO - 'MOZ_NO_REMOTE': '1', 03:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:57 INFO - 'NO_EM_RESTART': '1', 03:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:57 INFO - 'PWD': '/builds/slave/test', 03:28:57 INFO - 'SHELL': '/bin/bash', 03:28:57 INFO - 'SHLVL': '1', 03:28:57 INFO - 'TERM': 'linux', 03:28:57 INFO - 'TMOUT': '86400', 03:28:57 INFO - 'USER': 'cltbld', 03:28:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:57 INFO - '_': '/tools/buildbot/bin/python'} 03:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:57 INFO - Cleaning up... 03:28:57 INFO - Return code: 0 03:28:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb5b063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, '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-1466072872.144675-767667780', '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 03:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:28:57 INFO - Using env: {'DISPLAY': ':0', 03:28:57 INFO - 'HOME': '/home/cltbld', 03:28:57 INFO - 'LANG': 'en_US.UTF-8', 03:28:57 INFO - 'LANGUAGE': 'en_US:en', 03:28:57 INFO - 'LOGNAME': 'cltbld', 03:28:57 INFO - 'MAIL': '/var/mail/cltbld', 03:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:57 INFO - 'MOZ_NO_REMOTE': '1', 03:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:57 INFO - 'NO_EM_RESTART': '1', 03:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:57 INFO - 'PWD': '/builds/slave/test', 03:28:57 INFO - 'SHELL': '/bin/bash', 03:28:57 INFO - 'SHLVL': '1', 03:28:57 INFO - 'TERM': 'linux', 03:28:57 INFO - 'TMOUT': '86400', 03:28:57 INFO - 'USER': 'cltbld', 03:28:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:57 INFO - '_': '/tools/buildbot/bin/python'} 03:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:57 INFO - Cleaning up... 03:28:57 INFO - Return code: 0 03:28:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb5b063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, '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-1466072872.144675-767667780', '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 03:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:28:57 INFO - Using env: {'DISPLAY': ':0', 03:28:57 INFO - 'HOME': '/home/cltbld', 03:28:57 INFO - 'LANG': 'en_US.UTF-8', 03:28:57 INFO - 'LANGUAGE': 'en_US:en', 03:28:57 INFO - 'LOGNAME': 'cltbld', 03:28:57 INFO - 'MAIL': '/var/mail/cltbld', 03:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:57 INFO - 'MOZ_NO_REMOTE': '1', 03:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:57 INFO - 'NO_EM_RESTART': '1', 03:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:57 INFO - 'PWD': '/builds/slave/test', 03:28:57 INFO - 'SHELL': '/bin/bash', 03:28:57 INFO - 'SHLVL': '1', 03:28:57 INFO - 'TERM': 'linux', 03:28:57 INFO - 'TMOUT': '86400', 03:28:57 INFO - 'USER': 'cltbld', 03:28:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:57 INFO - '_': '/tools/buildbot/bin/python'} 03:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:57 INFO - Downloading/unpacking flake8 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:28:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:28:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:29:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:29:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:29:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:29:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:29:00 INFO - no previously-included directories found matching 'docs/_build' 03:29:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:29:00 INFO - Running setup.py install for pep8 03:29:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:29:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:29:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:29:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:29:00 INFO - no previously-included directories found matching 'docs/_build' 03:29:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:29:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:29:00 INFO - Cleaning up... 03:29:00 INFO - Return code: 0 03:29:00 INFO - Running post-action listener: _resource_record_post_action 03:29:00 INFO - Running post-action listener: _start_resource_monitoring 03:29:00 INFO - Starting resource monitoring. 03:29:00 INFO - ##### 03:29:00 INFO - ##### Finished create-virtualenv step (success) 03:29:00 INFO - ##### 03:29:00 INFO - ##### 03:29:00 INFO - ##### Running install step. 03:29:00 INFO - ##### 03:29:00 INFO - Running pre-action listener: _resource_record_pre_action 03:29:00 INFO - Running main action method: install 03:29:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:00 INFO - Reading from file tmpfile_stdout 03:29:00 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:00 INFO - Reading from file tmpfile_stdout 03:29:00 INFO - Output received: 03:29:00 INFO - Usage: mozinstall [options] installer 03:29:00 INFO - Options: 03:29:00 INFO - -h, --help show this help message and exit 03:29:00 INFO - -d DEST, --destination=DEST 03:29:00 INFO - Directory to install application into. [default: 03:29:00 INFO - "/builds/slave/test"] 03:29:00 INFO - --app=APP Application being installed. [default: firefox] 03:29:00 INFO - mkdir: /builds/slave/test/build/application 03:29:00 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'] 03:29:00 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 03:29:16 INFO - Reading from file tmpfile_stdout 03:29:16 INFO - Output received: 03:29:16 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:16 INFO - Running post-action listener: _resource_record_post_action 03:29:16 INFO - ##### 03:29:16 INFO - ##### Finished install step (success) 03:29:16 INFO - ##### 03:29:16 INFO - ##### 03:29:16 INFO - ##### Running run-tests step. 03:29:16 INFO - ##### 03:29:16 INFO - Running pre-action listener: _resource_record_pre_action 03:29:16 INFO - Running main action method: run_tests 03:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:16 INFO - Python 2.7.3 03:29:16 INFO - Return code: 0 03:29:16 INFO - grabbing minidump binary from tooltool 03:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:16 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 0x10be1c0>, '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 0x10bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bf550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:16 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 03:29:16 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 03:29:16 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 03:29:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:16 INFO - Return code: 0 03:29:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:29:17 INFO - Return code: 0 03:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/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_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:29:17 INFO - Using env: {'DISPLAY': ':0', 03:29:17 INFO - 'HOME': '/home/cltbld', 03:29:17 INFO - 'LANG': 'en_US.UTF-8', 03:29:17 INFO - 'LANGUAGE': 'en_US:en', 03:29:17 INFO - 'LOGNAME': 'cltbld', 03:29:17 INFO - 'MAIL': '/var/mail/cltbld', 03:29:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:17 INFO - 'MOZ_NO_REMOTE': '1', 03:29:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:17 INFO - 'NO_EM_RESTART': '1', 03:29:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:17 INFO - 'PWD': '/builds/slave/test', 03:29:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:17 INFO - 'SHELL': '/bin/bash', 03:29:17 INFO - 'SHLVL': '1', 03:29:17 INFO - 'TERM': 'linux', 03:29:17 INFO - 'TMOUT': '86400', 03:29:17 INFO - 'USER': 'cltbld', 03:29:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466072872.144675-767667780', 03:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:17 INFO - '_': '/tools/buildbot/bin/python'} 03:29:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/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_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:29:18 INFO - mozversion application_buildid: 20160616023926 03:29:18 INFO - mozversion application_changeset: 2dbae52b1ab8e0caac12fcc233de8828ff810b73 03:29:18 INFO - mozversion application_display_name: Nightly 03:29:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:18 INFO - mozversion application_name: Firefox 03:29:18 INFO - mozversion application_remotingname: firefox 03:29:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:29:18 INFO - mozversion application_vendor: Mozilla 03:29:18 INFO - mozversion application_version: 50.0a1 03:29:18 INFO - mozversion platform_buildid: 20160616023926 03:29:18 INFO - mozversion platform_changeset: 2dbae52b1ab8e0caac12fcc233de8828ff810b73 03:29:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:29:18 INFO - mozversion platform_version: 50.0a1 03:29:18 INFO - using testdate: 1466072958 03:29:18 INFO - actual date: 1466072958 03:29:18 INFO - starting webserver on 'localhost:50870' 03:29:18 INFO - SUITE-START | Running 2 tests 03:29:18 INFO - TEST-START | dromaeo_css 03:29:18 INFO - operating with platform_type : linux_ 03:29:18 INFO - Initialising browser for dromaeo_css test... 03:29:18 INFO - TEST-INFO | started process 15867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp16EcE2/profile http://localhost:50870/getInfo.html) 03:29:22 INFO - PROCESS | 15867 | __metrics Screen width/height:1600/1200 03:29:22 INFO - PROCESS | 15867 | colorDepth:24 03:29:22 INFO - PROCESS | 15867 | Browser inner width/height: 1024/697 03:29:22 INFO - PROCESS | 15867 | __metrics 03:29:24 INFO - PROCESS | 15867 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:29:25 INFO - TEST-INFO | 15867: exit 0 03:29:25 INFO - Browser initialized. 03:29:25 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:25 INFO - TEST-INFO | started process 15951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp16EcE2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:37 INFO - PROCESS | 15951 | RSS: Main: 175300608 03:29:37 INFO - PROCESS | 15951 | 03:30:28 INFO - PROCESS | 15951 | 1466073028542 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] 03:32:41 INFO - PROCESS | 15951 | Cycle 1(1): loaded http://localhost:50870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50870/tests/dromaeo/cssquery-ext.html) 03:32:42 INFO - PROCESS | 15951 | RSS: Main: 256032768 03:32:42 INFO - PROCESS | 15951 | 03:35:45 INFO - PROCESS | 15951 | Cycle 1(1): loaded http://localhost:50870/tests/dromaeo/cssquery-ext.html (next: http://localhost:50870/tests/dromaeo/cssquery-jquery.html) 03:35:46 INFO - PROCESS | 15951 | RSS: Main: 258514944 03:35:46 INFO - PROCESS | 15951 | 03:38:48 INFO - PROCESS | 15951 | Cycle 1(1): loaded http://localhost:50870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50870/tests/dromaeo/cssquery-mootools.html) 03:38:48 INFO - PROCESS | 15951 | RSS: Main: 261074944 03:38:48 INFO - PROCESS | 15951 | 03:41:51 INFO - PROCESS | 15951 | Cycle 1(1): loaded http://localhost:50870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50870/tests/dromaeo/cssquery-prototype.html) 03:41:51 INFO - PROCESS | 15951 | RSS: Main: 257040384 03:41:51 INFO - PROCESS | 15951 | 03:44:54 INFO - PROCESS | 15951 | Cycle 1(1): loaded http://localhost:50870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50870/tests/dromaeo/cssquery-yui.html) 03:44:55 INFO - PROCESS | 15951 | RSS: Main: 235651072 03:44:55 INFO - PROCESS | 15951 | 03:47:58 INFO - PROCESS | 15951 | Cycle 1(1): loaded http://localhost:50870/tests/dromaeo/cssquery-yui.html (next: http://localhost:50870/tests/dromaeo/cssquery-dojo.html) 03:47:58 INFO - PROCESS | 15951 | RSS: Main: 289816576 03:47:58 INFO - PROCESS | 15951 | 03:47:58 INFO - PROCESS | 15951 | __start_tp_report 03:47:58 INFO - PROCESS | 15951 | _x_x_mozilla_page_load 03:47:58 INFO - PROCESS | 15951 | _x_x_mozilla_page_load_details 03:47:58 INFO - PROCESS | 15951 | |i|pagename|runs| 03:47:58 INFO - PROCESS | 15951 | |0;dojo.html;2647.4175681350107;2655.561832297671;2688.776606643977;2691.865406729663;2696.824706394085;4620.838270660528;4723.574878260956;4768.475467698555;4836.37127173467;4930.654854160211;4775.522447755223;4777.474477807438;4799.808007679689;4861.538153875376;4871.025794841028;4347.86956391308;4386.868393948187;4439.178751930887;4470.642348612119;4536.228841097021;4439.245328294198;4453.153900758845;4476.731396116244;4486.192485352635;4509.661775366844;4366.6070053695;4390.824367025315;4408.955910440886;4412.713173643703;4436.911261774779;4392.472903251598;4405.757683327416;4425.336199570058;4456.041950980522;4462.085272519126;4433.6009759121835;4443.866683999485;4452.866414007585;4458.1306645204195;4495.235809912323;4731.881702957454;4756.976215118937;4815;4824.541668541518;4830.3237546743485;5253.448387919251;5259.737013149327;5260.92108618371;5275.235090911835;5287.286216360781;5236.7905283788605;5261.105612045962;5272.762725677316;5278.709670968095;5279.788808447657;4780.976095119537;4826.348442960226;4876.366072410564;4882.096812089775;4911.361523001987;5303.4696530346655;5371.409144994048;5425.321834770653;5425.647332923348;5431.918521222185;4972.701637901738;5145.845624631267;5183.870403239949;5195.350581177353;5202;5163.122269214243;5212.609054320866;5236.0575096482235;5238.371395432497;5242.318498595158;5189.532942035159;5202.375714914235;5203.271541984125;5204.635675502678;5252.606054545924;4996.7501624918605;5047.570956468741;5162.870928226825;5186.533212010937;5187.740612969412;4342.109867477159;4357.651387888961;4361.433013708198;4367.67242456817;4404.515503294635;3794.905127371783;3822.2928758179823;3830.0807806126886;3844.557875844258;3872;4319.200947824663;4492.0791237796175;4496;4503.234450143484;4543.818247270138;5158.819441319536;5162.561182299547;5168.9741551292755;5173.844784656466;5197.194434862602;4421.9336709949375;4424.115176964556;4425.756583387944;4443.955560444419;4452.910941781146;4555.726656400627;4559.407277054028;4640.512746161672;4645.256758918556;4675.812967481263;4820.783064762024;4838.7338696372035;4857;4867.245576935581;4916.7541622918;5176.948230517797;5187.688738675692;5187.844364669066;5195.844124676266;5253.816116435906;4752.857414277577;4812.06164797875;4820.614350851994;4828.589569886599;4906.9018619626695;5097.566706829961;5117.078925793393;5117.309163262912;5156.922646160236;5169.663971841818;5199.688018718889;5216.061109000265;5217.973910130425;5225;5271.525562699376;4919.704817710949;4984.675996060245;5002.724850133278;5035.823746168867;5040.974795126001;5046.621503387188;5050.49495050492;5054.21659642756;5061.974690126526;5102.948970510248;4917.852464426073;4925.556699897026;4969.552740253394;4991.450940396481;4994.175960966545;4938.111139994692;5003.849884503471;5037.672551284155;5057.31726216956;5081.517255860687;4949.356583644103;4970.130227210296;4973.055119527278;4981.975090124672;5029.823956161516 03:47:58 INFO - PROCESS | 15951 | |1;ext.html;553.361192207148;575.4964406144624;579.487153868826;582.7756313819178;590.4951266667;27008.594871076926;29327.560086598718;29389.11832645019;29390;29408;30087.548686769715;39597.60402395975;40233.19533609326;40393;45499.77250113753;7856.528608283507;7964.323032542212;7978.680852765911;7984.361251099898;7985.441019128663;7606.543607383547;7831.9216807832045;7902.20977902211;7923.366130709558;7925.405594580401;10118.645847395343;10423.791524169512;10429.68710938673;10833.512491937843;10839.67480975572;10253;10354.689359319233;10355.585776568929;10357.948210258975;10361.274710770249;7562.886556701654;9899.604015839357;10144.188464922789;10214.489275536194;10284;38405.423918641245;38753.224935501414;38757.80621096877;38794.418083728764;39082.413763793564;2912.533994560881;3063.1576316513137;3128.0772172209254;3439.914002149941;3637.508936293593;29169.416611667646;29841.850790745906;29855.10434686963;30319.545206821917;30501.237469063228;3622.42041273395;3623.655752703489;3639.5450568678916;3667.21154951684;3719.6466335698065;247970;249834;250327;250643;250722;54200.45799541954;54755.452445475035;54790;54837;54879;57015.714921425126;57200.71399642975;57217.427825721206;57235.42764572301;57249.14126288109;13960;14451.927740361441;14478.203698796457;14483;14509.419623214953;10712.732181695364;10715.19636027301;10721.142308615292;10728.624498142528;10742.731431714114;16380.344786208656;17731;17913.492111104457;18296.45110646656;18317.3588924387;6623.172103487064;6708.865822683519;6798.626075565792;6808.455323574102;6837.521373503807;760.9733659322007;937.4937533731845;964.5659453246068;1000.7298029531986;1061.9256652034283;27589.31026724308;27604.30989225245;28134.85932570324;28872.855635722106;28873.278168045967;948.1750876737283;962.1629182611173;1009.333839665817;1012.5595366015807;1084.5390708948664;14892.47876324345;15063.472778452702;15096.39614415433;15231.923840380949;15263.389464421522;397206;401449;402580;402998;403769;50102.49897501051;50790.49209507932;50840.49159508431;50904.23643645348;50937.745311273204;1037.273908264218;1134.6709454258337;1158.1545471805798;1172.1560476456937;1178.1222988873174;27578.5863212056;29177.416451671274;29208;29523.26191845135;29527;41637.79181104075;42164;42281.365779512715;42293.15413691648;42338.57661423346;233920;239625;239661;239750;240021;23624.409389765395;24089.759102408752;24453.51092978166;24930.750692492842;26721.465570688866;42245.788771055944;42494.66279354665;43125.353119703854;43313.783431082644;44252.11495770131;35902.64097359098;37291.44062839114;37292.44061339028;37778.43332349962;38015;36655.63344366629;36686.63313366832;37115.44326835153;37133.81433092817;37490.2501949954;36212;36869.631303687696;37109.25781484301;37191.6280837199;37451;32083.839580801945;33217.66782332242;33405.82644648755;33527.16182095467;33679.83160084184;25663.230103096936;25732.8713356432;25868;25893.708234143563;25991.22026339213 03:47:58 INFO - PROCESS | 15951 | |2;jquery.html;368.69030014787575;373.8392491228772;379.0485880440095;386.53229592193446;387.24100762505486;15824.68350632988;16975.66048679027;17159.65680686387;17381.652366952654;17389.91305043473;15943.123128227942;15993.600159996005;17033.148342582885;17062.232199551017;17063.317467301295;5099.872503187422;5272.525472707455;5280.656757310762;5316.680999140045;5317.8936421271555;3750.75620084695;3947.6052394760436;5164.561012313958;5918.822435326947;6283.811485655415;6222.688865556704;6238.750449981995;6245.781397651083;6256.906146407808;6266.498680105604;6001.489873360748;6081.726322315484;6153.63078215304;6170.938290617081;6187.164732761087;3380.121168496184;5025.949740502621;5387.919181212285;5391.3799913009725;5437;16721.247543860554;16957.660846782994;16986.660266794595;20037.899810501;20059.598808023904;1965.7542807149107;2001.1195074167465;2043.5402034542258;2079.6672532394896;2081.1675329868176;12898.742025159445;12934.417951192125;13002.60992170227;13027.218366898016;13238.139520931109;1774;1794.7577077094556;1821.4262507310286;1882.0589705147427;1927.575933294673;58810.41189588092;61584.38415615831;63744;68509.31490685079;71264.64367678181;9971.152452041513;10014.849777253346;10105.343152695052;10108.646197383056;10134.54394552247;13919.721605567833;13961.162330260015;13970.371333289822;13984.300784960915;13998.790018149735;7177.784666460015;7254.419646428273;7398.741044063432;7414.888776668355;7484.476086673881;6918.308169183142;6919.757808476679;6931.376176144171;7073.71705131789;7082.575045497287;4186.267403204488;4232.894177645522;4279.593438623326;4366.716163449366;4403.867883963486;1670.490500397366;1685.4775019743918;1787.883787553805;1823.753793237896;1839.7516335294563;810.959452027408;853.2107800284712;856.5075081827849;857.5197889182078;927.4296307770808;15985;16041.278142483616;16428.589285267964;16512.174391280387;16852.831471685127;824.6289169873581;832.679418423899;847.9533625650525;900.8828852249296;908.014803937735;8816.192680500482;9213.35506514551;9529.523523823782;9635.951820240994;9741.220702343795;355868;356098;376925;393896;396786;74385.62807185929;74823.62588187025;75955.62022189965;76573.61713191398;77117.22882771213;887.9511626860456;905.0180554098745;914.154407173362;914.5107367558325;915.66120535401;14563.48675573796;14815.92592037033;14854.108753474826;14989.925050374679;15101.924490377478;32410.351792963538;36838.26323473462;37304.44043339406;37434.81282593679;38117.23765524729;49120.2631960528;51205;52098.47901520936;52683.209751852984;52823.73588132035;7322;7461.552306861606;7509.962450187714;7665.961670191613;7831.412644051605;11579.826302605636;11581.073514119018;11643.88356116428;11654.125940554322;12047.156699030984;10022;10260.230482713976;10378.377297362182;10469.738256543647;10474.214433917334;10488.842667359842;10496.16030717556;10611.575536978435;10629.309094908805;10763.138948883914;9458.479783611692;10127.898721012696;10359.32664376813;10491.370517768959;10639.734006649896;7582.165961744314;7656.272654097852;7676.6161691916295;7783.805404864924;7814.413918956215;10157.695269141937;10355.275130740776;10434.06093451593;10451.790964180522;10536.57853685844 03:47:58 INFO - PROCESS | 15951 | |3;mootools.html;1186.810110382339;1390.673191799927;1392.0742706100443;1476.2397365356844;1684.4272947197958;6789.898151527725;7554.6978120875165;7849.960750196241;7852.60736963151;8055.879161812578;7876.842463150733;7889.132195458495;7985.880211796828;8003.799905002378;8008.27925486706;1894.2517705506316;2163.6429989051867;2172.9022194001227;2202.3282898715884;2204.0522575292616;2168.8481806273567;2215.1360969221937;2215.29110684581;2221.0893533651206;2221.577900198957;2212.369474699703;2230.197129033547;2235.094786611417;2240.9887950560224;2241.8879056047213;1826.2603645523584;2053.9281125160696;2128.1806504495726;2149.290734057765;2156.61180987423;2157.7302837145357;2178.346496051194;2180.1824315881545;2181.4437318483842;2182.967255491169;8048.436609437342;8111.3916456266015;8122.106568277485;8125.187481251886;8126.024877014796;4374.081442896995;4499.122671079108;4501.549845015505;4509.436320459942;4519.050999290153;2763.1296141715297;2880.942381152365;2898.7970842041063;2902.2454161917844;2920.2407374082677;894.7763059235191;926.1248120526105;938.6620816506053;973.7711637765119;979.0356498848629;11179.49692263842;11217.495212715447;11238.550457981672;11247.100231981422;11254.49354779037;4097.8770636880945;4229.767362795076;4282.143571285756;4305.9569404306185;4311.741295522279;9410.623575057058;9436.480993545283;9469.242460603135;9470.195033422098;9477.810443791086;4506.481754598198;4513.932291015637;4515.164694531522;4516.322551617283;4519.480259770103;3516.226430185355;3952.3281042222893;4036.8788936331957;4094.2220978014084;4098.73358231714;3667.3215455140885;3682.4108142697573;3737.682297004785;3775.131719704483;3792.3742582473583;1199.7780410624061;1215.3497878635064;1234.4321612058554;1235.32057368447;1238.6903274181454;685.4242436353487;806.3790881021698;810.9189081091962;812.4678335690014;823.81052357958;4854.393200849894;4992.450830408652;5163.690178589297;5196.168613021974;5403.918941215885;827.4745536584192;865.9307255419551;872.8167084912112;885.6634478897978;897.241830653097;3336.799792012487;3422.8973130806116;3451.2579795344122;3497.860085596548;3507.1582820122985;9260.536973151451;9709.077637624414;9734.269929755297;9787.951060244653;9798.804023919482;9407;9526.761830954281;9586.760330991781;9628.75928101789;9637.036296370306;7474.813129671802;7645.235476452422;7648.082230132309;7649.770506884803;7653.4642575020325;4980.676256043345;5092.185250359925;5124.461931497139;5181.611379146504;5202.635815492879;9325.86011209846;9337.299702522203;9340.71977840666;9366.016568260235;9479.620815167316;8725.694600688945;9116.77208069777;9129;9412.294077944318;9477.24182065447;6022.45797878193;6241.720447308382;6242.781502647385;6582.934170658232;6760.492963027891;6985.965070174617;7052.682629281797;7312.890306645299;7493.9250607495405;7494.5503269803985;6604;6802.761903333359;6832.214295356098;6841.863162736817;6977.581345119309;6898.379145876896;6898.413634840894;6961.338672826073;6967.96516017437;7046.048783414173;6115.3578874217565;6129.448349648553;6187.721552530057;6190.783322583688;6266.905996409966;3923.391874259494;3983.322835117979;4191.392248123944;4449.688521803443;4454.977725111354;4337.175936572041;4439.134368798053;4507.459104907301;4539.773011349485;4608.124456353282 03:47:58 INFO - PROCESS | 15951 | |4;prototype.html;283.86270113101546;289.0706378991542;290.06598752018505;290.9345397285612;291.8978357574848;4958.776855041523;4967.751612419378;4974.781178611236;4984.501549845014;4984.975075124628;4869.366982292297;4870.951290487094;4882.4629290778075;4913.656044076916;4927.162382394992;3596.604373518911;3705.147816002321;3730.253949210155;3740.2893450244364;3788.3181027415053;3740.17716102457;3766.1902690921447;3779.300829346566;3780.036090796843;3783.6405541473655;3595.94606080909;3729.6643302102807;3745.6441638044344;3753.136778540937;3760.4923335349786;3654.397024490956;3795.981020094882;3810.1046254130256;3815.523059617548;3819.427085937104;3335.216224187314;3339.3822142903396;3345.0968238575447;3351.2124650707065;3351.7988920664593;4789.736564488951;4798.2082956312515;4808.711477311373;4811.182099043136;4818.542238487338;4233.174530966463;4309.935350969738;4360.280553708666;4362.912741745179;4367.672424568138;5091.41448733393;5097.745112744385;5122.359705036871;5128.871778205537;5144.356955380577;3662.597114317423;3679.5032670589394;3694.8891533253777;3699.72252081095;3716.776993380379;5115.258287548322;5350.57195424369;5358.812441564565;5362.302900622933;5387.949349876775;3702.962970370316;3718;3732.533433320835;3736.925261494755;3742.1018955450495;3752.380857158593;3759.736818422739;3763.7929913855;3779.848806047727;3779.848806047727;4308.978455107705;4321.956780432155;4323.286657701507;4324.632406245441;4372.497162826252;4961.181405068195;5119.360079990001;5131.281620573122;5138.126518491866;5139.820106296336;1275.7320962597773;1302.0625149892062;1307.4835440001145;1313.2908229556124;1316.532630916011;830.5307501261768;834.3825569078838;866.8396346675759;895.6506962284714;906.2523418179896;4450.866474005785;4459;4480.14877173336;4483.529229430928;4508.0533088051225;5186.766595503212;5198.948010519922;5225.5819534437915;5291.603129765283;5312.468753124656;4311.719738217006;4465.866024019285;4490.191765482179;4509.977450112794;4587.885302867388;2831.2780241038404;2851.615031970699;2866.641669791276;2866.985665071703;2877.546838846369;5013.147764879979;5055.823046193439;5055.873603159876;5080.187170052848;5090.847274581768;5321.552086040388;5360.785568577213;5437.537809286176;5461.754221060062;5525.861853453615;5001.149804533238;5025.246213067996;5041.722705251246;5048;5055.34280543527;5344.305240318734;5356.410794812489;5364.9731751341;5375.838724838261;5412.404635490172;5057.949420505748;5190.351206099238;5219.321488206509;5227.660202086852;5230.895382092413;5016.949830501794;5051.62112841531;5054.4692807254705;5076.416212135652;5090.49095090488;3644.562652481613;3649.726270529774;3671.485991961181;3673.1918977824835;3689.9631003690693;5065.290859279778;5263.473652634706;5266.78932842682;5311.336082989626;5330.546903513245;5097.9490205098955;5134.150546446608;5164.664296820694;5175.767090480862;5182.870428239325;5072.771725272445;5077.365329333833;5105.157648987875;5196.194589838581;5230.189320655304;4754.359745887663;4801.975990120027;4959.752012399294;5020.397552293748;5024.045431368175;5009.949900500948;5170.146925757208;5201.803585175355;5202.765875535686;5202.921956170736;5006.7246301452315;5016.849494515171;5070.188769796815;5095.566876815364;5137.563307118937 03:47:58 INFO - PROCESS | 15951 | |5;yui.html;668.6188872342764;686.6669665212372;717.5515302935665;734.6143274780736;760.5474742528194;13108.41012154453;13295.335233238347;13488.730225395486;13541.526046588371;13771.586852394432;12480;12555.874441255608;12559.623211303653;12577.874221257785;12579.371031448436;620.7734177025376;751.8947347371372;767.2787579675115;776.2315307845221;791.5250849490317;786.7915002524336;787.7754839870638;787.8778789287669;790.8853216283635;790.9802254943644;841.7474757572704;844.3835999720208;846.0608724316004;846.2130218896424;846.8433339832151;656.0847617573482;788.7278888783361;823.6293667849492;826.0252901576138;840.5965136734341;600.9789657361971;601.8525461261975;601.9939800602026;602.2682440834408;602.3284038297311;13648.931755341258;13674.521391751341;13697.726045479034;13712.588622341345;13735.96980226477;12868.356582170854;13354.799678004838;13412.329383530881;13483.528076517372;13594.11638243521;11665.475053622607;11780.705482362924;11857.762844743143;11987.544122816093;12039.6388108356;4176.4570605821355;4261.531231564525;4273.401723758676;4283.935740963888;4302.526722060571;55908.72045639787;56018;56023.71988140074;56034.43965560333;56519.43480565183;10256.487175641189;10319.48402579868;10404.635837745795;10507.947460262803;10654.200934929911;19071.80928190728;19229.13468893903;19702.40892773219;19730.112144953513;19767.209311627375;6439;6485.286618471964;6485.54601177913;6554.70503827329;6563.8359041023405;3679.1721862580707;3683.171286460525;3684.613115622875;3740.233252183296;3787.14789172434;2805.8737356818992;2928.4875146849217;2931.4723349796814;2939.4415061138743;2945.1900727299735;488.4895284427781;501.65135231014824;502.06365129034816;502.4272329544322;515.8632962265003;446.6828551728244;478.3446678051023;482.7079616831766;486.56938609330996;502.4297422425573;7297.927020729725;7480.8877866832045;7528.134264559536;7537.660805263667;7567.167611562723;468.24144885285375;481.25645877119933;484.4259552430381;487.16694452486644;490.84783717047117;3637.836297366625;3678.393065144221;3684.373656478405;3720.1257704439436;3774.830132644038;54933.72533137309;84927.57536212279;87492;87726;88107.11892881118;23393.649095263583;23460.413489662897;23554;47422.28866567004;47606;69687;71437.2856271441;72134;72157.27842721611;73283.99999999894;6810.353016463428;6860.588364698134;6886.10480637514;7011.053507776385;7190.42476601881;42659;43958.12083758243;44021.55978440303;44263.55736442723;44916;39585.60414395935;43322.566774331855;53341.733291333294;60357;62918.37081629125;9074.228690561376;9079.95460022722;9213.76965575866;9309.301802364715;9325.906740932503;10414.843777343498;10455.16358691318;10706.089982351275;10790.028897399272;10940.070094042096;9149.634014639607;10730.195235357536;11113.499892504695;11469.942650286695;12178.45196966121;11190.888091118984;11193.216474846682;11225.494852731483;11293.153013523854;11447.141464390037;12468.438920248429;12593.93703031479;12773.808392873929;12819.743605128031;13229.735405292033;9803.607855685692;9979.356129051559;10634.787304253718;10662.573497060032;10967.287126336763;10125.493725313852;10315.638952636622;10339.22455815832;10376.273660843668;10422.947885260524 03:47:58 INFO - PROCESS | 15951 | __end_tp_report 03:47:58 INFO - PROCESS | 15951 | __start_cc_report 03:47:58 INFO - PROCESS | 15951 | _x_x_mozilla_cycle_collect,1086 03:47:58 INFO - PROCESS | 15951 | __end_cc_report 03:47:58 INFO - PROCESS | 15951 | __startTimestamp1466074078514__endTimestamp 03:47:58 INFO - PROCESS | 15951 | 03:47:58 INFO - PROCESS | 15951 | ------- Summary: start ------- 03:47:58 INFO - PROCESS | 15951 | Number of tests: 6 03:47:58 INFO - PROCESS | 15951 | 03:47:58 INFO - PROCESS | 15951 | [#0] dojo.html Cycles:165 Average:4784.31 Median:4911.36 stddev:517.33 (10.5%) stddev-sans-first:491.00 03:47:58 INFO - PROCESS | 15951 | Values: 2647.4 2655.6 2688.8 2691.9 2696.8 4620.8 4723.6 4768.5 4836.4 4930.7 4775.5 4777.5 4799.8 4861.5 4871.0 4347.9 4386.9 4439.2 4470.6 4536.2 4439.2 4453.2 4476.7 4486.2 4509.7 4366.6 4390.8 4409.0 4412.7 4436.9 4392.5 4405.8 4425.3 4456.0 4462.1 4433.6 4443.9 4452.9 4458.1 4495.2 4731.9 4757.0 4815.0 4824.5 4830.3 5253.4 5259.7 5260.9 5275.2 5287.3 5236.8 5261.1 5272.8 5278.7 5279.8 4781.0 4826.3 4876.4 4882.1 4911.4 5303.5 5371.4 5425.3 5425.6 5431.9 4972.7 5145.8 5183.9 5195.4 5202.0 5163.1 5212.6 5236.1 5238.4 5242.3 5189.5 5202.4 5203.3 5204.6 5252.6 4996.8 5047.6 5162.9 5186.5 5187.7 4342.1 4357.7 4361.4 4367.7 4404.5 3794.9 3822.3 3830.1 3844.6 3872.0 4319.2 4492.1 4496.0 4503.2 4543.8 5158.8 5162.6 5169.0 5173.8 5197.2 4421.9 4424.1 4425.8 4444.0 4452.9 4555.7 4559.4 4640.5 4645.3 4675.8 4820.8 4838.7 4857.0 4867.2 4916.8 5176.9 5187.7 5187.8 5195.8 5253.8 4752.9 4812.1 4820.6 4828.6 4906.9 5097.6 5117.1 5117.3 5156.9 5169.7 5199.7 5216.1 5218.0 5225.0 5271.5 4919.7 4984.7 5002.7 5035.8 5041.0 5046.6 5050.5 5054.2 5062.0 5102.9 4917.9 4925.6 4969.6 4991.5 4994.2 4938.1 5003.8 5037.7 5057.3 5081.5 4949.4 4970.1 4973.1 4982.0 5029.8 03:47:58 INFO - PROCESS | 15951 | 03:47:58 INFO - PROCESS | 15951 | [#1] ext.html Cycles:180 Average:45789.86 Median:33603.50 stddev:80496.29 (239.5%) stddev-sans-first:80650.45 03:47:58 INFO - PROCESS | 15951 | Values: 553.4 575.5 579.5 582.8 590.5 27008.6 29327.6 29389.1 29390.0 29408.0 30087.5 39597.6 40233.2 40393.0 45499.8 7856.5 7964.3 7978.7 7984.4 7985.4 7606.5 7831.9 7902.2 7923.4 7925.4 10118.6 10423.8 10429.7 10833.5 10839.7 10253.0 10354.7 10355.6 10357.9 10361.3 7562.9 9899.6 10144.2 10214.5 10284.0 38405.4 38753.2 38757.8 38794.4 39082.4 2912.5 3063.2 3128.1 3439.9 3637.5 29169.4 29841.9 29855.1 30319.5 30501.2 3622.4 3623.7 3639.5 3667.2 3719.6 247970.0 249834.0 250327.0 250643.0 250722.0 54200.5 54755.5 54790.0 54837.0 54879.0 57015.7 57200.7 57217.4 57235.4 57249.1 13960.0 14451.9 14478.2 14483.0 14509.4 10712.7 10715.2 10721.1 10728.6 10742.7 16380.3 17731.0 17913.5 18296.5 18317.4 6623.2 6708.9 6798.6 6808.5 6837.5 761.0 937.5 964.6 1000.7 1061.9 27589.3 27604.3 28134.9 28872.9 28873.3 948.2 962.2 1009.3 1012.6 1084.5 14892.5 15063.5 15096.4 15231.9 15263.4 397206.0 401449.0 402580.0 402998.0 403769.0 50102.5 50790.5 50840.5 50904.2 50937.7 1037.3 1134.7 1158.2 1172.2 1178.1 27578.6 29177.4 29208.0 29523.3 29527.0 41637.8 42164.0 42281.4 42293.2 42338.6 233920.0 239625.0 239661.0 239750.0 240021.0 23624.4 24089.8 24453.5 24930.8 26721.5 42245.8 42494.7 43125.4 43313.8 44252.1 35902.6 37291.4 37292.4 37778.4 38015.0 36655.6 36686.6 37115.4 37133.8 37490.3 36212.0 36869.6 37109.3 37191.6 37451.0 32083.8 33217.7 33405.8 33527.2 33679.8 25663.2 25732.9 25868.0 25893.7 25991.2 03:47:58 INFO - PROCESS | 15951 | 03:47:58 INFO - PROCESS | 15951 | [#2] jquery.html Cycles:180 Average:23810.51 Median:19251.88 stddev:62104.47 (322.6%) stddev-sans-first:62253.75 03:47:58 INFO - PROCESS | 15951 | Values: 368.7 373.8 379.0 386.5 387.2 15824.7 16975.7 17159.7 17381.7 17389.9 15943.1 15993.6 17033.1 17062.2 17063.3 5099.9 5272.5 5280.7 5316.7 5317.9 3750.8 3947.6 5164.6 5918.8 6283.8 6222.7 6238.8 6245.8 6256.9 6266.5 6001.5 6081.7 6153.6 6170.9 6187.2 3380.1 5025.9 5387.9 5391.4 5437.0 16721.2 16957.7 16986.7 20037.9 20059.6 1965.8 2001.1 2043.5 2079.7 2081.2 12898.7 12934.4 13002.6 13027.2 13238.1 1774.0 1794.8 1821.4 1882.1 1927.6 58810.4 61584.4 63744.0 68509.3 71264.6 9971.2 10014.8 10105.3 10108.6 10134.5 13919.7 13961.2 13970.4 13984.3 13998.8 7177.8 7254.4 7398.7 7414.9 7484.5 6918.3 6919.8 6931.4 7073.7 7082.6 4186.3 4232.9 4279.6 4366.7 4403.9 1670.5 1685.5 1787.9 1823.8 1839.8 811.0 853.2 856.5 857.5 927.4 15985.0 16041.3 16428.6 16512.2 16852.8 824.6 832.7 848.0 900.9 908.0 8816.2 9213.4 9529.5 9636.0 9741.2 355868.0 356098.0 376925.0 393896.0 396786.0 74385.6 74823.6 75955.6 76573.6 77117.2 888.0 905.0 914.2 914.5 915.7 14563.5 14815.9 14854.1 14989.9 15101.9 32410.4 36838.3 37304.4 37434.8 38117.2 49120.3 51205.0 52098.5 52683.2 52823.7 7322.0 7461.6 7510.0 7666.0 7831.4 11579.8 11581.1 11643.9 11654.1 12047.2 10022.0 10260.2 10378.4 10469.7 10474.2 10488.8 10496.2 10611.6 10629.3 10763.1 9458.5 10127.9 10359.3 10491.4 10639.7 7582.2 7656.3 7676.6 7783.8 7814.4 10157.7 10355.3 10434.1 10451.8 10536.6 03:47:58 INFO - PROCESS | 15951 | 03:47:58 INFO - PROCESS | 15951 | [#3] mootools.html Cycles:180 Average:5153.47 Median:5172.65 stddev:2967.67 (57.4%) stddev-sans-first:2961.02 03:47:58 INFO - PROCESS | 15951 | Values: 1186.8 1390.7 1392.1 1476.2 1684.4 6789.9 7554.7 7850.0 7852.6 8055.9 7876.8 7889.1 7985.9 8003.8 8008.3 1894.3 2163.6 2172.9 2202.3 2204.1 2168.8 2215.1 2215.3 2221.1 2221.6 2212.4 2230.2 2235.1 2241.0 2241.9 1826.3 2053.9 2128.2 2149.3 2156.6 2157.7 2178.3 2180.2 2181.4 2183.0 8048.4 8111.4 8122.1 8125.2 8126.0 4374.1 4499.1 4501.5 4509.4 4519.1 2763.1 2880.9 2898.8 2902.2 2920.2 894.8 926.1 938.7 973.8 979.0 11179.5 11217.5 11238.6 11247.1 11254.5 4097.9 4229.8 4282.1 4306.0 4311.7 9410.6 9436.5 9469.2 9470.2 9477.8 4506.5 4513.9 4515.2 4516.3 4519.5 3516.2 3952.3 4036.9 4094.2 4098.7 3667.3 3682.4 3737.7 3775.1 3792.4 1199.8 1215.3 1234.4 1235.3 1238.7 685.4 806.4 810.9 812.5 823.8 4854.4 4992.5 5163.7 5196.2 5403.9 827.5 865.9 872.8 885.7 897.2 3336.8 3422.9 3451.3 3497.9 3507.2 9260.5 9709.1 9734.3 9788.0 9798.8 9407.0 9526.8 9586.8 9628.8 9637.0 7474.8 7645.2 7648.1 7649.8 7653.5 4980.7 5092.2 5124.5 5181.6 5202.6 9325.9 9337.3 9340.7 9366.0 9479.6 8725.7 9116.8 9129.0 9412.3 9477.2 6022.5 6241.7 6242.8 6582.9 6760.5 6986.0 7052.7 7312.9 7493.9 7494.6 6604.0 6802.8 6832.2 6841.9 6977.6 6898.4 6898.4 6961.3 6968.0 7046.0 6115.4 6129.4 6187.7 6190.8 6266.9 3923.4 3983.3 4191.4 4449.7 4455.0 4337.2 4439.1 4507.5 4539.8 4608.1 03:47:58 INFO - PROCESS | 15951 | 03:47:58 INFO - PROCESS | 15951 | [#4] prototype.html Cycles:180 Average:4259.47 Median:4920.41 stddev:1247.85 (25.4%) stddev-sans-first:1215.15 03:47:58 INFO - PROCESS | 15951 | Values: 283.9 289.1 290.1 290.9 291.9 4958.8 4967.8 4974.8 4984.5 4985.0 4869.4 4871.0 4882.5 4913.7 4927.2 3596.6 3705.1 3730.3 3740.3 3788.3 3740.2 3766.2 3779.3 3780.0 3783.6 3595.9 3729.7 3745.6 3753.1 3760.5 3654.4 3796.0 3810.1 3815.5 3819.4 3335.2 3339.4 3345.1 3351.2 3351.8 4789.7 4798.2 4808.7 4811.2 4818.5 4233.2 4309.9 4360.3 4362.9 4367.7 5091.4 5097.7 5122.4 5128.9 5144.4 3662.6 3679.5 3694.9 3699.7 3716.8 5115.3 5350.6 5358.8 5362.3 5387.9 3703.0 3718.0 3732.5 3736.9 3742.1 3752.4 3759.7 3763.8 3779.8 3779.8 4309.0 4322.0 4323.3 4324.6 4372.5 4961.2 5119.4 5131.3 5138.1 5139.8 1275.7 1302.1 1307.5 1313.3 1316.5 830.5 834.4 866.8 895.7 906.3 4450.9 4459.0 4480.1 4483.5 4508.1 5186.8 5198.9 5225.6 5291.6 5312.5 4311.7 4465.9 4490.2 4510.0 4587.9 2831.3 2851.6 2866.6 2867.0 2877.5 5013.1 5055.8 5055.9 5080.2 5090.8 5321.6 5360.8 5437.5 5461.8 5525.9 5001.1 5025.2 5041.7 5048.0 5055.3 5344.3 5356.4 5365.0 5375.8 5412.4 5057.9 5190.4 5219.3 5227.7 5230.9 5016.9 5051.6 5054.5 5076.4 5090.5 3644.6 3649.7 3671.5 3673.2 3690.0 5065.3 5263.5 5266.8 5311.3 5330.5 5097.9 5134.2 5164.7 5175.8 5182.9 5072.8 5077.4 5105.2 5196.2 5230.2 4754.4 4802.0 4959.8 5020.4 5024.0 5009.9 5170.1 5201.8 5202.8 5202.9 5006.7 5016.8 5070.2 5095.6 5137.6 03:47:58 INFO - PROCESS | 15951 | 03:47:58 INFO - PROCESS | 15951 | [#5] yui.html Cycles:180 Average:15257.92 Median:22355.12 stddev:20394.89 (91.2%) stddev-sans-first:20422.68 03:47:58 INFO - PROCESS | 15951 | Values: 668.6 686.7 717.6 734.6 760.5 13108.4 13295.3 13488.7 13541.5 13771.6 12480.0 12555.9 12559.6 12577.9 12579.4 620.8 751.9 767.3 776.2 791.5 786.8 787.8 787.9 790.9 791.0 841.7 844.4 846.1 846.2 846.8 656.1 788.7 823.6 826.0 840.6 601.0 601.9 602.0 602.3 602.3 13648.9 13674.5 13697.7 13712.6 13736.0 12868.4 13354.8 13412.3 13483.5 13594.1 11665.5 11780.7 11857.8 11987.5 12039.6 4176.5 4261.5 4273.4 4283.9 4302.5 55908.7 56018.0 56023.7 56034.4 56519.4 10256.5 10319.5 10404.6 10507.9 10654.2 19071.8 19229.1 19702.4 19730.1 19767.2 6439.0 6485.3 6485.5 6554.7 6563.8 3679.2 3683.2 3684.6 3740.2 3787.1 2805.9 2928.5 2931.5 2939.4 2945.2 488.5 501.7 502.1 502.4 515.9 446.7 478.3 482.7 486.6 502.4 7297.9 7480.9 7528.1 7537.7 7567.2 468.2 481.3 484.4 487.2 490.8 3637.8 3678.4 3684.4 3720.1 3774.8 54933.7 84927.6 87492.0 87726.0 88107.1 23393.6 23460.4 23554.0 47422.3 47606.0 69687.0 71437.3 72134.0 72157.3 73284.0 6810.4 6860.6 6886.1 7011.1 7190.4 42659.0 43958.1 44021.6 44263.6 44916.0 39585.6 43322.6 53341.7 60357.0 62918.4 9074.2 9080.0 9213.8 9309.3 9325.9 10414.8 10455.2 10706.1 10790.0 10940.1 9149.6 10730.2 11113.5 11469.9 12178.5 11190.9 11193.2 11225.5 11293.2 11447.1 12468.4 12593.9 12773.8 12819.7 13229.7 9803.6 9979.4 10634.8 10662.6 10967.3 10125.5 10315.6 10339.2 10376.3 10422.9 03:47:58 INFO - PROCESS | 15951 | -------- Summary: end -------- 03:47:58 INFO - PROCESS | 15951 | 03:47:59 INFO - TEST-INFO | 15951: exit 0 03:47:59 INFO - TEST-OK | dromaeo_css | took 1121244ms 03:47:59 INFO - TEST-START | kraken 03:47:59 INFO - operating with platform_type : linux_ 03:47:59 INFO - Initialising browser for kraken test... 03:47:59 INFO - TEST-INFO | started process 16129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLz3Xil/profile http://localhost:50870/getInfo.html) 03:48:04 INFO - PROCESS | 16129 | __metrics Screen width/height:1600/1200 03:48:04 INFO - PROCESS | 16129 | colorDepth:24 03:48:04 INFO - PROCESS | 16129 | Browser inner width/height: 1024/697 03:48:04 INFO - PROCESS | 16129 | __metrics 03:48:05 INFO - PROCESS | 16129 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:48:06 INFO - TEST-INFO | 16129: exit 0 03:48:06 INFO - Browser initialized. 03:48:06 INFO - Running cycle 1/1 for kraken test... 03:48:06 INFO - TEST-INFO | started process 16210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLz3Xil/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:18 INFO - PROCESS | 16210 | RSS: Main: 175603712 03:48:18 INFO - PROCESS | 16210 | 03:48:20 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50870/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:21 INFO - PROCESS | 16210 | RSS: Main: 232779776 03:48:21 INFO - PROCESS | 16210 | 03:48:24 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50870/tests/kraken/driver.html?testName=audio-dft) 03:48:25 INFO - PROCESS | 16210 | RSS: Main: 220647424 03:48:25 INFO - PROCESS | 16210 | 03:48:28 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50870/tests/kraken/driver.html?testName=audio-fft) 03:48:29 INFO - PROCESS | 16210 | RSS: Main: 287797248 03:48:29 INFO - PROCESS | 16210 | 03:48:31 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50870/tests/kraken/driver.html?testName=audio-oscillator) 03:48:31 INFO - PROCESS | 16210 | RSS: Main: 199290880 03:48:31 INFO - PROCESS | 16210 | 03:48:34 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:34 INFO - PROCESS | 16210 | RSS: Main: 203522048 03:48:34 INFO - PROCESS | 16210 | 03:48:38 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50870/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:38 INFO - PROCESS | 16210 | RSS: Main: 239394816 03:48:38 INFO - PROCESS | 16210 | 03:48:42 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50870/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:42 INFO - PROCESS | 16210 | RSS: Main: 240259072 03:48:42 INFO - PROCESS | 16210 | 03:48:45 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50870/tests/kraken/driver.html?testName=json-parse-financial) 03:48:46 INFO - PROCESS | 16210 | RSS: Main: 240095232 03:48:46 INFO - PROCESS | 16210 | 03:48:47 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:48 INFO - PROCESS | 16210 | RSS: Main: 227676160 03:48:48 INFO - PROCESS | 16210 | 03:48:50 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50870/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:51 INFO - PROCESS | 16210 | RSS: Main: 231833600 03:48:51 INFO - PROCESS | 16210 | 03:48:53 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:53 INFO - PROCESS | 16210 | RSS: Main: 240128000 03:48:53 INFO - PROCESS | 16210 | 03:48:56 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:57 INFO - PROCESS | 16210 | RSS: Main: 240553984 03:48:57 INFO - PROCESS | 16210 | 03:49:00 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:00 INFO - PROCESS | 16210 | RSS: Main: 242401280 03:49:00 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:50870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50870/tests/kraken/driver.html?testName=ai-astar) 03:49:02 INFO - PROCESS | 16210 | RSS: Main: 284553216 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | __start_tp_report 03:49:02 INFO - PROCESS | 16210 | _x_x_mozilla_page_load 03:49:02 INFO - PROCESS | 16210 | _x_x_mozilla_page_load_details 03:49:02 INFO - PROCESS | 16210 | |i|pagename|runs| 03:49:02 INFO - PROCESS | 16210 | |0;ai-astar;112;107;113;113;112;113;112;111;113;113 03:49:02 INFO - PROCESS | 16210 | |1;audio-beat-detection;160;139;135;180;139;132;155;129;172;129 03:49:02 INFO - PROCESS | 16210 | |2;audio-dft;162;163;161;162;162;163;162;162;161;160 03:49:02 INFO - PROCESS | 16210 | |3;audio-fft;76;76;78;109;75;77;74;77;109;76 03:49:02 INFO - PROCESS | 16210 | |4;audio-oscillator;85;86;114;88;87;87;116;87;87;130 03:49:02 INFO - PROCESS | 16210 | |5;imaging-gaussian-blur;116;117;117;117;117;117;118;120;118;118 03:49:02 INFO - PROCESS | 16210 | |6;imaging-darkroom;147;146;146;146;146;147;147;146;146;145 03:49:02 INFO - PROCESS | 16210 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;95 03:49:02 INFO - PROCESS | 16210 | |8;json-parse-financial;63;64;65;63;65;71;64;65;65;64 03:49:02 INFO - PROCESS | 16210 | |9;json-stringify-tinderbox;64;65;65;66;65;66;65;65;75;64 03:49:02 INFO - PROCESS | 16210 | |10;stanford-crypto-aes;83;88;86;83;83;90;86;87;121;85 03:49:02 INFO - PROCESS | 16210 | |11;stanford-crypto-ccm;135;130;138;139;133;134;134;133;142;136 03:49:02 INFO - PROCESS | 16210 | |12;stanford-crypto-pbkdf2;176;179;173;170;168;170;171;173;170;167 03:49:02 INFO - PROCESS | 16210 | |13;stanford-crypto-sha256-iterative;70;67;68;69;68;67;70;68;70;71 03:49:02 INFO - PROCESS | 16210 | __end_tp_report 03:49:02 INFO - PROCESS | 16210 | __start_cc_report 03:49:02 INFO - PROCESS | 16210 | _x_x_mozilla_cycle_collect,1923 03:49:02 INFO - PROCESS | 16210 | __end_cc_report 03:49:02 INFO - PROCESS | 16210 | __startTimestamp1466074142892__endTimestamp 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | ------- Summary: start ------- 03:49:02 INFO - PROCESS | 16210 | Number of tests: 14 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:1.85 (1.6%) stddev-sans-first:1.96 03:49:02 INFO - PROCESS | 16210 | Values: 112.0 107.0 113.0 113.0 112.0 113.0 112.0 111.0 113.0 113.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:147.00 stddev:18.54 (12.6%) stddev-sans-first:19.05 03:49:02 INFO - PROCESS | 16210 | Values: 160.0 139.0 135.0 180.0 139.0 132.0 155.0 129.0 172.0 129.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 03:49:02 INFO - PROCESS | 16210 | Values: 162.0 163.0 161.0 162.0 162.0 163.0 162.0 162.0 161.0 160.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:13.90 (18.3%) stddev-sans-first:14.54 03:49:02 INFO - PROCESS | 16210 | Values: 76.0 76.0 78.0 109.0 75.0 77.0 74.0 77.0 109.0 76.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:87.00 stddev:16.61 (19.1%) stddev-sans-first:17.07 03:49:02 INFO - PROCESS | 16210 | Values: 85.0 86.0 114.0 88.0 87.0 87.0 116.0 87.0 87.0 130.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:1.08 (0.9%) stddev-sans-first:1.00 03:49:02 INFO - PROCESS | 16210 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 118.0 120.0 118.0 118.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 03:49:02 INFO - PROCESS | 16210 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 145.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:49:02 INFO - PROCESS | 16210 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:2.28 (3.5%) stddev-sans-first:2.32 03:49:02 INFO - PROCESS | 16210 | Values: 63.0 64.0 65.0 63.0 65.0 71.0 64.0 65.0 65.0 64.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.00 stddev:3.23 (5.0%) stddev-sans-first:3.35 03:49:02 INFO - PROCESS | 16210 | Values: 64.0 65.0 65.0 66.0 65.0 66.0 65.0 65.0 75.0 64.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:86.00 stddev:11.41 (13.3%) stddev-sans-first:11.88 03:49:02 INFO - PROCESS | 16210 | Values: 83.0 88.0 86.0 83.0 83.0 90.0 86.0 87.0 121.0 85.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:135.50 stddev:3.47 (2.6%) stddev-sans-first:3.68 03:49:02 INFO - PROCESS | 16210 | Values: 135.0 130.0 138.0 139.0 133.0 134.0 134.0 133.0 142.0 136.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.00 stddev:3.65 (2.1%) stddev-sans-first:3.53 03:49:02 INFO - PROCESS | 16210 | Values: 176.0 179.0 173.0 170.0 168.0 170.0 171.0 173.0 170.0 167.0 03:49:02 INFO - PROCESS | 16210 | 03:49:02 INFO - PROCESS | 16210 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:1.40 (2.0%) stddev-sans-first:1.41 03:49:02 INFO - PROCESS | 16210 | Values: 70.0 67.0 68.0 69.0 68.0 67.0 70.0 68.0 70.0 71.0 03:49:02 INFO - PROCESS | 16210 | -------- Summary: end -------- 03:49:02 INFO - PROCESS | 16210 | 03:49:04 INFO - TEST-INFO | 16210: exit 0 03:49:04 INFO - TEST-OK | kraken | took 64970ms 03:49:04 INFO - SUITE-END | took 1186s 03:49:04 INFO - Completed test suite (00:19:46) 03:49:04 INFO - javascript benchmark 03:49:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2647.4175681350107, 2655.561832297671, 2688.776606643977, 2691.865406729663, 2696.824706394085, 4620.838270660528, 4723.574878260956, 4768.475467698555, 4836.37127173467, 4930.654854160211, 4775.522447755223, 4777.474477807438, 4799.808007679689, 4861.538153875376, 4871.025794841028, 4347.86956391308, 4386.868393948187, 4439.178751930887, 4470.642348612119, 4536.228841097021, 4439.245328294198, 4453.153900758845, 4476.731396116244, 4486.192485352635, 4509.661775366844, 4366.6070053695, 4390.824367025315, 4408.955910440886, 4412.713173643703, 4436.911261774779, 4392.472903251598, 4405.757683327416, 4425.336199570058, 4456.041950980522, 4462.085272519126, 4433.6009759121835, 4443.866683999485, 4452.866414007585, 4458.1306645204195, 4495.235809912323, 4731.881702957454, 4756.976215118937, 4815.0, 4824.541668541518, 4830.3237546743485, 5253.448387919251, 5259.737013149327, 5260.92108618371, 5275.235090911835, 5287.286216360781, 5236.7905283788605, 5261.105612045962, 5272.762725677316, 5278.709670968095, 5279.788808447657, 4780.976095119537, 4826.348442960226, 4876.366072410564, 4882.096812089775, 4911.361523001987, 5303.4696530346655, 5371.409144994048, 5425.321834770653, 5425.647332923348, 5431.918521222185, 4972.701637901738, 5145.845624631267, 5183.870403239949, 5195.350581177353, 5202.0, 5163.122269214243, 5212.609054320866, 5236.0575096482235, 5238.371395432497, 5242.318498595158, 5189.532942035159, 5202.375714914235, 5203.271541984125, 5204.635675502678, 5252.606054545924, 4996.7501624918605, 5047.570956468741, 5162.870928226825, 5186.533212010937, 5187.740612969412, 4342.109867477159, 4357.651387888961, 4361.433013708198, 4367.67242456817, 4404.515503294635, 3794.905127371783, 3822.2928758179823, 3830.0807806126886, 3844.557875844258, 3872.0, 4319.200947824663, 4492.0791237796175, 4496.0, 4503.234450143484, 4543.818247270138, 5158.819441319536, 5162.561182299547, 5168.9741551292755, 5173.844784656466, 5197.194434862602, 4421.9336709949375, 4424.115176964556, 4425.756583387944, 4443.955560444419, 4452.910941781146, 4555.726656400627, 4559.407277054028, 4640.512746161672, 4645.256758918556, 4675.812967481263, 4820.783064762024, 4838.7338696372035, 4857.0, 4867.245576935581, 4916.7541622918, 5176.948230517797, 5187.688738675692, 5187.844364669066, 5195.844124676266, 5253.816116435906, 4752.857414277577, 4812.06164797875, 4820.614350851994, 4828.589569886599, 4906.9018619626695, 5097.566706829961, 5117.078925793393, 5117.309163262912, 5156.922646160236, 5169.663971841818, 5199.688018718889, 5216.061109000265, 5217.973910130425, 5225.0, 5271.525562699376, 4919.704817710949, 4984.675996060245, 5002.724850133278, 5035.823746168867, 5040.974795126001, 5046.621503387188, 5050.49495050492, 5054.21659642756, 5061.974690126526, 5102.948970510248, 4917.852464426073, 4925.556699897026, 4969.552740253394, 4991.450940396481, 4994.175960966545, 4938.111139994692, 5003.849884503471, 5037.672551284155, 5057.31726216956, 5081.517255860687, 4949.356583644103, 4970.130227210296, 4973.055119527278, 4981.975090124672, 5029.823956161516], "value": 4750.36770684064, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.361192207148, 575.4964406144624, 579.487153868826, 582.7756313819178, 590.4951266667, 27008.594871076926, 29327.560086598718, 29389.11832645019, 29390.0, 29408.0, 30087.548686769715, 39597.60402395975, 40233.19533609326, 40393.0, 45499.77250113753, 7856.528608283507, 7964.323032542212, 7978.680852765911, 7984.361251099898, 7985.441019128663, 7606.543607383547, 7831.9216807832045, 7902.20977902211, 7923.366130709558, 7925.405594580401, 10118.645847395343, 10423.791524169512, 10429.68710938673, 10833.512491937843, 10839.67480975572, 10253.0, 10354.689359319233, 10355.585776568929, 10357.948210258975, 10361.274710770249, 7562.886556701654, 9899.604015839357, 10144.188464922789, 10214.489275536194, 10284.0, 38405.423918641245, 38753.224935501414, 38757.80621096877, 38794.418083728764, 39082.413763793564, 2912.533994560881, 3063.1576316513137, 3128.0772172209254, 3439.914002149941, 3637.508936293593, 29169.416611667646, 29841.850790745906, 29855.10434686963, 30319.545206821917, 30501.237469063228, 3622.42041273395, 3623.655752703489, 3639.5450568678916, 3667.21154951684, 3719.6466335698065, 247970.0, 249834.0, 250327.0, 250643.0, 250722.0, 54200.45799541954, 54755.452445475035, 54790.0, 54837.0, 54879.0, 57015.714921425126, 57200.71399642975, 57217.427825721206, 57235.42764572301, 57249.14126288109, 13960.0, 14451.927740361441, 14478.203698796457, 14483.0, 14509.419623214953, 10712.732181695364, 10715.19636027301, 10721.142308615292, 10728.624498142528, 10742.731431714114, 16380.344786208656, 17731.0, 17913.492111104457, 18296.45110646656, 18317.3588924387, 6623.172103487064, 6708.865822683519, 6798.626075565792, 6808.455323574102, 6837.521373503807, 760.9733659322007, 937.4937533731845, 964.5659453246068, 1000.7298029531986, 1061.9256652034283, 27589.31026724308, 27604.30989225245, 28134.85932570324, 28872.855635722106, 28873.278168045967, 948.1750876737283, 962.1629182611173, 1009.333839665817, 1012.5595366015807, 1084.5390708948664, 14892.47876324345, 15063.472778452702, 15096.39614415433, 15231.923840380949, 15263.389464421522, 397206.0, 401449.0, 402580.0, 402998.0, 403769.0, 50102.49897501051, 50790.49209507932, 50840.49159508431, 50904.23643645348, 50937.745311273204, 1037.273908264218, 1134.6709454258337, 1158.1545471805798, 1172.1560476456937, 1178.1222988873174, 27578.5863212056, 29177.416451671274, 29208.0, 29523.26191845135, 29527.0, 41637.79181104075, 42164.0, 42281.365779512715, 42293.15413691648, 42338.57661423346, 233920.0, 239625.0, 239661.0, 239750.0, 240021.0, 23624.409389765395, 24089.759102408752, 24453.51092978166, 24930.750692492842, 26721.465570688866, 42245.788771055944, 42494.66279354665, 43125.353119703854, 43313.783431082644, 44252.11495770131, 35902.64097359098, 37291.44062839114, 37292.44061339028, 37778.43332349962, 38015.0, 36655.63344366629, 36686.63313366832, 37115.44326835153, 37133.81433092817, 37490.2501949954, 36212.0, 36869.631303687696, 37109.25781484301, 37191.6280837199, 37451.0, 32083.839580801945, 33217.66782332242, 33405.82644648755, 33527.16182095467, 33679.83160084184, 25663.230103096936, 25732.8713356432, 25868.0, 25893.708234143563, 25991.22026339213], "value": 17819.77106989625, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.69030014787575, 373.8392491228772, 379.0485880440095, 386.53229592193446, 387.24100762505486, 15824.68350632988, 16975.66048679027, 17159.65680686387, 17381.652366952654, 17389.91305043473, 15943.123128227942, 15993.600159996005, 17033.148342582885, 17062.232199551017, 17063.317467301295, 5099.872503187422, 5272.525472707455, 5280.656757310762, 5316.680999140045, 5317.8936421271555, 3750.75620084695, 3947.6052394760436, 5164.561012313958, 5918.822435326947, 6283.811485655415, 6222.688865556704, 6238.750449981995, 6245.781397651083, 6256.906146407808, 6266.498680105604, 6001.489873360748, 6081.726322315484, 6153.63078215304, 6170.938290617081, 6187.164732761087, 3380.121168496184, 5025.949740502621, 5387.919181212285, 5391.3799913009725, 5437.0, 16721.247543860554, 16957.660846782994, 16986.660266794595, 20037.899810501, 20059.598808023904, 1965.7542807149107, 2001.1195074167465, 2043.5402034542258, 2079.6672532394896, 2081.1675329868176, 12898.742025159445, 12934.417951192125, 13002.60992170227, 13027.218366898016, 13238.139520931109, 1774.0, 1794.7577077094556, 1821.4262507310286, 1882.0589705147427, 1927.575933294673, 58810.41189588092, 61584.38415615831, 63744.0, 68509.31490685079, 71264.64367678181, 9971.152452041513, 10014.849777253346, 10105.343152695052, 10108.646197383056, 10134.54394552247, 13919.721605567833, 13961.162330260015, 13970.371333289822, 13984.300784960915, 13998.790018149735, 7177.784666460015, 7254.419646428273, 7398.741044063432, 7414.888776668355, 7484.476086673881, 6918.308169183142, 6919.757808476679, 6931.376176144171, 7073.71705131789, 7082.575045497287, 4186.267403204488, 4232.894177645522, 4279.593438623326, 4366.716163449366, 4403.867883963486, 1670.490500397366, 1685.4775019743918, 1787.883787553805, 1823.753793237896, 1839.7516335294563, 810.959452027408, 853.2107800284712, 856.5075081827849, 857.5197889182078, 927.4296307770808, 15985.0, 16041.278142483616, 16428.589285267964, 16512.174391280387, 16852.831471685127, 824.6289169873581, 832.679418423899, 847.9533625650525, 900.8828852249296, 908.014803937735, 8816.192680500482, 9213.35506514551, 9529.523523823782, 9635.951820240994, 9741.220702343795, 355868.0, 356098.0, 376925.0, 393896.0, 396786.0, 74385.62807185929, 74823.62588187025, 75955.62022189965, 76573.61713191398, 77117.22882771213, 887.9511626860456, 905.0180554098745, 914.154407173362, 914.5107367558325, 915.66120535401, 14563.48675573796, 14815.92592037033, 14854.108753474826, 14989.925050374679, 15101.924490377478, 32410.351792963538, 36838.26323473462, 37304.44043339406, 37434.81282593679, 38117.23765524729, 49120.2631960528, 51205.0, 52098.47901520936, 52683.209751852984, 52823.73588132035, 7322.0, 7461.552306861606, 7509.962450187714, 7665.961670191613, 7831.412644051605, 11579.826302605636, 11581.073514119018, 11643.88356116428, 11654.125940554322, 12047.156699030984, 10022.0, 10260.230482713976, 10378.377297362182, 10469.738256543647, 10474.214433917334, 10488.842667359842, 10496.16030717556, 10611.575536978435, 10629.309094908805, 10763.138948883914, 9458.479783611692, 10127.898721012696, 10359.32664376813, 10491.370517768959, 10639.734006649896, 7582.165961744314, 7656.272654097852, 7676.6161691916295, 7783.805404864924, 7814.413918956215, 10157.695269141937, 10355.275130740776, 10434.06093451593, 10451.790964180522, 10536.57853685844], "value": 8272.8975215156, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1186.810110382339, 1390.673191799927, 1392.0742706100443, 1476.2397365356844, 1684.4272947197958, 6789.898151527725, 7554.6978120875165, 7849.960750196241, 7852.60736963151, 8055.879161812578, 7876.842463150733, 7889.132195458495, 7985.880211796828, 8003.799905002378, 8008.27925486706, 1894.2517705506316, 2163.6429989051867, 2172.9022194001227, 2202.3282898715884, 2204.0522575292616, 2168.8481806273567, 2215.1360969221937, 2215.29110684581, 2221.0893533651206, 2221.577900198957, 2212.369474699703, 2230.197129033547, 2235.094786611417, 2240.9887950560224, 2241.8879056047213, 1826.2603645523584, 2053.9281125160696, 2128.1806504495726, 2149.290734057765, 2156.61180987423, 2157.7302837145357, 2178.346496051194, 2180.1824315881545, 2181.4437318483842, 2182.967255491169, 8048.436609437342, 8111.3916456266015, 8122.106568277485, 8125.187481251886, 8126.024877014796, 4374.081442896995, 4499.122671079108, 4501.549845015505, 4509.436320459942, 4519.050999290153, 2763.1296141715297, 2880.942381152365, 2898.7970842041063, 2902.2454161917844, 2920.2407374082677, 894.7763059235191, 926.1248120526105, 938.6620816506053, 973.7711637765119, 979.0356498848629, 11179.49692263842, 11217.495212715447, 11238.550457981672, 11247.100231981422, 11254.49354779037, 4097.8770636880945, 4229.767362795076, 4282.143571285756, 4305.9569404306185, 4311.741295522279, 9410.623575057058, 9436.480993545283, 9469.242460603135, 9470.195033422098, 9477.810443791086, 4506.481754598198, 4513.932291015637, 4515.164694531522, 4516.322551617283, 4519.480259770103, 3516.226430185355, 3952.3281042222893, 4036.8788936331957, 4094.2220978014084, 4098.73358231714, 3667.3215455140885, 3682.4108142697573, 3737.682297004785, 3775.131719704483, 3792.3742582473583, 1199.7780410624061, 1215.3497878635064, 1234.4321612058554, 1235.32057368447, 1238.6903274181454, 685.4242436353487, 806.3790881021698, 810.9189081091962, 812.4678335690014, 823.81052357958, 4854.393200849894, 4992.450830408652, 5163.690178589297, 5196.168613021974, 5403.918941215885, 827.4745536584192, 865.9307255419551, 872.8167084912112, 885.6634478897978, 897.241830653097, 3336.799792012487, 3422.8973130806116, 3451.2579795344122, 3497.860085596548, 3507.1582820122985, 9260.536973151451, 9709.077637624414, 9734.269929755297, 9787.951060244653, 9798.804023919482, 9407.0, 9526.761830954281, 9586.760330991781, 9628.75928101789, 9637.036296370306, 7474.813129671802, 7645.235476452422, 7648.082230132309, 7649.770506884803, 7653.4642575020325, 4980.676256043345, 5092.185250359925, 5124.461931497139, 5181.611379146504, 5202.635815492879, 9325.86011209846, 9337.299702522203, 9340.71977840666, 9366.016568260235, 9479.620815167316, 8725.694600688945, 9116.77208069777, 9129.0, 9412.294077944318, 9477.24182065447, 6022.45797878193, 6241.720447308382, 6242.781502647385, 6582.934170658232, 6760.492963027891, 6985.965070174617, 7052.682629281797, 7312.890306645299, 7493.9250607495405, 7494.5503269803985, 6604.0, 6802.761903333359, 6832.214295356098, 6841.863162736817, 6977.581345119309, 6898.379145876896, 6898.413634840894, 6961.338672826073, 6967.96516017437, 7046.048783414173, 6115.3578874217565, 6129.448349648553, 6187.721552530057, 6190.783322583688, 6266.905996409966, 3923.391874259494, 3983.322835117979, 4191.392248123944, 4449.688521803443, 4454.977725111354, 4337.175936572041, 4439.134368798053, 4507.459104907301, 4539.773011349485, 4608.124456353282], "value": 4122.739616371511, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.86270113101546, 289.0706378991542, 290.06598752018505, 290.9345397285612, 291.8978357574848, 4958.776855041523, 4967.751612419378, 4974.781178611236, 4984.501549845014, 4984.975075124628, 4869.366982292297, 4870.951290487094, 4882.4629290778075, 4913.656044076916, 4927.162382394992, 3596.604373518911, 3705.147816002321, 3730.253949210155, 3740.2893450244364, 3788.3181027415053, 3740.17716102457, 3766.1902690921447, 3779.300829346566, 3780.036090796843, 3783.6405541473655, 3595.94606080909, 3729.6643302102807, 3745.6441638044344, 3753.136778540937, 3760.4923335349786, 3654.397024490956, 3795.981020094882, 3810.1046254130256, 3815.523059617548, 3819.427085937104, 3335.216224187314, 3339.3822142903396, 3345.0968238575447, 3351.2124650707065, 3351.7988920664593, 4789.736564488951, 4798.2082956312515, 4808.711477311373, 4811.182099043136, 4818.542238487338, 4233.174530966463, 4309.935350969738, 4360.280553708666, 4362.912741745179, 4367.672424568138, 5091.41448733393, 5097.745112744385, 5122.359705036871, 5128.871778205537, 5144.356955380577, 3662.597114317423, 3679.5032670589394, 3694.8891533253777, 3699.72252081095, 3716.776993380379, 5115.258287548322, 5350.57195424369, 5358.812441564565, 5362.302900622933, 5387.949349876775, 3702.962970370316, 3718.0, 3732.533433320835, 3736.925261494755, 3742.1018955450495, 3752.380857158593, 3759.736818422739, 3763.7929913855, 3779.848806047727, 3779.848806047727, 4308.978455107705, 4321.956780432155, 4323.286657701507, 4324.632406245441, 4372.497162826252, 4961.181405068195, 5119.360079990001, 5131.281620573122, 5138.126518491866, 5139.820106296336, 1275.7320962597773, 1302.0625149892062, 1307.4835440001145, 1313.2908229556124, 1316.532630916011, 830.5307501261768, 834.3825569078838, 866.8396346675759, 895.6506962284714, 906.2523418179896, 4450.866474005785, 4459.0, 4480.14877173336, 4483.529229430928, 4508.0533088051225, 5186.766595503212, 5198.948010519922, 5225.5819534437915, 5291.603129765283, 5312.468753124656, 4311.719738217006, 4465.866024019285, 4490.191765482179, 4509.977450112794, 4587.885302867388, 2831.2780241038404, 2851.615031970699, 2866.641669791276, 2866.985665071703, 2877.546838846369, 5013.147764879979, 5055.823046193439, 5055.873603159876, 5080.187170052848, 5090.847274581768, 5321.552086040388, 5360.785568577213, 5437.537809286176, 5461.754221060062, 5525.861853453615, 5001.149804533238, 5025.246213067996, 5041.722705251246, 5048.0, 5055.34280543527, 5344.305240318734, 5356.410794812489, 5364.9731751341, 5375.838724838261, 5412.404635490172, 5057.949420505748, 5190.351206099238, 5219.321488206509, 5227.660202086852, 5230.895382092413, 5016.949830501794, 5051.62112841531, 5054.4692807254705, 5076.416212135652, 5090.49095090488, 3644.562652481613, 3649.726270529774, 3671.485991961181, 3673.1918977824835, 3689.9631003690693, 5065.290859279778, 5263.473652634706, 5266.78932842682, 5311.336082989626, 5330.546903513245, 5097.9490205098955, 5134.150546446608, 5164.664296820694, 5175.767090480862, 5182.870428239325, 5072.771725272445, 5077.365329333833, 5105.157648987875, 5196.194589838581, 5230.189320655304, 4754.359745887663, 4801.975990120027, 4959.752012399294, 5020.397552293748, 5024.045431368175, 5009.949900500948, 5170.146925757208, 5201.803585175355, 5202.765875535686, 5202.921956170736, 5006.7246301452315, 5016.849494515171, 5070.188769796815, 5095.566876815364, 5137.563307118937], "value": 3858.622745049529, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.6188872342764, 686.6669665212372, 717.5515302935665, 734.6143274780736, 760.5474742528194, 13108.41012154453, 13295.335233238347, 13488.730225395486, 13541.526046588371, 13771.586852394432, 12480.0, 12555.874441255608, 12559.623211303653, 12577.874221257785, 12579.371031448436, 620.7734177025376, 751.8947347371372, 767.2787579675115, 776.2315307845221, 791.5250849490317, 786.7915002524336, 787.7754839870638, 787.8778789287669, 790.8853216283635, 790.9802254943644, 841.7474757572704, 844.3835999720208, 846.0608724316004, 846.2130218896424, 846.8433339832151, 656.0847617573482, 788.7278888783361, 823.6293667849492, 826.0252901576138, 840.5965136734341, 600.9789657361971, 601.8525461261975, 601.9939800602026, 602.2682440834408, 602.3284038297311, 13648.931755341258, 13674.521391751341, 13697.726045479034, 13712.588622341345, 13735.96980226477, 12868.356582170854, 13354.799678004838, 13412.329383530881, 13483.528076517372, 13594.11638243521, 11665.475053622607, 11780.705482362924, 11857.762844743143, 11987.544122816093, 12039.6388108356, 4176.4570605821355, 4261.531231564525, 4273.401723758676, 4283.935740963888, 4302.526722060571, 55908.72045639787, 56018.0, 56023.71988140074, 56034.43965560333, 56519.43480565183, 10256.487175641189, 10319.48402579868, 10404.635837745795, 10507.947460262803, 10654.200934929911, 19071.80928190728, 19229.13468893903, 19702.40892773219, 19730.112144953513, 19767.209311627375, 6439.0, 6485.286618471964, 6485.54601177913, 6554.70503827329, 6563.8359041023405, 3679.1721862580707, 3683.171286460525, 3684.613115622875, 3740.233252183296, 3787.14789172434, 2805.8737356818992, 2928.4875146849217, 2931.4723349796814, 2939.4415061138743, 2945.1900727299735, 488.4895284427781, 501.65135231014824, 502.06365129034816, 502.4272329544322, 515.8632962265003, 446.6828551728244, 478.3446678051023, 482.7079616831766, 486.56938609330996, 502.4297422425573, 7297.927020729725, 7480.8877866832045, 7528.134264559536, 7537.660805263667, 7567.167611562723, 468.24144885285375, 481.25645877119933, 484.4259552430381, 487.16694452486644, 490.84783717047117, 3637.836297366625, 3678.393065144221, 3684.373656478405, 3720.1257704439436, 3774.830132644038, 54933.72533137309, 84927.57536212279, 87492.0, 87726.0, 88107.11892881118, 23393.649095263583, 23460.413489662897, 23554.0, 47422.28866567004, 47606.0, 69687.0, 71437.2856271441, 72134.0, 72157.27842721611, 73283.99999999894, 6810.353016463428, 6860.588364698134, 6886.10480637514, 7011.053507776385, 7190.42476601881, 42659.0, 43958.12083758243, 44021.55978440303, 44263.55736442723, 44916.0, 39585.60414395935, 43322.566774331855, 53341.733291333294, 60357.0, 62918.37081629125, 9074.228690561376, 9079.95460022722, 9213.76965575866, 9309.301802364715, 9325.906740932503, 10414.843777343498, 10455.16358691318, 10706.089982351275, 10790.028897399272, 10940.070094042096, 9149.634014639607, 10730.195235357536, 11113.499892504695, 11469.942650286695, 12178.45196966121, 11190.888091118984, 11193.216474846682, 11225.494852731483, 11293.153013523854, 11447.141464390037, 12468.438920248429, 12593.93703031479, 12773.808392873929, 12819.743605128031, 13229.735405292033, 9803.607855685692, 9979.356129051559, 10634.787304253718, 10662.573497060032, 10967.287126336763, 10125.493725313852, 10315.638952636622, 10339.22455815832, 10376.273660843668, 10422.947885260524], "value": 6202.975957979618, "unit": "score"}], "name": "dromaeo_css", "value": 6406.081446507187, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 113.0, 113.0, 112.0, 113.0, 112.0, 111.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 139.0, 135.0, 180.0, 139.0, 132.0, 155.0, 129.0, 172.0, 129.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 162.0, 162.0, 163.0, 162.0, 162.0, 161.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 109.0, 75.0, 77.0, 74.0, 77.0, 109.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 114.0, 88.0, 87.0, 87.0, 116.0, 87.0, 87.0, 130.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 120.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 63.0, 65.0, 71.0, 64.0, 65.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 75.0, 64.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 86.0, 83.0, 83.0, 90.0, 86.0, 87.0, 121.0, 85.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 130.0, 138.0, 139.0, 133.0, 134.0, 134.0, 133.0, 142.0, 136.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 179.0, 173.0, 170.0, 168.0, 170.0, 171.0, 173.0, 170.0, 167.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 69.0, 68.0, 67.0, 70.0, 68.0, 70.0, 71.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1554.7, "alertThreshold": 2.0}]} 03:49:04 INFO - Return code: 0 03:49:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:04 INFO - # TBPL SUCCESS # 03:49:04 INFO - Running post-action listener: _resource_record_post_action 03:49:04 INFO - ##### 03:49:04 INFO - ##### Finished run-tests step (success) 03:49:04 INFO - ##### 03:49:04 INFO - Running post-run listener: _resource_record_post_run 03:49:04 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541872128; Read time: 20; Write time: 626488 03:49:04 INFO - TinderboxPrint: CPU usage
13.2% 03:49:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 03:49:04 INFO - TinderboxPrint: I/O write bytes / time
541,872,128 / 626,488 03:49:04 INFO - TinderboxPrint: CPU idle
8,341.5 (86.8%) 03:49:04 INFO - TinderboxPrint: CPU user
1,215.9 (12.7%) 03:49:04 INFO - TinderboxPrint: Swap in / out
0 / 0 03:49:04 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 251420672; Read time: 0; Write time: 365924 03:49:04 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290451456; Read time: 20; Write time: 260564 03:49:05 INFO - Running post-run listener: _upload_blobber_files 03:49:05 INFO - Blob upload gear active. 03:49:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:05 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 03:49:05 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'] 03:49:05 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 03:49:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:49:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:06 INFO - (blobuploader) - INFO - Done attempting. 03:49:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:09 INFO - (blobuploader) - INFO - Done attempting. 03:49:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:49:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:49:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:10 INFO - (blobuploader) - INFO - Done attempting. 03:49:10 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:10 INFO - Return code: 0 03:49:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a873c3b1b1bc64bbd13db7dd6420900dc7542ea554de5ff24a01b10617ec7cbf742b026271186acd17c4a999758acf35482b5c43809f6fe0adb1a578824c2a6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93c52769c147b269b2d4e837b59dfa19f55723481ef2bafea1bd16e33093c69c98bf34954f61f6056a0564475f436951c3d0ae819925b6e564df2519e42fc2ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b0881755404b3a638f7f46c9b60ef0b5e13ff7c3cb46d6388a4d18fa1294298c7b8357d167804cd0abb7198e9027c9efa447a49f6bbc744912a4405fd82644d"} 03:49:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:10 INFO - Contents: 03:49:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a873c3b1b1bc64bbd13db7dd6420900dc7542ea554de5ff24a01b10617ec7cbf742b026271186acd17c4a999758acf35482b5c43809f6fe0adb1a578824c2a6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93c52769c147b269b2d4e837b59dfa19f55723481ef2bafea1bd16e33093c69c98bf34954f61f6056a0564475f436951c3d0ae819925b6e564df2519e42fc2ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b0881755404b3a638f7f46c9b60ef0b5e13ff7c3cb46d6388a4d18fa1294298c7b8357d167804cd0abb7198e9027c9efa447a49f6bbc744912a4405fd82644d"} 03:49:10 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:10 INFO - Copying logs to upload dir... 03:49:10 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.087916 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-16 03:49:10.383544) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 03:49:10.389008) ========= 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-1466072872.144675-767667780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a873c3b1b1bc64bbd13db7dd6420900dc7542ea554de5ff24a01b10617ec7cbf742b026271186acd17c4a999758acf35482b5c43809f6fe0adb1a578824c2a6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93c52769c147b269b2d4e837b59dfa19f55723481ef2bafea1bd16e33093c69c98bf34954f61f6056a0564475f436951c3d0ae819925b6e564df2519e42fc2ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b0881755404b3a638f7f46c9b60ef0b5e13ff7c3cb46d6388a4d18fa1294298c7b8357d167804cd0abb7198e9027c9efa447a49f6bbc744912a4405fd82644d"} build_url:https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/JktiOVXwRDGd6TW0r-BqBg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a873c3b1b1bc64bbd13db7dd6420900dc7542ea554de5ff24a01b10617ec7cbf742b026271186acd17c4a999758acf35482b5c43809f6fe0adb1a578824c2a6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/93c52769c147b269b2d4e837b59dfa19f55723481ef2bafea1bd16e33093c69c98bf34954f61f6056a0564475f436951c3d0ae819925b6e564df2519e42fc2ed", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b0881755404b3a638f7f46c9b60ef0b5e13ff7c3cb46d6388a4d18fa1294298c7b8357d167804cd0abb7198e9027c9efa447a49f6bbc744912a4405fd82644d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 03:49:10.414865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:49:10.415190) ========= 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-1466072872.144675-767667780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 03:49:10.501214) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 03:49:10.501595) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 03:49:10.501972) ========= ========= Total master_lag: 0.17 =========