builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1466170026.73 results: success (0) buildid: 20160617053224 builduid: b58e494dee9646349a8d9d3c68e61f9c revision: 535a13bd2bf94fcc72d7e2432100fba85f7c322a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:06.725946) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:06.726371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:06.726640) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:06.813756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:06.814009) ========= 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=db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 06:27:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-06-17 06:27:07 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122731 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:06.951896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:06.952189) ========= 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=db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018511 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:07.000699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:07.001019) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 535a13bd2bf94fcc72d7e2432100fba85f7c322a --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 535a13bd2bf94fcc72d7e2432100fba85f7c322a --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=db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 06:27:07,186 truncating revision to first 12 chars 2016-06-17 06:27:07,186 Setting DEBUG logging. 2016-06-17 06:27:07,186 attempt 1/10 2016-06-17 06:27:07,187 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/535a13bd2bf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 06:27:07,521 unpacking tar archive at: fx-team-535a13bd2bf9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724342 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:07.738518) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:07.739001) ========= script_repo_revision: 535a13bd2bf94fcc72d7e2432100fba85f7c322a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:07.739417) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:07.739701) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 06:27:07.755962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-17 06:27:07.756313) ========= /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=db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:27:08 INFO - MultiFileLogger online at 20160617 06:27:08 in /builds/slave/test 06:27:08 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 06:27:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:27:08 INFO - {'append_to_log': False, 06:27:08 INFO - 'base_work_dir': '/builds/slave/test', 06:27:08 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:27:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:27:08 INFO - 'branch': 'Fx-Team-Non-PGO', 06:27:08 INFO - 'buildbot_json_path': 'buildprops.json', 06:27:08 INFO - 'config_files': ('talos/linux_config.py',), 06:27:08 INFO - 'default_actions': ('clobber', 06:27:08 INFO - 'read-buildbot-config', 06:27:08 INFO - 'download-and-extract', 06:27:08 INFO - 'populate-webroot', 06:27:08 INFO - 'create-virtualenv', 06:27:08 INFO - 'install', 06:27:08 INFO - 'run-tests'), 06:27:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:27:08 INFO - 'download_minidump_stackwalk': True, 06:27:08 INFO - 'download_symbols': 'ondemand', 06:27:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:27:08 INFO - 'tooltool.py': '/tools/tooltool.py', 06:27:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:27:08 INFO - '/tools/misc-python/virtualenv.py')}, 06:27:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:27:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:27:08 INFO - 'installer_path': 'installer.exe', 06:27:08 INFO - 'log_level': 'info', 06:27:08 INFO - 'log_name': 'talos', 06:27:08 INFO - 'log_to_console': True, 06:27:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:27:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:27:08 INFO - 'opt_config_files': (), 06:27:08 INFO - 'pip_index': False, 06:27:08 INFO - 'sps_profile': False, 06:27:08 INFO - 'sps_profile_interval': 0, 06:27:08 INFO - 'suite': 'dromaeojs', 06:27:08 INFO - 'system_bits': '32', 06:27:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:27:08 INFO - 'title': 'talos-linux64-ix-031', 06:27:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:27:08 INFO - 'use_talos_json': True, 06:27:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:27:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:27:08 INFO - 'work_dir': 'build'} 06:27:08 INFO - ##### 06:27:08 INFO - ##### Running clobber step. 06:27:08 INFO - ##### 06:27:08 INFO - Running pre-action listener: _resource_record_pre_action 06:27:08 INFO - Running main action method: clobber 06:27:08 INFO - rmtree: /builds/slave/test/build 06:27:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:27:08 INFO - Running post-action listener: _resource_record_post_action 06:27:08 INFO - ##### 06:27:08 INFO - ##### Finished clobber step (success) 06:27:08 INFO - ##### 06:27:08 INFO - ##### 06:27:08 INFO - ##### Running read-buildbot-config step. 06:27:08 INFO - ##### 06:27:08 INFO - Running pre-action listener: _resource_record_pre_action 06:27:08 INFO - Running main action method: read_buildbot_config 06:27:08 INFO - Using buildbot properties: 06:27:08 INFO - { 06:27:08 INFO - "project": "", 06:27:08 INFO - "product": "firefox", 06:27:08 INFO - "script_repo_revision": "production", 06:27:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:27:08 INFO - "repository": "", 06:27:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:27:08 INFO - "buildid": "20160617053224", 06:27:08 INFO - "pgo_build": "False", 06:27:08 INFO - "basedir": "/builds/slave/test", 06:27:08 INFO - "buildnumber": 1766, 06:27:08 INFO - "slavename": "talos-linux64-ix-031", 06:27:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:27:08 INFO - "platform": "ubuntu64_hw", 06:27:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:27:08 INFO - "branch": "fx-team", 06:27:08 INFO - "repo_path": "integration/fx-team", 06:27:08 INFO - "revision": "535a13bd2bf94fcc72d7e2432100fba85f7c322a", 06:27:08 INFO - "stage_platform": "linux64", 06:27:08 INFO - "builduid": "b58e494dee9646349a8d9d3c68e61f9c", 06:27:08 INFO - "slavebuilddir": "test" 06:27:08 INFO - } 06:27:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:27:08 INFO - Running post-action listener: _resource_record_post_action 06:27:08 INFO - ##### 06:27:08 INFO - ##### Finished read-buildbot-config step (success) 06:27:08 INFO - ##### 06:27:08 INFO - ##### 06:27:08 INFO - ##### Running download-and-extract step. 06:27:08 INFO - ##### 06:27:08 INFO - Running pre-action listener: _resource_record_pre_action 06:27:08 INFO - Running main action method: download_and_extract 06:27:08 INFO - mkdir: /builds/slave/test/build/tests 06:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:08 INFO - https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:27:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:27:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:27:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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 06:27:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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 06:27:12 INFO - Downloaded 1361 bytes. 06:27:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:27:12 INFO - Using the following test package requirements: 06:27:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:27:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:27:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:27:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:12 INFO - u'jsshell-linux-x86_64.zip'], 06:27:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:27:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:27:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:27:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:27:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:27:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:27:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:12 INFO - https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:27:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:27:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:27:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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 06:27:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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 06:27:22 INFO - Downloaded 22654592 bytes. 06:27:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:27:23 INFO - Return code: 0 06:27:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:23 INFO - https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:27:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:27:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:27:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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 06:27:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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 06:27:26 INFO - Downloaded 22654592 bytes. 06:27:26 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'] 06:27:26 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 06:27:28 INFO - Return code: 0 06:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:28 INFO - https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:27:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:27:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:27:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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 06:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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 06:27:29 INFO - Downloaded 14405384 bytes. 06:27:29 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'] 06:27:29 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 06:27:30 INFO - Return code: 0 06:27: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')]} 06:27:30 INFO - https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:27:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:27:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:27:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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 06:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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 06:27:42 INFO - Downloaded 55449583 bytes. 06:27:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:27:42 INFO - mkdir: /builds/slave/test/properties 06:27:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:27:42 INFO - Writing to file /builds/slave/test/properties/build_url 06:27:42 INFO - Contents: 06:27:42 INFO - build_url:https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:27:42 INFO - Running post-action listener: _resource_record_post_action 06:27:42 INFO - Running post-action listener: set_extra_try_arguments 06:27:42 INFO - ##### 06:27:42 INFO - ##### Finished download-and-extract step (success) 06:27:42 INFO - ##### 06:27:42 INFO - ##### 06:27:42 INFO - ##### Running populate-webroot step. 06:27:42 INFO - ##### 06:27:42 INFO - Running pre-action listener: _resource_record_pre_action 06:27:42 INFO - Running main action method: populate_webroot 06:27:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:27:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:27:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:27:42 INFO - '--tppagecycles', 06:27:42 INFO - '7'], 06:27:42 INFO - 'tests': ['tsvgm']}}, 06:27:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:27:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:27:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:27:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:27:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:42 INFO - 'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:42 INFO - 'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['damp', 'tps']}, 06:27:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:42 INFO - 'tests': ['damp', 'tps']}, 06:27:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['dromaeo_dom']}, 06:27:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:27:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['basic_compositor_video']}, 06:27:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:27:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['a11yr', 06:27:42 INFO - 'ts_paint', 06:27:42 INFO - 'tpaint', 06:27:42 INFO - 'sessionrestore', 06:27:42 INFO - 'sessionrestore_no_auto_restore', 06:27:42 INFO - 'tabpaint']}, 06:27:42 INFO - 'other-e10s': {'tests': ['a11yr', 06:27:42 INFO - 'ts_paint', 06:27:42 INFO - 'tpaint', 06:27:42 INFO - 'sessionrestore', 06:27:42 INFO - 'sessionrestore_no_auto_restore', 06:27:42 INFO - 'tabpaint']}, 06:27:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:27:42 INFO - 'ts_paint', 06:27:42 INFO - 'tpaint', 06:27:42 INFO - 'sessionrestore', 06:27:42 INFO - 'sessionrestore_no_auto_restore', 06:27:42 INFO - 'tabpaint']}, 06:27:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:27:42 INFO - 'ts_paint', 06:27:42 INFO - 'tpaint', 06:27:42 INFO - 'sessionrestore', 06:27:42 INFO - 'sessionrestore_no_auto_restore', 06:27:42 INFO - 'tabpaint']}, 06:27:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['a11yr', 06:27:42 INFO - 'ts_paint', 06:27:42 INFO - 'tpaint', 06:27:42 INFO - 'sessionrestore', 06:27:42 INFO - 'sessionrestore_no_auto_restore', 06:27:42 INFO - 'tabpaint']}, 06:27:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['a11yr', 06:27:42 INFO - 'ts_paint', 06:27:42 INFO - 'tpaint', 06:27:42 INFO - 'sessionrestore', 06:27:42 INFO - 'sessionrestore_no_auto_restore', 06:27:42 INFO - 'tabpaint']}, 06:27:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['tsvgx', 06:27:42 INFO - 'tsvgr_opacity', 06:27:42 INFO - 'tart', 06:27:42 INFO - 'tscrollx', 06:27:42 INFO - 'cart']}, 06:27:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:27:42 INFO - 'tsvgr_opacity', 06:27:42 INFO - 'tart', 06:27:42 INFO - 'tscrollx', 06:27:42 INFO - 'cart']}, 06:27:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:42 INFO - 'talos_options': ['--disable-e10s'], 06:27:42 INFO - 'tests': ['tp5o']}, 06:27:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:42 INFO - 'tests': ['tp5o']}, 06:27:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:42 INFO - 'talos_options': ['--disable-e10s', 06:27:42 INFO - '--xperf_path', 06:27:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:42 INFO - 'tests': ['tp5n']}, 06:27:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:42 INFO - 'talos_options': ['--xperf_path', 06:27:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:42 INFO - 'tests': ['tp5n']}}, 06:27:42 INFO - 'talos.zip': {'path': '', 06:27:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:27:42 INFO - Running post-action listener: _resource_record_post_action 06:27:42 INFO - ##### 06:27:42 INFO - ##### Finished populate-webroot step (success) 06:27:42 INFO - ##### 06:27:42 INFO - ##### 06:27:42 INFO - ##### Running create-virtualenv step. 06:27:42 INFO - ##### 06:27:42 INFO - Running pre-action listener: _resource_record_pre_action 06:27:42 INFO - Running main action method: create_virtualenv 06:27:42 INFO - Creating virtualenv /builds/slave/test/build/venv 06:27:42 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 06:27:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:27:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:27:42 INFO - Using real prefix '/usr' 06:27:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:27:43 INFO - Installing distribute.............................................................................................................................................................................................done. 06:27:45 INFO - Installing pip.................done. 06:27:45 INFO - Return code: 0 06:27:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:27:45 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')]} 06:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:45 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')]} 06:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:45 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 0x7ffc87ce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, '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': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', '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 06:27:45 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 06:27:45 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 06:27:45 INFO - Using env: {'DISPLAY': ':0', 06:27:45 INFO - 'HOME': '/home/cltbld', 06:27:45 INFO - 'LANG': 'en_US.UTF-8', 06:27:45 INFO - 'LANGUAGE': 'en_US:en', 06:27:45 INFO - 'LOGNAME': 'cltbld', 06:27:45 INFO - 'MAIL': '/var/mail/cltbld', 06:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:45 INFO - 'MOZ_NO_REMOTE': '1', 06:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:45 INFO - 'NO_EM_RESTART': '1', 06:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:45 INFO - 'PWD': '/builds/slave/test', 06:27:45 INFO - 'SHELL': '/bin/bash', 06:27:45 INFO - 'SHLVL': '1', 06:27:45 INFO - 'TERM': 'linux', 06:27:45 INFO - 'TMOUT': '86400', 06:27:45 INFO - 'USER': 'cltbld', 06:27:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:45 INFO - '_': '/tools/buildbot/bin/python'} 06:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:45 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 06:27:45 INFO - Cleaning up... 06:27:45 INFO - Return code: 0 06:27:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:27:45 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')]} 06:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:45 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')]} 06:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:45 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 0x7ffc87ce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, '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': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', '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 06:27:45 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 06:27:45 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 06:27:45 INFO - Using env: {'DISPLAY': ':0', 06:27:45 INFO - 'HOME': '/home/cltbld', 06:27:45 INFO - 'LANG': 'en_US.UTF-8', 06:27:45 INFO - 'LANGUAGE': 'en_US:en', 06:27:45 INFO - 'LOGNAME': 'cltbld', 06:27:45 INFO - 'MAIL': '/var/mail/cltbld', 06:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:45 INFO - 'MOZ_NO_REMOTE': '1', 06:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:45 INFO - 'NO_EM_RESTART': '1', 06:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:45 INFO - 'PWD': '/builds/slave/test', 06:27:45 INFO - 'SHELL': '/bin/bash', 06:27:45 INFO - 'SHLVL': '1', 06:27:45 INFO - 'TERM': 'linux', 06:27:45 INFO - 'TMOUT': '86400', 06:27:45 INFO - 'USER': 'cltbld', 06:27:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:45 INFO - '_': '/tools/buildbot/bin/python'} 06:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:45 INFO - Downloading/unpacking psutil>=3.1.1 06:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:27:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:47 INFO - Installing collected packages: psutil 06:27:47 INFO - Running setup.py install for psutil 06:27:47 INFO - building 'psutil._psutil_linux' extension 06:27:47 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 06:27:48 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 06:27:48 INFO - building 'psutil._psutil_posix' extension 06:27:48 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 06:27:48 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 06:27:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:48 INFO - Successfully installed psutil 06:27:48 INFO - Cleaning up... 06:27:48 INFO - Return code: 0 06:27:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:48 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 0x7ffc87ce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, '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': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', '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 06:27:48 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 06:27:48 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 06:27:48 INFO - Using env: {'DISPLAY': ':0', 06:27:48 INFO - 'HOME': '/home/cltbld', 06:27:48 INFO - 'LANG': 'en_US.UTF-8', 06:27:48 INFO - 'LANGUAGE': 'en_US:en', 06:27:48 INFO - 'LOGNAME': 'cltbld', 06:27:48 INFO - 'MAIL': '/var/mail/cltbld', 06:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:48 INFO - 'MOZ_NO_REMOTE': '1', 06:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:48 INFO - 'NO_EM_RESTART': '1', 06:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:48 INFO - 'PWD': '/builds/slave/test', 06:27:48 INFO - 'SHELL': '/bin/bash', 06:27:48 INFO - 'SHLVL': '1', 06:27:48 INFO - 'TERM': 'linux', 06:27:48 INFO - 'TMOUT': '86400', 06:27:48 INFO - 'USER': 'cltbld', 06:27:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:48 INFO - '_': '/tools/buildbot/bin/python'} 06:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27: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 06:27:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:27:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:27:50 INFO - Installing collected packages: mozsystemmonitor 06:27:50 INFO - Running setup.py install for mozsystemmonitor 06:27:50 INFO - Successfully installed mozsystemmonitor 06:27:50 INFO - Cleaning up... 06:27:50 INFO - Return code: 0 06:27:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:50 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 0x7ffc87ce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, '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': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', '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 06:27:50 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 06:27:50 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 06:27:50 INFO - Using env: {'DISPLAY': ':0', 06:27:50 INFO - 'HOME': '/home/cltbld', 06:27:50 INFO - 'LANG': 'en_US.UTF-8', 06:27:50 INFO - 'LANGUAGE': 'en_US:en', 06:27:50 INFO - 'LOGNAME': 'cltbld', 06:27:50 INFO - 'MAIL': '/var/mail/cltbld', 06:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:50 INFO - 'MOZ_NO_REMOTE': '1', 06:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:50 INFO - 'NO_EM_RESTART': '1', 06:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:50 INFO - 'PWD': '/builds/slave/test', 06:27:50 INFO - 'SHELL': '/bin/bash', 06:27:50 INFO - 'SHLVL': '1', 06:27:50 INFO - 'TERM': 'linux', 06:27:50 INFO - 'TMOUT': '86400', 06:27:50 INFO - 'USER': 'cltbld', 06:27:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:50 INFO - '_': '/tools/buildbot/bin/python'} 06:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:50 INFO - Downloading/unpacking jsonschema==2.5.1 06:27:50 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 06:27:50 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 06:27:50 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 06:27:50 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 06:27:50 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 06:27:50 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 06:27:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:27:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:52 INFO - Downloading functools32-3.2.3-2.tar.gz 06:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:27:53 INFO - warning: no files found matching '*.txt' 06:27:53 INFO - no previously-included directories found matching 'build' 06:27:53 INFO - no previously-included directories found matching 'dist' 06:27:53 INFO - no previously-included directories found matching '.git*' 06:27:53 INFO - Installing collected packages: jsonschema, functools32 06:27:53 INFO - Running setup.py install for functools32 06:27:53 INFO - warning: no files found matching '*.txt' 06:27:53 INFO - no previously-included directories found matching 'build' 06:27:53 INFO - no previously-included directories found matching 'dist' 06:27:53 INFO - no previously-included directories found matching '.git*' 06:27:53 INFO - Successfully installed jsonschema functools32 06:27:53 INFO - Cleaning up... 06:27:53 INFO - Return code: 0 06:27:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:27: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')]} 06:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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')]} 06:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:53 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 0x7ffc87ce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, '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': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', '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 06:27:53 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 06:27:53 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 06:27:53 INFO - Using env: {'DISPLAY': ':0', 06:27:53 INFO - 'HOME': '/home/cltbld', 06:27:53 INFO - 'LANG': 'en_US.UTF-8', 06:27:53 INFO - 'LANGUAGE': 'en_US:en', 06:27:53 INFO - 'LOGNAME': 'cltbld', 06:27:53 INFO - 'MAIL': '/var/mail/cltbld', 06:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:53 INFO - 'MOZ_NO_REMOTE': '1', 06:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:53 INFO - 'NO_EM_RESTART': '1', 06:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:53 INFO - 'PWD': '/builds/slave/test', 06:27:53 INFO - 'SHELL': '/bin/bash', 06:27:53 INFO - 'SHLVL': '1', 06:27:53 INFO - 'TERM': 'linux', 06:27:53 INFO - 'TMOUT': '86400', 06:27:53 INFO - 'USER': 'cltbld', 06:27:53 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:53 INFO - '_': '/tools/buildbot/bin/python'} 06:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:53 INFO - Downloading/unpacking blobuploader==1.2.4 06:27:53 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 06:27:53 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 06:27:53 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 06:27:53 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 06:27:53 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 06:27:53 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 06:27:55 INFO - Downloading blobuploader-1.2.4.tar.gz 06:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:27:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:27:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:55 INFO - Downloading docopt-0.6.1.tar.gz 06:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:27:56 INFO - Installing collected packages: blobuploader, requests, docopt 06:27:56 INFO - Running setup.py install for blobuploader 06:27:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:27:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:27:56 INFO - Running setup.py install for requests 06:27:56 INFO - Running setup.py install for docopt 06:27:56 INFO - Successfully installed blobuploader requests docopt 06:27:56 INFO - Cleaning up... 06:27:56 INFO - Return code: 0 06:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:56 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 0x7ffc87ce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, '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': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', '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 06:27:56 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 06:27:56 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 06:27:56 INFO - Using env: {'DISPLAY': ':0', 06:27:56 INFO - 'HOME': '/home/cltbld', 06:27:56 INFO - 'LANG': 'en_US.UTF-8', 06:27:56 INFO - 'LANGUAGE': 'en_US:en', 06:27:56 INFO - 'LOGNAME': 'cltbld', 06:27:56 INFO - 'MAIL': '/var/mail/cltbld', 06:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:56 INFO - 'MOZ_NO_REMOTE': '1', 06:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:56 INFO - 'NO_EM_RESTART': '1', 06:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:56 INFO - 'PWD': '/builds/slave/test', 06:27:56 INFO - 'SHELL': '/bin/bash', 06:27:56 INFO - 'SHLVL': '1', 06:27:56 INFO - 'TERM': 'linux', 06:27:56 INFO - 'TMOUT': '86400', 06:27:56 INFO - 'USER': 'cltbld', 06:27:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:56 INFO - '_': '/tools/buildbot/bin/python'} 06:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:56 INFO - Running setup.py (path:/tmp/pip-P7_XWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:56 INFO - Running setup.py (path:/tmp/pip-TRLvG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:57 INFO - Running setup.py (path:/tmp/pip-pF0ppV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:57 INFO - Running setup.py (path:/tmp/pip-mp821o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:57 INFO - Running setup.py (path:/tmp/pip-5BJVsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:57 INFO - Running setup.py (path:/tmp/pip-xdn279-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:57 INFO - Running setup.py (path:/tmp/pip-y5fgvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:57 INFO - Running setup.py (path:/tmp/pip-MhcsG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:57 INFO - Running setup.py (path:/tmp/pip-pAWJ5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:57 INFO - Running setup.py (path:/tmp/pip-l55dTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:57 INFO - Running setup.py (path:/tmp/pip-pMm0xR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:57 INFO - Running setup.py (path:/tmp/pip-pt7SWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:57 INFO - Running setup.py (path:/tmp/pip-Qw6bLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:57 INFO - Running setup.py (path:/tmp/pip-za87du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:57 INFO - Running setup.py (path:/tmp/pip-RwvWv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:57 INFO - Running setup.py (path:/tmp/pip-6RgKyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:58 INFO - Running setup.py (path:/tmp/pip-g3NXRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:27:58 INFO - Running setup.py install for manifestparser 06:27:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Running setup.py install for mozcrash 06:27:58 INFO - Running setup.py install for mozdebug 06:27:58 INFO - Running setup.py install for mozdevice 06:27:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Running setup.py install for mozfile 06:27:58 INFO - Running setup.py install for mozhttpd 06:27:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Running setup.py install for mozinfo 06:27:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Running setup.py install for mozInstall 06:27:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Running setup.py install for mozleak 06:27:59 INFO - Running setup.py install for mozlog 06:27:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:27:59 INFO - Running setup.py install for moznetwork 06:27:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:27:59 INFO - Running setup.py install for mozprocess 06:27:59 INFO - Running setup.py install for mozprofile 06:27:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:27:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:27:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:27:59 INFO - Running setup.py install for mozrunner 06:27:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:27:59 INFO - Running setup.py install for mozscreenshot 06:27:59 INFO - Running setup.py install for moztest 06:27:59 INFO - Running setup.py install for mozversion 06:27:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:27:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:27:59 INFO - Cleaning up... 06:27:59 INFO - Return code: 0 06:27:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:59 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 0x7ffc87ce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, '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': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', '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 06:27:59 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 06:27:59 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 06:27:59 INFO - Using env: {'DISPLAY': ':0', 06:27:59 INFO - 'HOME': '/home/cltbld', 06:27:59 INFO - 'LANG': 'en_US.UTF-8', 06:27:59 INFO - 'LANGUAGE': 'en_US:en', 06:27:59 INFO - 'LOGNAME': 'cltbld', 06:27:59 INFO - 'MAIL': '/var/mail/cltbld', 06:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:59 INFO - 'MOZ_NO_REMOTE': '1', 06:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:59 INFO - 'NO_EM_RESTART': '1', 06:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:59 INFO - 'PWD': '/builds/slave/test', 06:27:59 INFO - 'SHELL': '/bin/bash', 06:27:59 INFO - 'SHLVL': '1', 06:27:59 INFO - 'TERM': 'linux', 06:27:59 INFO - 'TMOUT': '86400', 06:27:59 INFO - 'USER': 'cltbld', 06:27:59 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:59 INFO - '_': '/tools/buildbot/bin/python'} 06:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:00 INFO - Running setup.py (path:/tmp/pip-bxYAEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:00 INFO - Running setup.py (path:/tmp/pip-zpIcAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:00 INFO - Running setup.py (path:/tmp/pip-xxyXUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:00 INFO - Running setup.py (path:/tmp/pip-vK7buz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:00 INFO - Running setup.py (path:/tmp/pip-MH3cDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:00 INFO - Running setup.py (path:/tmp/pip-InVqxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:00 INFO - Running setup.py (path:/tmp/pip-O9Bym_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:00 INFO - Running setup.py (path:/tmp/pip-cAevs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:00 INFO - Running setup.py (path:/tmp/pip-GO4Kkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:00 INFO - Running setup.py (path:/tmp/pip-fHRYFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:00 INFO - Running setup.py (path:/tmp/pip-YsAOvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:00 INFO - Running setup.py (path:/tmp/pip-p9tiI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:01 INFO - Running setup.py (path:/tmp/pip-huWEO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:01 INFO - Running setup.py (path:/tmp/pip-WE8CXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:01 INFO - Running setup.py (path:/tmp/pip-bc1j2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:01 INFO - Running setup.py (path:/tmp/pip-0g8LaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:01 INFO - Running setup.py (path:/tmp/pip-p_tRaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:01 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)) 06:28:01 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)) 06:28:01 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)) 06:28:01 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)) 06:28:01 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)) 06:28:01 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)) 06:28:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:28:01 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 06:28:01 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 06:28:01 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 06:28:01 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 06:28:01 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 06:28:01 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 06:28:03 INFO - Downloading blessings-1.6.tar.gz 06:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:28:03 INFO - Installing collected packages: blessings 06:28:03 INFO - Running setup.py install for blessings 06:28:03 INFO - Successfully installed blessings 06:28:03 INFO - Cleaning up... 06:28:04 INFO - Return code: 0 06:28:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:28:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:04 INFO - Reading from file tmpfile_stdout 06:28:04 INFO - Current package versions: 06:28:04 INFO - argparse == 1.2.1 06:28:04 INFO - blessings == 1.6 06:28:04 INFO - blobuploader == 1.2.4 06:28:04 INFO - docopt == 0.6.1 06:28:04 INFO - functools32 == 3.2.3-2 06:28:04 INFO - jsonschema == 2.5.1 06:28:04 INFO - manifestparser == 1.1 06:28:04 INFO - mozInstall == 1.12 06:28:04 INFO - mozcrash == 0.17 06:28:04 INFO - mozdebug == 0.1 06:28:04 INFO - mozdevice == 0.48 06:28:04 INFO - mozfile == 1.2 06:28:04 INFO - mozhttpd == 0.7 06:28:04 INFO - mozinfo == 0.9 06:28:04 INFO - mozleak == 0.1 06:28:04 INFO - mozlog == 3.2 06:28:04 INFO - moznetwork == 0.27 06:28:04 INFO - mozprocess == 0.22 06:28:04 INFO - mozprofile == 0.28 06:28:04 INFO - mozrunner == 6.11 06:28:04 INFO - mozscreenshot == 0.1 06:28:04 INFO - mozsystemmonitor == 0.3 06:28:04 INFO - moztest == 0.7 06:28:04 INFO - mozversion == 1.4 06:28:04 INFO - psutil == 3.1.1 06:28:04 INFO - requests == 1.2.3 06:28:04 INFO - wsgiref == 0.1.2 06:28:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 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 0x7ffc87ce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, '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': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', '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 06:28:04 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 06:28:04 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 06:28:04 INFO - Using env: {'DISPLAY': ':0', 06:28:04 INFO - 'HOME': '/home/cltbld', 06:28:04 INFO - 'LANG': 'en_US.UTF-8', 06:28:04 INFO - 'LANGUAGE': 'en_US:en', 06:28:04 INFO - 'LOGNAME': 'cltbld', 06:28:04 INFO - 'MAIL': '/var/mail/cltbld', 06:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:04 INFO - 'MOZ_NO_REMOTE': '1', 06:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:04 INFO - 'NO_EM_RESTART': '1', 06:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:04 INFO - 'PWD': '/builds/slave/test', 06:28:04 INFO - 'SHELL': '/bin/bash', 06:28:04 INFO - 'SHLVL': '1', 06:28:04 INFO - 'TERM': 'linux', 06:28:04 INFO - 'TMOUT': '86400', 06:28:04 INFO - 'USER': 'cltbld', 06:28:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:04 INFO - '_': '/tools/buildbot/bin/python'} 06:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 INFO - Cleaning up... 06:28:04 INFO - Return code: 0 06:28:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc87ce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, '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': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', '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 06:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:28:04 INFO - Using env: {'DISPLAY': ':0', 06:28:04 INFO - 'HOME': '/home/cltbld', 06:28:04 INFO - 'LANG': 'en_US.UTF-8', 06:28:04 INFO - 'LANGUAGE': 'en_US:en', 06:28:04 INFO - 'LOGNAME': 'cltbld', 06:28:04 INFO - 'MAIL': '/var/mail/cltbld', 06:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:04 INFO - 'MOZ_NO_REMOTE': '1', 06:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:04 INFO - 'NO_EM_RESTART': '1', 06:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:04 INFO - 'PWD': '/builds/slave/test', 06:28:04 INFO - 'SHELL': '/bin/bash', 06:28:04 INFO - 'SHLVL': '1', 06:28:04 INFO - 'TERM': 'linux', 06:28:04 INFO - 'TMOUT': '86400', 06:28:04 INFO - 'USER': 'cltbld', 06:28:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:04 INFO - '_': '/tools/buildbot/bin/python'} 06:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:28:04 INFO - Cleaning up... 06:28:04 INFO - Return code: 0 06:28:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc87ce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, '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': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', '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 06:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:28:04 INFO - Using env: {'DISPLAY': ':0', 06:28:04 INFO - 'HOME': '/home/cltbld', 06:28:04 INFO - 'LANG': 'en_US.UTF-8', 06:28:04 INFO - 'LANGUAGE': 'en_US:en', 06:28:04 INFO - 'LOGNAME': 'cltbld', 06:28:04 INFO - 'MAIL': '/var/mail/cltbld', 06:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:04 INFO - 'MOZ_NO_REMOTE': '1', 06:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:04 INFO - 'NO_EM_RESTART': '1', 06:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:04 INFO - 'PWD': '/builds/slave/test', 06:28:04 INFO - 'SHELL': '/bin/bash', 06:28:04 INFO - 'SHLVL': '1', 06:28:04 INFO - 'TERM': 'linux', 06:28:04 INFO - 'TMOUT': '86400', 06:28:04 INFO - 'USER': 'cltbld', 06:28:04 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:04 INFO - '_': '/tools/buildbot/bin/python'} 06:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:04 INFO - Downloading/unpacking flake8 06:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:28:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:28:06 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 06:28:06 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 06:28:06 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 06:28:06 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 06:28:06 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 06:28:06 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 06:28:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:28:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:28:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:07 INFO - no previously-included directories found matching 'docs/_build' 06:28:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:28:07 INFO - Running setup.py install for pep8 06:28:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:07 INFO - no previously-included directories found matching 'docs/_build' 06:28:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:28:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:28:07 INFO - Cleaning up... 06:28:07 INFO - Return code: 0 06:28:07 INFO - Running post-action listener: _resource_record_post_action 06:28:07 INFO - Running post-action listener: _start_resource_monitoring 06:28:07 INFO - Starting resource monitoring. 06:28:07 INFO - ##### 06:28:07 INFO - ##### Finished create-virtualenv step (success) 06:28:07 INFO - ##### 06:28:07 INFO - ##### 06:28:07 INFO - ##### Running install step. 06:28:07 INFO - ##### 06:28:07 INFO - Running pre-action listener: _resource_record_pre_action 06:28:07 INFO - Running main action method: install 06:28:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:08 INFO - Reading from file tmpfile_stdout 06:28:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:28:08 INFO - Reading from file tmpfile_stdout 06:28:08 INFO - Output received: 06:28:08 INFO - Usage: mozinstall [options] installer 06:28:08 INFO - Options: 06:28:08 INFO - -h, --help show this help message and exit 06:28:08 INFO - -d DEST, --destination=DEST 06:28:08 INFO - Directory to install application into. [default: 06:28:08 INFO - "/builds/slave/test"] 06:28:08 INFO - --app=APP Application being installed. [default: firefox] 06:28:08 INFO - mkdir: /builds/slave/test/build/application 06:28:08 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'] 06:28:08 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 06:28:24 INFO - Reading from file tmpfile_stdout 06:28:24 INFO - Output received: 06:28:24 INFO - /builds/slave/test/build/application/firefox/firefox 06:28:24 INFO - Running post-action listener: _resource_record_post_action 06:28:24 INFO - ##### 06:28:24 INFO - ##### Finished install step (success) 06:28:24 INFO - ##### 06:28:24 INFO - ##### 06:28:24 INFO - ##### Running run-tests step. 06:28:24 INFO - ##### 06:28:24 INFO - Running pre-action listener: _resource_record_pre_action 06:28:24 INFO - Running main action method: run_tests 06:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:28:24 INFO - Python 2.7.3 06:28:24 INFO - Return code: 0 06:28:24 INFO - grabbing minidump binary from tooltool 06:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:24 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 0x1b372e0>, '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 0x1aa3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa35d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:28:24 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 06:28:24 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 06:28:24 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 06:28:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:28:24 INFO - Return code: 0 06:28:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:28:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:28:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:28:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:28:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:28:25 INFO - Return code: 0 06:28:25 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/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 06:28:25 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/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 06:28:25 INFO - Using env: {'DISPLAY': ':0', 06:28:25 INFO - 'HOME': '/home/cltbld', 06:28:25 INFO - 'LANG': 'en_US.UTF-8', 06:28:25 INFO - 'LANGUAGE': 'en_US:en', 06:28:25 INFO - 'LOGNAME': 'cltbld', 06:28:25 INFO - 'MAIL': '/var/mail/cltbld', 06:28:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:28:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:25 INFO - 'MOZ_NO_REMOTE': '1', 06:28:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:25 INFO - 'NO_EM_RESTART': '1', 06:28:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:25 INFO - 'PWD': '/builds/slave/test', 06:28:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:28:25 INFO - 'SHELL': '/bin/bash', 06:28:25 INFO - 'SHLVL': '1', 06:28:25 INFO - 'TERM': 'linux', 06:28:25 INFO - 'TMOUT': '86400', 06:28:25 INFO - 'USER': 'cltbld', 06:28:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423', 06:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:25 INFO - '_': '/tools/buildbot/bin/python'} 06:28:25 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/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 06:28:25 INFO - mozversion application_buildid: 20160617053224 06:28:25 INFO - mozversion application_changeset: 535a13bd2bf94fcc72d7e2432100fba85f7c322a 06:28:25 INFO - mozversion application_display_name: Nightly 06:28:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:28:25 INFO - mozversion application_name: Firefox 06:28:25 INFO - mozversion application_remotingname: firefox 06:28:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:28:25 INFO - mozversion application_vendor: Mozilla 06:28:25 INFO - mozversion application_version: 50.0a1 06:28:25 INFO - mozversion platform_buildid: 20160617053224 06:28:25 INFO - mozversion platform_changeset: 535a13bd2bf94fcc72d7e2432100fba85f7c322a 06:28:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:28:25 INFO - mozversion platform_version: 50.0a1 06:28:25 INFO - using testdate: 1466170105 06:28:25 INFO - actual date: 1466170105 06:28:25 INFO - starting webserver on 'localhost:44082' 06:28:25 INFO - SUITE-START | Running 2 tests 06:28:25 INFO - TEST-START | dromaeo_css 06:28:25 INFO - operating with platform_type : linux_ 06:28:25 INFO - Initialising browser for dromaeo_css test... 06:28:25 INFO - TEST-INFO | started process 13824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9MuS2g/profile http://localhost:44082/getInfo.html) 06:28:29 INFO - PROCESS | 13824 | __metrics Screen width/height:1600/1200 06:28:29 INFO - PROCESS | 13824 | colorDepth:24 06:28:29 INFO - PROCESS | 13824 | Browser inner width/height: 1024/697 06:28:29 INFO - PROCESS | 13824 | __metrics 06:28:30 INFO - PROCESS | 13824 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:28:31 INFO - TEST-INFO | 13824: exit 0 06:28:31 INFO - Browser initialized. 06:28:31 INFO - Running cycle 1/1 for dromaeo_css test... 06:28:31 INFO - TEST-INFO | started process 13902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9MuS2g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:28:43 INFO - PROCESS | 13902 | RSS: Main: 175685632 06:28:43 INFO - PROCESS | 13902 | 06:29:34 INFO - PROCESS | 13902 | 1466170174915 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] 06:31:47 INFO - PROCESS | 13902 | Cycle 1(1): loaded http://localhost:44082/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44082/tests/dromaeo/cssquery-ext.html) 06:31:48 INFO - PROCESS | 13902 | RSS: Main: 263794688 06:31:48 INFO - PROCESS | 13902 | 06:34:51 INFO - PROCESS | 13902 | Cycle 1(1): loaded http://localhost:44082/tests/dromaeo/cssquery-ext.html (next: http://localhost:44082/tests/dromaeo/cssquery-jquery.html) 06:34:51 INFO - PROCESS | 13902 | RSS: Main: 261152768 06:34:51 INFO - PROCESS | 13902 | 06:37:54 INFO - PROCESS | 13902 | Cycle 1(1): loaded http://localhost:44082/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44082/tests/dromaeo/cssquery-mootools.html) 06:37:54 INFO - PROCESS | 13902 | RSS: Main: 254730240 06:37:54 INFO - PROCESS | 13902 | 06:40:57 INFO - PROCESS | 13902 | Cycle 1(1): loaded http://localhost:44082/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44082/tests/dromaeo/cssquery-prototype.html) 06:40:57 INFO - PROCESS | 13902 | RSS: Main: 252391424 06:40:57 INFO - PROCESS | 13902 | 06:44:00 INFO - PROCESS | 13902 | Cycle 1(1): loaded http://localhost:44082/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44082/tests/dromaeo/cssquery-yui.html) 06:44:01 INFO - PROCESS | 13902 | RSS: Main: 229969920 06:44:01 INFO - PROCESS | 13902 | 06:47:04 INFO - PROCESS | 13902 | Cycle 1(1): loaded http://localhost:44082/tests/dromaeo/cssquery-yui.html (next: http://localhost:44082/tests/dromaeo/cssquery-dojo.html) 06:47:04 INFO - PROCESS | 13902 | RSS: Main: 340365312 06:47:04 INFO - PROCESS | 13902 | 06:47:04 INFO - PROCESS | 13902 | __start_tp_report 06:47:04 INFO - PROCESS | 13902 | _x_x_mozilla_page_load 06:47:04 INFO - PROCESS | 13902 | _x_x_mozilla_page_load_details 06:47:04 INFO - PROCESS | 13902 | |i|pagename|runs| 06:47:04 INFO - PROCESS | 13902 | |0;dojo.html;2627.6058591211317;2635.446556223193;2666.733326667332;2669.546177149885;2680.2227354067336;4704.31787390829;4726.881827954303;4778.9044219115685;4794.568488836008;4867.075255701418;4772.164871147553;4774.904501909959;4816.157172494817;4819.397575303087;4890.951090489094;4333.6749743769105;4343.5004974427875;4388.166248412791;4452.065066336073;4517.232070548015;4418.403515525427;4443.200223959686;4454.599086082252;4460.107978404316;4483.484399294074;4303.07483890965;4345.435093437864;4352.107817897323;4360.760158191299;4391.27543955247;4342.826286948518;4344.761038142901;4346.56534346566;4389.100234451929;4403.955960440387;4374.190774706658;4374.475062992461;4376.584224498668;4381.189479946188;4419.756913369795;4595.310703394518;4629.675922685414;4661.813527458898;4787.066522028206;4828.903421931542;5047.217681259411;5060.063888180698;5065.240213967897;5066.265391518246;5067.797288108472;5035.521625445577;5057.822976195852;5094.286799848024;5100.362454693163;5108.386993560759;4582.518835522289;4745.762711864428;4748.287756836433;4803.159447096744;4812.06164797868;5300.549453296436;5313.203019547099;5321.175217841163;5322.654027488201;5329.094054010828;5070.112730272188;5105.33630628016;5110.71891045996;5118.488151184852;5121.385433747974;4968.105740966661;5045.066662667418;5073.923891141636;5129.435762066169;5134.178531435027;5070.239464080418;5071.695698258116;5072.644914855925;5073.188289873602;5117.385913690381;5050.949490505048;5054.090263752486;5054.166062599704;5057.317262169634;5094.133997220481;4302.978485107555;4351.021020270414;4352.978235108804;4416.028473735773;4426.402435671143;3829.6553310202216;3850.5186851643543;3884.2037382336553;3890.902727431837;3891.4357418174204;4310.719803212781;4371.256886329332;4384.342348647729;4391.187630288407;4401.977990110029;5122.129238029544;5133.204353325241;5140.306058682105;5152.639315247897;5173.1722924331925;4407.140607581491;4407.140607581555;4407.867763967086;4440.245158323093;4450.755208463501;4579.519150489217;4615.030843522898;4640.257558790578;4642.048380082143;4645.396098507173;4845.224764037737;4857.344258525054;4859.343988561499;4859.392575928009;4894.632902532253;5131.512506311894;5152.871178220425;5176.327077479904;5178.093833579033;5184.429712731521;4675.649326300609;4800.66395352336;4852.102361063215;4862.246351815475;4879.87800304981;5085.237214417867;5103.515166059218;5115.386153661584;5119.283300337881;5160.303359046631;5017.422996355466;5176.482351764794;5189.195674670432;5190.455002224712;5191.844244672666;4949.282354058713;4997.275395067622;5002.324686167321;5022.397312322545;5037.294778731054;5027.472115427828;5030.5975521957425;5040.092783299041;5040.344755181803;5086.109930762028;4810.326554282333;4834.830780922651;4954.5540901319055;4961.330220420197;5008.023435430056;4975.751212439436;4983.8504844854715;4995.950040499694;5011.649184557046;5058.873528161826;4888.144574699484;4889.193283108248;4891.95108048915;4897.216445368724;4950.4059512858685 06:47:04 INFO - PROCESS | 13902 | |1;ext.html;555.5694336888911;586.9706514674265;595.4908553187025;606.5329696133977;610.2280615021997;29025.56461653074;31510.369792604135;31580.68419315806;31630.051098467055;31655.525167122483;32030;41520.377194342036;42601;42653;46842;7900.683972641087;8029.076656184526;8031.393721255743;8032.39757018226;8034.477758945679;7859.842803143933;7921.881171782428;7937.682492700285;7946.443748937577;7952.840943181133;7933.880991785128;7953.244441778022;7970;7971.840563188733;7976.361891048731;7897;7959.0847052589115;7965.283124518821;7969.800754981114;7973.800654983614;7896.210378962115;7906.644201010969;7955.562444065574;7958.761237162837;7986.960065199695;38794.418083728764;39458;39547.40678889819;39564;39643.40534891979;3055.908322750299;3087.197328694533;3150.9054728358187;3186.3786561620495;3300.3399320135827;28213.717862821315;29374;29984.100476985725;30231.674515803243;30418;3584.731145164097;3592.2815436912724;3608.5308909841815;3617.94573081404;3630.909227269313;187373;187784.99999999863;187875;188082;188186;54858.45141548533;55046;55400.16899746507;55449;55514;32807;58227.12659310114;58284.41715582875;58296;58485.70757146187;12968.157069790434;13046.347682615831;13091.869081309065;13106.344682765824;13132.934335328262;11032.779344413068;11154.330740155616;11155.72110697239;11162.888371116185;11169.83245251322;18715.251389944522;18739.063046847605;18791;18819.71770423445;18822;6671.799846004531;7085.397741192057;7120.71517139319;7126.144862616416;7155.606441645759;790.8576456237818;800.5596921693045;885.6103314541581;962.4177372689562;973.6592192732487;26343.736562634127;27415.725842741715;27487.725122748918;28901.56647650287;29548.113556593336;846.7205822078699;933.1368484152132;968.8982656821073;970.9563069661882;1019.1235537437798;14539.127652340894;14981.250937453084;15012.774808377882;15240.618984525476;15353.925225234127;362578;366327;366549;366642;367299;48745;49908;49945;49949.75025124851;49973;1071.6517131931998;1154.4977934598476;1173.1729130962651;1176.5587904535628;1189.9464524096436;28136.29659258535;29076;29301.70698293075;29537.704622953497;29789.70210297956;42180.367294489995;42560.57439425566;42808.57191428046;42870;42948;316036;317926;318061;318985;319019;35309.29381412409;37994.24011519699;39181.80409097936;39363.80318098391;42562;42990.35514467348;43314.56685433105;43747;43971;44164.337534937644;36270.8186459066;36925.63074369222;37362;37371.81314093412;37801.62198377981;36822;36822;37029.259414811015;37054.6294537062;37420.43869341908;35713;36360.63639363572;36452.81773591115;37112.443313350865;37218.62781372152;32388.83805580957;33552.664473354955;33824.830875845466;34083;34239.14402139966;25604.487910241318;25650.8717456419;25701.887697968235;25859.353516162246;25860.35349116287 06:47:04 INFO - PROCESS | 13902 | |2;jquery.html;373.89717827597417;374.5598921267511;376.52745804015956;382.60400485497513;395.25494442975;15389.230538473073;17130.229139688712;17305.7404138938;17798.46604601864;17824.64350712985;14970.700585988274;15787.447439339596;15806.762898556532;16207.189640517985;16407.425740099097;4572.177008138534;4699.600533954618;4721.69308994916;4747.145513807513;4751.691140075884;3519.472079188117;3688.114852435423;4613.538646135376;5132.281480592701;5428.728563571825;5457.69982650956;5462.262594549725;5473.151661492455;5488.396276409591;5489.670619762807;5062.164742817449;5372.274742909696;5378.354597448292;5447.428020057916;5455.0453670607685;3406.233597440581;5040.269160971675;5281.551068159211;5392.973035134838;5403.540699040586;12138.878611213862;12283.57007504733;12394;13538.932305338509;20731.170753169856;1988.532694816717;1990.4924244317751;2020.3029954665617;2120.586485635302;2198.318521258415;9219.723408297761;9231.353805233637;9233.49215793131;9304.348695591312;9660.275479339078;1600.2638786158382;1601.6316247263194;1673.7740405045286;1684.866148962928;1687.966240675192;63682;65505;65636.34363656398;66313.6684316585;67605.32394676088;9655.71032869001;10191.439470829027;10381.429021403896;10382.3251488653;10403.5838566458;14013.159210447406;14088.295585220698;14240.287985600678;14279.071860329046;14302.928485357716;7028;7118.323759242864;7131.71473141079;7153.6780844862105;7361.48469607133;6740.157480314961;6755.324467553205;6877.140357455318;6916.377526022682;6921.446284297244;4324.913501729948;4456.30235014654;4464.352668862996;4467.195904737178;4542.273236282179;1666.691662042526;1742.7866609405983;1758.5691505581215;1795.5600877784766;1846.9353572624893;727.7198278662753;910.5720311453606;927.735595355334;935.1350001248818;966.5312323523086;16302;16865.32538698463;17026.659466810594;17130.14349282556;17376.21807018687;866.5927014303268;884.3720958119807;885.1546772832058;894.9373543851868;898.4788822482944;9294.488803115893;9848.50757462124;9925.156361709336;9934.850977235346;10091.394516328897;375667;379929;380399;381804;383821;78268;78918;79150.66794656414;79859;80269;908.5411867007119;916.7433118726767;922.4465320807597;932.7994481186441;938.1931538876561;15352.69294614079;15418.306176221873;15443.69112617719;15452.381904723685;15788.526344209693;33983.15042123868;35349.82325088358;35839.92480225598;36431.635683642824;36688.44967325439;45541.77229113833;47237.52762472331;47773.76113119412;49238.507614923394;49646.25530617116;6568.638724870178;7190.352868241884;7224.927750722425;7321.304476074764;7438.814029649302;9070.410423322463;12075.818862716891;12138.33239171854;12243.632691019284;12441.751164976831;10319.48402579883;10365.32625379378;10433.113185379025;10703.839442408525;10749.838752418877;10330.173586113244;10376.221783366429;10575.947120264656;10650;10780.191485638452;10533.57865685364;10534.578616855546;10698.62554810578;10830.566777329133;10834.783304334027;7229.819254518679;7380.077490313711;7393.07586551681;7403.962980185064;7416.480846340704;9731.610735570497;10101.646442374775;10111;10300.793984120126;10450.68647940563 06:47:04 INFO - PROCESS | 13902 | |3;mootools.html;1180.0972256223986;1350.8108864758935;1412.5479846449134;1478.5416520878528;1709.3931654262744;6782.762603308885;7718.652660630271;8023.358131349492;8037;8043.55760433176;7830.138684744674;7884.684612615503;7956.602169891511;7962.920370796291;7967.76096717098;1905.1522072677665;2127.9787202127936;2204.8236141108714;2219.7447293561204;2239.6080685879906;2239.708837851077;2255.672927425522;2261.3216035189375;2262.7058482397265;2263.864168149916;2200.3179014505477;2220.500387412835;2225.643896976484;2228.3426389215138;2229.2754854672216;1813.6826055440245;2015.9596808063902;2101.4536220582604;2102.127617038927;2157.85973911696;2154.278316763886;2169.240765731997;2171.0447403142725;2172.7935846094597;2174.847760656755;7887.566183859885;7942.920570794276;7947.96026019872;7952;7960.641771120314;4365.978170109161;4478.193925093482;4501.482329532113;4508.549145085465;4512.954870451319;2764.7926405519465;2861.370498490329;2961.8519074046426;3003.9636325467677;3008.864601092934;896.9416987895765;897.6499165325529;911.4986757283467;914.3051281026401;923.6813299411692;10794;10801.513931873085;10813.729656758644;10840.024397804236;10856.837147442795;4095.7542547447247;4244.978775106105;4254.319308910622;4325.632321252729;4335.067960388532;9015.098490151064;9092.408993415407;9103.590338434786;9107.726768196964;9110.088991100969;4620.145273124483;4624.514425985223;4627.028324051987;4627.375304333939;4627.467841198305;3658.2683463307444;4084.571120032413;4199.496060472702;4205.516365617932;4259.829606815692;3633.94549081764;3660.6888414485065;3719.739618226752;3732.64539868712;3776.4146557283666;1174.4890972427022;1209.2019267283551;1212.7392610588765;1227.7237621535082;1234.234774439853;756.7729681095649;793.9321612431271;809.0655293136437;835.415209353455;841.1126261793867;5271.499207575274;5275.525202731696;5296.894062118813;5322.547583455373;5333.439988801198;895.8745775591423;899.5309164218806;941.1623654947102;955.345588272022;994.22450488619;3382.780119292238;3560;3593.874214402483;3602.090891827336;3666.688331491853;9490.952545237229;9677.274204434696;9729.270304727173;9827.11555959967;9866.703998880044;9528.475933823705;9774.266929980138;9774.51127443625;9777.120059194707;9789.46157961319;7187.676554555058;7202.20775714671;7272.96363518179;7289.453291003196;7308.1230252369;5021.49785021495;5109.310243117132;5140.049090918192;5197.610179236648;5245.082110630548;8467.11095334981;8699.347548933729;8723.214910658071;8949.910500894908;8970.102989700978;8902.643894244417;8911.465312081296;8926.509042002752;8997.730068097968;9022.052684468037;5911.408859114226;6343.207099112611;6477.967610161919;6514.9348506514325;6593.175853018372;7550.735724249625;7613.467057305936;7641.42689298316;7670.27132422419;7675.155732869268;6428.742850285937;6543.640099794557;6664.766733164316;6673.966630167012;6791.3548212919695;6504.512161587994;6546.443552298108;6549.083128362128;6599.967000164968;6687.1975362956755;5946.643201407929;5995.580309378476;6018.067199584071;6021.066734656135;6028.186194863637;4494.932576011297;4522.570355816192;4647.279671650899;4651.3720647712125;4708.92936605958;4428.512863584939;4483.125790470827;4490.259107247398;4536.500984891593;4546.272596384562 06:47:04 INFO - PROCESS | 13902 | |4;prototype.html;300.9488386974214;306.0664971835901;309.31486756833624;310.0265167374444;310.15946784214776;4827.131116399047;4879.609631229502;4891;4904.632152588557;4923.975380123099;4822.228443449048;4827.903441931168;4829.444613869406;4834.2265237562;4837.516248375161;3613.512175856265;3726.869559565416;3732.440133979911;3739.2147648993746;3769.2838360711376;3640.4903313535992;3754.9812250938708;3768.547774267092;3788.7726736395766;3850.84596616135;3683.8027641016643;3718.4794128821986;3724.664780169784;3731.1231860512758;3732.328180927432;3615.5299811024397;3729.8881033569037;3741.962580374216;3755.4179102239195;3763.416670416076;3130.89041883533;3250.6424293327714;3342.715869151125;3350.2193179661067;3356.1441832332844;4679.60223381013;4679.625629949596;4684.789184486706;4689.20283551797;4701.952980470186;4287.656987440997;4304.740011493959;4304.945288404329;4313.180495705806;4315.848945286932;4852.878678033042;5024.522670346311;5035.590034790264;5053.267276244961;5055.974720126413;3626.6192049834654;3633.1643721943838;3635.8727444539313;3651;3655.323765103464;5242.9213561796605;5275.573236311301;5276.736163191825;5276.92084618731;5302.628815982883;3632.564092308887;3713.1459764254373;3736;3749.812509374575;3775.8867233983024;3766.8681596144;3773.603771603997;3776.188119554309;3801.847926082981;3808.200277941608;4234.28511452862;4257.276263035292;4261.573842615776;4265.4881414230495;4267.317229243368;5027.8938633500575;5031.7987280509105;5039.3952725672425;5041.260765036057;5041.59667226621;1263.8625237286515;1304.562971404571;1314.1392387985884;1334.126147373472;1334.8998825088158;853.2320911179987;872.9345299102592;874.2699845628971;874.4054043250651;881.7839629290864;3934.272159650474;3979.880603581897;3989.202159568098;4001.8599349023225;4008.2985477541315;4657.950501779274;4686.118037407038;4691.82704323919;4711;4733.857984260478;3921.8627348042683;4046.635802777764;4046.9275641954905;4059.918801623951;4075.7758323292505;2313.37538864509;2468.3335499415057;2468.9753102469103;2664.8407942545055;2718.8640567971524;4917.336159618477;4936.951165266446;4949.183384741477;4953.702777833341;4955.876103097379;5299.894002119936;5328.749462827672;5340.626156169031;5342.839714808484;5383.300170977826;4701.27130294798;4950.5544500994365;4977.601791856643;4987.401511818605;4990.351254336913;5263;5287.656302340336;5291.682499049915;5302.151655735064;5303.5757139429525;5218.478152184751;5222.451642577475;5224.9738751306;5228.738563071755;5242.370915490165;4756.120117778222;4952.925706114339;4962.330085438564;4975.328330675313;4995.550400463976;3678.521792167001;3688.6864616507896;3699.8890033299044;3727.2545490901384;3767.321882061255;5286.3392075990505;5301.310829592128;5330.653507522154;5335.35975682905;5394.435613672148;4955.925661115159;5096.955124199456;5105.923411148761;5130.769115389742;5154.14956532168;5058;5058.54473097423;5070.670406423571;5078.568321692697;5106.285120083266;5018.5232402921665;5018.573421259088;5035.748212589283;5041.773120209526;5070.746462676925;4819.493953135011;5103;5113.795448182031;5121.823225129379;5164.715940623151;4950.762309422645;4975.353204083446;4992;4996.2505624156665;5033.144365457808 06:47:04 INFO - PROCESS | 13902 | |5;yui.html;591.7248479457052;603.3182503770739;620.6183197333642;628.0798630007039;675.5102550650782;12086.395680215976;12792.104552681305;13661.112027718204;14608.19654918979;15311.310991005405;14329.140251584911;14906.552803415887;15002.924985375084;15011.624709382271;15031.248437578131;626.298545628894;781.7732857471326;799.7840583042575;805.7381351060899;808.2079562029215;792.1563534835382;793.0602236349915;796.108358638323;796.2634563029204;796.5220867479524;831.7130589946458;834.7036801935317;835.0688981785327;835.1398059998212;835.4736515994915;654.3260441745034;672.4687496877461;672.6367761408833;677.5900580148988;828.8218033122878;587.3245767367519;603.8248907816728;605.1316361021903;605.3915814606337;605.7788907048939;13009.21944683322;13033.087683862133;13038.739225215442;13078.542251021168;13136.474541018444;12692;13272.469101235938;13326.93336533311;13366.465341386333;13697;11898.762024759457;12121.818172727417;12157.331346775924;12177.695557611041;12398.31809250491;4196.81114349855;4229.6827737919475;4276.358546218061;4278.850240241608;4283.657307415399;58352;59287;60277.39722602762;60654.69672651653;60763.69618151925;10581.36511809294;10648.307859989076;10664.253502254924;10665.390806831725;10888.40113793749;20519.38441846747;20880.47798805042;20919.790802091786;20935.476613084797;21005.894970525354;6828;6846.520743547904;6861;6873.621950792654;7085.326893945067;3700.8704695336073;3863.8840834775;3881.825317860703;3928.4500169976227;3929.5677475477673;3020.6677265500775;3118;3125.812451252932;3128.702773236539;3130.0296907958605;511.9027384796877;519.1693290734794;527.4145698274912;531.3013387395563;532;467.73339196657577;472.5912086045615;477.0173442708033;509.59996402824345;519.654429804176;7738;7852.528848269122;7975.72084977023;8017.4387792855105;8163.510189388537;403.29222215012464;526.6655673647261;543.8613153645874;545.2992904118269;551.7282366983511;3729.5710993235584;3855.267499175148;3881.728279020498;3882.7929556882186;3897.0841852164717;90534.54732726426;91184;91508.54245728729;93592.0640793597;93898;72276.27723722695;75584.62207689036;76075;76270.23729762631;76771.61614192005;43587;44359;45415;47886.76056619764;63740.362596373445;7353.669084891086;7463.6641351140415;8395.24442800151;8395.622197001272;8439.409241353047;39262.21475570415;42137.789311053246;42567.78716106524;42697.35953960631;42826.57173428226;38943.805280973414;44916.326255106855;48406;57381;59128.408715912294;10491.422971736627;10852.620158294421;11169.553217871195;11250.828586095742;11396.715082122682;12245.816312755138;12389.132760706663;12472.501099956264;12586.18189817659;13767.931160344535;11560.537578496765;11924.403779810802;12036.939815300868;12053.337066461429;12900.032497562908;10812;10832.97086776755;11560.768784624428;11698.06415486742;12024.579139730067;11593.478293476983;11986.520539178335;11988.040956723615;12094.352682239632;12155.878441215475;10770.73073173177;10787.784244315228;10885.510152043336;10941;11513.194076414906;10291.94854025725;10502.422366769595;10508.684739457829;10543.20925930543;10864.891351086388 06:47:04 INFO - PROCESS | 13902 | __end_tp_report 06:47:04 INFO - PROCESS | 13902 | __start_cc_report 06:47:04 INFO - PROCESS | 13902 | _x_x_mozilla_cycle_collect,858 06:47:04 INFO - PROCESS | 13902 | __end_cc_report 06:47:04 INFO - PROCESS | 13902 | __startTimestamp1466171224446__endTimestamp 06:47:04 INFO - PROCESS | 13902 | 06:47:04 INFO - PROCESS | 13902 | ------- Summary: start ------- 06:47:04 INFO - PROCESS | 13902 | Number of tests: 6 06:47:04 INFO - PROCESS | 13902 | 06:47:04 INFO - PROCESS | 13902 | [#0] dojo.html Cycles:165 Average:4733.45 Median:4862.25 stddev:498.32 (10.2%) stddev-sans-first:471.67 06:47:04 INFO - PROCESS | 13902 | Values: 2627.6 2635.4 2666.7 2669.5 2680.2 4704.3 4726.9 4778.9 4794.6 4867.1 4772.2 4774.9 4816.2 4819.4 4891.0 4333.7 4343.5 4388.2 4452.1 4517.2 4418.4 4443.2 4454.6 4460.1 4483.5 4303.1 4345.4 4352.1 4360.8 4391.3 4342.8 4344.8 4346.6 4389.1 4404.0 4374.2 4374.5 4376.6 4381.2 4419.8 4595.3 4629.7 4661.8 4787.1 4828.9 5047.2 5060.1 5065.2 5066.3 5067.8 5035.5 5057.8 5094.3 5100.4 5108.4 4582.5 4745.8 4748.3 4803.2 4812.1 5300.5 5313.2 5321.2 5322.7 5329.1 5070.1 5105.3 5110.7 5118.5 5121.4 4968.1 5045.1 5073.9 5129.4 5134.2 5070.2 5071.7 5072.6 5073.2 5117.4 5050.9 5054.1 5054.2 5057.3 5094.1 4303.0 4351.0 4353.0 4416.0 4426.4 3829.7 3850.5 3884.2 3890.9 3891.4 4310.7 4371.3 4384.3 4391.2 4402.0 5122.1 5133.2 5140.3 5152.6 5173.2 4407.1 4407.1 4407.9 4440.2 4450.8 4579.5 4615.0 4640.3 4642.0 4645.4 4845.2 4857.3 4859.3 4859.4 4894.6 5131.5 5152.9 5176.3 5178.1 5184.4 4675.6 4800.7 4852.1 4862.2 4879.9 5085.2 5103.5 5115.4 5119.3 5160.3 5017.4 5176.5 5189.2 5190.5 5191.8 4949.3 4997.3 5002.3 5022.4 5037.3 5027.5 5030.6 5040.1 5040.3 5086.1 4810.3 4834.8 4954.6 4961.3 5008.0 4975.8 4983.9 4996.0 5011.6 5058.9 4888.1 4889.2 4892.0 4897.2 4950.4 06:47:04 INFO - PROCESS | 13902 | 06:47:04 INFO - PROCESS | 13902 | [#1] ext.html Cycles:180 Average:45520.56 Median:36977.45 stddev:78976.09 (213.6%) stddev-sans-first:79125.47 06:47:04 INFO - PROCESS | 13902 | Values: 555.6 587.0 595.5 606.5 610.2 29025.6 31510.4 31580.7 31630.1 31655.5 32030.0 41520.4 42601.0 42653.0 46842.0 7900.7 8029.1 8031.4 8032.4 8034.5 7859.8 7921.9 7937.7 7946.4 7952.8 7933.9 7953.2 7970.0 7971.8 7976.4 7897.0 7959.1 7965.3 7969.8 7973.8 7896.2 7906.6 7955.6 7958.8 7987.0 38794.4 39458.0 39547.4 39564.0 39643.4 3055.9 3087.2 3150.9 3186.4 3300.3 28213.7 29374.0 29984.1 30231.7 30418.0 3584.7 3592.3 3608.5 3617.9 3630.9 187373.0 187785.0 187875.0 188082.0 188186.0 54858.5 55046.0 55400.2 55449.0 55514.0 32807.0 58227.1 58284.4 58296.0 58485.7 12968.2 13046.3 13091.9 13106.3 13132.9 11032.8 11154.3 11155.7 11162.9 11169.8 18715.3 18739.1 18791.0 18819.7 18822.0 6671.8 7085.4 7120.7 7126.1 7155.6 790.9 800.6 885.6 962.4 973.7 26343.7 27415.7 27487.7 28901.6 29548.1 846.7 933.1 968.9 971.0 1019.1 14539.1 14981.3 15012.8 15240.6 15353.9 362578.0 366327.0 366549.0 366642.0 367299.0 48745.0 49908.0 49945.0 49949.8 49973.0 1071.7 1154.5 1173.2 1176.6 1189.9 28136.3 29076.0 29301.7 29537.7 29789.7 42180.4 42560.6 42808.6 42870.0 42948.0 316036.0 317926.0 318061.0 318985.0 319019.0 35309.3 37994.2 39181.8 39363.8 42562.0 42990.4 43314.6 43747.0 43971.0 44164.3 36270.8 36925.6 37362.0 37371.8 37801.6 36822.0 36822.0 37029.3 37054.6 37420.4 35713.0 36360.6 36452.8 37112.4 37218.6 32388.8 33552.7 33824.8 34083.0 34239.1 25604.5 25650.9 25701.9 25859.4 25860.4 06:47:04 INFO - PROCESS | 13902 | 06:47:04 INFO - PROCESS | 13902 | [#2] jquery.html Cycles:180 Average:23664.44 Median:2360.08 stddev:62843.08 (2662.7%) stddev-sans-first:62995.04 06:47:04 INFO - PROCESS | 13902 | Values: 373.9 374.6 376.5 382.6 395.3 15389.2 17130.2 17305.7 17798.5 17824.6 14970.7 15787.4 15806.8 16207.2 16407.4 4572.2 4699.6 4721.7 4747.1 4751.7 3519.5 3688.1 4613.5 5132.3 5428.7 5457.7 5462.3 5473.2 5488.4 5489.7 5062.2 5372.3 5378.4 5447.4 5455.0 3406.2 5040.3 5281.6 5393.0 5403.5 12138.9 12283.6 12394.0 13538.9 20731.2 1988.5 1990.5 2020.3 2120.6 2198.3 9219.7 9231.4 9233.5 9304.3 9660.3 1600.3 1601.6 1673.8 1684.9 1688.0 63682.0 65505.0 65636.3 66313.7 67605.3 9655.7 10191.4 10381.4 10382.3 10403.6 14013.2 14088.3 14240.3 14279.1 14302.9 7028.0 7118.3 7131.7 7153.7 7361.5 6740.2 6755.3 6877.1 6916.4 6921.4 4324.9 4456.3 4464.4 4467.2 4542.3 1666.7 1742.8 1758.6 1795.6 1846.9 727.7 910.6 927.7 935.1 966.5 16302.0 16865.3 17026.7 17130.1 17376.2 866.6 884.4 885.2 894.9 898.5 9294.5 9848.5 9925.2 9934.9 10091.4 375667.0 379929.0 380399.0 381804.0 383821.0 78268.0 78918.0 79150.7 79859.0 80269.0 908.5 916.7 922.4 932.8 938.2 15352.7 15418.3 15443.7 15452.4 15788.5 33983.2 35349.8 35839.9 36431.6 36688.4 45541.8 47237.5 47773.8 49238.5 49646.3 6568.6 7190.4 7224.9 7321.3 7438.8 9070.4 12075.8 12138.3 12243.6 12441.8 10319.5 10365.3 10433.1 10703.8 10749.8 10330.2 10376.2 10575.9 10650.0 10780.2 10533.6 10534.6 10698.6 10830.6 10834.8 7229.8 7380.1 7393.1 7404.0 7416.5 9731.6 10101.6 10111.0 10300.8 10450.7 06:47:04 INFO - PROCESS | 13902 | 06:47:04 INFO - PROCESS | 13902 | [#3] mootools.html Cycles:180 Average:5121.52 Median:5273.51 stddev:2885.71 (54.7%) stddev-sans-first:2878.60 06:47:04 INFO - PROCESS | 13902 | Values: 1180.1 1350.8 1412.5 1478.5 1709.4 6782.8 7718.7 8023.4 8037.0 8043.6 7830.1 7884.7 7956.6 7962.9 7967.8 1905.2 2128.0 2204.8 2219.7 2239.6 2239.7 2255.7 2261.3 2262.7 2263.9 2200.3 2220.5 2225.6 2228.3 2229.3 1813.7 2016.0 2101.5 2102.1 2157.9 2154.3 2169.2 2171.0 2172.8 2174.8 7887.6 7942.9 7948.0 7952.0 7960.6 4366.0 4478.2 4501.5 4508.5 4513.0 2764.8 2861.4 2961.9 3004.0 3008.9 896.9 897.6 911.5 914.3 923.7 10794.0 10801.5 10813.7 10840.0 10856.8 4095.8 4245.0 4254.3 4325.6 4335.1 9015.1 9092.4 9103.6 9107.7 9110.1 4620.1 4624.5 4627.0 4627.4 4627.5 3658.3 4084.6 4199.5 4205.5 4259.8 3633.9 3660.7 3719.7 3732.6 3776.4 1174.5 1209.2 1212.7 1227.7 1234.2 756.8 793.9 809.1 835.4 841.1 5271.5 5275.5 5296.9 5322.5 5333.4 895.9 899.5 941.2 955.3 994.2 3382.8 3560.0 3593.9 3602.1 3666.7 9491.0 9677.3 9729.3 9827.1 9866.7 9528.5 9774.3 9774.5 9777.1 9789.5 7187.7 7202.2 7273.0 7289.5 7308.1 5021.5 5109.3 5140.0 5197.6 5245.1 8467.1 8699.3 8723.2 8949.9 8970.1 8902.6 8911.5 8926.5 8997.7 9022.1 5911.4 6343.2 6478.0 6514.9 6593.2 7550.7 7613.5 7641.4 7670.3 7675.2 6428.7 6543.6 6664.8 6674.0 6791.4 6504.5 6546.4 6549.1 6600.0 6687.2 5946.6 5995.6 6018.1 6021.1 6028.2 4494.9 4522.6 4647.3 4651.4 4708.9 4428.5 4483.1 4490.3 4536.5 4546.3 06:47:04 INFO - PROCESS | 13902 | 06:47:04 INFO - PROCESS | 13902 | [#4] prototype.html Cycles:180 Average:4175.01 Median:4744.99 stddev:1229.57 (25.9%) stddev-sans-first:1198.15 06:47:04 INFO - PROCESS | 13902 | Values: 300.9 306.1 309.3 310.0 310.2 4827.1 4879.6 4891.0 4904.6 4924.0 4822.2 4827.9 4829.4 4834.2 4837.5 3613.5 3726.9 3732.4 3739.2 3769.3 3640.5 3755.0 3768.5 3788.8 3850.8 3683.8 3718.5 3724.7 3731.1 3732.3 3615.5 3729.9 3742.0 3755.4 3763.4 3130.9 3250.6 3342.7 3350.2 3356.1 4679.6 4679.6 4684.8 4689.2 4702.0 4287.7 4304.7 4304.9 4313.2 4315.8 4852.9 5024.5 5035.6 5053.3 5056.0 3626.6 3633.2 3635.9 3651.0 3655.3 5242.9 5275.6 5276.7 5276.9 5302.6 3632.6 3713.1 3736.0 3749.8 3775.9 3766.9 3773.6 3776.2 3801.8 3808.2 4234.3 4257.3 4261.6 4265.5 4267.3 5027.9 5031.8 5039.4 5041.3 5041.6 1263.9 1304.6 1314.1 1334.1 1334.9 853.2 872.9 874.3 874.4 881.8 3934.3 3979.9 3989.2 4001.9 4008.3 4658.0 4686.1 4691.8 4711.0 4733.9 3921.9 4046.6 4046.9 4059.9 4075.8 2313.4 2468.3 2469.0 2664.8 2718.9 4917.3 4937.0 4949.2 4953.7 4955.9 5299.9 5328.7 5340.6 5342.8 5383.3 4701.3 4950.6 4977.6 4987.4 4990.4 5263.0 5287.7 5291.7 5302.2 5303.6 5218.5 5222.5 5225.0 5228.7 5242.4 4756.1 4952.9 4962.3 4975.3 4995.6 3678.5 3688.7 3699.9 3727.3 3767.3 5286.3 5301.3 5330.7 5335.4 5394.4 4955.9 5097.0 5105.9 5130.8 5154.1 5058.0 5058.5 5070.7 5078.6 5106.3 5018.5 5018.6 5035.7 5041.8 5070.7 4819.5 5103.0 5113.8 5121.8 5164.7 4950.8 4975.4 4992.0 4996.3 5033.1 06:47:04 INFO - PROCESS | 13902 | 06:47:04 INFO - PROCESS | 13902 | [#5] yui.html Cycles:180 Average:16419.23 Median:23398.73 stddev:22065.74 (94.3%) stddev-sans-first:22095.63 06:47:04 INFO - PROCESS | 13902 | Values: 591.7 603.3 620.6 628.1 675.5 12086.4 12792.1 13661.1 14608.2 15311.3 14329.1 14906.6 15002.9 15011.6 15031.2 626.3 781.8 799.8 805.7 808.2 792.2 793.1 796.1 796.3 796.5 831.7 834.7 835.1 835.1 835.5 654.3 672.5 672.6 677.6 828.8 587.3 603.8 605.1 605.4 605.8 13009.2 13033.1 13038.7 13078.5 13136.5 12692.0 13272.5 13326.9 13366.5 13697.0 11898.8 12121.8 12157.3 12177.7 12398.3 4196.8 4229.7 4276.4 4278.9 4283.7 58352.0 59287.0 60277.4 60654.7 60763.7 10581.4 10648.3 10664.3 10665.4 10888.4 20519.4 20880.5 20919.8 20935.5 21005.9 6828.0 6846.5 6861.0 6873.6 7085.3 3700.9 3863.9 3881.8 3928.5 3929.6 3020.7 3118.0 3125.8 3128.7 3130.0 511.9 519.2 527.4 531.3 532.0 467.7 472.6 477.0 509.6 519.7 7738.0 7852.5 7975.7 8017.4 8163.5 403.3 526.7 543.9 545.3 551.7 3729.6 3855.3 3881.7 3882.8 3897.1 90534.5 91184.0 91508.5 93592.1 93898.0 72276.3 75584.6 76075.0 76270.2 76771.6 43587.0 44359.0 45415.0 47886.8 63740.4 7353.7 7463.7 8395.2 8395.6 8439.4 39262.2 42137.8 42567.8 42697.4 42826.6 38943.8 44916.3 48406.0 57381.0 59128.4 10491.4 10852.6 11169.6 11250.8 11396.7 12245.8 12389.1 12472.5 12586.2 13767.9 11560.5 11924.4 12036.9 12053.3 12900.0 10812.0 10833.0 11560.8 11698.1 12024.6 11593.5 11986.5 11988.0 12094.4 12155.9 10770.7 10787.8 10885.5 10941.0 11513.2 10291.9 10502.4 10508.7 10543.2 10864.9 06:47:04 INFO - PROCESS | 13902 | -------- Summary: end -------- 06:47:04 INFO - PROCESS | 13902 | 06:47:05 INFO - TEST-INFO | 13902: exit 0 06:47:05 INFO - TEST-OK | dromaeo_css | took 1119936ms 06:47:05 INFO - TEST-START | kraken 06:47:05 INFO - operating with platform_type : linux_ 06:47:05 INFO - Initialising browser for kraken test... 06:47:05 INFO - TEST-INFO | started process 14079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppio9kW/profile http://localhost:44082/getInfo.html) 06:47:09 INFO - PROCESS | 14079 | __metrics Screen width/height:1600/1200 06:47:09 INFO - PROCESS | 14079 | colorDepth:24 06:47:09 INFO - PROCESS | 14079 | Browser inner width/height: 1024/697 06:47:09 INFO - PROCESS | 14079 | __metrics 06:47:10 INFO - PROCESS | 14079 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:47:11 INFO - TEST-INFO | 14079: exit 0 06:47:11 INFO - Browser initialized. 06:47:11 INFO - Running cycle 1/1 for kraken test... 06:47:11 INFO - TEST-INFO | started process 14160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppio9kW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:23 INFO - PROCESS | 14160 | RSS: Main: 175853568 06:47:23 INFO - PROCESS | 14160 | 06:47:26 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44082/tests/kraken/driver.html?testName=audio-beat-detection) 06:47:27 INFO - PROCESS | 14160 | RSS: Main: 234459136 06:47:27 INFO - PROCESS | 14160 | 06:47:30 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44082/tests/kraken/driver.html?testName=audio-dft) 06:47:30 INFO - PROCESS | 14160 | RSS: Main: 222797824 06:47:30 INFO - PROCESS | 14160 | 06:47:33 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44082/tests/kraken/driver.html?testName=audio-fft) 06:47:34 INFO - PROCESS | 14160 | RSS: Main: 288837632 06:47:34 INFO - PROCESS | 14160 | 06:47:36 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44082/tests/kraken/driver.html?testName=audio-oscillator) 06:47:37 INFO - PROCESS | 14160 | RSS: Main: 199680000 06:47:37 INFO - PROCESS | 14160 | 06:47:39 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44082/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:47:40 INFO - PROCESS | 14160 | RSS: Main: 202977280 06:47:40 INFO - PROCESS | 14160 | 06:47:43 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44082/tests/kraken/driver.html?testName=imaging-darkroom) 06:47:43 INFO - PROCESS | 14160 | RSS: Main: 240041984 06:47:43 INFO - PROCESS | 14160 | 06:47:47 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44082/tests/kraken/driver.html?testName=imaging-desaturate) 06:47:48 INFO - PROCESS | 14160 | RSS: Main: 235237376 06:47:48 INFO - PROCESS | 14160 | 06:47:51 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44082/tests/kraken/driver.html?testName=json-parse-financial) 06:47:51 INFO - PROCESS | 14160 | RSS: Main: 238149632 06:47:51 INFO - PROCESS | 14160 | 06:47:53 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44082/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:47:53 INFO - PROCESS | 14160 | RSS: Main: 227074048 06:47:53 INFO - PROCESS | 14160 | 06:47:55 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44082/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:47:56 INFO - PROCESS | 14160 | RSS: Main: 233484288 06:47:56 INFO - PROCESS | 14160 | 06:47:58 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44082/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:47:59 INFO - PROCESS | 14160 | RSS: Main: 239144960 06:47:59 INFO - PROCESS | 14160 | 06:48:02 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:48:02 INFO - PROCESS | 14160 | RSS: Main: 241713152 06:48:02 INFO - PROCESS | 14160 | 06:48:05 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:48:06 INFO - PROCESS | 14160 | RSS: Main: 242249728 06:48:06 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | Cycle 1(1): loaded http://localhost:44082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44082/tests/kraken/driver.html?testName=ai-astar) 06:48:08 INFO - PROCESS | 14160 | RSS: Main: 284852224 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | __start_tp_report 06:48:08 INFO - PROCESS | 14160 | _x_x_mozilla_page_load 06:48:08 INFO - PROCESS | 14160 | _x_x_mozilla_page_load_details 06:48:08 INFO - PROCESS | 14160 | |i|pagename|runs| 06:48:08 INFO - PROCESS | 14160 | |0;ai-astar;113;109;111;113;111;114;112;112;113;112 06:48:08 INFO - PROCESS | 14160 | |1;audio-beat-detection;159;131;136;181;133;132;161;130;170;131 06:48:08 INFO - PROCESS | 14160 | |2;audio-dft;161;161;160;160;162;161;164;159;161;159 06:48:08 INFO - PROCESS | 14160 | |3;audio-fft;77;76;77;126;77;77;74;75;100;76 06:48:08 INFO - PROCESS | 14160 | |4;audio-oscillator;87;86;116;86;87;87;119;87;87;135 06:48:08 INFO - PROCESS | 14160 | |5;imaging-gaussian-blur;117;117;118;117;118;118;117;118;118;117 06:48:08 INFO - PROCESS | 14160 | |6;imaging-darkroom;147;147;146;148;147;146;147;148;146;146 06:48:08 INFO - PROCESS | 14160 | |7;imaging-desaturate;96;95;94;95;96;95;96;95;95;95 06:48:08 INFO - PROCESS | 14160 | |8;json-parse-financial;63;64;63;63;64;63;64;63;63;71 06:48:08 INFO - PROCESS | 14160 | |9;json-stringify-tinderbox;65;65;64;64;65;64;65;66;65;65 06:48:08 INFO - PROCESS | 14160 | |10;stanford-crypto-aes;84;84;84;89;89;84;87;84;114;84 06:48:08 INFO - PROCESS | 14160 | |11;stanford-crypto-ccm;136;131;132;133;136;130;130;128;138;146 06:48:08 INFO - PROCESS | 14160 | |12;stanford-crypto-pbkdf2;174;185;172;168;173;168;171;170;167;170 06:48:08 INFO - PROCESS | 14160 | |13;stanford-crypto-sha256-iterative;68;67;67;67;70;66;67;69;66;65 06:48:08 INFO - PROCESS | 14160 | __end_tp_report 06:48:08 INFO - PROCESS | 14160 | __start_cc_report 06:48:08 INFO - PROCESS | 14160 | _x_x_mozilla_cycle_collect,1887 06:48:08 INFO - PROCESS | 14160 | __end_cc_report 06:48:08 INFO - PROCESS | 14160 | __startTimestamp1466171288259__endTimestamp 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | ------- Summary: start ------- 06:48:08 INFO - PROCESS | 14160 | Number of tests: 14 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.50 stddev:1.41 (1.3%) stddev-sans-first:1.45 06:48:08 INFO - PROCESS | 14160 | Values: 113.0 109.0 111.0 113.0 111.0 114.0 112.0 112.0 113.0 112.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:147.50 stddev:19.33 (13.1%) stddev-sans-first:19.96 06:48:08 INFO - PROCESS | 14160 | Values: 159.0 131.0 136.0 181.0 133.0 132.0 161.0 130.0 170.0 131.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 06:48:08 INFO - PROCESS | 14160 | Values: 161.0 161.0 160.0 160.0 162.0 161.0 164.0 159.0 161.0 159.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.50 stddev:16.74 (21.9%) stddev-sans-first:17.59 06:48:08 INFO - PROCESS | 14160 | Values: 77.0 76.0 77.0 126.0 77.0 77.0 74.0 75.0 100.0 76.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:87.00 stddev:18.34 (21.1%) stddev-sans-first:19.04 06:48:08 INFO - PROCESS | 14160 | Values: 87.0 86.0 116.0 86.0 87.0 87.0 119.0 87.0 87.0 135.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:48:08 INFO - PROCESS | 14160 | Values: 117.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 117.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 06:48:08 INFO - PROCESS | 14160 | Values: 147.0 147.0 146.0 148.0 147.0 146.0 147.0 148.0 146.0 146.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 06:48:08 INFO - PROCESS | 14160 | Values: 96.0 95.0 94.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:63.50 stddev:2.47 (3.9%) stddev-sans-first:2.59 06:48:08 INFO - PROCESS | 14160 | Values: 63.0 64.0 63.0 63.0 64.0 63.0 64.0 63.0 63.0 71.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 06:48:08 INFO - PROCESS | 14160 | Values: 65.0 65.0 64.0 64.0 65.0 64.0 65.0 66.0 65.0 65.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:84.00 stddev:9.27 (11.0%) stddev-sans-first:9.71 06:48:08 INFO - PROCESS | 14160 | Values: 84.0 84.0 84.0 89.0 89.0 84.0 87.0 84.0 114.0 84.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:134.50 stddev:5.27 (3.9%) stddev-sans-first:5.54 06:48:08 INFO - PROCESS | 14160 | Values: 136.0 131.0 132.0 133.0 136.0 130.0 130.0 128.0 138.0 146.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:171.50 stddev:5.16 (3.0%) stddev-sans-first:5.41 06:48:08 INFO - PROCESS | 14160 | Values: 174.0 185.0 172.0 168.0 173.0 168.0 171.0 170.0 167.0 170.0 06:48:08 INFO - PROCESS | 14160 | 06:48:08 INFO - PROCESS | 14160 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.48 (2.2%) stddev-sans-first:1.54 06:48:08 INFO - PROCESS | 14160 | Values: 68.0 67.0 67.0 67.0 70.0 66.0 67.0 69.0 66.0 65.0 06:48:08 INFO - PROCESS | 14160 | -------- Summary: end -------- 06:48:08 INFO - PROCESS | 14160 | 06:48:09 INFO - TEST-INFO | 14160: exit 0 06:48:09 INFO - TEST-OK | kraken | took 64150ms 06:48:09 INFO - SUITE-END | took 1184s 06:48:09 INFO - Completed test suite (00:19:44) 06:48:09 INFO - javascript benchmark 06:48:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.6058591211317, 2635.446556223193, 2666.733326667332, 2669.546177149885, 2680.2227354067336, 4704.31787390829, 4726.881827954303, 4778.9044219115685, 4794.568488836008, 4867.075255701418, 4772.164871147553, 4774.904501909959, 4816.157172494817, 4819.397575303087, 4890.951090489094, 4333.6749743769105, 4343.5004974427875, 4388.166248412791, 4452.065066336073, 4517.232070548015, 4418.403515525427, 4443.200223959686, 4454.599086082252, 4460.107978404316, 4483.484399294074, 4303.07483890965, 4345.435093437864, 4352.107817897323, 4360.760158191299, 4391.27543955247, 4342.826286948518, 4344.761038142901, 4346.56534346566, 4389.100234451929, 4403.955960440387, 4374.190774706658, 4374.475062992461, 4376.584224498668, 4381.189479946188, 4419.756913369795, 4595.310703394518, 4629.675922685414, 4661.813527458898, 4787.066522028206, 4828.903421931542, 5047.217681259411, 5060.063888180698, 5065.240213967897, 5066.265391518246, 5067.797288108472, 5035.521625445577, 5057.822976195852, 5094.286799848024, 5100.362454693163, 5108.386993560759, 4582.518835522289, 4745.762711864428, 4748.287756836433, 4803.159447096744, 4812.06164797868, 5300.549453296436, 5313.203019547099, 5321.175217841163, 5322.654027488201, 5329.094054010828, 5070.112730272188, 5105.33630628016, 5110.71891045996, 5118.488151184852, 5121.385433747974, 4968.105740966661, 5045.066662667418, 5073.923891141636, 5129.435762066169, 5134.178531435027, 5070.239464080418, 5071.695698258116, 5072.644914855925, 5073.188289873602, 5117.385913690381, 5050.949490505048, 5054.090263752486, 5054.166062599704, 5057.317262169634, 5094.133997220481, 4302.978485107555, 4351.021020270414, 4352.978235108804, 4416.028473735773, 4426.402435671143, 3829.6553310202216, 3850.5186851643543, 3884.2037382336553, 3890.902727431837, 3891.4357418174204, 4310.719803212781, 4371.256886329332, 4384.342348647729, 4391.187630288407, 4401.977990110029, 5122.129238029544, 5133.204353325241, 5140.306058682105, 5152.639315247897, 5173.1722924331925, 4407.140607581491, 4407.140607581555, 4407.867763967086, 4440.245158323093, 4450.755208463501, 4579.519150489217, 4615.030843522898, 4640.257558790578, 4642.048380082143, 4645.396098507173, 4845.224764037737, 4857.344258525054, 4859.343988561499, 4859.392575928009, 4894.632902532253, 5131.512506311894, 5152.871178220425, 5176.327077479904, 5178.093833579033, 5184.429712731521, 4675.649326300609, 4800.66395352336, 4852.102361063215, 4862.246351815475, 4879.87800304981, 5085.237214417867, 5103.515166059218, 5115.386153661584, 5119.283300337881, 5160.303359046631, 5017.422996355466, 5176.482351764794, 5189.195674670432, 5190.455002224712, 5191.844244672666, 4949.282354058713, 4997.275395067622, 5002.324686167321, 5022.397312322545, 5037.294778731054, 5027.472115427828, 5030.5975521957425, 5040.092783299041, 5040.344755181803, 5086.109930762028, 4810.326554282333, 4834.830780922651, 4954.5540901319055, 4961.330220420197, 5008.023435430056, 4975.751212439436, 4983.8504844854715, 4995.950040499694, 5011.649184557046, 5058.873528161826, 4888.144574699484, 4889.193283108248, 4891.95108048915, 4897.216445368724, 4950.4059512858685], "value": 4701.408221743473, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.5694336888911, 586.9706514674265, 595.4908553187025, 606.5329696133977, 610.2280615021997, 29025.56461653074, 31510.369792604135, 31580.68419315806, 31630.051098467055, 31655.525167122483, 32030.0, 41520.377194342036, 42601.0, 42653.0, 46842.0, 7900.683972641087, 8029.076656184526, 8031.393721255743, 8032.39757018226, 8034.477758945679, 7859.842803143933, 7921.881171782428, 7937.682492700285, 7946.443748937577, 7952.840943181133, 7933.880991785128, 7953.244441778022, 7970.0, 7971.840563188733, 7976.361891048731, 7897.0, 7959.0847052589115, 7965.283124518821, 7969.800754981114, 7973.800654983614, 7896.210378962115, 7906.644201010969, 7955.562444065574, 7958.761237162837, 7986.960065199695, 38794.418083728764, 39458.0, 39547.40678889819, 39564.0, 39643.40534891979, 3055.908322750299, 3087.197328694533, 3150.9054728358187, 3186.3786561620495, 3300.3399320135827, 28213.717862821315, 29374.0, 29984.100476985725, 30231.674515803243, 30418.0, 3584.731145164097, 3592.2815436912724, 3608.5308909841815, 3617.94573081404, 3630.909227269313, 187373.0, 187784.99999999863, 187875.0, 188082.0, 188186.0, 54858.45141548533, 55046.0, 55400.16899746507, 55449.0, 55514.0, 32807.0, 58227.12659310114, 58284.41715582875, 58296.0, 58485.70757146187, 12968.157069790434, 13046.347682615831, 13091.869081309065, 13106.344682765824, 13132.934335328262, 11032.779344413068, 11154.330740155616, 11155.72110697239, 11162.888371116185, 11169.83245251322, 18715.251389944522, 18739.063046847605, 18791.0, 18819.71770423445, 18822.0, 6671.799846004531, 7085.397741192057, 7120.71517139319, 7126.144862616416, 7155.606441645759, 790.8576456237818, 800.5596921693045, 885.6103314541581, 962.4177372689562, 973.6592192732487, 26343.736562634127, 27415.725842741715, 27487.725122748918, 28901.56647650287, 29548.113556593336, 846.7205822078699, 933.1368484152132, 968.8982656821073, 970.9563069661882, 1019.1235537437798, 14539.127652340894, 14981.250937453084, 15012.774808377882, 15240.618984525476, 15353.925225234127, 362578.0, 366327.0, 366549.0, 366642.0, 367299.0, 48745.0, 49908.0, 49945.0, 49949.75025124851, 49973.0, 1071.6517131931998, 1154.4977934598476, 1173.1729130962651, 1176.5587904535628, 1189.9464524096436, 28136.29659258535, 29076.0, 29301.70698293075, 29537.704622953497, 29789.70210297956, 42180.367294489995, 42560.57439425566, 42808.57191428046, 42870.0, 42948.0, 316036.0, 317926.0, 318061.0, 318985.0, 319019.0, 35309.29381412409, 37994.24011519699, 39181.80409097936, 39363.80318098391, 42562.0, 42990.35514467348, 43314.56685433105, 43747.0, 43971.0, 44164.337534937644, 36270.8186459066, 36925.63074369222, 37362.0, 37371.81314093412, 37801.62198377981, 36822.0, 36822.0, 37029.259414811015, 37054.6294537062, 37420.43869341908, 35713.0, 36360.63639363572, 36452.81773591115, 37112.443313350865, 37218.62781372152, 32388.83805580957, 33552.664473354955, 33824.830875845466, 34083.0, 34239.14402139966, 25604.487910241318, 25650.8717456419, 25701.887697968235, 25859.353516162246, 25860.35349116287], "value": 17631.726615169337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.89717827597417, 374.5598921267511, 376.52745804015956, 382.60400485497513, 395.25494442975, 15389.230538473073, 17130.229139688712, 17305.7404138938, 17798.46604601864, 17824.64350712985, 14970.700585988274, 15787.447439339596, 15806.762898556532, 16207.189640517985, 16407.425740099097, 4572.177008138534, 4699.600533954618, 4721.69308994916, 4747.145513807513, 4751.691140075884, 3519.472079188117, 3688.114852435423, 4613.538646135376, 5132.281480592701, 5428.728563571825, 5457.69982650956, 5462.262594549725, 5473.151661492455, 5488.396276409591, 5489.670619762807, 5062.164742817449, 5372.274742909696, 5378.354597448292, 5447.428020057916, 5455.0453670607685, 3406.233597440581, 5040.269160971675, 5281.551068159211, 5392.973035134838, 5403.540699040586, 12138.878611213862, 12283.57007504733, 12394.0, 13538.932305338509, 20731.170753169856, 1988.532694816717, 1990.4924244317751, 2020.3029954665617, 2120.586485635302, 2198.318521258415, 9219.723408297761, 9231.353805233637, 9233.49215793131, 9304.348695591312, 9660.275479339078, 1600.2638786158382, 1601.6316247263194, 1673.7740405045286, 1684.866148962928, 1687.966240675192, 63682.0, 65505.0, 65636.34363656398, 66313.6684316585, 67605.32394676088, 9655.71032869001, 10191.439470829027, 10381.429021403896, 10382.3251488653, 10403.5838566458, 14013.159210447406, 14088.295585220698, 14240.287985600678, 14279.071860329046, 14302.928485357716, 7028.0, 7118.323759242864, 7131.71473141079, 7153.6780844862105, 7361.48469607133, 6740.157480314961, 6755.324467553205, 6877.140357455318, 6916.377526022682, 6921.446284297244, 4324.913501729948, 4456.30235014654, 4464.352668862996, 4467.195904737178, 4542.273236282179, 1666.691662042526, 1742.7866609405983, 1758.5691505581215, 1795.5600877784766, 1846.9353572624893, 727.7198278662753, 910.5720311453606, 927.735595355334, 935.1350001248818, 966.5312323523086, 16302.0, 16865.32538698463, 17026.659466810594, 17130.14349282556, 17376.21807018687, 866.5927014303268, 884.3720958119807, 885.1546772832058, 894.9373543851868, 898.4788822482944, 9294.488803115893, 9848.50757462124, 9925.156361709336, 9934.850977235346, 10091.394516328897, 375667.0, 379929.0, 380399.0, 381804.0, 383821.0, 78268.0, 78918.0, 79150.66794656414, 79859.0, 80269.0, 908.5411867007119, 916.7433118726767, 922.4465320807597, 932.7994481186441, 938.1931538876561, 15352.69294614079, 15418.306176221873, 15443.69112617719, 15452.381904723685, 15788.526344209693, 33983.15042123868, 35349.82325088358, 35839.92480225598, 36431.635683642824, 36688.44967325439, 45541.77229113833, 47237.52762472331, 47773.76113119412, 49238.507614923394, 49646.25530617116, 6568.638724870178, 7190.352868241884, 7224.927750722425, 7321.304476074764, 7438.814029649302, 9070.410423322463, 12075.818862716891, 12138.33239171854, 12243.632691019284, 12441.751164976831, 10319.48402579883, 10365.32625379378, 10433.113185379025, 10703.839442408525, 10749.838752418877, 10330.173586113244, 10376.221783366429, 10575.947120264656, 10650.0, 10780.191485638452, 10533.57865685364, 10534.578616855546, 10698.62554810578, 10830.566777329133, 10834.783304334027, 7229.819254518679, 7380.077490313711, 7393.07586551681, 7403.962980185064, 7416.480846340704, 9731.610735570497, 10101.646442374775, 10111.0, 10300.793984120126, 10450.68647940563], "value": 8027.483416075168, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1180.0972256223986, 1350.8108864758935, 1412.5479846449134, 1478.5416520878528, 1709.3931654262744, 6782.762603308885, 7718.652660630271, 8023.358131349492, 8037.0, 8043.55760433176, 7830.138684744674, 7884.684612615503, 7956.602169891511, 7962.920370796291, 7967.76096717098, 1905.1522072677665, 2127.9787202127936, 2204.8236141108714, 2219.7447293561204, 2239.6080685879906, 2239.708837851077, 2255.672927425522, 2261.3216035189375, 2262.7058482397265, 2263.864168149916, 2200.3179014505477, 2220.500387412835, 2225.643896976484, 2228.3426389215138, 2229.2754854672216, 1813.6826055440245, 2015.9596808063902, 2101.4536220582604, 2102.127617038927, 2157.85973911696, 2154.278316763886, 2169.240765731997, 2171.0447403142725, 2172.7935846094597, 2174.847760656755, 7887.566183859885, 7942.920570794276, 7947.96026019872, 7952.0, 7960.641771120314, 4365.978170109161, 4478.193925093482, 4501.482329532113, 4508.549145085465, 4512.954870451319, 2764.7926405519465, 2861.370498490329, 2961.8519074046426, 3003.9636325467677, 3008.864601092934, 896.9416987895765, 897.6499165325529, 911.4986757283467, 914.3051281026401, 923.6813299411692, 10794.0, 10801.513931873085, 10813.729656758644, 10840.024397804236, 10856.837147442795, 4095.7542547447247, 4244.978775106105, 4254.319308910622, 4325.632321252729, 4335.067960388532, 9015.098490151064, 9092.408993415407, 9103.590338434786, 9107.726768196964, 9110.088991100969, 4620.145273124483, 4624.514425985223, 4627.028324051987, 4627.375304333939, 4627.467841198305, 3658.2683463307444, 4084.571120032413, 4199.496060472702, 4205.516365617932, 4259.829606815692, 3633.94549081764, 3660.6888414485065, 3719.739618226752, 3732.64539868712, 3776.4146557283666, 1174.4890972427022, 1209.2019267283551, 1212.7392610588765, 1227.7237621535082, 1234.234774439853, 756.7729681095649, 793.9321612431271, 809.0655293136437, 835.415209353455, 841.1126261793867, 5271.499207575274, 5275.525202731696, 5296.894062118813, 5322.547583455373, 5333.439988801198, 895.8745775591423, 899.5309164218806, 941.1623654947102, 955.345588272022, 994.22450488619, 3382.780119292238, 3560.0, 3593.874214402483, 3602.090891827336, 3666.688331491853, 9490.952545237229, 9677.274204434696, 9729.270304727173, 9827.11555959967, 9866.703998880044, 9528.475933823705, 9774.266929980138, 9774.51127443625, 9777.120059194707, 9789.46157961319, 7187.676554555058, 7202.20775714671, 7272.96363518179, 7289.453291003196, 7308.1230252369, 5021.49785021495, 5109.310243117132, 5140.049090918192, 5197.610179236648, 5245.082110630548, 8467.11095334981, 8699.347548933729, 8723.214910658071, 8949.910500894908, 8970.102989700978, 8902.643894244417, 8911.465312081296, 8926.509042002752, 8997.730068097968, 9022.052684468037, 5911.408859114226, 6343.207099112611, 6477.967610161919, 6514.9348506514325, 6593.175853018372, 7550.735724249625, 7613.467057305936, 7641.42689298316, 7670.27132422419, 7675.155732869268, 6428.742850285937, 6543.640099794557, 6664.766733164316, 6673.966630167012, 6791.3548212919695, 6504.512161587994, 6546.443552298108, 6549.083128362128, 6599.967000164968, 6687.1975362956755, 5946.643201407929, 5995.580309378476, 6018.067199584071, 6021.066734656135, 6028.186194863637, 4494.932576011297, 4522.570355816192, 4647.279671650899, 4651.3720647712125, 4708.92936605958, 4428.512863584939, 4483.125790470827, 4490.259107247398, 4536.500984891593, 4546.272596384562], "value": 4125.619500304337, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.9488386974214, 306.0664971835901, 309.31486756833624, 310.0265167374444, 310.15946784214776, 4827.131116399047, 4879.609631229502, 4891.0, 4904.632152588557, 4923.975380123099, 4822.228443449048, 4827.903441931168, 4829.444613869406, 4834.2265237562, 4837.516248375161, 3613.512175856265, 3726.869559565416, 3732.440133979911, 3739.2147648993746, 3769.2838360711376, 3640.4903313535992, 3754.9812250938708, 3768.547774267092, 3788.7726736395766, 3850.84596616135, 3683.8027641016643, 3718.4794128821986, 3724.664780169784, 3731.1231860512758, 3732.328180927432, 3615.5299811024397, 3729.8881033569037, 3741.962580374216, 3755.4179102239195, 3763.416670416076, 3130.89041883533, 3250.6424293327714, 3342.715869151125, 3350.2193179661067, 3356.1441832332844, 4679.60223381013, 4679.625629949596, 4684.789184486706, 4689.20283551797, 4701.952980470186, 4287.656987440997, 4304.740011493959, 4304.945288404329, 4313.180495705806, 4315.848945286932, 4852.878678033042, 5024.522670346311, 5035.590034790264, 5053.267276244961, 5055.974720126413, 3626.6192049834654, 3633.1643721943838, 3635.8727444539313, 3651.0, 3655.323765103464, 5242.9213561796605, 5275.573236311301, 5276.736163191825, 5276.92084618731, 5302.628815982883, 3632.564092308887, 3713.1459764254373, 3736.0, 3749.812509374575, 3775.8867233983024, 3766.8681596144, 3773.603771603997, 3776.188119554309, 3801.847926082981, 3808.200277941608, 4234.28511452862, 4257.276263035292, 4261.573842615776, 4265.4881414230495, 4267.317229243368, 5027.8938633500575, 5031.7987280509105, 5039.3952725672425, 5041.260765036057, 5041.59667226621, 1263.8625237286515, 1304.562971404571, 1314.1392387985884, 1334.126147373472, 1334.8998825088158, 853.2320911179987, 872.9345299102592, 874.2699845628971, 874.4054043250651, 881.7839629290864, 3934.272159650474, 3979.880603581897, 3989.202159568098, 4001.8599349023225, 4008.2985477541315, 4657.950501779274, 4686.118037407038, 4691.82704323919, 4711.0, 4733.857984260478, 3921.8627348042683, 4046.635802777764, 4046.9275641954905, 4059.918801623951, 4075.7758323292505, 2313.37538864509, 2468.3335499415057, 2468.9753102469103, 2664.8407942545055, 2718.8640567971524, 4917.336159618477, 4936.951165266446, 4949.183384741477, 4953.702777833341, 4955.876103097379, 5299.894002119936, 5328.749462827672, 5340.626156169031, 5342.839714808484, 5383.300170977826, 4701.27130294798, 4950.5544500994365, 4977.601791856643, 4987.401511818605, 4990.351254336913, 5263.0, 5287.656302340336, 5291.682499049915, 5302.151655735064, 5303.5757139429525, 5218.478152184751, 5222.451642577475, 5224.9738751306, 5228.738563071755, 5242.370915490165, 4756.120117778222, 4952.925706114339, 4962.330085438564, 4975.328330675313, 4995.550400463976, 3678.521792167001, 3688.6864616507896, 3699.8890033299044, 3727.2545490901384, 3767.321882061255, 5286.3392075990505, 5301.310829592128, 5330.653507522154, 5335.35975682905, 5394.435613672148, 4955.925661115159, 5096.955124199456, 5105.923411148761, 5130.769115389742, 5154.14956532168, 5058.0, 5058.54473097423, 5070.670406423571, 5078.568321692697, 5106.285120083266, 5018.5232402921665, 5018.573421259088, 5035.748212589283, 5041.773120209526, 5070.746462676925, 4819.493953135011, 5103.0, 5113.795448182031, 5121.823225129379, 5164.715940623151, 4950.762309422645, 4975.353204083446, 4992.0, 4996.2505624156665, 5033.144365457808], "value": 3790.0064576702416, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.7248479457052, 603.3182503770739, 620.6183197333642, 628.0798630007039, 675.5102550650782, 12086.395680215976, 12792.104552681305, 13661.112027718204, 14608.19654918979, 15311.310991005405, 14329.140251584911, 14906.552803415887, 15002.924985375084, 15011.624709382271, 15031.248437578131, 626.298545628894, 781.7732857471326, 799.7840583042575, 805.7381351060899, 808.2079562029215, 792.1563534835382, 793.0602236349915, 796.108358638323, 796.2634563029204, 796.5220867479524, 831.7130589946458, 834.7036801935317, 835.0688981785327, 835.1398059998212, 835.4736515994915, 654.3260441745034, 672.4687496877461, 672.6367761408833, 677.5900580148988, 828.8218033122878, 587.3245767367519, 603.8248907816728, 605.1316361021903, 605.3915814606337, 605.7788907048939, 13009.21944683322, 13033.087683862133, 13038.739225215442, 13078.542251021168, 13136.474541018444, 12692.0, 13272.469101235938, 13326.93336533311, 13366.465341386333, 13697.0, 11898.762024759457, 12121.818172727417, 12157.331346775924, 12177.695557611041, 12398.31809250491, 4196.81114349855, 4229.6827737919475, 4276.358546218061, 4278.850240241608, 4283.657307415399, 58352.0, 59287.0, 60277.39722602762, 60654.69672651653, 60763.69618151925, 10581.36511809294, 10648.307859989076, 10664.253502254924, 10665.390806831725, 10888.40113793749, 20519.38441846747, 20880.47798805042, 20919.790802091786, 20935.476613084797, 21005.894970525354, 6828.0, 6846.520743547904, 6861.0, 6873.621950792654, 7085.326893945067, 3700.8704695336073, 3863.8840834775, 3881.825317860703, 3928.4500169976227, 3929.5677475477673, 3020.6677265500775, 3118.0, 3125.812451252932, 3128.702773236539, 3130.0296907958605, 511.9027384796877, 519.1693290734794, 527.4145698274912, 531.3013387395563, 532.0, 467.73339196657577, 472.5912086045615, 477.0173442708033, 509.59996402824345, 519.654429804176, 7738.0, 7852.528848269122, 7975.72084977023, 8017.4387792855105, 8163.510189388537, 403.29222215012464, 526.6655673647261, 543.8613153645874, 545.2992904118269, 551.7282366983511, 3729.5710993235584, 3855.267499175148, 3881.728279020498, 3882.7929556882186, 3897.0841852164717, 90534.54732726426, 91184.0, 91508.54245728729, 93592.0640793597, 93898.0, 72276.27723722695, 75584.62207689036, 76075.0, 76270.23729762631, 76771.61614192005, 43587.0, 44359.0, 45415.0, 47886.76056619764, 63740.362596373445, 7353.669084891086, 7463.6641351140415, 8395.24442800151, 8395.622197001272, 8439.409241353047, 39262.21475570415, 42137.789311053246, 42567.78716106524, 42697.35953960631, 42826.57173428226, 38943.805280973414, 44916.326255106855, 48406.0, 57381.0, 59128.408715912294, 10491.422971736627, 10852.620158294421, 11169.553217871195, 11250.828586095742, 11396.715082122682, 12245.816312755138, 12389.132760706663, 12472.501099956264, 12586.18189817659, 13767.931160344535, 11560.537578496765, 11924.403779810802, 12036.939815300868, 12053.337066461429, 12900.032497562908, 10812.0, 10832.97086776755, 11560.768784624428, 11698.06415486742, 12024.579139730067, 11593.478293476983, 11986.520539178335, 11988.040956723615, 12094.352682239632, 12155.878441215475, 10770.73073173177, 10787.784244315228, 10885.510152043336, 10941.0, 11513.194076414906, 10291.94854025725, 10502.422366769595, 10508.684739457829, 10543.20925930543, 10864.891351086388], "value": 6481.607051065727, "unit": "score"}], "name": "dromaeo_css", "value": 6380.096719967895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 111.0, 113.0, 111.0, 114.0, 112.0, 112.0, 113.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 136.0, 181.0, 133.0, 132.0, 161.0, 130.0, 170.0, 131.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 164.0, 159.0, 161.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 126.0, 77.0, 77.0, 74.0, 75.0, 100.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 116.0, 86.0, 87.0, 87.0, 119.0, 87.0, 87.0, 135.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 71.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 89.0, 89.0, 84.0, 87.0, 84.0, 114.0, 84.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 132.0, 133.0, 136.0, 130.0, 130.0, 128.0, 138.0, 146.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 185.0, 172.0, 168.0, 173.0, 168.0, 171.0, 170.0, 167.0, 170.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 70.0, 66.0, 67.0, 69.0, 66.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1550.1, "alertThreshold": 2.0}]} 06:48:09 INFO - Return code: 0 06:48:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:48:09 INFO - # TBPL SUCCESS # 06:48:09 INFO - Running post-action listener: _resource_record_post_action 06:48:09 INFO - ##### 06:48:09 INFO - ##### Finished run-tests step (success) 06:48:09 INFO - ##### 06:48:09 INFO - Running post-run listener: _resource_record_post_run 06:48:09 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302313472; Read time: 4; Write time: 170852 06:48:09 INFO - TinderboxPrint: CPU usage
13.2% 06:48:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 06:48:09 INFO - TinderboxPrint: I/O write bytes / time
302,313,472 / 170,852 06:48:09 INFO - TinderboxPrint: CPU idle
8,322.6 (86.8%) 06:48:09 INFO - TinderboxPrint: CPU user
1,216.6 (12.7%) 06:48:09 INFO - TinderboxPrint: Swap in / out
0 / 0 06:48:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20750336; Read time: 0; Write time: 7592 06:48:09 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281563136; Read time: 4; Write time: 163260 06:48:10 INFO - Running post-run listener: _upload_blobber_files 06:48:10 INFO - Blob upload gear active. 06:48:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:48:10 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 06:48:10 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'] 06:48:10 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 06:48:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:48:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:48:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:48:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:14 INFO - (blobuploader) - INFO - Done attempting. 06:48:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:48:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:48:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:14 INFO - (blobuploader) - INFO - Done attempting. 06:48:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:48:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:48:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:15 INFO - (blobuploader) - INFO - Done attempting. 06:48:15 INFO - (blobuploader) - INFO - Iteration through files over. 06:48:15 INFO - Return code: 0 06:48:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:48:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:48:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df9d8e9795752bb98ed6a1ad06a9ebc88c2889e8508ac7a3acd15a8d4c6b43dae22be90d1134e832a616d82342f8f0a8b85569bb2df07fc43adfc640ef8124b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c3f8be86f834db787bce9261fb4c2f0f5131d4d4b780090b839e26a2949ed6d9077e5219639abb784b5696a1b3382e99f1c7ad1ea8698fd2c4508abb287b5d60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35cb326006ee1eec9d7436a737669a1ff621936e3032826bcf09af6348d856ef82bdc37707809638991d6880266081f6340e59dd6364b468537ca9e5d044accd"} 06:48:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:48:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:48:15 INFO - Contents: 06:48:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/df9d8e9795752bb98ed6a1ad06a9ebc88c2889e8508ac7a3acd15a8d4c6b43dae22be90d1134e832a616d82342f8f0a8b85569bb2df07fc43adfc640ef8124b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c3f8be86f834db787bce9261fb4c2f0f5131d4d4b780090b839e26a2949ed6d9077e5219639abb784b5696a1b3382e99f1c7ad1ea8698fd2c4508abb287b5d60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35cb326006ee1eec9d7436a737669a1ff621936e3032826bcf09af6348d856ef82bdc37707809638991d6880266081f6340e59dd6364b468537ca9e5d044accd"} 06:48:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:48:15 INFO - Copying logs to upload dir... 06:48:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:48:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.935563 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-17 06:48:15.743805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 06:48:15.748690) ========= 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=db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423 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/df9d8e9795752bb98ed6a1ad06a9ebc88c2889e8508ac7a3acd15a8d4c6b43dae22be90d1134e832a616d82342f8f0a8b85569bb2df07fc43adfc640ef8124b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c3f8be86f834db787bce9261fb4c2f0f5131d4d4b780090b839e26a2949ed6d9077e5219639abb784b5696a1b3382e99f1c7ad1ea8698fd2c4508abb287b5d60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35cb326006ee1eec9d7436a737669a1ff621936e3032826bcf09af6348d856ef82bdc37707809638991d6880266081f6340e59dd6364b468537ca9e5d044accd"} build_url:https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/LzUqW3z1SKWZ6f8pcBUO4g/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/df9d8e9795752bb98ed6a1ad06a9ebc88c2889e8508ac7a3acd15a8d4c6b43dae22be90d1134e832a616d82342f8f0a8b85569bb2df07fc43adfc640ef8124b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c3f8be86f834db787bce9261fb4c2f0f5131d4d4b780090b839e26a2949ed6d9077e5219639abb784b5696a1b3382e99f1c7ad1ea8698fd2c4508abb287b5d60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/35cb326006ee1eec9d7436a737669a1ff621936e3032826bcf09af6348d856ef82bdc37707809638991d6880266081f6340e59dd6364b468537ca9e5d044accd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 06:48:15.776722) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:48:15.777062) ========= 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=db0483c52d987ecb441a263b000001ad-1466163546.554460-2096580423 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 06:48:15.859418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 06:48:15.859780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 06:48:15.860112) ========= ========= Total master_lag: 0.20 =========