builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1450283251.77 results: success (0) buildid: 20151216073608 builduid: 153ed67a8969405fb52f767469c35ad4 revision: ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.772613) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.773086) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.773372) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006323 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.795930) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.796233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.809412) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.809734) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.859284) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.859599) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.859998) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:31.860273) ========= 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=20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 08:27:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2015-12-16 08:27:33 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181305 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:32.054509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:32.054828) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014197 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:32.104535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:32.104890) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63 --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 ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63 --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=20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 08:27:33,989 truncating revision to first 12 chars 2015-12-16 08:27:33,989 Setting DEBUG logging. 2015-12-16 08:27:33,989 attempt 1/10 2015-12-16 08:27:33,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ac9c0f02ef33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 08:27:34,384 unpacking tar archive at: fx-team-ac9c0f02ef33/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669825 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:32.788057) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:32.788460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:32.798797) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:32.799212) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 08:27:32.799735) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-16 08:27:32.800039) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:27:34 INFO - MultiFileLogger online at 20151216 08:27:34 in /builds/slave/test 08:27:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:27:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:27:34 INFO - {'append_to_log': False, 08:27:34 INFO - 'base_work_dir': '/builds/slave/test', 08:27:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:27:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:27:34 INFO - 'branch': 'Fx-Team-Non-PGO', 08:27:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:27:34 INFO - 'config_files': ('talos/linux_config.py',), 08:27:34 INFO - 'default_actions': ('clobber', 08:27:34 INFO - 'read-buildbot-config', 08:27:34 INFO - 'download-and-extract', 08:27:34 INFO - 'populate-webroot', 08:27:34 INFO - 'create-virtualenv', 08:27:34 INFO - 'install', 08:27:34 INFO - 'run-tests'), 08:27:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:27:34 INFO - 'download_minidump_stackwalk': True, 08:27:34 INFO - 'download_symbols': 'ondemand', 08:27:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:27:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:27:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:27:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:27:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:27:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:27:34 INFO - 'installer_path': 'installer.exe', 08:27:34 INFO - 'log_level': 'info', 08:27:34 INFO - 'log_name': 'talos', 08:27:34 INFO - 'log_to_console': True, 08:27:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:27:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:27:34 INFO - 'opt_config_files': (), 08:27:34 INFO - 'pip_index': False, 08:27:34 INFO - 'sps_profile': False, 08:27:34 INFO - 'sps_profile_interval': 0, 08:27:34 INFO - 'suite': 'dromaeojs', 08:27:34 INFO - 'system_bits': '64', 08:27:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:27:34 INFO - 'title': 'talos-linux64-ix-065', 08:27:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:27:34 INFO - 'use_talos_json': True, 08:27:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:27:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:27:34 INFO - 'work_dir': 'build'} 08:27:34 INFO - ##### 08:27:34 INFO - ##### Running clobber step. 08:27:34 INFO - ##### 08:27:34 INFO - Running pre-action listener: _resource_record_pre_action 08:27:34 INFO - Running main action method: clobber 08:27:34 INFO - rmtree: /builds/slave/test/build 08:27:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:27:35 INFO - Running post-action listener: _resource_record_post_action 08:27:35 INFO - ##### 08:27:35 INFO - ##### Running read-buildbot-config step. 08:27:35 INFO - ##### 08:27:35 INFO - Running pre-action listener: _resource_record_pre_action 08:27:35 INFO - Running main action method: read_buildbot_config 08:27:35 INFO - Using buildbot properties: 08:27:35 INFO - { 08:27:35 INFO - "properties": { 08:27:35 INFO - "buildnumber": 1199, 08:27:35 INFO - "product": "firefox", 08:27:35 INFO - "script_repo_revision": "production", 08:27:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:27:35 INFO - "repository": "", 08:27:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:27:35 INFO - "buildid": "20151216073608", 08:27:35 INFO - "slavename": "talos-linux64-ix-065", 08:27:35 INFO - "pgo_build": "False", 08:27:35 INFO - "basedir": "/builds/slave/test", 08:27:35 INFO - "project": "", 08:27:35 INFO - "platform": "ubuntu64_hw", 08:27:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:27:35 INFO - "slavebuilddir": "test", 08:27:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:27:35 INFO - "branch": "fx-team", 08:27:35 INFO - "repo_path": "integration/fx-team", 08:27:35 INFO - "stage_platform": "linux64", 08:27:35 INFO - "builduid": "153ed67a8969405fb52f767469c35ad4", 08:27:35 INFO - "revision": "ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63" 08:27:35 INFO - }, 08:27:35 INFO - "sourcestamp": { 08:27:35 INFO - "repository": "", 08:27:35 INFO - "hasPatch": false, 08:27:35 INFO - "project": "", 08:27:35 INFO - "branch": "fx-team-linux64-talos", 08:27:35 INFO - "changes": [ 08:27:35 INFO - { 08:27:35 INFO - "category": null, 08:27:35 INFO - "files": [ 08:27:35 INFO - { 08:27:35 INFO - "url": null, 08:27:35 INFO - "name": "https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 08:27:35 INFO - } 08:27:35 INFO - ], 08:27:35 INFO - "repository": "", 08:27:35 INFO - "rev": "ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63", 08:27:35 INFO - "who": "mdeboer@mozilla.com", 08:27:35 INFO - "when": 1450282029, 08:27:35 INFO - "number": 7367027, 08:27:35 INFO - "comments": "Bug 1229933: create the Loop menu item in the browser Tools menu dynamically from the extension and remove it from core browser code. r=Standard8", 08:27:35 INFO - "project": "", 08:27:35 INFO - "at": "Wed 16 Dec 2015 08:07:09", 08:27:35 INFO - "branch": "fx-team-linux64-talos", 08:27:35 INFO - "revlink": "", 08:27:35 INFO - "properties": [ 08:27:35 INFO - [ 08:27:35 INFO - "buildid", 08:27:35 INFO - "20151216073608", 08:27:35 INFO - "Change" 08:27:35 INFO - ], 08:27:35 INFO - [ 08:27:35 INFO - "builduid", 08:27:35 INFO - "153ed67a8969405fb52f767469c35ad4", 08:27:35 INFO - "Change" 08:27:35 INFO - ], 08:27:35 INFO - [ 08:27:35 INFO - "pgo_build", 08:27:35 INFO - "False", 08:27:35 INFO - "Change" 08:27:35 INFO - ] 08:27:35 INFO - ], 08:27:35 INFO - "revision": "ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63" 08:27:35 INFO - } 08:27:35 INFO - ], 08:27:35 INFO - "revision": "ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63" 08:27:35 INFO - } 08:27:35 INFO - } 08:27:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:27:35 INFO - Running post-action listener: _resource_record_post_action 08:27:35 INFO - ##### 08:27:35 INFO - ##### Running download-and-extract step. 08:27:35 INFO - ##### 08:27:35 INFO - Running pre-action listener: _resource_record_pre_action 08:27:35 INFO - Running main action method: download_and_extract 08:27:35 INFO - mkdir: /builds/slave/test/build/tests 08:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:35 INFO - https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:27:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/test_packages.json 08:27:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/test_packages.json 08:27:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:27:35 INFO - Downloaded 1302 bytes. 08:27:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:27:35 INFO - Using the following test package requirements: 08:27:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:27:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:27:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:27:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:27:35 INFO - u'jsshell-linux-x86_64.zip'], 08:27:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:27:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:27:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:27:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:27:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:27:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:27:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:27:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:27:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:27:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:27:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:27:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:27:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:35 INFO - https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:27:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:27:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:27:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:27:36 INFO - Downloaded 21870297 bytes. 08:27:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:27:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:27:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:27:37 INFO - Return code: 0 08:27:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:37 INFO - https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:27:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:27:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:27:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:27:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:27:38 INFO - Downloaded 21870297 bytes. 08:27:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:27:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:27:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:27:40 INFO - Return code: 0 08:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:40 INFO - https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:27:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:27:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:27:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:27:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:27:40 INFO - Downloaded 11132052 bytes. 08:27:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 08:27:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:27:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:27:41 INFO - Return code: 0 08:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:41 INFO - https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:27:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:27:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:27:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:27:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:27:42 INFO - Downloaded 57750859 bytes. 08:27:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:27:42 INFO - mkdir: /builds/slave/test/properties 08:27:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:27:42 INFO - Writing to file /builds/slave/test/properties/build_url 08:27:42 INFO - Contents: 08:27:42 INFO - build_url:https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:27:42 INFO - Running post-action listener: _resource_record_post_action 08:27:42 INFO - Running post-action listener: set_extra_try_arguments 08:27:42 INFO - ##### 08:27:42 INFO - ##### Running populate-webroot step. 08:27:42 INFO - ##### 08:27:42 INFO - Running pre-action listener: _resource_record_pre_action 08:27:42 INFO - Running main action method: populate_webroot 08:27:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:27:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:27:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:27:42 INFO - '--tppagecycles', 08:27:42 INFO - '7'], 08:27:42 INFO - 'tests': ['tsvgm']}}, 08:27:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:27:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:27:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:27:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:27:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:27:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:27:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:27:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:27:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:27:42 INFO - 'talos_options': ['--e10s'], 08:27:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:27:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:27:42 INFO - 'tests': ['damp', 'tps']}, 08:27:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:27:42 INFO - 'talos_options': ['--e10s'], 08:27:42 INFO - 'tests': ['damp', 'tps']}, 08:27:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:27:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:27:42 INFO - 'other': {'tests': ['a11yr', 08:27:42 INFO - 'ts_paint', 08:27:42 INFO - 'tpaint', 08:27:42 INFO - 'sessionrestore', 08:27:42 INFO - 'sessionrestore_no_auto_restore']}, 08:27:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:27:42 INFO - 'tests': ['a11yr', 08:27:42 INFO - 'ts_paint', 08:27:42 INFO - 'tpaint', 08:27:42 INFO - 'sessionrestore', 08:27:42 INFO - 'sessionrestore_no_auto_restore']}, 08:27:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:27:42 INFO - 'tests': ['a11yr', 08:27:42 INFO - 'ts_paint', 08:27:42 INFO - 'tpaint', 08:27:42 INFO - 'sessionrestore', 08:27:42 INFO - 'sessionrestore_no_auto_restore']}, 08:27:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:27:42 INFO - 'tests': ['a11yr', 08:27:42 INFO - 'ts_paint', 08:27:42 INFO - 'tpaint', 08:27:42 INFO - 'sessionrestore', 08:27:42 INFO - 'sessionrestore_no_auto_restore']}, 08:27:42 INFO - 'other_l64': {'tests': ['a11yr', 08:27:42 INFO - 'ts_paint', 08:27:42 INFO - 'tpaint', 08:27:42 INFO - 'sessionrestore', 08:27:42 INFO - 'sessionrestore_no_auto_restore']}, 08:27:42 INFO - 'other_nol64': {'tests': ['a11yr', 08:27:42 INFO - 'ts_paint', 08:27:42 INFO - 'tpaint', 08:27:42 INFO - 'sessionrestore', 08:27:42 INFO - 'sessionrestore_no_auto_restore']}, 08:27:42 INFO - 'svgr': {'tests': ['tsvgx', 08:27:42 INFO - 'tsvgr_opacity', 08:27:42 INFO - 'tart', 08:27:42 INFO - 'tscrollx', 08:27:42 INFO - 'cart']}, 08:27:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:27:42 INFO - 'tests': ['tsvgx', 08:27:42 INFO - 'tsvgr_opacity', 08:27:42 INFO - 'tart', 08:27:42 INFO - 'tscrollx', 08:27:42 INFO - 'cart']}, 08:27:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:27:42 INFO - 'tests': ['tp5o']}, 08:27:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:27:42 INFO - 'talos_options': ['--e10s'], 08:27:42 INFO - 'tests': ['tp5o']}, 08:27:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:27:42 INFO - 'talos_options': ['--xperf_path', 08:27:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:27:42 INFO - 'tests': ['tp5n']}, 08:27:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:27:42 INFO - 'talos_options': ['--e10s', 08:27:42 INFO - '--xperf_path', 08:27:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:27:42 INFO - 'tests': ['tp5n']}}, 08:27:42 INFO - 'talos.zip': {'path': '', 08:27:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:27:42 INFO - Running post-action listener: _resource_record_post_action 08:27:42 INFO - ##### 08:27:42 INFO - ##### Running create-virtualenv step. 08:27:42 INFO - ##### 08:27:42 INFO - Running pre-action listener: _resource_record_pre_action 08:27:42 INFO - Running main action method: create_virtualenv 08:27:42 INFO - Creating virtualenv /builds/slave/test/build/venv 08: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 08:27:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:27:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:27:42 INFO - Using real prefix '/usr' 08:27:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:27:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:27:45 INFO - Installing pip.................done. 08:27:45 INFO - Return code: 0 08:27:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f633c764f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d00b0>, '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 0x29d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d1440>, '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': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:27:45 INFO - Using env: {'DISPLAY': ':0', 08:27:45 INFO - 'HOME': '/home/cltbld', 08:27:45 INFO - 'LANG': 'en_US.UTF-8', 08:27:45 INFO - 'LANGUAGE': 'en_US:en', 08:27:45 INFO - 'LOGNAME': 'cltbld', 08:27:45 INFO - 'MAIL': '/var/mail/cltbld', 08:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:45 INFO - 'MOZ_NO_REMOTE': '1', 08:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:45 INFO - 'NO_EM_RESTART': '1', 08:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:45 INFO - 'PWD': '/builds/slave/test', 08:27:45 INFO - 'SHELL': '/bin/bash', 08:27:45 INFO - 'SHLVL': '1', 08:27:45 INFO - 'TERM': 'linux', 08:27:45 INFO - 'TMOUT': '86400', 08:27:45 INFO - 'USER': 'cltbld', 08:27:45 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 08:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:45 INFO - '_': '/tools/buildbot/bin/python'} 08:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08: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 08:27:45 INFO - Cleaning up... 08:27:45 INFO - Return code: 0 08:27:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f633c764f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d00b0>, '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 0x29d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d1440>, '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': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 08:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 08:27:45 INFO - Using env: {'DISPLAY': ':0', 08:27:45 INFO - 'HOME': '/home/cltbld', 08:27:45 INFO - 'LANG': 'en_US.UTF-8', 08:27:45 INFO - 'LANGUAGE': 'en_US:en', 08:27:45 INFO - 'LOGNAME': 'cltbld', 08:27:45 INFO - 'MAIL': '/var/mail/cltbld', 08:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:45 INFO - 'MOZ_NO_REMOTE': '1', 08:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:45 INFO - 'NO_EM_RESTART': '1', 08:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:45 INFO - 'PWD': '/builds/slave/test', 08:27:45 INFO - 'SHELL': '/bin/bash', 08:27:45 INFO - 'SHLVL': '1', 08:27:45 INFO - 'TERM': 'linux', 08:27:45 INFO - 'TMOUT': '86400', 08:27:45 INFO - 'USER': 'cltbld', 08:27:45 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 08:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:45 INFO - '_': '/tools/buildbot/bin/python'} 08:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:45 INFO - Downloading/unpacking psutil>=0.7.1 08: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 08: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 08: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 08: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 08: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 08: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 08:27:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:27:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:27:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:27:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:27:47 INFO - Installing collected packages: psutil 08:27:47 INFO - Running setup.py install for psutil 08:27:47 INFO - building 'psutil._psutil_linux' extension 08: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 08:27:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:27:47 INFO - building 'psutil._psutil_posix' extension 08:27:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:27:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:27:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:27:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:27:47 INFO - Successfully installed psutil 08:27:47 INFO - Cleaning up... 08:27:47 INFO - Return code: 0 08:27:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f633c764f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d00b0>, '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 0x29d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d1440>, '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': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:27:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 08:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 08:27:47 INFO - Using env: {'DISPLAY': ':0', 08:27:47 INFO - 'HOME': '/home/cltbld', 08:27:47 INFO - 'LANG': 'en_US.UTF-8', 08:27:47 INFO - 'LANGUAGE': 'en_US:en', 08:27:47 INFO - 'LOGNAME': 'cltbld', 08:27:47 INFO - 'MAIL': '/var/mail/cltbld', 08:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:47 INFO - 'MOZ_NO_REMOTE': '1', 08:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:47 INFO - 'NO_EM_RESTART': '1', 08:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:47 INFO - 'PWD': '/builds/slave/test', 08:27:47 INFO - 'SHELL': '/bin/bash', 08:27:47 INFO - 'SHLVL': '1', 08:27:47 INFO - 'TERM': 'linux', 08:27:47 INFO - 'TMOUT': '86400', 08:27:47 INFO - 'USER': 'cltbld', 08:27:47 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 08:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:47 INFO - '_': '/tools/buildbot/bin/python'} 08:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08: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 08: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 08: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 08: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 08: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 08: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 08:27:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:27:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:27:49 INFO - Installing collected packages: mozsystemmonitor 08:27:49 INFO - Running setup.py install for mozsystemmonitor 08:27:49 INFO - Successfully installed mozsystemmonitor 08:27:49 INFO - Cleaning up... 08:27:49 INFO - Return code: 0 08:27:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f633c764f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d00b0>, '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 0x29d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d1440>, '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': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:27:49 INFO - Using env: {'DISPLAY': ':0', 08:27:49 INFO - 'HOME': '/home/cltbld', 08:27:49 INFO - 'LANG': 'en_US.UTF-8', 08:27:49 INFO - 'LANGUAGE': 'en_US:en', 08:27:49 INFO - 'LOGNAME': 'cltbld', 08:27:49 INFO - 'MAIL': '/var/mail/cltbld', 08:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:49 INFO - 'MOZ_NO_REMOTE': '1', 08:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:49 INFO - 'NO_EM_RESTART': '1', 08:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:49 INFO - 'PWD': '/builds/slave/test', 08:27:49 INFO - 'SHELL': '/bin/bash', 08:27:49 INFO - 'SHLVL': '1', 08:27:49 INFO - 'TERM': 'linux', 08:27:49 INFO - 'TMOUT': '86400', 08:27:49 INFO - 'USER': 'cltbld', 08:27:49 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 08:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:49 INFO - '_': '/tools/buildbot/bin/python'} 08:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:50 INFO - Downloading/unpacking blobuploader==1.2.4 08: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 08: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 08: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 08: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 08: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 08: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 08:27:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:27:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:27:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:27:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08: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 08: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 08: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 08: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 08: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 08: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 08:27:52 INFO - Downloading docopt-0.6.1.tar.gz 08:27:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:27:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:27:52 INFO - Running setup.py install for blobuploader 08:27:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:27:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:27:52 INFO - Running setup.py install for requests 08:27:52 INFO - Running setup.py install for docopt 08:27:53 INFO - Successfully installed blobuploader requests docopt 08:27:53 INFO - Cleaning up... 08:27:53 INFO - Return code: 0 08:27:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f633c764f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d00b0>, '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 0x29d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d1440>, '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': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:27:53 INFO - Using env: {'DISPLAY': ':0', 08:27:53 INFO - 'HOME': '/home/cltbld', 08:27:53 INFO - 'LANG': 'en_US.UTF-8', 08:27:53 INFO - 'LANGUAGE': 'en_US:en', 08:27:53 INFO - 'LOGNAME': 'cltbld', 08:27:53 INFO - 'MAIL': '/var/mail/cltbld', 08:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:53 INFO - 'MOZ_NO_REMOTE': '1', 08:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:53 INFO - 'NO_EM_RESTART': '1', 08:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:53 INFO - 'PWD': '/builds/slave/test', 08:27:53 INFO - 'SHELL': '/bin/bash', 08:27:53 INFO - 'SHLVL': '1', 08:27:53 INFO - 'TERM': 'linux', 08:27:53 INFO - 'TMOUT': '86400', 08:27:53 INFO - 'USER': 'cltbld', 08:27:53 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 08:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:53 INFO - '_': '/tools/buildbot/bin/python'} 08:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:27:53 INFO - Running setup.py (path:/tmp/pip-Hu4KsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:27:53 INFO - Running setup.py (path:/tmp/pip-etLxaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:27:53 INFO - Running setup.py (path:/tmp/pip-HL_KQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:27:53 INFO - Running setup.py (path:/tmp/pip-uR67Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:53 INFO - Running setup.py (path:/tmp/pip-oSg0Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:53 INFO - Running setup.py (path:/tmp/pip-8Ke5r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:53 INFO - Running setup.py (path:/tmp/pip-v_Mua1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:53 INFO - Running setup.py (path:/tmp/pip-0iDyKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:53 INFO - Running setup.py (path:/tmp/pip-xUFSYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:53 INFO - Running setup.py (path:/tmp/pip-QXd5dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:54 INFO - Running setup.py (path:/tmp/pip-aurAOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:54 INFO - Running setup.py (path:/tmp/pip-Ig0yDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:54 INFO - Running setup.py (path:/tmp/pip-0xK9e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:54 INFO - Running setup.py (path:/tmp/pip-vDsHQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:54 INFO - Running setup.py (path:/tmp/pip-kUPFJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:54 INFO - Running setup.py (path:/tmp/pip-w_jNfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:54 INFO - Running setup.py (path:/tmp/pip-62uERi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:27:54 INFO - Running setup.py install for manifestparser 08:27:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:27:54 INFO - Running setup.py install for mozcrash 08:27:54 INFO - Running setup.py install for mozdebug 08:27:54 INFO - Running setup.py install for mozdevice 08:27:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Running setup.py install for mozfile 08:27:55 INFO - Running setup.py install for mozhttpd 08:27:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Running setup.py install for mozinfo 08:27:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Running setup.py install for mozInstall 08:27:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Running setup.py install for mozleak 08:27:55 INFO - Running setup.py install for mozlog 08:27:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Running setup.py install for moznetwork 08:27:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Running setup.py install for mozprocess 08:27:55 INFO - Running setup.py install for mozprofile 08:27:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:27:55 INFO - Running setup.py install for mozrunner 08:27:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:27:56 INFO - Running setup.py install for mozscreenshot 08:27:56 INFO - Running setup.py install for moztest 08:27:56 INFO - Running setup.py install for mozversion 08:27:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:27:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:27:56 INFO - Cleaning up... 08:27:56 INFO - Return code: 0 08:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f633c764f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d00b0>, '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 0x29d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d1440>, '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': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:27:56 INFO - Using env: {'DISPLAY': ':0', 08:27:56 INFO - 'HOME': '/home/cltbld', 08:27:56 INFO - 'LANG': 'en_US.UTF-8', 08:27:56 INFO - 'LANGUAGE': 'en_US:en', 08:27:56 INFO - 'LOGNAME': 'cltbld', 08:27:56 INFO - 'MAIL': '/var/mail/cltbld', 08:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:56 INFO - 'MOZ_NO_REMOTE': '1', 08:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:56 INFO - 'NO_EM_RESTART': '1', 08:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:56 INFO - 'PWD': '/builds/slave/test', 08:27:56 INFO - 'SHELL': '/bin/bash', 08:27:56 INFO - 'SHLVL': '1', 08:27:56 INFO - 'TERM': 'linux', 08:27:56 INFO - 'TMOUT': '86400', 08:27:56 INFO - 'USER': 'cltbld', 08:27:56 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 08:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:56 INFO - '_': '/tools/buildbot/bin/python'} 08:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:27:56 INFO - Running setup.py (path:/tmp/pip-Aw1Fi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:27:56 INFO - Running setup.py (path:/tmp/pip-r7XGRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:27:56 INFO - Running setup.py (path:/tmp/pip-YBzt2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:27:56 INFO - Running setup.py (path:/tmp/pip-UuIijB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:27:56 INFO - Running setup.py (path:/tmp/pip-XRo528-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:27:56 INFO - Running setup.py (path:/tmp/pip-R_zjrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:27:57 INFO - Running setup.py (path:/tmp/pip-EqZSom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:27:57 INFO - Running setup.py (path:/tmp/pip-_7CWXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:27:57 INFO - Running setup.py (path:/tmp/pip-UBnAG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:27:57 INFO - Running setup.py (path:/tmp/pip-Q0KZfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:27:57 INFO - Running setup.py (path:/tmp/pip-hU8MdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:27:57 INFO - Running setup.py (path:/tmp/pip-CVeX94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:27:57 INFO - Running setup.py (path:/tmp/pip-WK6Sis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:27:57 INFO - Running setup.py (path:/tmp/pip-7fODC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:57 INFO - Running setup.py (path:/tmp/pip-q1qOxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:27:57 INFO - Running setup.py (path:/tmp/pip-Ke7_vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:27:57 INFO - Running setup.py (path:/tmp/pip-u6EDzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:27:57 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:27:57 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:27:57 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:57 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:27:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:27:59 INFO - Downloading blessings-1.5.1.tar.gz 08:27:59 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:27:59 INFO - Installing collected packages: blessings 08:27:59 INFO - Running setup.py install for blessings 08:27:59 INFO - Successfully installed blessings 08:27:59 INFO - Cleaning up... 08:27:59 INFO - Return code: 0 08:27:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:27:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:27:59 INFO - Reading from file tmpfile_stdout 08:27:59 INFO - Current package versions: 08:27:59 INFO - argparse == 1.2.1 08:27:59 INFO - blessings == 1.5.1 08:27:59 INFO - blobuploader == 1.2.4 08:27:59 INFO - docopt == 0.6.1 08:27:59 INFO - manifestparser == 1.1 08:27:59 INFO - mozInstall == 1.12 08:27:59 INFO - mozcrash == 0.16 08:27:59 INFO - mozdebug == 0.1 08:27:59 INFO - mozdevice == 0.47 08:27:59 INFO - mozfile == 1.2 08:27:59 INFO - mozhttpd == 0.7 08:27:59 INFO - mozinfo == 0.9 08:27:59 INFO - mozleak == 0.1 08:27:59 INFO - mozlog == 3.1 08:27:59 INFO - moznetwork == 0.27 08:27:59 INFO - mozprocess == 0.22 08:27:59 INFO - mozprofile == 0.27 08:27:59 INFO - mozrunner == 6.11 08:27:59 INFO - mozscreenshot == 0.1 08:27:59 INFO - mozsystemmonitor == 0.0 08:27:59 INFO - moztest == 0.7 08:27:59 INFO - mozversion == 1.4 08:27:59 INFO - psutil == 3.1.1 08:27:59 INFO - requests == 1.2.3 08:27:59 INFO - wsgiref == 0.1.2 08:27:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:27:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f633c764f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d00b0>, '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 0x29d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d1440>, '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': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:27:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:27:59 INFO - Using env: {'DISPLAY': ':0', 08:27:59 INFO - 'HOME': '/home/cltbld', 08:27:59 INFO - 'LANG': 'en_US.UTF-8', 08:27:59 INFO - 'LANGUAGE': 'en_US:en', 08:27:59 INFO - 'LOGNAME': 'cltbld', 08:27:59 INFO - 'MAIL': '/var/mail/cltbld', 08:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:27:59 INFO - 'MOZ_NO_REMOTE': '1', 08:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:27:59 INFO - 'NO_EM_RESTART': '1', 08:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:27:59 INFO - 'PWD': '/builds/slave/test', 08:27:59 INFO - 'SHELL': '/bin/bash', 08:27:59 INFO - 'SHLVL': '1', 08:27:59 INFO - 'TERM': 'linux', 08:27:59 INFO - 'TMOUT': '86400', 08:27:59 INFO - 'USER': 'cltbld', 08:27:59 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 08:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:27:59 INFO - '_': '/tools/buildbot/bin/python'} 08:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:00 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 1)) 08:28:00 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 2)) 08:28:00 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 3)) 08:28:00 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 4)) 08:28:00 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 5)) 08:28:00 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 6)) 08:28:00 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 7)) 08:28:00 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 8)) 08:28:00 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:28:00 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 3)) 08:28:00 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:28:00 INFO - Cleaning up... 08:28:00 INFO - Return code: 0 08:28:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f633c764f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d00b0>, '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 0x29d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d1440>, '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': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:28:00 INFO - Using env: {'DISPLAY': ':0', 08:28:00 INFO - 'HOME': '/home/cltbld', 08:28:00 INFO - 'LANG': 'en_US.UTF-8', 08:28:00 INFO - 'LANGUAGE': 'en_US:en', 08:28:00 INFO - 'LOGNAME': 'cltbld', 08:28:00 INFO - 'MAIL': '/var/mail/cltbld', 08:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:00 INFO - 'MOZ_NO_REMOTE': '1', 08:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:00 INFO - 'NO_EM_RESTART': '1', 08:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:00 INFO - 'PWD': '/builds/slave/test', 08:28:00 INFO - 'SHELL': '/bin/bash', 08:28:00 INFO - 'SHLVL': '1', 08:28:00 INFO - 'TERM': 'linux', 08:28:00 INFO - 'TMOUT': '86400', 08:28:00 INFO - 'USER': 'cltbld', 08:28:00 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 08:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:00 INFO - '_': '/tools/buildbot/bin/python'} 08:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:00 INFO - Downloading/unpacking jsonschema 08:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:28:02 INFO - Downloading/unpacking functools32 (from jsonschema) 08:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:28:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:28:02 INFO - warning: no files found matching '*.txt' 08:28:02 INFO - no previously-included directories found matching 'build' 08:28:02 INFO - no previously-included directories found matching 'dist' 08:28:02 INFO - no previously-included directories found matching '.git*' 08:28:02 INFO - Installing collected packages: jsonschema, functools32 08:28:02 INFO - Running setup.py install for functools32 08:28:02 INFO - warning: no files found matching '*.txt' 08:28:02 INFO - no previously-included directories found matching 'build' 08:28:02 INFO - no previously-included directories found matching 'dist' 08:28:02 INFO - no previously-included directories found matching '.git*' 08:28:02 INFO - Successfully installed jsonschema functools32 08:28:02 INFO - Cleaning up... 08:28:02 INFO - Return code: 0 08:28:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f633c764f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2941240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d00b0>, '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 0x29d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d1440>, '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': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:28:02 INFO - Using env: {'DISPLAY': ':0', 08:28:02 INFO - 'HOME': '/home/cltbld', 08:28:02 INFO - 'LANG': 'en_US.UTF-8', 08:28:02 INFO - 'LANGUAGE': 'en_US:en', 08:28:02 INFO - 'LOGNAME': 'cltbld', 08:28:02 INFO - 'MAIL': '/var/mail/cltbld', 08:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:02 INFO - 'MOZ_NO_REMOTE': '1', 08:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:02 INFO - 'NO_EM_RESTART': '1', 08:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:02 INFO - 'PWD': '/builds/slave/test', 08:28:02 INFO - 'SHELL': '/bin/bash', 08:28:02 INFO - 'SHLVL': '1', 08:28:02 INFO - 'TERM': 'linux', 08:28:02 INFO - 'TMOUT': '86400', 08:28:02 INFO - 'USER': 'cltbld', 08:28:02 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 08:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:02 INFO - '_': '/tools/buildbot/bin/python'} 08:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:02 INFO - Downloading/unpacking flake8 08:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:28:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:28:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08: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 08: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 08: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 08: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 08: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 08: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 08:28:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:28:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:28:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08: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 08: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 08: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 08: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 08: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 08: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 08:28:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:28:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08: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 08: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 08: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 08: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 08: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 08: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 08:28:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:28:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:28:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:28:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:28:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:28:05 INFO - no previously-included directories found matching 'docs/_build' 08:28:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:28:05 INFO - Running setup.py install for pep8 08:28:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:28:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:28:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:28:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:28:05 INFO - no previously-included directories found matching 'docs/_build' 08:28:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:28:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:28:05 INFO - Cleaning up... 08:28:05 INFO - Return code: 0 08:28:05 INFO - Running post-action listener: _resource_record_post_action 08:28:05 INFO - Running post-action listener: _start_resource_monitoring 08:28:05 INFO - Starting resource monitoring. 08:28:05 INFO - ##### 08:28:05 INFO - ##### Running install step. 08:28:05 INFO - ##### 08:28:05 INFO - Running pre-action listener: _resource_record_pre_action 08:28:05 INFO - Running main action method: install 08:28:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:05 INFO - Reading from file tmpfile_stdout 08:28:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:28:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:28:05 INFO - Reading from file tmpfile_stdout 08:28:05 INFO - Output received: 08:28:05 INFO - Usage: mozinstall [options] installer 08:28:05 INFO - Options: 08:28:05 INFO - -h, --help show this help message and exit 08:28:05 INFO - -d DEST, --destination=DEST 08:28:05 INFO - Directory to install application into. [default: 08:28:05 INFO - "/builds/slave/test"] 08:28:05 INFO - --app=APP Application being installed. [default: firefox] 08:28:05 INFO - mkdir: /builds/slave/test/build/application 08:28:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:28:20 INFO - Reading from file tmpfile_stdout 08:28:20 INFO - Output received: 08:28:20 INFO - /builds/slave/test/build/application/firefox/firefox 08:28:20 INFO - Running post-action listener: _resource_record_post_action 08:28:20 INFO - ##### 08:28:20 INFO - ##### Running run-tests step. 08:28:20 INFO - ##### 08:28:20 INFO - Running pre-action listener: _resource_record_pre_action 08:28:20 INFO - Running main action method: run_tests 08:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:28:20 INFO - Python 2.7.3 08:28:20 INFO - Return code: 0 08:28:20 INFO - grabbing minidump binary from tooltool 08:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:28:20 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d00b0>, '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 0x29d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d1440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:28:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:28:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:28:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:28:20 INFO - Return code: 0 08:28:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:28:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:28:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:28:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:28:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:28:21 INFO - Return code: 0 08:28:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] in /builds/slave/test/build 08:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost 08:28:21 INFO - Using env: {'DISPLAY': ':0', 08:28:21 INFO - 'HOME': '/home/cltbld', 08:28:21 INFO - 'LANG': 'en_US.UTF-8', 08:28:21 INFO - 'LANGUAGE': 'en_US:en', 08:28:21 INFO - 'LOGNAME': 'cltbld', 08:28:21 INFO - 'MAIL': '/var/mail/cltbld', 08:28:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:28:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:21 INFO - 'MOZ_NO_REMOTE': '1', 08:28:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:28:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:21 INFO - 'NO_EM_RESTART': '1', 08:28:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:21 INFO - 'PWD': '/builds/slave/test', 08:28:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:28:21 INFO - 'SHELL': '/bin/bash', 08:28:21 INFO - 'SHLVL': '1', 08:28:21 INFO - 'TERM': 'linux', 08:28:21 INFO - 'TMOUT': '86400', 08:28:21 INFO - 'USER': 'cltbld', 08:28:21 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682', 08:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:21 INFO - '_': '/tools/buildbot/bin/python'} 08:28:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] with output_timeout 3600 08:28:21 INFO - mozversion INFO | application_buildid: 20151216073608 08:28:21 INFO - mozversion INFO | application_changeset: ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63 08:28:21 INFO - mozversion INFO | application_display_name: Nightly 08:28:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:28:21 INFO - mozversion INFO | application_name: Firefox 08:28:21 INFO - mozversion INFO | application_remotingname: firefox 08:28:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:28:21 INFO - mozversion INFO | application_vendor: Mozilla 08:28:21 INFO - mozversion INFO | application_version: 46.0a1 08:28:21 INFO - mozversion INFO | platform_buildid: 20151216073608 08:28:21 INFO - mozversion INFO | platform_changeset: ac9c0f02ef3357c1a6b7ca8f43781e9f15f86d63 08:28:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:28:21 INFO - mozversion INFO | platform_version: 46.0a1 08:28:21 INFO - 2015-12-16 08:28:21,409 DEBUG : using testdate: 1450283301 08:28:21 INFO - 2015-12-16 08:28:21,409 DEBUG : actual date: 1450283301 08:28:21 INFO - 2015-12-16 08:28:21,457 INFO : starting webserver on 'localhost:43066' 08:28:21 INFO - 2015-12-16 08:28:21,458 INFO : Starting test suite talos-linux64-ix-065 08:28:21 INFO - 2015-12-16 08:28:21,458 INFO : Starting test dromaeo_css 08:28:21 INFO - 2015-12-16 08:28:21,458 DEBUG : operating with platform_type : linux_ 08:28:21 INFO - 2015-12-16 08:28:21,459 INFO : Initialising browser for dromaeo_css test... 08:28:21 INFO - 2015-12-16 08:28:21,476 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPG2RE/profile http://localhost:43066/getInfo.html 08:28:26 INFO - 2015-12-16 08:28:26,138 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:28:26 INFO - 2015-12-16 08:28:26,138 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:28:26 INFO - 2015-12-16 08:28:26,139 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:28:26 INFO - 2015-12-16 08:28:26,139 DEBUG : BROWSER_OUTPUT: __metrics 08:28:26 INFO - 2015-12-16 08:28:26,215 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:28:26 INFO - 2015-12-16 08:28:26,276 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:26 ERROR - 2015-12-16 08:28:26,297 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 08:28:27 INFO - 2015-12-16 08:28:27,146 INFO : Browser initialized. 08:28:27 INFO - 2015-12-16 08:28:27,146 INFO : Running cycle 1/1 for dromaeo_css test... 08:28:27 INFO - 2015-12-16 08:28:27,147 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPG2RE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:28:39 INFO - 2015-12-16 08:28:39,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 143421440 08:28:39 INFO - 2015-12-16 08:28:39,152 DEBUG : BROWSER_OUTPUT: 08:29:30 INFO - 2015-12-16 08:29:30,372 DEBUG : BROWSER_OUTPUT: 1450283370371 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:31:41 INFO - 2015-12-16 08:31:41,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43066/tests/dromaeo/cssquery-ext.html) 08:31:43 INFO - 2015-12-16 08:31:43,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 223412224 08:31:43 INFO - 2015-12-16 08:31:43,483 DEBUG : BROWSER_OUTPUT: 08:34:45 INFO - 2015-12-16 08:34:45,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-ext.html (next: http://localhost:43066/tests/dromaeo/cssquery-jquery.html) 08:34:46 INFO - 2015-12-16 08:34:46,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 218693632 08:34:46 INFO - 2015-12-16 08:34:46,470 DEBUG : BROWSER_OUTPUT: 08:37:48 INFO - 2015-12-16 08:37:48,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43066/tests/dromaeo/cssquery-mootools.html) 08:37:49 INFO - 2015-12-16 08:37:49,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 222273536 08:37:49 INFO - 2015-12-16 08:37:49,093 DEBUG : BROWSER_OUTPUT: 08:40:51 INFO - 2015-12-16 08:40:51,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43066/tests/dromaeo/cssquery-prototype.html) 08:40:51 INFO - 2015-12-16 08:40:51,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 203415552 08:40:51 INFO - 2015-12-16 08:40:51,584 DEBUG : BROWSER_OUTPUT: 08:43:54 INFO - 2015-12-16 08:43:54,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43066/tests/dromaeo/cssquery-yui.html) 08:43:54 INFO - 2015-12-16 08:43:54,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 181268480 08:43:54 INFO - 2015-12-16 08:43:54,874 DEBUG : BROWSER_OUTPUT: 08:46:57 INFO - 2015-12-16 08:46:57,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/dromaeo/cssquery-yui.html (next: http://localhost:43066/tests/dromaeo/cssquery-dojo.html) 08:46:57 INFO - 2015-12-16 08:46:57,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 250040320 08:46:57 INFO - 2015-12-16 08:46:57,654 DEBUG : BROWSER_OUTPUT: 08:46:57 INFO - 2015-12-16 08:46:57,654 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:46:57 INFO - 2015-12-16 08:46:57,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:46:57 INFO - 2015-12-16 08:46:57,654 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:46:57 INFO - 2015-12-16 08:46:57,654 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:46:57 INFO - 2015-12-16 08:46:57,655 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2628.1589891234808;2711.6745990481145;2715.9864200678994;2719.959200611991;2733.3166708322915;4576.748278844662;4745.57289843914;4766.142094423002;4767.737774422405;4768.809247630095;4710.411198600175;4776.8328108516125;4824.27635854622;4826;4924.581410580096;4321.286987647034;4339.284018137011;4358.063016451462;4462.821487140511;4478.865634030968;4404.075144219718;4424.933625995613;4465.642748580122;4472.865814025585;4508.549145085498;4247.04441500663;4249.596288352602;4360.367746676746;4363;4367.650587952988;4374.081442896995;4394.758288294142;4396.912061758779;4398.516163222043;4440.245158323093;4363.52001279859;4370.956290437087;4386.868393948187;4410.140022695576;4410.580994805488;4431.047324825146;4536.319552067183;4543.068670922453;4579.793909274091;4731.834385796515;5118.692878427306;5142.254373115915;5145.562627176694;5151.4333423323405;5155.690658560498;5169.095408303532;5181.948180518184;5183.041137389595;5186.429492755794;5240.68555886648;4473.463184417858;4579.038401935598;4582.427196600425;4674.906501869944;4804.039192161582;5193.091209038404;5224.608154388436;5224.608154388436;5230.110881150214;5230.267762513251;5004.699718016931;5007.599392048627;5009.12340340439;5009.949900501021;5050.72221027847;4736.928946065812;4883.780229889592;4886.267059940967;4949.257611358325;5037.823676171316;5031.84904452867;5063.518965698253;5067.265246539231;5072.51811077947;5113.463086375951;5027.748612569357;5029.2958985742025;5034.11902916988;5037.697738135724;5040.722760248148;4038.7374820636564;4126.7523948563185;4130.194612050621;4138.337865941435;4206.0115872769875;3677.2277821657217;3694.4458331250526;3717.665410113103;3721.6464435878547;3751.0434839116397;4394.12117576486;4396.252637051709;4408.625266852289;4437.245668236407;4437.800298986554;4837.2260438329695;4940.357753492023;4949.455559888409;4949.876253093701;5051.722155281494;4369.06065195978;4393.604575588212;4401.163778882003;4416.779161041999;4448.421705178306;4513.68404211702;4532.750698711537;4532.841350552715;4536.523665015192;4576.199165146086;4686.531346865286;4695.81216751333;4817.1810792164715;4822.927656085231;4880.585150262267;5070.771815268248;5086.491350864884;5114.872128196676;5118.769655365443;5121.231815227746;4874.439439464507;4878.658493905535;4881.170201065898;4881.707097574157;4912.70523768575;4788.904221915473;4894.192458244493;4899.265110233494;4901.803927842989;5091.210862316347;4951.8266860659705;4953.554180123806;4997.600191984705;5006.524380183877;5009.77456014473;4694.6009589185305;4843.152448321459;4847.079054979543;4853.247746599282;4910.288008238714;4918.2376731606655;4939.60483161339;4950.77721502526;4957.529034741694;4986.750662466935;4831.347768051409;4851.660383773102;4852.733099679552;4854.708717476963;4881.170201065898;4756.429228492603;4874.147024270667;4877.073356062337;4878.682885612424;4979.651424400257;4808.422989241173;4840.564349208447;4845.733484658236;4846.39420072491;4880.585150262125 08:46:57 INFO - 2015-12-16 08:46:57,657 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.4310695323387;552.3178874090497;560.5403569073359;561.8286422641098;561.9072852979257;26989.865050674744;27572.724272757267;34900.301993960136;35274.118147046276;35358.46962295568;38745.22509549814;39315;39366.8031659842;39394.01514962127;39395.424183032716;6848.315168483162;6971.128608923885;7872.3308518775975;8045.316148127416;8052.557109358983;10135.44255065971;10379.117774989136;10399.84400233997;10407.531661075232;10407.68776936693;9966.65116720915;9999.600015999351;10024.348417352885;10025.047620476043;10046;7150.10623672041;7330.926690733131;10082.89917100827;10180.185585153169;10479.94760026195;9891;10094.394336339843;10101.444420556867;10106.191504679608;10106.898931010743;37564.812175939216;37819.62180378188;38036;38092.42861357054;38133.618663813286;2947.513660246057;2948.2776719703597;3136.278655909131;3509.859605615772;3597.9460308095136;27905.72094279072;28670.713292867014;28706.425871482454;28745.856270718512;29749.10752677423;3348.4475061614803;3354.647761985005;3381.8642663978985;3397.1846756778195;3431.279431319426;202365;208092;208099;208323.9999999985;208573;49833.25250121251;50926;59625.70187149037;60592.39407605868;60725;57442;57661.711691441276;58046.70976645174;58214;58256.63075269287;13623;13629.522966696317;13717.108387954751;13767;13805.17168969865;10158.847617285746;10197.643082492226;10205.795884082278;10209.38743675382;10218.131458825934;19801.504962376057;20145.194192232146;20163;20197.798022019593;20255;8314.875276870851;8361.707340243061;8365.372597055124;8433.873491897626;8548.786280343042;817.967281308741;854.9658013679383;914.6067191107754;915.0620613870835;916.9312301577409;26010.86994565015;26917.865410673214;26986.865065674938;27081.1875643731;27245.318867028484;938.7606160429046;944.093670076734;961.778790878088;966.5988614724951;989.7773001074701;13962.930185349009;14078.225697586526;14133.081349712236;14264.786028209584;14344.497942572169;253181;258762;260022;260086;260996;46569.30146047812;47036.52963470321;47095.5290447098;47235.5276447238;47296;1217.3973882928008;1229.6987238126717;1247.6381849263612;1252.1422825364655;1256.1709271880516;25300.493990120463;25838;26600.467990640467;26621.467570648867;26672.733272667025;41440.79279603583;41716;41866.58133418627;41878.162436750485;41937.58062419337;251325;252764;299592;304864;322069;29994.850025749733;30149.09552713422;30163.69836301609;30487.54268685927;30623.387532249675;38736.418953715154;39224.80387598044;39571.208575828896;40054.59945400509;40219.597804021585;33025.00924972255;34081.31837363289;34175.14562135967;34178.65821341755;34524.13689657779;33546;33553.16117097092;33556.328873422884;33724;33803.323933521686;33018.17454563655;34013.14967125842;34236;34302.65697342995;34309.48535771915;32782.83608581942;35766.64233357633;35914;36093.45859812157;36109.458358124124;23416.882915585993;23488.412789680395;23956.760432395455;24074.638880416456;24122.276331710076 08:46:57 INFO - 2015-12-16 08:46:57,657 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.3444016946869;336.6366216821872;340.8176625505352;341.9623841377448;344.85516083245034;12389.938050309736;12727.42726577304;14654;14803.111813291196;15503.379864805409;12811.807822882663;15206.771898421504;15207.543773686779;15496.535103946871;15498;4980.27785971034;5146.176611742122;6431.131797207364;6635.469162466991;6642.103316052319;4080.06158583526;4208.116295577917;6378.266499352564;6562.507811914102;6564.146660934072;6355.364463553654;6487.643179625119;6518.380753828379;6559.475241980654;6563.442107420875;6480.4815614750705;6542.345765423467;6552.803415897531;6555.541112122177;6556.377144171296;6099.085137229451;6212.751489940442;6217.906731398987;6276.089966954812;6291.622502649856;21585.676214856634;21679.241226556995;21745.891270543547;22105.778942210694;22174;2017.522946715937;2032.8780273183656;2058.217877206667;2080.6150862090562;2118.9934780979065;13779.242141682204;14087;14115;14272.500462483764;14295.857041429557;1866.6266746650724;1893.2427029188298;1924.6246981838547;1949.6100779844087;1950.7464029676194;57125.23440725433;61416.38583614151;61731.07403388998;61945;62364.68817655928;15391.307391167424;15490.767638485431;15511.301991410413;15526.37894484208;15589.688206236038;23280;23397.88301058484;23544.764552354598;23565.81861448717;23624.17315393953;8486.74539763808;8500.659973600987;8503.277221436123;8514.616842242114;8592.355573332025;7123.358897699232;7151.928480715231;7168.390686791577;7178.497505174588;7185.173705023884;7467.514611550232;7561.168271490132;7567.432442566829;7602.277783610548;7620.428467864932;2578.819482636235;2959.1270575180374;2990.2524368907775;2993.3713920076593;3049.207206126379;374.17681101576096;374.96062913394246;392.7741548609561;394.9861754838567;946.7964387656687;8972.237359824489;9145.634174633073;9511.857322140173;9641.710748677411;9788.363756355815;410.74739035492956;414.57298982048536;422.4908984673461;427.9957200428018;430.4017415792052;5187.0922588546855;5261.421243663194;5326.813561525328;5335.466453354634;5382.730863456812;405394;478758;478976;496644;497484;68431;71677.19066688656;71818.64090679618;71937;72528.27471725321;1071.287593750163;1074.5218377821793;1125.6735546691368;1147.9655610331704;1151.654503648902;14437.35031923587;14471.27643617794;14505.202213878338;14604.196769177797;14623.122612643276;28881.711182887902;29551.704482954894;30137.698623014367;30575.541366879068;31254;39969;40940.79529602333;41343.7932810334;41557.58442415537;43472.78263608662;8147.266745992889;8389.11914248995;8450.281726053108;8798.736037918872;8803.427777194462;10196.184305255414;10226.590936362461;10251;12429.875701242872;16017.759733603772;12897.48410063587;13201.669958250737;13212.933935330262;13302.534411295559;13448.462061517821;12789.74420511566;13047.739045219232;13133.212007279593;13169;13568.050236483747;13626.250556219504;13751.312434378442;13757.38091785852;14458.337291211645;14715;8990.187715438738;9068.591913364047;9083.137101975302;9109.407888487227;9160.129787670161;13945.302734863013;14134.929325353307;14244.715105698035;14287;14408.927955360155 08:46:57 INFO - 2015-12-16 08:46:57,658 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1265.3736400481762;1675.9497215083547;1723.5260303416562;1737.417964981731;1761.5331937036678;6176.505879529638;7112.964435177823;7294.270572942703;7308.488405811595;7310.634468276585;7011.579305241689;7141.214466408691;7171.497995140329;7180.066591343131;7228.855422891539;2080.6878968154783;2119.3112238522463;2119.8834064126468;2120.8833514156713;2121.893905304736;2102.475705113788;2135.7543882453483;2140.9357719268446;2153.54775497145;2156.644153714635;2000.8599398042143;2029.6143732690741;2040.0411806450945;2066.679664651974;2070.4306315763133;2087.603355362476;2112.0706888968803;2114.5453727448516;2116.767155612881;2118.3433135727973;2043.1520918818671;2059.938201853947;2062.5565503416688;2064.98967505163;2079.0228592561625;7162.606056666881;7196.424286057103;7223.602701851396;7230.674619642129;7234.24040475753;4214.831406743727;4283.229018776619;4296.957030429687;4314.266574682311;4316.956830431687;2727.7681397081074;2738.931816591531;2745.437185376993;2754.724527547249;2782.9721702783118;854.448880472092;1527.816662000567;1558.6648870492786;1573.1033311012727;1615.1843319123768;9760.219182465386;9806;9824.214062875024;9829.852552211723;9831.606735730562;3830.731848770615;3894.1043559981363;3967.0677390813134;3967.484227050465;3986.1629057898167;7959.880601790977;8004.479708818908;8024.959875200587;8029.478083924643;8038.517688938566;4243.830246790156;4254.170436764863;4259.105587826592;4283.421738065322;4288.978555107205;3239.9676003239665;3305;3806.7715937043868;3921.235359105004;3924.50943632046;3228.757843161772;3242.886498972525;3272.083816531375;3275.263065810221;3276.5904261967253;963.0562049191831;981.3375971219541;982.2044144243185;1013.8276492996208;1015.7663737340453;864.3171894203509;884.7788052986754;902.7652810269377;914.8627705844177;915.2174890468686;6895.310468953165;6910.619915904674;6916.827079323057;6933.583984960918;6935.202451718117;423.6758879457218;440.7840158322399;444.9621782148489;449.14662141929944;450.25258071600985;5410.296661433988;5467.507924286833;5475.6440831345835;5530.972345138249;5539.41836107211;8565.229129378262;8672.8699069514;8683.2185103341;8700.477971321741;8803.911960880308;8632.223099921037;8642.913570864337;8648.918885139357;8649.308055355556;8651.826963460822;6644.734210631521;6815.5910645360445;6835.692393842289;6841.828954276183;6900.068490753784;6556.18047744032;6557.377049180321;6563.704633291609;6580.967095164494;6614.801555953329;7569;7701.730439434593;7778.844423111619;7803.180666029985;7808.804779880548;7256.45576581769;7397.223291554309;7417.109946806418;7484.139323977813;7494.775156745306;5442.809501667422;5895.4399332063385;6808.523403361915;6875.4155896749335;6964.477664175106;6702.865942681216;6900.516963812485;6913.481488888454;6917.13535808024;6928.856738638068;6327.462165715966;6530.718119600158;6599.0761293418;6610.735570577123;6651.035599838093;6266.498680105489;6404.423601875854;6474.1907261592305;6483.448906842783;6636.435902948304;6597.571157874723;6614.338566143347;6649.800505984635;6657.966710166418;6662.333766623299;6055.3944605540855;6098.695065246809;6133.049377346519;6135.478484328882;6138.877222455615;6147.907781383194;6169.413905678954;6177.505799536116;6194.318624951162;6202.2867370253 08:46:57 INFO - 2015-12-16 08:46:57,659 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.7003266765902;302.8546297777067;303.2736595852932;306.0832805746786;309.26240915416736;5301.257823904656;5330.733463326837;5347.358317001956;5396.244525766396;5396.43337449568;5258.605604579662;5288.6562373445695;5295.0468915595175;5296.09966305728;5302.628815982883;3941.8423263069444;4159.729617574848;4159.771212583307;4171.249175148472;4173.831327228381;3997.580254073324;4018.5177778666603;4130.0500884796365;4138.937915931264;4139.234241665302;4126.298529250034;4126.628603425691;4138.586141385867;4143.02638879863;4149.585041495857;3899.941500877489;3998.820053097618;4009.0979529605897;4136.4415803866395;4141.855035073788;3636.2909232699635;3650.0874781304674;3651.434027725707;3658.3963645998642;3663.8534458621625;5086;5125.256837758541;5142.537171654569;5150.381954165524;5154.252633368178;4725.5510726480925;4737.668363214576;4742.668013239075;4750.762461876892;4757.738324392157;5455.863603409946;5568.916466253009;5572.247746554204;5584.6090773645865;5586.608937374385;3969.4045893115976;3974.940375894364;3975.5030621172355;3976.264391087658;3976.622220889011;5856.941430585724;5857.179994800731;5862.677552734598;5862.941370586283;5868.09044598088;4085.8978525536504;4086.5504794472586;4088.018875469925;4093.038136038029;4093.8567150150197;4043.8989025274013;4151.626353628188;4158.08522125132;4162.458880345535;4171.416001759756;4696.483386827446;4714.858554243378;4723.952760472352;4724.126036683225;4725.432948046257;5556.388797232301;5570.6657600544095;5571.609987300931;5575.414581468968;5578;1455.1778245291378;1479.2381923309504;1480.141517919604;1481.777733339986;1482.1181397068726;982.8476586129161;1019.673704414595;1022.1260821997234;1022.3150489172273;1039.6828967164936;4947.876303092451;4958.107540642719;4959.181735013754;4959.181735013754;4962.131626965339;5765.077587585966;5773.364929857712;5776.56675749312;5781.6241944274325;5786.697992951552;4938.38270216223;4939.753012349368;4945.826896058621;4948.529889660476;4949.7772600233075;3059.3575349176476;3080.5995220621176;3118.485449900741;3122.0789866989294;3122.1414111119625;5526.751296191681;5539.612227144061;5560.944390556124;5564.972175139098;5571.359293681278;5947.494462970696;5979.701014949323;5987.730552125165;5990.9101363479585;5995.250593675791;5543.584231182677;5554.805581804618;5558.77764889408;5559.27729395176;5560.888782224333;5698.430156984268;5852.297724273115;5852.7658893643775;5856.0630299151935;5859.882802344015;5699.487046165865;5700.25896633435;5703.08750599902;5714.657120572779;5719.5138413235345;5540.86147846291;5546.944530554804;5554.527865131509;5556.888862222814;5557.944420555743;3866.4200369944733;3983.143624120712;4012.879613611596;4031.871076098697;4044.0496483326983;5777.595568310178;5779;5784.479396854304;5785.768569257182;5786.479216870502;5545.4472747630725;5550.222968784293;5551.223608445259;5552.972235138798;5556.138798486241;5563.666180029211;5575.1915972183;5579.442055794388;5580.665160090408;5583.888322233452;5360.839174824761;5452.718611126462;5519.834404967857;5524.585656075891;5532.114861622121;5467.07059799843;5597;5662.377138514842;5688.857778555569;5697.4302569742695;5412.891742165213;5502.669839809624;5529.364123125892;5532.114861622121;5533.3083364579425 08:46:57 INFO - 2015-12-16 08:46:57,661 DEBUG : BROWSER_OUTPUT: |5;yui.html;661.8610091880706;723.9177429742535;731.0715391452852;742.9405647548197;747.338605334279;10617.256792024551;10931.781364372708;10949;10961.780764384728;10975.945120274408;11386.373749443777;11471.885281147186;11475.081993440526;11483.59807406741;11496.022838058774;802.8635132027555;820.0774129104757;820.4502983001404;820.8153165537766;821.3593397150232;637.4040272345349;645.1451826330108;810.6473683947472;828.0973738624898;828.130463013833;834.7036801935317;840.1850205300879;853.2320911179957;853.6713365354352;854.4360721923532;656.3207080671482;666.4368608525788;844.771911583872;845.7082306604242;845.8900342955408;621.0621960839165;631.343402861024;631.7599312261357;632.4466092169351;632.772202007277;11337.886621133766;11353.772924541463;11413.372264525447;11425;11438.714032149179;10867.45662716861;11548.653540393801;11695.766084678258;11738.530458781639;11791.29252244868;9001.414908030956;9093.181613654802;9142.634294628207;9157;9235.353525253235;3226.9838650806832;3280.7867488613165;3284.8029118252744;3285.3100848821778;3299.059767966118;37112.62887371119;37526.43710344347;37605.811970940245;37691.81154094239;37708.2458350837;8749.47503149813;9101.549326509217;9147.679831205876;9365.859512107323;9401.482918439415;16482.75275870863;16504;16508.83491165073;16517.174141292886;16529.33882644705;6037.939620603738;6055.152278680988;6063.696815159225;6064.545159113084;6162.630242185483;3239.8380080995857;3265.232670322472;3376.0884561168345;3413.761036727405;3447.4484082546674;2455.58255096634;2467.4941636964736;2470.481198948241;2471.2092130518063;2498.7626175513296;437.94963579188163;446.506610195729;449.44044664392385;450.8354450625498;451.9796609152596;428.35532523551854;469.0033678433329;490.69822059433193;602.2772672792579;614.241411856357;7789.466347374607;7789.7273595423885;8041.9947506561675;8074.636641351153;8185.631646575918;472.70928379047325;495.40551338394073;498.89273806131854;510.5519036221328;586.1588620329841;3784.129650180474;3850.942235866464;3954.406838974177;4098.139390727921;4143.8964025899595;51776.482235177165;51832.48167518352;51914;51989.7400512995;54543;46715.53284467112;46963;46968;47125;47398.28902566464;42181.99999999939;42897.78551107287;42903;43153.16303036958;44113.558864411585;7614.238576142563;7656.425768067305;7759;7851.882221766792;7919.208079192034;30064.84967575148;30139.547906780976;30531.54202686917;30886;31613;35512.822435887654;37222.25555488929;37822;37998.43002354912;43285;10797.838032429363;10857.67426977192;10947.34315941046;10950.34297942126;10955.780884382428;11134.129458283132;11317.320960742381;11329.490172942073;11480;11706.414679266172;10596.417197054236;10723.785524289626;10856.620018299322;10907.672769816918;10943.562257509611;10622.468876556295;10800.783984320113;10838.512266948164;10869.836952445878;11317;9877.209823213982;10636.468176591294;11069.225154239126;11420.257683250895;11434.599789007345;6448.355164483514;7936.277914640779;8259.297959673495;8662.177093176138;8941.239994600532;8758.167974042455;9031.593578288861;9038.638454461749;9099.454032758056;9287.257019438293 08:46:57 INFO - 2015-12-16 08:46:57,661 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:46:57 INFO - 2015-12-16 08:46:57,661 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:46:57 INFO - 2015-12-16 08:46:57,661 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1363 08:46:57 INFO - 2015-12-16 08:46:57,661 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:46:57 INFO - 2015-12-16 08:46:57,661 DEBUG : BROWSER_OUTPUT: __startTimestamp1450284417653__endTimestamp 08:46:57 INFO - 2015-12-16 08:46:57,661 DEBUG : BROWSER_OUTPUT: 08:46:57 INFO - 2015-12-16 08:46:57,662 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:46:57 INFO - 2015-12-16 08:46:57,662 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:46:57 INFO - 2015-12-16 08:46:57,662 DEBUG : BROWSER_OUTPUT: 08:46:57 INFO - 2015-12-16 08:46:57,662 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4670.30 Median:4826.00 stddev:485.13 (10.1%) stddev-sans-first:459.41 08:46:57 INFO - 2015-12-16 08:46:57,662 DEBUG : BROWSER_OUTPUT: Values: 2628.2 2711.7 2716.0 2720.0 2733.3 4576.7 4745.6 4766.1 4767.7 4768.8 4710.4 4776.8 4824.3 4826.0 4924.6 4321.3 4339.3 4358.1 4462.8 4478.9 4404.1 4424.9 4465.6 4472.9 4508.5 4247.0 4249.6 4360.4 4363.0 4367.7 4374.1 4394.8 4396.9 4398.5 4440.2 4363.5 4371.0 4386.9 4410.1 4410.6 4431.0 4536.3 4543.1 4579.8 4731.8 5118.7 5142.3 5145.6 5151.4 5155.7 5169.1 5181.9 5183.0 5186.4 5240.7 4473.5 4579.0 4582.4 4674.9 4804.0 5193.1 5224.6 5224.6 5230.1 5230.3 5004.7 5007.6 5009.1 5009.9 5050.7 4736.9 4883.8 4886.3 4949.3 5037.8 5031.8 5063.5 5067.3 5072.5 5113.5 5027.7 5029.3 5034.1 5037.7 5040.7 4038.7 4126.8 4130.2 4138.3 4206.0 3677.2 3694.4 3717.7 3721.6 3751.0 4394.1 4396.3 4408.6 4437.2 4437.8 4837.2 4940.4 4949.5 4949.9 5051.7 4369.1 4393.6 4401.2 4416.8 4448.4 4513.7 4532.8 4532.8 4536.5 4576.2 4686.5 4695.8 4817.2 4822.9 4880.6 5070.8 5086.5 5114.9 5118.8 5121.2 4874.4 4878.7 4881.2 4881.7 4912.7 4788.9 4894.2 4899.3 4901.8 5091.2 4951.8 4953.6 4997.6 5006.5 5009.8 4694.6 4843.2 4847.1 4853.2 4910.3 4918.2 4939.6 4950.8 4957.5 4986.8 4831.3 4851.7 4852.7 4854.7 4881.2 4756.4 4874.1 4877.1 4878.7 4979.7 4808.4 4840.6 4845.7 4846.4 4880.6 08:46:57 INFO - 2015-12-16 08:46:57,662 DEBUG : BROWSER_OUTPUT: 08:46:57 INFO - 2015-12-16 08:46:57,662 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41676.57 Median:33549.58 stddev:65989.61 (196.7%) stddev-sans-first:66102.46 08:46:57 INFO - 2015-12-16 08:46:57,663 DEBUG : BROWSER_OUTPUT: Values: 544.4 552.3 560.5 561.8 561.9 26989.9 27572.7 34900.3 35274.1 35358.5 38745.2 39315.0 39366.8 39394.0 39395.4 6848.3 6971.1 7872.3 8045.3 8052.6 10135.4 10379.1 10399.8 10407.5 10407.7 9966.7 9999.6 10024.3 10025.0 10046.0 7150.1 7330.9 10082.9 10180.2 10479.9 9891.0 10094.4 10101.4 10106.2 10106.9 37564.8 37819.6 38036.0 38092.4 38133.6 2947.5 2948.3 3136.3 3509.9 3597.9 27905.7 28670.7 28706.4 28745.9 29749.1 3348.4 3354.6 3381.9 3397.2 3431.3 202365.0 208092.0 208099.0 208324.0 208573.0 49833.3 50926.0 59625.7 60592.4 60725.0 57442.0 57661.7 58046.7 58214.0 58256.6 13623.0 13629.5 13717.1 13767.0 13805.2 10158.8 10197.6 10205.8 10209.4 10218.1 19801.5 20145.2 20163.0 20197.8 20255.0 8314.9 8361.7 8365.4 8433.9 8548.8 818.0 855.0 914.6 915.1 916.9 26010.9 26917.9 26986.9 27081.2 27245.3 938.8 944.1 961.8 966.6 989.8 13962.9 14078.2 14133.1 14264.8 14344.5 253181.0 258762.0 260022.0 260086.0 260996.0 46569.3 47036.5 47095.5 47235.5 47296.0 1217.4 1229.7 1247.6 1252.1 1256.2 25300.5 25838.0 26600.5 26621.5 26672.7 41440.8 41716.0 41866.6 41878.2 41937.6 251325.0 252764.0 299592.0 304864.0 322069.0 29994.9 30149.1 30163.7 30487.5 30623.4 38736.4 39224.8 39571.2 40054.6 40219.6 33025.0 34081.3 34175.1 34178.7 34524.1 33546.0 33553.2 33556.3 33724.0 33803.3 33018.2 34013.1 34236.0 34302.7 34309.5 32782.8 35766.6 35914.0 36093.5 36109.5 23416.9 23488.4 23956.8 24074.6 24122.3 08:46:57 INFO - 2015-12-16 08:46:57,663 DEBUG : BROWSER_OUTPUT: 08:46:57 INFO - 2015-12-16 08:46:57,663 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26543.54 Median:374.57 stddev:77159.12 (20599.5%) stddev-sans-first:77350.48 08:46:57 INFO - 2015-12-16 08:46:57,663 DEBUG : BROWSER_OUTPUT: Values: 335.3 336.6 340.8 342.0 344.9 12389.9 12727.4 14654.0 14803.1 15503.4 12811.8 15206.8 15207.5 15496.5 15498.0 4980.3 5146.2 6431.1 6635.5 6642.1 4080.1 4208.1 6378.3 6562.5 6564.1 6355.4 6487.6 6518.4 6559.5 6563.4 6480.5 6542.3 6552.8 6555.5 6556.4 6099.1 6212.8 6217.9 6276.1 6291.6 21585.7 21679.2 21745.9 22105.8 22174.0 2017.5 2032.9 2058.2 2080.6 2119.0 13779.2 14087.0 14115.0 14272.5 14295.9 1866.6 1893.2 1924.6 1949.6 1950.7 57125.2 61416.4 61731.1 61945.0 62364.7 15391.3 15490.8 15511.3 15526.4 15589.7 23280.0 23397.9 23544.8 23565.8 23624.2 8486.7 8500.7 8503.3 8514.6 8592.4 7123.4 7151.9 7168.4 7178.5 7185.2 7467.5 7561.2 7567.4 7602.3 7620.4 2578.8 2959.1 2990.3 2993.4 3049.2 374.2 375.0 392.8 395.0 946.8 8972.2 9145.6 9511.9 9641.7 9788.4 410.7 414.6 422.5 428.0 430.4 5187.1 5261.4 5326.8 5335.5 5382.7 405394.0 478758.0 478976.0 496644.0 497484.0 68431.0 71677.2 71818.6 71937.0 72528.3 1071.3 1074.5 1125.7 1148.0 1151.7 14437.4 14471.3 14505.2 14604.2 14623.1 28881.7 29551.7 30137.7 30575.5 31254.0 39969.0 40940.8 41343.8 41557.6 43472.8 8147.3 8389.1 8450.3 8798.7 8803.4 10196.2 10226.6 10251.0 12429.9 16017.8 12897.5 13201.7 13212.9 13302.5 13448.5 12789.7 13047.7 13133.2 13169.0 13568.1 13626.3 13751.3 13757.4 14458.3 14715.0 8990.2 9068.6 9083.1 9109.4 9160.1 13945.3 14134.9 14244.7 14287.0 14408.9 08:46:57 INFO - 2015-12-16 08:46:57,663 DEBUG : BROWSER_OUTPUT: 08:46:57 INFO - 2015-12-16 08:46:57,663 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5018.07 Median:6365.94 stddev:2610.57 (41.0%) stddev-sans-first:2602.65 08:46:57 INFO - 2015-12-16 08:46:57,664 DEBUG : BROWSER_OUTPUT: Values: 1265.4 1675.9 1723.5 1737.4 1761.5 6176.5 7113.0 7294.3 7308.5 7310.6 7011.6 7141.2 7171.5 7180.1 7228.9 2080.7 2119.3 2119.9 2120.9 2121.9 2102.5 2135.8 2140.9 2153.5 2156.6 2000.9 2029.6 2040.0 2066.7 2070.4 2087.6 2112.1 2114.5 2116.8 2118.3 2043.2 2059.9 2062.6 2065.0 2079.0 7162.6 7196.4 7223.6 7230.7 7234.2 4214.8 4283.2 4297.0 4314.3 4317.0 2727.8 2738.9 2745.4 2754.7 2783.0 854.4 1527.8 1558.7 1573.1 1615.2 9760.2 9806.0 9824.2 9829.9 9831.6 3830.7 3894.1 3967.1 3967.5 3986.2 7959.9 8004.5 8025.0 8029.5 8038.5 4243.8 4254.2 4259.1 4283.4 4289.0 3240.0 3305.0 3806.8 3921.2 3924.5 3228.8 3242.9 3272.1 3275.3 3276.6 963.1 981.3 982.2 1013.8 1015.8 864.3 884.8 902.8 914.9 915.2 6895.3 6910.6 6916.8 6933.6 6935.2 423.7 440.8 445.0 449.1 450.3 5410.3 5467.5 5475.6 5531.0 5539.4 8565.2 8672.9 8683.2 8700.5 8803.9 8632.2 8642.9 8648.9 8649.3 8651.8 6644.7 6815.6 6835.7 6841.8 6900.1 6556.2 6557.4 6563.7 6581.0 6614.8 7569.0 7701.7 7778.8 7803.2 7808.8 7256.5 7397.2 7417.1 7484.1 7494.8 5442.8 5895.4 6808.5 6875.4 6964.5 6702.9 6900.5 6913.5 6917.1 6928.9 6327.5 6530.7 6599.1 6610.7 6651.0 6266.5 6404.4 6474.2 6483.4 6636.4 6597.6 6614.3 6649.8 6658.0 6662.3 6055.4 6098.7 6133.0 6135.5 6138.9 6147.9 6169.4 6177.5 6194.3 6202.3 08:46:57 INFO - 2015-12-16 08:46:57,665 DEBUG : BROWSER_OUTPUT: 08:46:57 INFO - 2015-12-16 08:46:57,665 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4658.39 Median:5291.85 stddev:1358.43 (25.7%) stddev-sans-first:1322.32 08:46:57 INFO - 2015-12-16 08:46:57,666 DEBUG : BROWSER_OUTPUT: Values: 302.7 302.9 303.3 306.1 309.3 5301.3 5330.7 5347.4 5396.2 5396.4 5258.6 5288.7 5295.0 5296.1 5302.6 3941.8 4159.7 4159.8 4171.2 4173.8 3997.6 4018.5 4130.1 4138.9 4139.2 4126.3 4126.6 4138.6 4143.0 4149.6 3899.9 3998.8 4009.1 4136.4 4141.9 3636.3 3650.1 3651.4 3658.4 3663.9 5086.0 5125.3 5142.5 5150.4 5154.3 4725.6 4737.7 4742.7 4750.8 4757.7 5455.9 5568.9 5572.2 5584.6 5586.6 3969.4 3974.9 3975.5 3976.3 3976.6 5856.9 5857.2 5862.7 5862.9 5868.1 4085.9 4086.6 4088.0 4093.0 4093.9 4043.9 4151.6 4158.1 4162.5 4171.4 4696.5 4714.9 4724.0 4724.1 4725.4 5556.4 5570.7 5571.6 5575.4 5578.0 1455.2 1479.2 1480.1 1481.8 1482.1 982.8 1019.7 1022.1 1022.3 1039.7 4947.9 4958.1 4959.2 4959.2 4962.1 5765.1 5773.4 5776.6 5781.6 5786.7 4938.4 4939.8 4945.8 4948.5 4949.8 3059.4 3080.6 3118.5 3122.1 3122.1 5526.8 5539.6 5560.9 5565.0 5571.4 5947.5 5979.7 5987.7 5990.9 5995.3 5543.6 5554.8 5558.8 5559.3 5560.9 5698.4 5852.3 5852.8 5856.1 5859.9 5699.5 5700.3 5703.1 5714.7 5719.5 5540.9 5546.9 5554.5 5556.9 5557.9 3866.4 3983.1 4012.9 4031.9 4044.0 5777.6 5779.0 5784.5 5785.8 5786.5 5545.4 5550.2 5551.2 5553.0 5556.1 5563.7 5575.2 5579.4 5580.7 5583.9 5360.8 5452.7 5519.8 5524.6 5532.1 5467.1 5597.0 5662.4 5688.9 5697.4 5412.9 5502.7 5529.4 5532.1 5533.3 08:46:57 INFO - 2015-12-16 08:46:57,666 DEBUG : BROWSER_OUTPUT: 08:46:57 INFO - 2015-12-16 08:46:57,667 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12276.77 Median:22280.03 stddev:14109.21 (63.3%) stddev-sans-first:14121.82 08:46:57 INFO - 2015-12-16 08:46:57,667 DEBUG : BROWSER_OUTPUT: Values: 661.9 723.9 731.1 742.9 747.3 10617.3 10931.8 10949.0 10961.8 10975.9 11386.4 11471.9 11475.1 11483.6 11496.0 802.9 820.1 820.5 820.8 821.4 637.4 645.1 810.6 828.1 828.1 834.7 840.2 853.2 853.7 854.4 656.3 666.4 844.8 845.7 845.9 621.1 631.3 631.8 632.4 632.8 11337.9 11353.8 11413.4 11425.0 11438.7 10867.5 11548.7 11695.8 11738.5 11791.3 9001.4 9093.2 9142.6 9157.0 9235.4 3227.0 3280.8 3284.8 3285.3 3299.1 37112.6 37526.4 37605.8 37691.8 37708.2 8749.5 9101.5 9147.7 9365.9 9401.5 16482.8 16504.0 16508.8 16517.2 16529.3 6037.9 6055.2 6063.7 6064.5 6162.6 3239.8 3265.2 3376.1 3413.8 3447.4 2455.6 2467.5 2470.5 2471.2 2498.8 437.9 446.5 449.4 450.8 452.0 428.4 469.0 490.7 602.3 614.2 7789.5 7789.7 8042.0 8074.6 8185.6 472.7 495.4 498.9 510.6 586.2 3784.1 3850.9 3954.4 4098.1 4143.9 51776.5 51832.5 51914.0 51989.7 54543.0 46715.5 46963.0 46968.0 47125.0 47398.3 42182.0 42897.8 42903.0 43153.2 44113.6 7614.2 7656.4 7759.0 7851.9 7919.2 30064.8 30139.5 30531.5 30886.0 31613.0 35512.8 37222.3 37822.0 37998.4 43285.0 10797.8 10857.7 10947.3 10950.3 10955.8 11134.1 11317.3 11329.5 11480.0 11706.4 10596.4 10723.8 10856.6 10907.7 10943.6 10622.5 10800.8 10838.5 10869.8 11317.0 9877.2 10636.5 11069.2 11420.3 11434.6 6448.4 7936.3 8259.3 8662.2 8941.2 8758.2 9031.6 9038.6 9099.5 9287.3 08:46:57 INFO - 2015-12-16 08:46:57,667 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:46:57 INFO - 2015-12-16 08:46:57,667 DEBUG : BROWSER_OUTPUT: 08:46:58 INFO - 2015-12-16 08:46:58,455 INFO : Browser exited with error code: 0 08:46:58 INFO - 2015-12-16 08:46:58,476 INFO : Completed test dromaeo_css (00:18:37) 08:46:58 INFO - 2015-12-16 08:46:58,476 INFO : Starting test kraken 08:46:58 INFO - 2015-12-16 08:46:58,476 DEBUG : operating with platform_type : linux_ 08:46:58 INFO - 2015-12-16 08:46:58,476 INFO : Initialising browser for kraken test... 08:46:58 INFO - 2015-12-16 08:46:58,482 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoyvIOF/profile http://localhost:43066/getInfo.html 08:47:03 INFO - 2015-12-16 08:47:03,211 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:47:03 INFO - 2015-12-16 08:47:03,211 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:47:03 INFO - 2015-12-16 08:47:03,211 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:47:03 INFO - 2015-12-16 08:47:03,211 DEBUG : BROWSER_OUTPUT: __metrics 08:47:03 INFO - 2015-12-16 08:47:03,312 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:47:03 INFO - 2015-12-16 08:47:03,393 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:47:04 INFO - 2015-12-16 08:47:04,253 INFO : Browser initialized. 08:47:04 INFO - 2015-12-16 08:47:04,254 INFO : Running cycle 1/1 for kraken test... 08:47:04 INFO - 2015-12-16 08:47:04,254 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoyvIOF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:47:16 INFO - 2015-12-16 08:47:16,248 DEBUG : BROWSER_OUTPUT: RSS: Main: 141803520 08:47:16 INFO - 2015-12-16 08:47:16,248 DEBUG : BROWSER_OUTPUT: 08:47:18 INFO - 2015-12-16 08:47:18,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43066/tests/kraken/driver.html?testName=audio-beat-detection) 08:47:19 INFO - 2015-12-16 08:47:19,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 177438720 08:47:19 INFO - 2015-12-16 08:47:19,459 DEBUG : BROWSER_OUTPUT: 08:47:22 INFO - 2015-12-16 08:47:22,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43066/tests/kraken/driver.html?testName=audio-dft) 08:47:22 INFO - 2015-12-16 08:47:22,778 DEBUG : BROWSER_OUTPUT: RSS: Main: 167292928 08:47:22 INFO - 2015-12-16 08:47:22,779 DEBUG : BROWSER_OUTPUT: 08:47:25 INFO - 2015-12-16 08:47:25,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43066/tests/kraken/driver.html?testName=audio-fft) 08:47:26 INFO - 2015-12-16 08:47:26,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 151572480 08:47:26 INFO - 2015-12-16 08:47:26,335 DEBUG : BROWSER_OUTPUT: 08:47:28 INFO - 2015-12-16 08:47:28,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43066/tests/kraken/driver.html?testName=audio-oscillator) 08:47:28 INFO - 2015-12-16 08:47:28,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 156073984 08:47:28 INFO - 2015-12-16 08:47:28,953 DEBUG : BROWSER_OUTPUT: 08:47:31 INFO - 2015-12-16 08:47:31,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43066/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:47:31 INFO - 2015-12-16 08:47:31,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 156532736 08:47:31 INFO - 2015-12-16 08:47:31,764 DEBUG : BROWSER_OUTPUT: 08:47:34 INFO - 2015-12-16 08:47:34,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43066/tests/kraken/driver.html?testName=imaging-darkroom) 08:47:35 INFO - 2015-12-16 08:47:35,349 DEBUG : BROWSER_OUTPUT: RSS: Main: 157204480 08:47:35 INFO - 2015-12-16 08:47:35,349 DEBUG : BROWSER_OUTPUT: 08:47:38 INFO - 2015-12-16 08:47:38,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43066/tests/kraken/driver.html?testName=imaging-desaturate) 08:47:39 INFO - 2015-12-16 08:47:39,341 DEBUG : BROWSER_OUTPUT: RSS: Main: 159092736 08:47:39 INFO - 2015-12-16 08:47:39,341 DEBUG : BROWSER_OUTPUT: 08:47:42 INFO - 2015-12-16 08:47:42,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43066/tests/kraken/driver.html?testName=json-parse-financial) 08:47:42 INFO - 2015-12-16 08:47:42,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 157089792 08:47:42 INFO - 2015-12-16 08:47:42,753 DEBUG : BROWSER_OUTPUT: 08:47:44 INFO - 2015-12-16 08:47:44,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43066/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:47:45 INFO - 2015-12-16 08:47:45,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 168534016 08:47:45 INFO - 2015-12-16 08:47:45,111 DEBUG : BROWSER_OUTPUT: 08:47:47 INFO - 2015-12-16 08:47:47,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:47:47 INFO - 2015-12-16 08:47:47,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 167727104 08:47:47 INFO - 2015-12-16 08:47:47,596 DEBUG : BROWSER_OUTPUT: 08:47:49 INFO - 2015-12-16 08:47:49,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:47:50 INFO - 2015-12-16 08:47:50,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 179200000 08:47:50 INFO - 2015-12-16 08:47:50,301 DEBUG : BROWSER_OUTPUT: 08:47:52 INFO - 2015-12-16 08:47:52,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:47:53 INFO - 2015-12-16 08:47:53,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 185217024 08:47:53 INFO - 2015-12-16 08:47:53,424 DEBUG : BROWSER_OUTPUT: 08:47:56 INFO - 2015-12-16 08:47:56,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:47:56 INFO - 2015-12-16 08:47:56,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 182071296 08:47:56 INFO - 2015-12-16 08:47:56,609 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43066/tests/kraken/driver.html?testName=ai-astar) 08:47:58 INFO - 2015-12-16 08:47:58,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 239407104 08:47:58 INFO - 2015-12-16 08:47:58,609 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,610 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:47:58 INFO - 2015-12-16 08:47:58,610 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:47:58 INFO - 2015-12-16 08:47:58,610 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:47:58 INFO - 2015-12-16 08:47:58,610 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:47:58 INFO - 2015-12-16 08:47:58,611 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;112;108;115;115;114;104;114;113;121 08:47:58 INFO - 2015-12-16 08:47:58,611 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;128;159;169;131;163;157;133;164;129 08:47:58 INFO - 2015-12-16 08:47:58,611 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;161;162;160;163;164;162;162 08:47:58 INFO - 2015-12-16 08:47:58,611 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;87;95;72;75;72;114;93;73 08:47:58 INFO - 2015-12-16 08:47:58,611 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;96;94;95;132;95;95;134 08:47:58 INFO - 2015-12-16 08:47:58,612 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;109;109;110;110;109;110 08:47:58 INFO - 2015-12-16 08:47:58,612 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;148;148;146;149;147;148;146 08:47:58 INFO - 2015-12-16 08:47:58,612 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;96;95;95;96;96 08:47:58 INFO - 2015-12-16 08:47:58,612 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;73;72;72;74;72;81;70;71 08:47:58 INFO - 2015-12-16 08:47:58,612 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;69;69;69;69 08:47:58 INFO - 2015-12-16 08:47:58,612 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;87;88;87;88;85;85;86;86;85 08:47:58 INFO - 2015-12-16 08:47:58,612 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;119;126;119;126;121;124;123;129;127 08:47:58 INFO - 2015-12-16 08:47:58,613 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;145;162;151;151;136;150;148;139;139 08:47:58 INFO - 2015-12-16 08:47:58,613 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;71;72;70;69;69;70;70;69;69 08:47:58 INFO - 2015-12-16 08:47:58,613 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:47:58 INFO - 2015-12-16 08:47:58,613 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:47:58 INFO - 2015-12-16 08:47:58,613 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,993 08:47:58 INFO - 2015-12-16 08:47:58,613 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:47:58 INFO - 2015-12-16 08:47:58,613 DEBUG : BROWSER_OUTPUT: __startTimestamp1450284478608__endTimestamp 08:47:58 INFO - 2015-12-16 08:47:58,614 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,621 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:47:58 INFO - 2015-12-16 08:47:58,621 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:4.49 (3.9%) stddev-sans-first:4.76 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: Values: 112.0 112.0 108.0 115.0 115.0 114.0 104.0 114.0 113.0 121.0 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.00 Median:158.00 stddev:16.57 (10.5%) stddev-sans-first:17.32 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: Values: 157.0 128.0 159.0 169.0 131.0 163.0 157.0 133.0 164.0 129.0 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 161.0 162.0 160.0 163.0 164.0 162.0 162.0 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.60 Median:74.00 stddev:14.32 (19.4%) stddev-sans-first:14.67 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 87.0 95.0 72.0 75.0 72.0 114.0 93.0 73.0 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,622 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:18.05 (19.0%) stddev-sans-first:18.69 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 96.0 94.0 95.0 132.0 95.0 95.0 134.0 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:1.03 (0.7%) stddev-sans-first:1.00 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 148.0 148.0 146.0 149.0 147.0 148.0 146.0 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.20 Median:73.00 stddev:3.01 (4.1%) stddev-sans-first:3.18 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 73.0 72.0 72.0 74.0 72.0 81.0 70.0 71.0 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 08:47:58 INFO - 2015-12-16 08:47:58,623 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 69.0 69.0 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:1.16 (1.3%) stddev-sans-first:1.22 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: Values: 86.0 87.0 88.0 87.0 88.0 85.0 85.0 86.0 86.0 85.0 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:125.00 stddev:3.57 (2.9%) stddev-sans-first:3.56 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: Values: 120.0 119.0 126.0 119.0 126.0 121.0 124.0 123.0 129.0 127.0 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:149.00 stddev:8.09 (5.4%) stddev-sans-first:8.06 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: Values: 138.0 145.0 162.0 151.0 151.0 136.0 150.0 148.0 139.0 139.0 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.20 (1.7%) stddev-sans-first:1.05 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 70.0 69.0 69.0 70.0 70.0 69.0 69.0 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:47:58 INFO - 2015-12-16 08:47:58,624 DEBUG : BROWSER_OUTPUT: 08:47:59 INFO - 2015-12-16 08:47:59,498 INFO : Browser exited with error code: 0 08:47:59 INFO - 2015-12-16 08:47:59,545 INFO : Completed test kraken (00:01:01) 08:47:59 INFO - 2015-12-16 08:47:59,545 INFO : Starting test v8_7 08:47:59 INFO - 2015-12-16 08:47:59,545 DEBUG : operating with platform_type : linux_ 08:47:59 INFO - 2015-12-16 08:47:59,546 INFO : Initialising browser for v8_7 test... 08:47:59 INFO - 2015-12-16 08:47:59,552 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq6hDAr/profile http://localhost:43066/getInfo.html 08:48:04 INFO - 2015-12-16 08:48:04,035 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:48:04 INFO - 2015-12-16 08:48:04,035 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:48:04 INFO - 2015-12-16 08:48:04,035 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:48:04 INFO - 2015-12-16 08:48:04,035 DEBUG : BROWSER_OUTPUT: __metrics 08:48:04 INFO - 2015-12-16 08:48:04,137 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:48:04 INFO - 2015-12-16 08:48:04,205 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:05 INFO - 2015-12-16 08:48:05,474 INFO : Browser initialized. 08:48:05 INFO - 2015-12-16 08:48:05,474 INFO : Running cycle 1/1 for v8_7 test... 08:48:05 INFO - 2015-12-16 08:48:05,474 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq6hDAr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:48:17 INFO - 2015-12-16 08:48:17,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 142266368 08:48:17 INFO - 2015-12-16 08:48:17,542 DEBUG : BROWSER_OUTPUT: 08:48:38 INFO - 2015-12-16 08:48:38,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43066/tests/v8_7/run.html (next: http://localhost:43066/tests/v8_7/run.html) 08:48:39 INFO - 2015-12-16 08:48:39,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 446218240 08:48:39 INFO - 2015-12-16 08:48:39,181 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,182 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:48:39 INFO - 2015-12-16 08:48:39,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:48:39 INFO - 2015-12-16 08:48:39,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:48:39 INFO - 2015-12-16 08:48:39,182 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:48:39 INFO - 2015-12-16 08:48:39,182 DEBUG : BROWSER_OUTPUT: |0;Richards;165.34391534391534 08:48:39 INFO - 2015-12-16 08:48:39,182 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.70649738610905 08:48:39 INFO - 2015-12-16 08:48:39,182 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 08:48:39 INFO - 2015-12-16 08:48:39,183 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 08:48:39 INFO - 2015-12-16 08:48:39,183 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2002 08:48:39 INFO - 2015-12-16 08:48:39,183 DEBUG : BROWSER_OUTPUT: |5;Earley;793.0214115781126 08:48:39 INFO - 2015-12-16 08:48:39,183 DEBUG : BROWSER_OUTPUT: |6;Boyer;12537.5 08:48:39 INFO - 2015-12-16 08:48:39,183 DEBUG : BROWSER_OUTPUT: |7;RegExp;26552.63157894737 08:48:39 INFO - 2015-12-16 08:48:39,183 DEBUG : BROWSER_OUTPUT: |8;Splay;623.9103362391033 08:48:39 INFO - 2015-12-16 08:48:39,183 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 08:48:39 INFO - 2015-12-16 08:48:39,184 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:48:39 INFO - 2015-12-16 08:48:39,184 DEBUG : BROWSER_OUTPUT: __startTimestamp1450284519175__endTimestamp 08:48:39 INFO - 2015-12-16 08:48:39,184 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,184 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:48:39 INFO - 2015-12-16 08:48:39,184 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:48:39 INFO - 2015-12-16 08:48:39,184 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,184 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.34 Median:165.34 stddev:0.00 (0.0%) 08:48:39 INFO - 2015-12-16 08:48:39,185 DEBUG : BROWSER_OUTPUT: Values: 165.3 08:48:39 INFO - 2015-12-16 08:48:39,185 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,185 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.71 Median:186.71 stddev:0.00 (0.0%) 08:48:39 INFO - 2015-12-16 08:48:39,185 DEBUG : BROWSER_OUTPUT: Values: 186.7 08:48:39 INFO - 2015-12-16 08:48:39,185 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,185 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 08:48:39 INFO - 2015-12-16 08:48:39,185 DEBUG : BROWSER_OUTPUT: Values: 278.6 08:48:39 INFO - 2015-12-16 08:48:39,185 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,186 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 08:48:39 INFO - 2015-12-16 08:48:39,186 DEBUG : BROWSER_OUTPUT: Values: 5191.7 08:48:39 INFO - 2015-12-16 08:48:39,186 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,186 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 08:48:39 INFO - 2015-12-16 08:48:39,186 DEBUG : BROWSER_OUTPUT: Values: 2002.0 08:48:39 INFO - 2015-12-16 08:48:39,186 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,186 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.02 Median:793.02 stddev:0.00 (0.0%) 08:48:39 INFO - 2015-12-16 08:48:39,186 DEBUG : BROWSER_OUTPUT: Values: 793.0 08:48:39 INFO - 2015-12-16 08:48:39,186 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12537.50 Median:12537.50 stddev:0.00 (0.0%) 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: Values: 12537.5 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: Values: 26552.6 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:623.91 Median:623.91 stddev:0.00 (0.0%) 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: Values: 623.9 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: Values: 4859.2 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:48:39 INFO - 2015-12-16 08:48:39,187 DEBUG : BROWSER_OUTPUT: 08:48:40 INFO - 2015-12-16 08:48:40,071 INFO : Browser exited with error code: 0 08:48:40 INFO - 2015-12-16 08:48:40,088 INFO : Completed test v8_7 (00:00:40) 08:48:40 INFO - 2015-12-16 08:48:40,223 INFO : Completed test suite (00:20:18) 08:48:40 INFO - 2015-12-16 08:48:40,223 DEBUG : Working with test: dromaeo_css 08:48:40 INFO - 2015-12-16 08:48:40,223 DEBUG : Generating results file: dromaeo_css 08:48:40 INFO - 2015-12-16 08:48:40,224 DEBUG : Working with test: kraken 08:48:40 INFO - 2015-12-16 08:48:40,224 DEBUG : Generating results file: kraken 08:48:40 INFO - 2015-12-16 08:48:40,225 INFO : javascript benchmark 08:48:40 INFO - 2015-12-16 08:48:40,225 DEBUG : Working with test: v8_7 08:48:40 INFO - 2015-12-16 08:48:40,225 DEBUG : Generating results file: v8_7 08:48:40 INFO - 2015-12-16 08:48:40,225 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:48:40 INFO - 2015-12-16 08:48:40,279 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 08:48:40 INFO - 2015-12-16 08:48:40,279 DEBUG : process_Request line: dromaeo_css 6387.22 graph.html#tests=[[72,132,35]] 08:48:40 INFO - 2015-12-16 08:48:40,279 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:48:40 INFO - 2015-12-16 08:48:40,314 DEBUG : process_Request line: kraken 1532.20 graph.html#tests=[[232,132,35]] 08:48:40 INFO - 2015-12-16 08:48:40,314 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:48:40 INFO - 2015-12-16 08:48:40,347 DEBUG : process_Request line: v8_7 19677.69 graph.html#tests=[[230,132,35]] 08:48:40 INFO - 2015-12-16 08:48:40,348 INFO : javascript benchmark 08:48:40 INFO - 2015-12-16 08:48:40,351 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2628.1589891234808, 2711.6745990481145, 2715.9864200678994, 2719.959200611991, 2733.3166708322915, 4576.748278844662, 4745.57289843914, 4766.142094423002, 4767.737774422405, 4768.809247630095, 4710.411198600175, 4776.8328108516125, 4824.27635854622, 4826.0, 4924.581410580096, 4321.286987647034, 4339.284018137011, 4358.063016451462, 4462.821487140511, 4478.865634030968, 4404.075144219718, 4424.933625995613, 4465.642748580122, 4472.865814025585, 4508.549145085498, 4247.04441500663, 4249.596288352602, 4360.367746676746, 4363.0, 4367.650587952988, 4374.081442896995, 4394.758288294142, 4396.912061758779, 4398.516163222043, 4440.245158323093, 4363.52001279859, 4370.956290437087, 4386.868393948187, 4410.140022695576, 4410.580994805488, 4431.047324825146, 4536.319552067183, 4543.068670922453, 4579.793909274091, 4731.834385796515, 5118.692878427306, 5142.254373115915, 5145.562627176694, 5151.4333423323405, 5155.690658560498, 5169.095408303532, 5181.948180518184, 5183.041137389595, 5186.429492755794, 5240.68555886648, 4473.463184417858, 4579.038401935598, 4582.427196600425, 4674.906501869944, 4804.039192161582, 5193.091209038404, 5224.608154388436, 5224.608154388436, 5230.110881150214, 5230.267762513251, 5004.699718016931, 5007.599392048627, 5009.12340340439, 5009.949900501021, 5050.72221027847, 4736.928946065812, 4883.780229889592, 4886.267059940967, 4949.257611358325, 5037.823676171316, 5031.84904452867, 5063.518965698253, 5067.265246539231, 5072.51811077947, 5113.463086375951, 5027.748612569357, 5029.2958985742025, 5034.11902916988, 5037.697738135724, 5040.722760248148, 4038.7374820636564, 4126.7523948563185, 4130.194612050621, 4138.337865941435, 4206.0115872769875, 3677.2277821657217, 3694.4458331250526, 3717.665410113103, 3721.6464435878547, 3751.0434839116397, 4394.12117576486, 4396.252637051709, 4408.625266852289, 4437.245668236407, 4437.800298986554, 4837.2260438329695, 4940.357753492023, 4949.455559888409, 4949.876253093701, 5051.722155281494, 4369.06065195978, 4393.604575588212, 4401.163778882003, 4416.779161041999, 4448.421705178306, 4513.68404211702, 4532.750698711537, 4532.841350552715, 4536.523665015192, 4576.199165146086, 4686.531346865286, 4695.81216751333, 4817.1810792164715, 4822.927656085231, 4880.585150262267, 5070.771815268248, 5086.491350864884, 5114.872128196676, 5118.769655365443, 5121.231815227746, 4874.439439464507, 4878.658493905535, 4881.170201065898, 4881.707097574157, 4912.70523768575, 4788.904221915473, 4894.192458244493, 4899.265110233494, 4901.803927842989, 5091.210862316347, 4951.8266860659705, 4953.554180123806, 4997.600191984705, 5006.524380183877, 5009.77456014473, 4694.6009589185305, 4843.152448321459, 4847.079054979543, 4853.247746599282, 4910.288008238714, 4918.2376731606655, 4939.60483161339, 4950.77721502526, 4957.529034741694, 4986.750662466935, 4831.347768051409, 4851.660383773102, 4852.733099679552, 4854.708717476963, 4881.170201065898, 4756.429228492603, 4874.147024270667, 4877.073356062337, 4878.682885612424, 4979.651424400257, 4808.422989241173, 4840.564349208447, 4845.733484658236, 4846.39420072491, 4880.585150262125], "unit": "score", "name": "dojo.html", "value": 4640.130935079724}, {"lowerIsBetter": false, "replicates": [544.4310695323387, 552.3178874090497, 560.5403569073359, 561.8286422641098, 561.9072852979257, 26989.865050674744, 27572.724272757267, 34900.301993960136, 35274.118147046276, 35358.46962295568, 38745.22509549814, 39315.0, 39366.8031659842, 39394.01514962127, 39395.424183032716, 6848.315168483162, 6971.128608923885, 7872.3308518775975, 8045.316148127416, 8052.557109358983, 10135.44255065971, 10379.117774989136, 10399.84400233997, 10407.531661075232, 10407.68776936693, 9966.65116720915, 9999.600015999351, 10024.348417352885, 10025.047620476043, 10046.0, 7150.10623672041, 7330.926690733131, 10082.89917100827, 10180.185585153169, 10479.94760026195, 9891.0, 10094.394336339843, 10101.444420556867, 10106.191504679608, 10106.898931010743, 37564.812175939216, 37819.62180378188, 38036.0, 38092.42861357054, 38133.618663813286, 2947.513660246057, 2948.2776719703597, 3136.278655909131, 3509.859605615772, 3597.9460308095136, 27905.72094279072, 28670.713292867014, 28706.425871482454, 28745.856270718512, 29749.10752677423, 3348.4475061614803, 3354.647761985005, 3381.8642663978985, 3397.1846756778195, 3431.279431319426, 202365.0, 208092.0, 208099.0, 208323.9999999985, 208573.0, 49833.25250121251, 50926.0, 59625.70187149037, 60592.39407605868, 60725.0, 57442.0, 57661.711691441276, 58046.70976645174, 58214.0, 58256.63075269287, 13623.0, 13629.522966696317, 13717.108387954751, 13767.0, 13805.17168969865, 10158.847617285746, 10197.643082492226, 10205.795884082278, 10209.38743675382, 10218.131458825934, 19801.504962376057, 20145.194192232146, 20163.0, 20197.798022019593, 20255.0, 8314.875276870851, 8361.707340243061, 8365.372597055124, 8433.873491897626, 8548.786280343042, 817.967281308741, 854.9658013679383, 914.6067191107754, 915.0620613870835, 916.9312301577409, 26010.86994565015, 26917.865410673214, 26986.865065674938, 27081.1875643731, 27245.318867028484, 938.7606160429046, 944.093670076734, 961.778790878088, 966.5988614724951, 989.7773001074701, 13962.930185349009, 14078.225697586526, 14133.081349712236, 14264.786028209584, 14344.497942572169, 253181.0, 258762.0, 260022.0, 260086.0, 260996.0, 46569.30146047812, 47036.52963470321, 47095.5290447098, 47235.5276447238, 47296.0, 1217.3973882928008, 1229.6987238126717, 1247.6381849263612, 1252.1422825364655, 1256.1709271880516, 25300.493990120463, 25838.0, 26600.467990640467, 26621.467570648867, 26672.733272667025, 41440.79279603583, 41716.0, 41866.58133418627, 41878.162436750485, 41937.58062419337, 251325.0, 252764.0, 299592.0, 304864.0, 322069.0, 29994.850025749733, 30149.09552713422, 30163.69836301609, 30487.54268685927, 30623.387532249675, 38736.418953715154, 39224.80387598044, 39571.208575828896, 40054.59945400509, 40219.597804021585, 33025.00924972255, 34081.31837363289, 34175.14562135967, 34178.65821341755, 34524.13689657779, 33546.0, 33553.16117097092, 33556.328873422884, 33724.0, 33803.323933521686, 33018.17454563655, 34013.14967125842, 34236.0, 34302.65697342995, 34309.48535771915, 32782.83608581942, 35766.64233357633, 35914.0, 36093.45859812157, 36109.458358124124, 23416.882915585993, 23488.412789680395, 23956.760432395455, 24074.638880416456, 24122.276331710076], "unit": "score", "name": "ext.html", "value": 17505.805228745463}, {"lowerIsBetter": false, "replicates": [335.3444016946869, 336.6366216821872, 340.8176625505352, 341.9623841377448, 344.85516083245034, 12389.938050309736, 12727.42726577304, 14654.0, 14803.111813291196, 15503.379864805409, 12811.807822882663, 15206.771898421504, 15207.543773686779, 15496.535103946871, 15498.0, 4980.27785971034, 5146.176611742122, 6431.131797207364, 6635.469162466991, 6642.103316052319, 4080.06158583526, 4208.116295577917, 6378.266499352564, 6562.507811914102, 6564.146660934072, 6355.364463553654, 6487.643179625119, 6518.380753828379, 6559.475241980654, 6563.442107420875, 6480.4815614750705, 6542.345765423467, 6552.803415897531, 6555.541112122177, 6556.377144171296, 6099.085137229451, 6212.751489940442, 6217.906731398987, 6276.089966954812, 6291.622502649856, 21585.676214856634, 21679.241226556995, 21745.891270543547, 22105.778942210694, 22174.0, 2017.522946715937, 2032.8780273183656, 2058.217877206667, 2080.6150862090562, 2118.9934780979065, 13779.242141682204, 14087.0, 14115.0, 14272.500462483764, 14295.857041429557, 1866.6266746650724, 1893.2427029188298, 1924.6246981838547, 1949.6100779844087, 1950.7464029676194, 57125.23440725433, 61416.38583614151, 61731.07403388998, 61945.0, 62364.68817655928, 15391.307391167424, 15490.767638485431, 15511.301991410413, 15526.37894484208, 15589.688206236038, 23280.0, 23397.88301058484, 23544.764552354598, 23565.81861448717, 23624.17315393953, 8486.74539763808, 8500.659973600987, 8503.277221436123, 8514.616842242114, 8592.355573332025, 7123.358897699232, 7151.928480715231, 7168.390686791577, 7178.497505174588, 7185.173705023884, 7467.514611550232, 7561.168271490132, 7567.432442566829, 7602.277783610548, 7620.428467864932, 2578.819482636235, 2959.1270575180374, 2990.2524368907775, 2993.3713920076593, 3049.207206126379, 374.17681101576096, 374.96062913394246, 392.7741548609561, 394.9861754838567, 946.7964387656687, 8972.237359824489, 9145.634174633073, 9511.857322140173, 9641.710748677411, 9788.363756355815, 410.74739035492956, 414.57298982048536, 422.4908984673461, 427.9957200428018, 430.4017415792052, 5187.0922588546855, 5261.421243663194, 5326.813561525328, 5335.466453354634, 5382.730863456812, 405394.0, 478758.0, 478976.0, 496644.0, 497484.0, 68431.0, 71677.19066688656, 71818.64090679618, 71937.0, 72528.27471725321, 1071.287593750163, 1074.5218377821793, 1125.6735546691368, 1147.9655610331704, 1151.654503648902, 14437.35031923587, 14471.27643617794, 14505.202213878338, 14604.196769177797, 14623.122612643276, 28881.711182887902, 29551.704482954894, 30137.698623014367, 30575.541366879068, 31254.0, 39969.0, 40940.79529602333, 41343.7932810334, 41557.58442415537, 43472.78263608662, 8147.266745992889, 8389.11914248995, 8450.281726053108, 8798.736037918872, 8803.427777194462, 10196.184305255414, 10226.590936362461, 10251.0, 12429.875701242872, 16017.759733603772, 12897.48410063587, 13201.669958250737, 13212.933935330262, 13302.534411295559, 13448.462061517821, 12789.74420511566, 13047.739045219232, 13133.212007279593, 13169.0, 13568.050236483747, 13626.250556219504, 13751.312434378442, 13757.38091785852, 14458.337291211645, 14715.0, 8990.187715438738, 9068.591913364047, 9083.137101975302, 9109.407888487227, 9160.129787670161, 13945.302734863013, 14134.929325353307, 14244.715105698035, 14287.0, 14408.927955360155], "unit": "score", "name": "jquery.html", "value": 8636.121082051275}, {"lowerIsBetter": false, "replicates": [1265.3736400481762, 1675.9497215083547, 1723.5260303416562, 1737.417964981731, 1761.5331937036678, 6176.505879529638, 7112.964435177823, 7294.270572942703, 7308.488405811595, 7310.634468276585, 7011.579305241689, 7141.214466408691, 7171.497995140329, 7180.066591343131, 7228.855422891539, 2080.6878968154783, 2119.3112238522463, 2119.8834064126468, 2120.8833514156713, 2121.893905304736, 2102.475705113788, 2135.7543882453483, 2140.9357719268446, 2153.54775497145, 2156.644153714635, 2000.8599398042143, 2029.6143732690741, 2040.0411806450945, 2066.679664651974, 2070.4306315763133, 2087.603355362476, 2112.0706888968803, 2114.5453727448516, 2116.767155612881, 2118.3433135727973, 2043.1520918818671, 2059.938201853947, 2062.5565503416688, 2064.98967505163, 2079.0228592561625, 7162.606056666881, 7196.424286057103, 7223.602701851396, 7230.674619642129, 7234.24040475753, 4214.831406743727, 4283.229018776619, 4296.957030429687, 4314.266574682311, 4316.956830431687, 2727.7681397081074, 2738.931816591531, 2745.437185376993, 2754.724527547249, 2782.9721702783118, 854.448880472092, 1527.816662000567, 1558.6648870492786, 1573.1033311012727, 1615.1843319123768, 9760.219182465386, 9806.0, 9824.214062875024, 9829.852552211723, 9831.606735730562, 3830.731848770615, 3894.1043559981363, 3967.0677390813134, 3967.484227050465, 3986.1629057898167, 7959.880601790977, 8004.479708818908, 8024.959875200587, 8029.478083924643, 8038.517688938566, 4243.830246790156, 4254.170436764863, 4259.105587826592, 4283.421738065322, 4288.978555107205, 3239.9676003239665, 3305.0, 3806.7715937043868, 3921.235359105004, 3924.50943632046, 3228.757843161772, 3242.886498972525, 3272.083816531375, 3275.263065810221, 3276.5904261967253, 963.0562049191831, 981.3375971219541, 982.2044144243185, 1013.8276492996208, 1015.7663737340453, 864.3171894203509, 884.7788052986754, 902.7652810269377, 914.8627705844177, 915.2174890468686, 6895.310468953165, 6910.619915904674, 6916.827079323057, 6933.583984960918, 6935.202451718117, 423.6758879457218, 440.7840158322399, 444.9621782148489, 449.14662141929944, 450.25258071600985, 5410.296661433988, 5467.507924286833, 5475.6440831345835, 5530.972345138249, 5539.41836107211, 8565.229129378262, 8672.8699069514, 8683.2185103341, 8700.477971321741, 8803.911960880308, 8632.223099921037, 8642.913570864337, 8648.918885139357, 8649.308055355556, 8651.826963460822, 6644.734210631521, 6815.5910645360445, 6835.692393842289, 6841.828954276183, 6900.068490753784, 6556.18047744032, 6557.377049180321, 6563.704633291609, 6580.967095164494, 6614.801555953329, 7569.0, 7701.730439434593, 7778.844423111619, 7803.180666029985, 7808.804779880548, 7256.45576581769, 7397.223291554309, 7417.109946806418, 7484.139323977813, 7494.775156745306, 5442.809501667422, 5895.4399332063385, 6808.523403361915, 6875.4155896749335, 6964.477664175106, 6702.865942681216, 6900.516963812485, 6913.481488888454, 6917.13535808024, 6928.856738638068, 6327.462165715966, 6530.718119600158, 6599.0761293418, 6610.735570577123, 6651.035599838093, 6266.498680105489, 6404.423601875854, 6474.1907261592305, 6483.448906842783, 6636.435902948304, 6597.571157874723, 6614.338566143347, 6649.800505984635, 6657.966710166418, 6662.333766623299, 6055.3944605540855, 6098.695065246809, 6133.049377346519, 6135.478484328882, 6138.877222455615, 6147.907781383194, 6169.413905678954, 6177.505799536116, 6194.318624951162, 6202.2867370253], "unit": "score", "name": "mootools.html", "value": 4063.8937415925147}, {"lowerIsBetter": false, "replicates": [302.7003266765902, 302.8546297777067, 303.2736595852932, 306.0832805746786, 309.26240915416736, 5301.257823904656, 5330.733463326837, 5347.358317001956, 5396.244525766396, 5396.43337449568, 5258.605604579662, 5288.6562373445695, 5295.0468915595175, 5296.09966305728, 5302.628815982883, 3941.8423263069444, 4159.729617574848, 4159.771212583307, 4171.249175148472, 4173.831327228381, 3997.580254073324, 4018.5177778666603, 4130.0500884796365, 4138.937915931264, 4139.234241665302, 4126.298529250034, 4126.628603425691, 4138.586141385867, 4143.02638879863, 4149.585041495857, 3899.941500877489, 3998.820053097618, 4009.0979529605897, 4136.4415803866395, 4141.855035073788, 3636.2909232699635, 3650.0874781304674, 3651.434027725707, 3658.3963645998642, 3663.8534458621625, 5086.0, 5125.256837758541, 5142.537171654569, 5150.381954165524, 5154.252633368178, 4725.5510726480925, 4737.668363214576, 4742.668013239075, 4750.762461876892, 4757.738324392157, 5455.863603409946, 5568.916466253009, 5572.247746554204, 5584.6090773645865, 5586.608937374385, 3969.4045893115976, 3974.940375894364, 3975.5030621172355, 3976.264391087658, 3976.622220889011, 5856.941430585724, 5857.179994800731, 5862.677552734598, 5862.941370586283, 5868.09044598088, 4085.8978525536504, 4086.5504794472586, 4088.018875469925, 4093.038136038029, 4093.8567150150197, 4043.8989025274013, 4151.626353628188, 4158.08522125132, 4162.458880345535, 4171.416001759756, 4696.483386827446, 4714.858554243378, 4723.952760472352, 4724.126036683225, 4725.432948046257, 5556.388797232301, 5570.6657600544095, 5571.609987300931, 5575.414581468968, 5578.0, 1455.1778245291378, 1479.2381923309504, 1480.141517919604, 1481.777733339986, 1482.1181397068726, 982.8476586129161, 1019.673704414595, 1022.1260821997234, 1022.3150489172273, 1039.6828967164936, 4947.876303092451, 4958.107540642719, 4959.181735013754, 4959.181735013754, 4962.131626965339, 5765.077587585966, 5773.364929857712, 5776.56675749312, 5781.6241944274325, 5786.697992951552, 4938.38270216223, 4939.753012349368, 4945.826896058621, 4948.529889660476, 4949.7772600233075, 3059.3575349176476, 3080.5995220621176, 3118.485449900741, 3122.0789866989294, 3122.1414111119625, 5526.751296191681, 5539.612227144061, 5560.944390556124, 5564.972175139098, 5571.359293681278, 5947.494462970696, 5979.701014949323, 5987.730552125165, 5990.9101363479585, 5995.250593675791, 5543.584231182677, 5554.805581804618, 5558.77764889408, 5559.27729395176, 5560.888782224333, 5698.430156984268, 5852.297724273115, 5852.7658893643775, 5856.0630299151935, 5859.882802344015, 5699.487046165865, 5700.25896633435, 5703.08750599902, 5714.657120572779, 5719.5138413235345, 5540.86147846291, 5546.944530554804, 5554.527865131509, 5556.888862222814, 5557.944420555743, 3866.4200369944733, 3983.143624120712, 4012.879613611596, 4031.871076098697, 4044.0496483326983, 5777.595568310178, 5779.0, 5784.479396854304, 5785.768569257182, 5786.479216870502, 5545.4472747630725, 5550.222968784293, 5551.223608445259, 5552.972235138798, 5556.138798486241, 5563.666180029211, 5575.1915972183, 5579.442055794388, 5580.665160090408, 5583.888322233452, 5360.839174824761, 5452.718611126462, 5519.834404967857, 5524.585656075891, 5532.114861622121, 5467.07059799843, 5597.0, 5662.377138514842, 5688.857778555569, 5697.4302569742695, 5412.891742165213, 5502.669839809624, 5529.364123125892, 5532.114861622121, 5533.3083364579425], "unit": "score", "name": "prototype.html", "value": 4224.720032031879}, {"lowerIsBetter": false, "replicates": [661.8610091880706, 723.9177429742535, 731.0715391452852, 742.9405647548197, 747.338605334279, 10617.256792024551, 10931.781364372708, 10949.0, 10961.780764384728, 10975.945120274408, 11386.373749443777, 11471.885281147186, 11475.081993440526, 11483.59807406741, 11496.022838058774, 802.8635132027555, 820.0774129104757, 820.4502983001404, 820.8153165537766, 821.3593397150232, 637.4040272345349, 645.1451826330108, 810.6473683947472, 828.0973738624898, 828.130463013833, 834.7036801935317, 840.1850205300879, 853.2320911179957, 853.6713365354352, 854.4360721923532, 656.3207080671482, 666.4368608525788, 844.771911583872, 845.7082306604242, 845.8900342955408, 621.0621960839165, 631.343402861024, 631.7599312261357, 632.4466092169351, 632.772202007277, 11337.886621133766, 11353.772924541463, 11413.372264525447, 11425.0, 11438.714032149179, 10867.45662716861, 11548.653540393801, 11695.766084678258, 11738.530458781639, 11791.29252244868, 9001.414908030956, 9093.181613654802, 9142.634294628207, 9157.0, 9235.353525253235, 3226.9838650806832, 3280.7867488613165, 3284.8029118252744, 3285.3100848821778, 3299.059767966118, 37112.62887371119, 37526.43710344347, 37605.811970940245, 37691.81154094239, 37708.2458350837, 8749.47503149813, 9101.549326509217, 9147.679831205876, 9365.859512107323, 9401.482918439415, 16482.75275870863, 16504.0, 16508.83491165073, 16517.174141292886, 16529.33882644705, 6037.939620603738, 6055.152278680988, 6063.696815159225, 6064.545159113084, 6162.630242185483, 3239.8380080995857, 3265.232670322472, 3376.0884561168345, 3413.761036727405, 3447.4484082546674, 2455.58255096634, 2467.4941636964736, 2470.481198948241, 2471.2092130518063, 2498.7626175513296, 437.94963579188163, 446.506610195729, 449.44044664392385, 450.8354450625498, 451.9796609152596, 428.35532523551854, 469.0033678433329, 490.69822059433193, 602.2772672792579, 614.241411856357, 7789.466347374607, 7789.7273595423885, 8041.9947506561675, 8074.636641351153, 8185.631646575918, 472.70928379047325, 495.40551338394073, 498.89273806131854, 510.5519036221328, 586.1588620329841, 3784.129650180474, 3850.942235866464, 3954.406838974177, 4098.139390727921, 4143.8964025899595, 51776.482235177165, 51832.48167518352, 51914.0, 51989.7400512995, 54543.0, 46715.53284467112, 46963.0, 46968.0, 47125.0, 47398.28902566464, 42181.99999999939, 42897.78551107287, 42903.0, 43153.16303036958, 44113.558864411585, 7614.238576142563, 7656.425768067305, 7759.0, 7851.882221766792, 7919.208079192034, 30064.84967575148, 30139.547906780976, 30531.54202686917, 30886.0, 31613.0, 35512.822435887654, 37222.25555488929, 37822.0, 37998.43002354912, 43285.0, 10797.838032429363, 10857.67426977192, 10947.34315941046, 10950.34297942126, 10955.780884382428, 11134.129458283132, 11317.320960742381, 11329.490172942073, 11480.0, 11706.414679266172, 10596.417197054236, 10723.785524289626, 10856.620018299322, 10907.672769816918, 10943.562257509611, 10622.468876556295, 10800.783984320113, 10838.512266948164, 10869.836952445878, 11317.0, 9877.209823213982, 10636.468176591294, 11069.225154239126, 11420.257683250895, 11434.599789007345, 6448.355164483514, 7936.277914640779, 8259.297959673495, 8662.177093176138, 8941.239994600532, 8758.167974042455, 9031.593578288861, 9038.638454461749, 9099.454032758056, 9287.257019438293], "unit": "score", "name": "yui.html", "value": 5637.040846800939}], "name": "dromaeo_css", "value": 6387.216763054413}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 108.0, 115.0, 115.0, 114.0, 104.0, 114.0, 113.0, 121.0], "unit": "score", "name": "ai-astar", "value": 112.8}, {"lowerIsBetter": true, "replicates": [157.0, 128.0, 159.0, 169.0, 131.0, 163.0, 157.0, 133.0, 164.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 161.0, 162.0, 160.0, 163.0, 164.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 87.0, 95.0, 72.0, 75.0, 72.0, 114.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 96.0, 94.0, 95.0, 132.0, 95.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 148.0, 148.0, 146.0, 149.0, 147.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 72.0, 72.0, 74.0, 72.0, 81.0, 70.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 88.0, 87.0, 88.0, 85.0, 85.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [120.0, 119.0, 126.0, 119.0, 126.0, 121.0, 124.0, 123.0, 129.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [138.0, 145.0, 162.0, 151.0, 151.0, 136.0, 150.0, 148.0, 139.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1532.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.34391534391534], "unit": "score", "name": "Richards", "value": 213.506496}, {"lowerIsBetter": false, "replicates": [186.70649738610905], "unit": "score", "name": "DeltaBlue", "value": 354.12800799999997}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [793.0214115781126], "unit": "score", "name": "Earley", "value": 840.4098429999997}, {"lowerIsBetter": false, "replicates": [12537.5], "unit": "score", "name": "Boyer", "value": 53.15756729810566}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [623.9103362391033], "unit": "score", "name": "Splay", "value": 130.61331936127743}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 19677.687346214247}]} 08:48:40 INFO - RETURN: dromaeo_css: 6387.22 08:48:40 INFO - RETURN: kraken: 1532.20 08:48:40 INFO - RETURN: v8_7: 19677.69 08:48:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19677.69"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1532.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6387.22"}}} 08:48:40 INFO - Return code: 0 08:48:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:48:40 ERROR - # TBPL SUCCESS # 08:48:40 INFO - Running post-action listener: _resource_record_post_action 08:48:40 INFO - Running post-run listener: _resource_record_post_run 08:48:41 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521433088; Read time: 12; Write time: 427728 08:48:41 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 231424000; Read time: 0; Write time: 225608 08:48:41 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274821120; Read time: 12; Write time: 186132 08:48:41 INFO - Running post-run listener: _upload_blobber_files 08:48:41 INFO - Blob upload gear active. 08:48:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:48:41 INFO - Copying logs to upload dir... 08:48:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.946159 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-16 08:48:39.751649) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 08:48:39.754842) ========= 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=20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009901 build_url: 'https://queue.taskcluster.net/v1/task/_UJ6UiGPTFyfG4Q4PmPwoA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 08:48:39.805339) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:48:39.805650) ========= 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=20aa3857bbc5a756c598c738000001bb-1450283252.978236-838575682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004630 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 08:48:39.854900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 08:48:39.855180) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 08:48:39.855449) ========= ========= Total master_lag: 0.21 =========