builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1450107393.38 results: success (0) buildid: 20151214064931 builduid: bc7c31b0f0e040d3a9477eba00d72e9e revision: a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.384617) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.385219) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.385671) ========= 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=6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.420044) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.420387) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.438508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.438753) ========= 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=6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.493259) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.493531) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.493858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.494122) ========= 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=6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-14 07:36: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-14 07:36:34 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195731 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.702212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.702564) ========= 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=6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017234 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:33.752138) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-14 07:36:33.752491) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69 --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 a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69 --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=6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-14 07:36:34,136 truncating revision to first 12 chars 2015-12-14 07:36:34,136 Setting DEBUG logging. 2015-12-14 07:36:34,136 attempt 1/10 2015-12-14 07:36:34,136 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a5a1cf9c5a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-14 07:36:35,120 unpacking tar archive at: fx-team-a5a1cf9c5a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.254565 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-14 07:36:35.020336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:35.020647) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:35.030558) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:35.030945) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:35.031407) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-14 07:36:35.031690) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:35 INFO - MultiFileLogger online at 20151214 07:36:35 in /builds/slave/test 07:36:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 07:36:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:35 INFO - {'append_to_log': False, 07:36:35 INFO - 'base_work_dir': '/builds/slave/test', 07:36:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:36:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:35 INFO - 'branch': 'Fx-Team-Non-PGO', 07:36:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:35 INFO - 'config_files': ('talos/linux_config.py',), 07:36:35 INFO - 'default_actions': ('clobber', 07:36:35 INFO - 'read-buildbot-config', 07:36:35 INFO - 'download-and-extract', 07:36:35 INFO - 'populate-webroot', 07:36:35 INFO - 'create-virtualenv', 07:36:35 INFO - 'install', 07:36:35 INFO - 'run-tests'), 07:36:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:35 INFO - 'download_minidump_stackwalk': True, 07:36:35 INFO - 'download_symbols': 'ondemand', 07:36:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:35 INFO - 'installer_path': 'installer.exe', 07:36:35 INFO - 'log_level': 'info', 07:36:35 INFO - 'log_name': 'talos', 07:36:35 INFO - 'log_to_console': True, 07:36:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:35 INFO - 'opt_config_files': (), 07:36:35 INFO - 'pip_index': False, 07:36:35 INFO - 'sps_profile': False, 07:36:35 INFO - 'sps_profile_interval': 0, 07:36:35 INFO - 'suite': 'dromaeojs-e10s', 07:36:35 INFO - 'system_bits': '64', 07:36:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:35 INFO - 'title': 'talos-linux64-ix-007', 07:36:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:35 INFO - 'use_talos_json': True, 07:36:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:35 INFO - 'work_dir': 'build'} 07:36:35 INFO - ##### 07:36:35 INFO - ##### Running clobber step. 07:36:35 INFO - ##### 07:36:35 INFO - Running pre-action listener: _resource_record_pre_action 07:36:35 INFO - Running main action method: clobber 07:36:35 INFO - rmtree: /builds/slave/test/build 07:36:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:36 INFO - Running post-action listener: _resource_record_post_action 07:36:36 INFO - ##### 07:36:36 INFO - ##### Running read-buildbot-config step. 07:36:36 INFO - ##### 07:36:36 INFO - Running pre-action listener: _resource_record_pre_action 07:36:36 INFO - Running main action method: read_buildbot_config 07:36:36 INFO - Using buildbot properties: 07:36:36 INFO - { 07:36:36 INFO - "properties": { 07:36:36 INFO - "buildnumber": 570, 07:36:36 INFO - "product": "firefox", 07:36:36 INFO - "script_repo_revision": "production", 07:36:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:36:36 INFO - "repository": "", 07:36:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:36:36 INFO - "buildid": "20151214064931", 07:36:36 INFO - "slavename": "talos-linux64-ix-007", 07:36:36 INFO - "pgo_build": "False", 07:36:36 INFO - "basedir": "/builds/slave/test", 07:36:36 INFO - "project": "", 07:36:36 INFO - "platform": "ubuntu64_hw", 07:36:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:36:36 INFO - "slavebuilddir": "test", 07:36:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:36:36 INFO - "branch": "fx-team", 07:36:36 INFO - "repo_path": "integration/fx-team", 07:36:36 INFO - "stage_platform": "linux64", 07:36:36 INFO - "builduid": "bc7c31b0f0e040d3a9477eba00d72e9e", 07:36:36 INFO - "revision": "a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69" 07:36:36 INFO - }, 07:36:36 INFO - "sourcestamp": { 07:36:36 INFO - "repository": "", 07:36:36 INFO - "hasPatch": false, 07:36:36 INFO - "project": "", 07:36:36 INFO - "branch": "fx-team-linux64-talos", 07:36:36 INFO - "changes": [ 07:36:36 INFO - { 07:36:36 INFO - "category": null, 07:36:36 INFO - "files": [ 07:36:36 INFO - { 07:36:36 INFO - "url": null, 07:36:36 INFO - "name": "https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:36:36 INFO - } 07:36:36 INFO - ], 07:36:36 INFO - "repository": "", 07:36:36 INFO - "rev": "a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69", 07:36:36 INFO - "who": "cbook@mozilla.com", 07:36:36 INFO - "when": 1450107379, 07:36:36 INFO - "number": 7357373, 07:36:36 INFO - "comments": "Bug 1231003 - clarify in variable names and comments that temporary add-ons can be files or dirs r=mossop", 07:36:36 INFO - "project": "", 07:36:36 INFO - "at": "Mon 14 Dec 2015 07:36:19", 07:36:36 INFO - "branch": "fx-team-linux64-talos", 07:36:36 INFO - "revlink": "", 07:36:36 INFO - "properties": [ 07:36:36 INFO - [ 07:36:36 INFO - "buildid", 07:36:36 INFO - "20151214064931", 07:36:36 INFO - "Change" 07:36:36 INFO - ], 07:36:36 INFO - [ 07:36:36 INFO - "builduid", 07:36:36 INFO - "bc7c31b0f0e040d3a9477eba00d72e9e", 07:36:36 INFO - "Change" 07:36:36 INFO - ], 07:36:36 INFO - [ 07:36:36 INFO - "pgo_build", 07:36:36 INFO - "False", 07:36:36 INFO - "Change" 07:36:36 INFO - ] 07:36:36 INFO - ], 07:36:36 INFO - "revision": "a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69" 07:36:36 INFO - } 07:36:36 INFO - ], 07:36:36 INFO - "revision": "a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69" 07:36:36 INFO - } 07:36:36 INFO - } 07:36:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:36:36 INFO - Running post-action listener: _resource_record_post_action 07:36:36 INFO - ##### 07:36:36 INFO - ##### Running download-and-extract step. 07:36:36 INFO - ##### 07:36:36 INFO - Running pre-action listener: _resource_record_pre_action 07:36:36 INFO - Running main action method: download_and_extract 07:36:36 INFO - mkdir: /builds/slave/test/build/tests 07:36:36 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')]} 07:36:36 INFO - https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:36:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/test_packages.json 07:36:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/test_packages.json 07:36:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:36:37 INFO - Downloaded 1302 bytes. 07:36:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:36:37 INFO - Using the following test package requirements: 07:36:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:37 INFO - u'jsshell-linux-x86_64.zip'], 07:36:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:36:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:36:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36: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')]} 07:36:37 INFO - https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:36:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:36:38 INFO - Downloaded 21869925 bytes. 07:36:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:36:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:36:39 INFO - Return code: 0 07:36:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:39 INFO - https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:36:41 INFO - Downloaded 21869925 bytes. 07:36:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:36:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:36:42 INFO - Return code: 0 07:36:42 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')]} 07:36:42 INFO - https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:36:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:36:43 INFO - Downloaded 11132038 bytes. 07:36:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 07:36:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:36:44 INFO - Return code: 0 07:36:44 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')]} 07:36:44 INFO - https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:36:45 INFO - Downloaded 57745158 bytes. 07:36:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:36:45 INFO - mkdir: /builds/slave/test/properties 07:36:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:45 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:45 INFO - Contents: 07:36:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:36:45 INFO - Running post-action listener: _resource_record_post_action 07:36:45 INFO - Running post-action listener: set_extra_try_arguments 07:36:45 INFO - ##### 07:36:45 INFO - ##### Running populate-webroot step. 07:36:45 INFO - ##### 07:36:45 INFO - Running pre-action listener: _resource_record_pre_action 07:36:45 INFO - Running main action method: populate_webroot 07:36:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:45 INFO - '--tppagecycles', 07:36:45 INFO - '7'], 07:36:45 INFO - 'tests': ['tsvgm']}}, 07:36:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:36:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:36:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:36:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:36:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:36:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:45 INFO - 'talos_options': ['--e10s'], 07:36:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:45 INFO - 'tests': ['damp', 'tps']}, 07:36:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:45 INFO - 'talos_options': ['--e10s'], 07:36:45 INFO - 'tests': ['damp', 'tps']}, 07:36:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:36:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:45 INFO - 'other': {'tests': ['a11yr', 07:36:45 INFO - 'ts_paint', 07:36:45 INFO - 'tpaint', 07:36:45 INFO - 'sessionrestore', 07:36:45 INFO - 'sessionrestore_no_auto_restore']}, 07:36:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:36:45 INFO - 'tests': ['a11yr', 07:36:45 INFO - 'ts_paint', 07:36:45 INFO - 'tpaint', 07:36:45 INFO - 'sessionrestore', 07:36:45 INFO - 'sessionrestore_no_auto_restore']}, 07:36:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:36:45 INFO - 'tests': ['a11yr', 07:36:45 INFO - 'ts_paint', 07:36:45 INFO - 'tpaint', 07:36:45 INFO - 'sessionrestore', 07:36:45 INFO - 'sessionrestore_no_auto_restore']}, 07:36:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:36:45 INFO - 'tests': ['a11yr', 07:36:45 INFO - 'ts_paint', 07:36:45 INFO - 'tpaint', 07:36:45 INFO - 'sessionrestore', 07:36:45 INFO - 'sessionrestore_no_auto_restore']}, 07:36:45 INFO - 'other_l64': {'tests': ['a11yr', 07:36:45 INFO - 'ts_paint', 07:36:45 INFO - 'tpaint', 07:36:45 INFO - 'sessionrestore', 07:36:45 INFO - 'sessionrestore_no_auto_restore']}, 07:36:45 INFO - 'other_nol64': {'tests': ['a11yr', 07:36:45 INFO - 'ts_paint', 07:36:45 INFO - 'tpaint', 07:36:45 INFO - 'sessionrestore', 07:36:45 INFO - 'sessionrestore_no_auto_restore']}, 07:36:45 INFO - 'svgr': {'tests': ['tsvgx', 07:36:45 INFO - 'tsvgr_opacity', 07:36:45 INFO - 'tart', 07:36:45 INFO - 'tscrollx', 07:36:45 INFO - 'cart']}, 07:36:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:36:45 INFO - 'tests': ['tsvgx', 07:36:45 INFO - 'tsvgr_opacity', 07:36:45 INFO - 'tart', 07:36:45 INFO - 'tscrollx', 07:36:45 INFO - 'cart']}, 07:36:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:45 INFO - 'tests': ['tp5o']}, 07:36:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:45 INFO - 'talos_options': ['--e10s'], 07:36:45 INFO - 'tests': ['tp5o']}, 07:36:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:45 INFO - 'talos_options': ['--xperf_path', 07:36:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:45 INFO - 'tests': ['tp5n']}, 07:36:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:45 INFO - 'talos_options': ['--e10s', 07:36:45 INFO - '--xperf_path', 07:36:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:45 INFO - 'tests': ['tp5n']}}, 07:36:45 INFO - 'talos.zip': {'path': '', 07:36:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:45 INFO - Running post-action listener: _resource_record_post_action 07:36:45 INFO - ##### 07:36:45 INFO - ##### Running create-virtualenv step. 07:36:45 INFO - ##### 07:36:45 INFO - Running pre-action listener: _resource_record_pre_action 07:36:45 INFO - Running main action method: create_virtualenv 07:36:45 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:45 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 07:36:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:45 INFO - Using real prefix '/usr' 07:36:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:46 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:48 INFO - Installing pip.................done. 07:36:48 INFO - Return code: 0 07:36:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:48 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 0x7f90e1614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b80b0>, '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 0x21b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b9440>, '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': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', '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 07:36:48 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 07:36:48 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 07:36:48 INFO - Using env: {'DISPLAY': ':0', 07:36:48 INFO - 'HOME': '/home/cltbld', 07:36:48 INFO - 'LANG': 'en_US.UTF-8', 07:36:48 INFO - 'LANGUAGE': 'en_US:en', 07:36:48 INFO - 'LOGNAME': 'cltbld', 07:36:48 INFO - 'MAIL': '/var/mail/cltbld', 07:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:48 INFO - 'MOZ_NO_REMOTE': '1', 07:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:48 INFO - 'NO_EM_RESTART': '1', 07:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:48 INFO - 'PWD': '/builds/slave/test', 07:36:48 INFO - 'SHELL': '/bin/bash', 07:36:48 INFO - 'SHLVL': '1', 07:36:48 INFO - 'TERM': 'linux', 07:36:48 INFO - 'TMOUT': '86400', 07:36:48 INFO - 'USER': 'cltbld', 07:36:48 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', 07:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:48 INFO - '_': '/tools/buildbot/bin/python'} 07:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:48 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 07:36:48 INFO - Cleaning up... 07:36:48 INFO - Return code: 0 07:36:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:48 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 0x7f90e1614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b80b0>, '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 0x21b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b9440>, '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': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', '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 07:36:48 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 07:36:48 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 07:36:48 INFO - Using env: {'DISPLAY': ':0', 07:36:48 INFO - 'HOME': '/home/cltbld', 07:36:48 INFO - 'LANG': 'en_US.UTF-8', 07:36:48 INFO - 'LANGUAGE': 'en_US:en', 07:36:48 INFO - 'LOGNAME': 'cltbld', 07:36:48 INFO - 'MAIL': '/var/mail/cltbld', 07:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:48 INFO - 'MOZ_NO_REMOTE': '1', 07:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:48 INFO - 'NO_EM_RESTART': '1', 07:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:48 INFO - 'PWD': '/builds/slave/test', 07:36:48 INFO - 'SHELL': '/bin/bash', 07:36:48 INFO - 'SHLVL': '1', 07:36:48 INFO - 'TERM': 'linux', 07:36:48 INFO - 'TMOUT': '86400', 07:36:48 INFO - 'USER': 'cltbld', 07:36:48 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', 07:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:48 INFO - '_': '/tools/buildbot/bin/python'} 07:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:48 INFO - Downloading/unpacking psutil>=0.7.1 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:36:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:50 INFO - Installing collected packages: psutil 07:36:50 INFO - Running setup.py install for psutil 07:36:50 INFO - building 'psutil._psutil_linux' extension 07:36:50 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 07:36:50 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 07:36:50 INFO - building 'psutil._psutil_posix' extension 07:36:50 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 07:36:50 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 07:36:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:51 INFO - Successfully installed psutil 07:36:51 INFO - Cleaning up... 07:36:51 INFO - Return code: 0 07:36:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:36:51 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')]} 07:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:51 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')]} 07:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:51 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 0x7f90e1614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b80b0>, '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 0x21b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b9440>, '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': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', '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 07:36:51 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 07:36:51 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 07:36:51 INFO - Using env: {'DISPLAY': ':0', 07:36:51 INFO - 'HOME': '/home/cltbld', 07:36:51 INFO - 'LANG': 'en_US.UTF-8', 07:36:51 INFO - 'LANGUAGE': 'en_US:en', 07:36:51 INFO - 'LOGNAME': 'cltbld', 07:36:51 INFO - 'MAIL': '/var/mail/cltbld', 07:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:51 INFO - 'MOZ_NO_REMOTE': '1', 07:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:51 INFO - 'NO_EM_RESTART': '1', 07:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:51 INFO - 'PWD': '/builds/slave/test', 07:36:51 INFO - 'SHELL': '/bin/bash', 07:36:51 INFO - 'SHLVL': '1', 07:36:51 INFO - 'TERM': 'linux', 07:36:51 INFO - 'TMOUT': '86400', 07:36:51 INFO - 'USER': 'cltbld', 07:36:51 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', 07:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:51 INFO - '_': '/tools/buildbot/bin/python'} 07:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:36:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:36:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:36:53 INFO - Installing collected packages: mozsystemmonitor 07:36:53 INFO - Running setup.py install for mozsystemmonitor 07:36:53 INFO - Successfully installed mozsystemmonitor 07:36:53 INFO - Cleaning up... 07:36:53 INFO - Return code: 0 07:36:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:53 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 0x7f90e1614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b80b0>, '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 0x21b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b9440>, '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': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', '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 07:36:53 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 07:36:53 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 07:36:53 INFO - Using env: {'DISPLAY': ':0', 07:36:53 INFO - 'HOME': '/home/cltbld', 07:36:53 INFO - 'LANG': 'en_US.UTF-8', 07:36:53 INFO - 'LANGUAGE': 'en_US:en', 07:36:53 INFO - 'LOGNAME': 'cltbld', 07:36:53 INFO - 'MAIL': '/var/mail/cltbld', 07:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:53 INFO - 'MOZ_NO_REMOTE': '1', 07:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:53 INFO - 'NO_EM_RESTART': '1', 07:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:53 INFO - 'PWD': '/builds/slave/test', 07:36:53 INFO - 'SHELL': '/bin/bash', 07:36:53 INFO - 'SHLVL': '1', 07:36:53 INFO - 'TERM': 'linux', 07:36:53 INFO - 'TMOUT': '86400', 07:36:53 INFO - 'USER': 'cltbld', 07:36:53 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', 07:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:53 INFO - '_': '/tools/buildbot/bin/python'} 07:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:55 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:55 INFO - Downloading docopt-0.6.1.tar.gz 07:36:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:55 INFO - Running setup.py install for blobuploader 07:36:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:55 INFO - Running setup.py install for requests 07:36:56 INFO - Running setup.py install for docopt 07:36:56 INFO - Successfully installed blobuploader requests docopt 07:36:56 INFO - Cleaning up... 07:36:56 INFO - Return code: 0 07:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:56 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 0x7f90e1614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b80b0>, '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 0x21b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b9440>, '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': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', '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 07:36:56 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 07:36:56 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 07:36:56 INFO - Using env: {'DISPLAY': ':0', 07:36:56 INFO - 'HOME': '/home/cltbld', 07:36:56 INFO - 'LANG': 'en_US.UTF-8', 07:36:56 INFO - 'LANGUAGE': 'en_US:en', 07:36:56 INFO - 'LOGNAME': 'cltbld', 07:36:56 INFO - 'MAIL': '/var/mail/cltbld', 07:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:56 INFO - 'MOZ_NO_REMOTE': '1', 07:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:56 INFO - 'NO_EM_RESTART': '1', 07:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:56 INFO - 'PWD': '/builds/slave/test', 07:36:56 INFO - 'SHELL': '/bin/bash', 07:36:56 INFO - 'SHLVL': '1', 07:36:56 INFO - 'TERM': 'linux', 07:36:56 INFO - 'TMOUT': '86400', 07:36:56 INFO - 'USER': 'cltbld', 07:36:56 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', 07:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:56 INFO - '_': '/tools/buildbot/bin/python'} 07:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:56 INFO - Running setup.py (path:/tmp/pip-LVqlPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:56 INFO - Running setup.py (path:/tmp/pip-CVgloe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:56 INFO - Running setup.py (path:/tmp/pip-fN5T8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:56 INFO - Running setup.py (path:/tmp/pip-D4AWbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:56 INFO - Running setup.py (path:/tmp/pip-4TgZc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:56 INFO - Running setup.py (path:/tmp/pip-bledlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:57 INFO - Running setup.py (path:/tmp/pip-nYdErp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:57 INFO - Running setup.py (path:/tmp/pip-C8ZCXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:57 INFO - Running setup.py (path:/tmp/pip-UODFj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:57 INFO - Running setup.py (path:/tmp/pip-LPek6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:57 INFO - Running setup.py (path:/tmp/pip-qm_HSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:57 INFO - Running setup.py (path:/tmp/pip-vnaj1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:57 INFO - Running setup.py (path:/tmp/pip-z4HnoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:57 INFO - Running setup.py (path:/tmp/pip-4Gt7w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:57 INFO - Running setup.py (path:/tmp/pip-OPyRMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:57 INFO - Running setup.py (path:/tmp/pip-bPdU4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:57 INFO - Running setup.py (path:/tmp/pip-NvVe8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:57 INFO - Running setup.py install for manifestparser 07:36:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:57 INFO - Running setup.py install for mozcrash 07:36:58 INFO - Running setup.py install for mozdebug 07:36:58 INFO - Running setup.py install for mozdevice 07:36:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:58 INFO - Running setup.py install for mozfile 07:36:58 INFO - Running setup.py install for mozhttpd 07:36:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:58 INFO - Running setup.py install for mozinfo 07:36:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:58 INFO - Running setup.py install for mozInstall 07:36:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:58 INFO - Running setup.py install for mozleak 07:36:58 INFO - Running setup.py install for mozlog 07:36:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:58 INFO - Running setup.py install for moznetwork 07:36:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:58 INFO - Running setup.py install for mozprocess 07:36:59 INFO - Running setup.py install for mozprofile 07:36:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:59 INFO - Running setup.py install for mozrunner 07:36:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:59 INFO - Running setup.py install for mozscreenshot 07:36:59 INFO - Running setup.py install for moztest 07:36:59 INFO - Running setup.py install for mozversion 07:36:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:59 INFO - Cleaning up... 07:36:59 INFO - Return code: 0 07:36:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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/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 0x7f90e1614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b80b0>, '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 0x21b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b9440>, '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': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', '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 07:36: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/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 07:36: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/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 07:36:59 INFO - Using env: {'DISPLAY': ':0', 07:36:59 INFO - 'HOME': '/home/cltbld', 07:36:59 INFO - 'LANG': 'en_US.UTF-8', 07:36:59 INFO - 'LANGUAGE': 'en_US:en', 07:36:59 INFO - 'LOGNAME': 'cltbld', 07:36:59 INFO - 'MAIL': '/var/mail/cltbld', 07:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:59 INFO - 'MOZ_NO_REMOTE': '1', 07:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:59 INFO - 'NO_EM_RESTART': '1', 07:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:59 INFO - 'PWD': '/builds/slave/test', 07:36:59 INFO - 'SHELL': '/bin/bash', 07:36:59 INFO - 'SHLVL': '1', 07:36:59 INFO - 'TERM': 'linux', 07:36:59 INFO - 'TMOUT': '86400', 07:36:59 INFO - 'USER': 'cltbld', 07:36:59 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', 07:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:59 INFO - '_': '/tools/buildbot/bin/python'} 07:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:59 INFO - Running setup.py (path:/tmp/pip-3HT0J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:59 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)) 07:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:59 INFO - Running setup.py (path:/tmp/pip-3NIkqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:59 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)) 07:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:59 INFO - Running setup.py (path:/tmp/pip-caWmmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:00 INFO - Running setup.py (path:/tmp/pip-UAXBjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:00 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)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:00 INFO - Running setup.py (path:/tmp/pip-Wn6e4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:00 INFO - Running setup.py (path:/tmp/pip-fO4xOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:00 INFO - Running setup.py (path:/tmp/pip-z870Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:00 INFO - Running setup.py (path:/tmp/pip-IoU1P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:00 INFO - Running setup.py (path:/tmp/pip-2TQTic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:00 INFO - Running setup.py (path:/tmp/pip-Y2LOSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:00 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)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:00 INFO - Running setup.py (path:/tmp/pip-yqnzvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:00 INFO - Running setup.py (path:/tmp/pip-19NyjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:00 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)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:00 INFO - Running setup.py (path:/tmp/pip-r2J_i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:00 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)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:00 INFO - Running setup.py (path:/tmp/pip-9bNK8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:00 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)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:00 INFO - Running setup.py (path:/tmp/pip-s_3Guk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:00 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)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:00 INFO - Running setup.py (path:/tmp/pip-dRUVKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:00 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)) 07:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:00 INFO - Running setup.py (path:/tmp/pip-Skpf7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:02 INFO - Downloading blessings-1.5.1.tar.gz 07:37:02 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 07:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:02 INFO - Installing collected packages: blessings 07:37:02 INFO - Running setup.py install for blessings 07:37:02 INFO - Successfully installed blessings 07:37:02 INFO - Cleaning up... 07:37:02 INFO - Return code: 0 07:37:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:03 INFO - Reading from file tmpfile_stdout 07:37:03 INFO - Current package versions: 07:37:03 INFO - argparse == 1.2.1 07:37:03 INFO - blessings == 1.5.1 07:37:03 INFO - blobuploader == 1.2.4 07:37:03 INFO - docopt == 0.6.1 07:37:03 INFO - manifestparser == 1.1 07:37:03 INFO - mozInstall == 1.12 07:37:03 INFO - mozcrash == 0.16 07:37:03 INFO - mozdebug == 0.1 07:37:03 INFO - mozdevice == 0.47 07:37:03 INFO - mozfile == 1.2 07:37:03 INFO - mozhttpd == 0.7 07:37:03 INFO - mozinfo == 0.9 07:37:03 INFO - mozleak == 0.1 07:37:03 INFO - mozlog == 3.1 07:37:03 INFO - moznetwork == 0.27 07:37:03 INFO - mozprocess == 0.22 07:37:03 INFO - mozprofile == 0.27 07:37:03 INFO - mozrunner == 6.11 07:37:03 INFO - mozscreenshot == 0.1 07:37:03 INFO - mozsystemmonitor == 0.0 07:37:03 INFO - moztest == 0.7 07:37:03 INFO - mozversion == 1.4 07:37:03 INFO - psutil == 3.1.1 07:37:03 INFO - requests == 1.2.3 07:37:03 INFO - wsgiref == 0.1.2 07:37:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:03 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 0x7f90e1614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b80b0>, '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 0x21b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b9440>, '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': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', '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 07:37:03 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 07:37:03 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 07:37:03 INFO - Using env: {'DISPLAY': ':0', 07:37:03 INFO - 'HOME': '/home/cltbld', 07:37:03 INFO - 'LANG': 'en_US.UTF-8', 07:37:03 INFO - 'LANGUAGE': 'en_US:en', 07:37:03 INFO - 'LOGNAME': 'cltbld', 07:37:03 INFO - 'MAIL': '/var/mail/cltbld', 07:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:03 INFO - 'MOZ_NO_REMOTE': '1', 07:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:03 INFO - 'NO_EM_RESTART': '1', 07:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:03 INFO - 'PWD': '/builds/slave/test', 07:37:03 INFO - 'SHELL': '/bin/bash', 07:37:03 INFO - 'SHLVL': '1', 07:37:03 INFO - 'TERM': 'linux', 07:37:03 INFO - 'TMOUT': '86400', 07:37:03 INFO - 'USER': 'cltbld', 07:37:03 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', 07:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:03 INFO - '_': '/tools/buildbot/bin/python'} 07:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:03 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)) 07:37:03 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)) 07:37:03 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)) 07:37:03 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)) 07:37:03 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)) 07:37:03 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)) 07:37:03 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)) 07:37:03 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)) 07:37:03 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)) 07:37:03 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)) 07:37:03 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)) 07:37:03 INFO - Cleaning up... 07:37:03 INFO - Return code: 0 07:37:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:03 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 0x7f90e1614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b80b0>, '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 0x21b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b9440>, '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': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', '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 07:37:03 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 07:37:03 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 07:37:03 INFO - Using env: {'DISPLAY': ':0', 07:37:03 INFO - 'HOME': '/home/cltbld', 07:37:03 INFO - 'LANG': 'en_US.UTF-8', 07:37:03 INFO - 'LANGUAGE': 'en_US:en', 07:37:03 INFO - 'LOGNAME': 'cltbld', 07:37:03 INFO - 'MAIL': '/var/mail/cltbld', 07:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:03 INFO - 'MOZ_NO_REMOTE': '1', 07:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:03 INFO - 'NO_EM_RESTART': '1', 07:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:03 INFO - 'PWD': '/builds/slave/test', 07:37:03 INFO - 'SHELL': '/bin/bash', 07:37:03 INFO - 'SHLVL': '1', 07:37:03 INFO - 'TERM': 'linux', 07:37:03 INFO - 'TMOUT': '86400', 07:37:03 INFO - 'USER': 'cltbld', 07:37:03 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', 07:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:03 INFO - '_': '/tools/buildbot/bin/python'} 07:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:03 INFO - Downloading/unpacking jsonschema 07:37:03 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 07:37:03 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 07:37:03 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 07:37:03 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 07:37:03 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 07:37:03 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 07:37:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:05 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 07:37:05 INFO - Downloading/unpacking functools32 (from jsonschema) 07:37:05 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 07:37:05 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 07:37:05 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 07:37:05 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 07:37:05 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 07:37:05 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 07:37:05 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:05 INFO - warning: no files found matching '*.txt' 07:37:05 INFO - no previously-included directories found matching 'build' 07:37:05 INFO - no previously-included directories found matching 'dist' 07:37:05 INFO - no previously-included directories found matching '.git*' 07:37:05 INFO - Installing collected packages: jsonschema, functools32 07:37:05 INFO - Running setup.py install for functools32 07:37:05 INFO - warning: no files found matching '*.txt' 07:37:05 INFO - no previously-included directories found matching 'build' 07:37:05 INFO - no previously-included directories found matching 'dist' 07:37:05 INFO - no previously-included directories found matching '.git*' 07:37:05 INFO - Successfully installed jsonschema functools32 07:37:05 INFO - Cleaning up... 07:37:05 INFO - Return code: 0 07:37:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:37:05 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')]} 07:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:05 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')]} 07:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:05 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 0x7f90e1614f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2129240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b80b0>, '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 0x21b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b9440>, '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': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', '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 07:37:05 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 07:37:05 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 07:37:05 INFO - Using env: {'DISPLAY': ':0', 07:37:05 INFO - 'HOME': '/home/cltbld', 07:37:05 INFO - 'LANG': 'en_US.UTF-8', 07:37:05 INFO - 'LANGUAGE': 'en_US:en', 07:37:05 INFO - 'LOGNAME': 'cltbld', 07:37:05 INFO - 'MAIL': '/var/mail/cltbld', 07:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:05 INFO - 'MOZ_NO_REMOTE': '1', 07:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:05 INFO - 'NO_EM_RESTART': '1', 07:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:05 INFO - 'PWD': '/builds/slave/test', 07:37:05 INFO - 'SHELL': '/bin/bash', 07:37:05 INFO - 'SHLVL': '1', 07:37:05 INFO - 'TERM': 'linux', 07:37:05 INFO - 'TMOUT': '86400', 07:37:05 INFO - 'USER': 'cltbld', 07:37:05 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', 07:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:05 INFO - '_': '/tools/buildbot/bin/python'} 07:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:05 INFO - Downloading/unpacking flake8 07:37:05 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 07:37:05 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 07:37:05 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 07:37:05 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 07:37:05 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 07:37:05 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 07:37:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:37:07 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 07:37:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:37:07 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 07:37:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:07 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 07:37:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:37:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:37:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:37:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:37:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:37:08 INFO - no previously-included directories found matching 'docs/_build' 07:37:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:37:08 INFO - Running setup.py install for pep8 07:37:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:37:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:37:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:37:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:37:08 INFO - no previously-included directories found matching 'docs/_build' 07:37:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:37:08 INFO - Cleaning up... 07:37:08 INFO - Return code: 0 07:37:08 INFO - Running post-action listener: _resource_record_post_action 07:37:08 INFO - Running post-action listener: _start_resource_monitoring 07:37:08 INFO - Starting resource monitoring. 07:37:08 INFO - ##### 07:37:08 INFO - ##### Running install step. 07:37:08 INFO - ##### 07:37:08 INFO - Running pre-action listener: _resource_record_pre_action 07:37:08 INFO - Running main action method: install 07:37:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:08 INFO - Reading from file tmpfile_stdout 07:37:08 INFO - Detecting whether we're running mozinstall >=1.0... 07:37:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:37:08 INFO - Reading from file tmpfile_stdout 07:37:08 INFO - Output received: 07:37:08 INFO - Usage: mozinstall [options] installer 07:37:08 INFO - Options: 07:37:08 INFO - -h, --help show this help message and exit 07:37:08 INFO - -d DEST, --destination=DEST 07:37:08 INFO - Directory to install application into. [default: 07:37:08 INFO - "/builds/slave/test"] 07:37:08 INFO - --app=APP Application being installed. [default: firefox] 07:37:08 INFO - mkdir: /builds/slave/test/build/application 07:37:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:37:23 INFO - Reading from file tmpfile_stdout 07:37:23 INFO - Output received: 07:37:23 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:23 INFO - Running post-action listener: _resource_record_post_action 07:37:23 INFO - ##### 07:37:23 INFO - ##### Running run-tests step. 07:37:23 INFO - ##### 07:37:23 INFO - Running pre-action listener: _resource_record_pre_action 07:37:23 INFO - Running main action method: run_tests 07:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:23 INFO - Python 2.7.3 07:37:23 INFO - Return code: 0 07:37:23 INFO - grabbing minidump binary from tooltool 07:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:23 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 0x21b80b0>, '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 0x21b8fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b9440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:23 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 07:37:23 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 07:37:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:23 INFO - Return code: 0 07:37:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:37:24 INFO - Return code: 0 07:37:24 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] in /builds/slave/test/build 07:37:24 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost 07:37:24 INFO - Using env: {'DISPLAY': ':0', 07:37:24 INFO - 'HOME': '/home/cltbld', 07:37:24 INFO - 'LANG': 'en_US.UTF-8', 07:37:24 INFO - 'LANGUAGE': 'en_US:en', 07:37:24 INFO - 'LOGNAME': 'cltbld', 07:37:24 INFO - 'MAIL': '/var/mail/cltbld', 07:37:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:24 INFO - 'MOZ_NO_REMOTE': '1', 07:37:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:24 INFO - 'NO_EM_RESTART': '1', 07:37:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:24 INFO - 'PWD': '/builds/slave/test', 07:37:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:24 INFO - 'SHELL': '/bin/bash', 07:37:24 INFO - 'SHLVL': '1', 07:37:24 INFO - 'TERM': 'linux', 07:37:24 INFO - 'TMOUT': '86400', 07:37:24 INFO - 'USER': 'cltbld', 07:37:24 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401', 07:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:24 INFO - '_': '/tools/buildbot/bin/python'} 07:37:24 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] with output_timeout 3600 07:37:24 INFO - mozversion INFO | application_buildid: 20151214064931 07:37:24 INFO - mozversion INFO | application_changeset: a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69 07:37:24 INFO - mozversion INFO | application_display_name: Nightly 07:37:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:24 INFO - mozversion INFO | application_name: Firefox 07:37:24 INFO - mozversion INFO | application_remotingname: firefox 07:37:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:37:24 INFO - mozversion INFO | application_vendor: Mozilla 07:37:24 INFO - mozversion INFO | application_version: 45.0a1 07:37:24 INFO - mozversion INFO | platform_buildid: 20151214064931 07:37:24 INFO - mozversion INFO | platform_changeset: a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69 07:37:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:37:24 INFO - mozversion INFO | platform_version: 45.0a1 07:37:24 INFO - 2015-12-14 07:37:24,641 DEBUG : using testdate: 1450107444 07:37:24 INFO - 2015-12-14 07:37:24,641 DEBUG : actual date: 1450107444 07:37:24 INFO - 2015-12-14 07:37:24,650 INFO : starting webserver on 'localhost:59595' 07:37:24 INFO - 2015-12-14 07:37:24,651 INFO : Starting test suite talos-linux64-ix-007.e 07:37:24 INFO - 2015-12-14 07:37:24,651 INFO : Starting test dromaeo_css 07:37:24 INFO - 2015-12-14 07:37:24,651 DEBUG : operating with platform_type : linux_ 07:37:24 INFO - 2015-12-14 07:37:24,652 INFO : Initialising browser for dromaeo_css test... 07:37:24 INFO - 2015-12-14 07:37:24,667 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqxR2MC/profile http://localhost:59595/getInfo.html 07:37:29 INFO - 2015-12-14 07:37:29,551 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:37:29 INFO - 2015-12-14 07:37:29,551 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:37:29 INFO - 2015-12-14 07:37:29,551 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:37:29 INFO - 2015-12-14 07:37:29,551 DEBUG : BROWSER_OUTPUT: __metrics 07:37:29 INFO - 2015-12-14 07:37:29,672 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] 07:37:30 INFO - 2015-12-14 07:37:30,615 INFO : Browser initialized. 07:37:30 INFO - 2015-12-14 07:37:30,615 INFO : Running cycle 1/1 for dromaeo_css test... 07:37:30 INFO - 2015-12-14 07:37:30,615 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqxR2MC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:37:42 INFO - 2015-12-14 07:37:42,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 143601664 07:37:42 INFO - 2015-12-14 07:37:42,683 DEBUG : BROWSER_OUTPUT: 07:38:32 INFO - 2015-12-14 07:38:32,311 DEBUG : BROWSER_OUTPUT: 1450107512304 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] 07:40:44 INFO - 2015-12-14 07:40:44,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59595/tests/dromaeo/cssquery-ext.html) 07:40:45 INFO - 2015-12-14 07:40:45,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 147746816 07:40:45 INFO - 2015-12-14 07:40:45,144 DEBUG : BROWSER_OUTPUT: 07:43:47 INFO - 2015-12-14 07:43:47,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/dromaeo/cssquery-ext.html (next: http://localhost:59595/tests/dromaeo/cssquery-jquery.html) 07:43:47 INFO - 2015-12-14 07:43:47,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 143433728 07:43:47 INFO - 2015-12-14 07:43:47,797 DEBUG : BROWSER_OUTPUT: 07:46:49 INFO - 2015-12-14 07:46:49,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59595/tests/dromaeo/cssquery-mootools.html) 07:46:50 INFO - 2015-12-14 07:46:50,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 146145280 07:46:50 INFO - 2015-12-14 07:46:50,185 DEBUG : BROWSER_OUTPUT: 07:49:51 INFO - 2015-12-14 07:49:51,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59595/tests/dromaeo/cssquery-prototype.html) 07:49:52 INFO - 2015-12-14 07:49:52,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 143958016 07:49:52 INFO - 2015-12-14 07:49:52,588 DEBUG : BROWSER_OUTPUT: 07:52:55 INFO - 2015-12-14 07:52:55,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59595/tests/dromaeo/cssquery-yui.html) 07:52:55 INFO - 2015-12-14 07:52:55,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 144461824 07:52:55 INFO - 2015-12-14 07:52:55,916 DEBUG : BROWSER_OUTPUT: 07:55:58 INFO - 2015-12-14 07:55:58,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/dromaeo/cssquery-yui.html (next: http://localhost:59595/tests/dromaeo/cssquery-dojo.html) 07:55:58 INFO - 2015-12-14 07:55:58,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 147247104 07:55:58 INFO - 2015-12-14 07:55:58,475 DEBUG : BROWSER_OUTPUT: 07:55:58 INFO - 2015-12-14 07:55:58,475 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:55:58 INFO - 2015-12-14 07:55:58,475 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:55:58 INFO - 2015-12-14 07:55:58,476 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:55:58 INFO - 2015-12-14 07:55:58,476 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:55:58 INFO - 2015-12-14 07:55:58,476 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2661.214941592231;2666.4933662604117;2729.358600728828;2738.383863630683;2743.478739039583;4634.096351211515;4795.328653988445;4802.567768900798;4820.903581928359;4881.170201065818;4727.338172655831;4744.240921452569;4755.429348478179;4898.730569818658;4903;4328.13437312538;4389.824407023715;4428.822847086113;4464.955350446503;4483.753393563353;4370.6940514164025;4425.137098265839;4445.755483448409;4468.374427580141;4504.7747612619405;4212.410262563244;4338.934915976263;4346.0655958968655;4391.385206071152;4420.823167073346;4436.622887054604;4450.799714012877;4451.087527056946;4456.041950980522;4476.440444944382;4428.778561071966;4442.155990361821;4454.844080457168;4464.486584042844;4469.508354081048;4503.527129651372;4577.862664120082;4677.4854765975715;4699.718016918961;4746.050789842011;5091.1090559152;5104.795808167669;5137.2037334213255;5173.379194496684;5204.115300398941;5165.509276618753;5183.170692689189;5183.455737147583;5207.3751149862255;5214.661047031968;4572.748498832563;4656.697314674535;4667.789949452283;4805.1590971579835;4859.319695242669;5201.973990130101;5268.051750684914;5271.339389033194;5282.656627319212;5308.973455132699;4787.2101103318255;5044.722540260247;5044.8234311798915;5050.787810925352;5058.822941197114;5026.4973502649445;5068.16375298079;5098.566621837112;5103.157978933435;5148;5097.592192624581;5114.820981265712;5117.641765076409;5128.564072053842;5164.8192313268855;4845.854624361275;4962.528559786814;5097.9745101275;5102.183650615883;5105.693658380509;4137.379393091061;4140.855070072533;4202.306619407825;4267.381229721673;4297.290946993773;3718.7420403638225;3746.925061498755;3757.342465068602;3782.583915769263;3794.317022935843;4203.117345357509;4448.065906159743;4453.554644535585;4458.554144585581;4467.039586488855;5068.239764035424;5070.670406423571;5085.211792172219;5137.075326441276;5195.376554813447;4423.071155057474;4433.8226470941445;4438.467383913887;4442.555744425532;4476.171908196994;4358.585934336296;4494.52807455219;4543.591076803037;4556.908861822745;4586.793594288265;4807.351007613997;4811.4707382187935;4874.8537543873745;4931.506849315183;4963.057019166491;5120.052790233819;5136.512031357015;5138.743062846917;5144.048351055067;5209.6874187548865;4610.2854057621125;4726.929096063493;4861.222204447272;4891.559759621651;4931.778069986931;5021.799128034838;5064.696118232918;5080.415752188545;5107.284980102714;5128.974355128201;5147.382314122329;5177.4822517749435;5189.506996835295;5198.324217851655;5215.687058776485;4774.761261936958;4860.635452341159;4936.333594964633;4992.975035124801;4995.050940321327;4925.581325587365;4931.13705101613;4952.083864485082;4952.380952380952;4958.752062396794;4855;4878.024395121061;4891.413030436228;4906.705597664151;4937.308776771183;4805;4916.70499770015;4968.403791545038;5028.497150284942;5046.57104146137;4915;4946.208606622923;4954.1825598775795;4965.925511117408;5002.699838009731 07:55:58 INFO - 2015-12-14 07:55:58,476 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.0719405786394;570.0679389198659;575.8445219790657;581.2269681323837;595.3391735173959;35378.82310588447;36036.27927441456;36375.272494550125;36415;36417.63582364176;39540.20919581607;40134.19731605366;40284.39573406394;40335;40379.79810100945;7835.333996610295;7977.082635496934;7984.121746607869;7999.080105787822;8010.759677209693;7818.296353328199;7928.563928983904;7938.682452701885;7945.205479452066;7974.920250797476;7848.960755196216;7924.881126783102;7930.048394192705;7931.286184243446;7948.880766788503;7842.647080881346;7877.566733829608;7923.4057445691515;7935.682572697086;7954.045514538292;7741.3419859312025;7832.216778322122;7869.095054068741;7881.330086942617;7897.486663366863;37285.813570932245;37567.24865502702;37614;37625.24749505022;37652.24695506074;2930.7362337389523;2956.2609347663083;3086.2284428892776;3339.9499007514905;3720.293144302601;28330.150095497167;28410.431791364055;28761.137165884847;29072;29512.26219344512;3201.3917355702574;3347.7991320520846;3374.0889959710985;3405.523226748257;3447.896563103111;207460;208362.95818520963;208388;209315;209549;50958.74520627373;52152.478475215525;53606.731966340696;54030;56113;55878.72060639671;55977;55986.440135598124;56137;56228;12529.686757830945;12697;12721.173123747112;12762.68093297675;12768.744625107445;10189.847152292721;10218.540165692562;10285.588576457008;10322.638707645196;10448.164146868232;19104.904475477535;19182.424527264204;19244.903775481314;19337.129829157722;19425.4172374829;7383.704651813975;7491.213422590658;7547.28300811422;7639.860838964987;7644.0827100748265;798.4131663227523;813.9267465928095;837.7905523619095;873.4846440600077;917.8072604753077;26188.476230475666;26331.34171645686;27050;29016.854915725708;29468.705312947026;920.7145784806731;920.7974245665943;930.4696323095906;942.3827393057559;946.9621215151454;11979.28124312544;12279.263244205198;12287.508499659914;12298.20061695987;12355.505779768708;264807;270459;271240;271240;271755;44275.778621106685;44320.55679443229;44590.33114503285;44686.77656611696;44762.77618611951;1213.1932265043824;1279.2196759976407;1283.5700040486543;1288.1305119044794;1288.8711128887037;23869.403264917823;29377;32077.358452830347;32553.837230813693;32606.83696581502;42437.78781106075;43113;43115.353269700354;43142.56857431385;43289.35065974076;190396;195656;195778;196294;196754.0649187037;39332.80333598428;43948.12103757971;44420;44935;45085.32372014357;43593.78203109091;43814.78092609517;43826.78086609674;44099;44215.778921105186;36333;36722.8163859179;37396.62603373932;37503;37814.43278350882;37318.81340593279;37375.252494950495;37407.251854963295;37482.812585936896;37674;36243.45634815533;36328;36967;37211;37230;30780.53829192519;31091.067267981998;33142.17144571405;33414.49878251877;33512.83243583766;25623.74376256288;25830.612540811526;26125;26327.4734505305;26445.603315950662 07:55:58 INFO - 2015-12-14 07:55:58,477 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.0404815913454;328.9375018746437;330.60327606871755;334.07461332110057;335.4147013461507;14946.925265373671;15278.388864445422;15419.460318888841;16088;16663.916680416613;14391.856081439182;14763.335649895753;15296.617584560363;15541.844581554182;15630.765538516904;4712.175369310366;5157.432682404932;5158.74206289684;5166.018456493273;5167.018266529366;5046;5067.493250674921;5072.695638261716;5073.289739436482;5083.923741143867;4731.6451266155;4846.151923413388;4885.413750349963;4909.852704418873;5004.049230646184;4937.456879743226;4945.77744001519;4952.158133117378;4984.277279794428;5220.92168617471;5123.666961647518;5129.6409251352425;5152.768125434364;5163.251328557338;5163.483651634844;11541.711457213552;11788;16216.75674864878;18983;19040;1641.089195496511;1693.9322427102902;1769.3364988129451;1773.3084097202102;1881.0594702648675;9049.592768325441;9073.228775554086;9248.213901818353;10862.819666271187;12513.687157821127;1722.4488163787594;1731.852792512638;1732.1425894182335;1757.92089355978;1785.5000599832067;52899.97058398256;54370.99999999961;54640.72679636616;55549.444505555235;55881.44118558803;9520.571574279174;9616.807663846685;9793.755156121155;9828.262880284008;9975.600975961026;12428.067894907917;12461.813072803916;12463.255144279627;12470.625881223577;12481.500739970299;6565.80302590923;6573.5398522103;6635.2037755469655;6756.594604323658;7196.64016799158;6138.539609529304;6145.877082458326;6146.907796383058;6439.291677915426;6468.3855033771715;4026.275270451288;4068.267711811843;4099.959000409957;4114.979425102915;4164.646005089601;1649.0682764238406;1714.262866967216;1723.9827601724073;1735.1324337831084;1748.4404990403202;742.6323969635065;773.2885745114509;787.5196130360475;901.2474583722534;1009.4145395670494;13539.458421663023;15142.772858407132;15868;15882.523524294289;15970.441034563735;844.9775771316653;846.5894041389921;846.716350022737;890.7951171230524;905.0451773379148;9005.819883602291;9216.262698984065;9216.308776841764;9247.445153290824;9392.530373481299;488867;490529;490797;493804;497523.09907604015;70047;70483.6475817628;72481.6375918117;73211.63394183101;73588.63205683937;1102.862142232237;1106.2975010868156;1181.3030312115893;1196.5991392883482;1198.6523908066738;14372.856271437151;14521.353166986886;14523.927380363031;14563;14777.630559236106;33794.831025844716;34027.48958765571;34254.82872585621;34532.482012769324;35353.116172095906;46247;46644.53355466402;47589;48599.5140048595;48695;8414.158584141536;8532.23209911111;8734.344924130843;8785.868211976953;8917.464952102895;10343.63797267092;10349.586016559555;10424.635137770141;10453.47732613351;13740.793888091886;13072.411741471466;13463.259520726455;13540.255285959367;13850;13883.375248113656;12869.871301287241;13119.883245534058;13780.242086685328;14140.858591413955;14335.92832035833;14254.643633909236;14488.565343039725;14537.20045397471;14683.192424416333;15052.623684407978;8823.647054117764;11642.708932276422;11741.706457338634;11948.940255298668;12316.630501084981;14403.495877644233;15326.693466130839;15361;15844.841551584337;15894.364225430852 07:55:58 INFO - 2015-12-14 07:55:58,479 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1466.0690461556908;1672.4313733330664;1709.5213340264722;1718.5617667494794;1739.8260173982599;6790.083338749268;6889.724411023553;7014.29857014299;7023.508354415187;7139.428845692345;7039.04972828668;7097.396721278685;7106.680199391027;7130;7151.749688760894;2003.2587942461273;2045.3659365596714;2047.2936836791282;2047.4369548374168;2049.221295907553;2033.3493282149718;2037.643412402831;2058.3207541511265;2114.587655407196;2117.1637203304685;1678.2280151130494;1704.9062301573408;1978.6042791441698;2028.3205126282712;2051.887146206958;1939.1273926732956;1962.1856929374292;1963.7447131872907;1965.705144228363;1967.655660259456;1982.5241941933975;1986.7781314491629;2067.2041264113273;2073.668213085914;2080.6462901306663;7007.229204787469;7071.717131314741;7091.042709234239;7107.786766397016;7123.145222573325;4140.648044916155;4181.581841815824;4201.516825565069;4219.641330486912;4239.724417912826;2641.1152263991394;2670.198940317897;2702.594610808375;2707.945841083167;2718.293243756618;846.5005646668434;856.618804631939;857.4126723194631;878.0604752914384;890.5057692980394;9330.860037099448;9354.017828128084;9409.811803763887;9416.529173541296;9427.575759090789;3640.7087433005295;3652.908677283036;3653.8355773990234;3749.250149970017;3814;7674.386049116058;7724.6523906424345;7728.381729461629;7728.690852365842;7734.110577283572;4020.7587544747407;4030.375291829771;4041.9086846551268;4048.0689441428635;4057.89855253621;3688.354537955847;3711.925761484755;3712.9628703713156;3724.2923844469465;3730.3844865597416;3026.455238057171;3033.1203950854006;3063.6170478690165;3099.395617854542;3100.612423447069;902.2105657549644;902.4359775140537;904.2585080234145;905.0949050949051;906.9773255668529;753.6985205917567;773.8374941262398;960.5564052870399;1029.0429900192892;1046.0480962324248;6213.099100630474;6338.58799178052;6404.679766011681;6439.742410303629;6473.029045643191;572.6621293436892;578.6152208781114;578.6875087452728;580.0516156084832;736.0799001248439;5100.38795344561;5153.2785410042625;5167.767450464738;5205.063088644005;5208.244804503326;7794.025746781653;8140.063892652421;8281.792955176168;8293.543855088028;8315.750527484186;8140.063892652421;8155.429119961545;8159.46963447374;8193.385496087818;8204.056533498604;6448.033349828253;6561.2782593914635;6578.407943285128;6586.341365863471;6645.568038077509;6098.695065246631;6155;6159.1069294951085;6160.353162918008;6165.10605962124;7263.891041634274;7355.926440735739;7455.627218639155;7467.738629147953;7505.437092217996;7430.665620047002;7632.8855067175145;7677.884831727641;7699.34555562761;7731.265529774662;5885.646861188342;5923.763049478145;5934.7922822701;5934.881302374015;5948.8810223796145;6050.42520960508;6282.8429289266305;6299.559030867796;6306.779262725782;6555.901661474986;6325.399087086719;6335.113084168128;6359.586626869239;6465.741370345134;6514.315996820265;6147.293061297829;6282.528810339151;6310.368963103653;6314.052892066226;6362.491000720024;5470.56235501151;5829.15477255787;5918.408159184047;5922.73347699346;5965.28416590012;5835.766569337349;5882.676452795137;5886.676232807065;5890.352061273171;5890.852728681817;5714.857128571819;5860.501857342174;5919.230500034968;5936.554758393051;5964.045752679551 07:55:58 INFO - 2015-12-14 07:55:58,482 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.28595085843114;305.7783107247246;306.03903742249355;306.6442926205601;309.6810285406033;5549;5583.106702927533;5621.859453513664;5632.493075623193;5677.261955945732;5535.640183388087;5565.693886836222;5574.331080270363;5591.713905801668;5596.4123767004485;4213.389058586503;4221.852235171769;4243.278642630745;4246.5541118182455;4248.107897341562;4232.894177645553;4238.406623072772;4246.68149888758;4252.277112890816;4256.914861702764;4060.776657283848;4151.398047283142;4171.874843754692;4190.832366705328;4215.768132752697;4172.5410204877435;4196.538380778112;4197.097624010852;4202.747835129887;4210.726302790325;3631.4915911772373;3645.963540364589;3647.3252448296885;3659.3413185626578;3676.448532720087;5311.973440132774;5313.734313284359;5320.361556613192;5326.573874090063;5348.304720386363;4639.420072490939;4665.113628410625;4820.084184005028;4824.179889418772;4833.468318484964;5778.3354914184565;5782.248307720011;5785.681787501686;5791.942080579182;5797.623154494944;3953.189596132786;3963.762174269524;3972.2651309507546;3974.5627980922077;3982.7012974026775;6020.789272375446;6038.909416358758;6083.087536869461;6094.299155597163;6109.5723299369065;3944.6055394460323;4063.1061166543313;4077.103037331782;4111.835526578963;4112.444819949268;4172.645325147336;4173.728707633994;4188.476440444944;4190.811413486401;4191.937120943188;4792.059216017518;4830.565249127525;4831.758412079453;4832.371791667061;4837.080954618611;5741;5787.276590426197;5828.970855145697;5832.3292821326095;5833;1426.8787153092103;1466.1716130386299;1473.5505670770517;1487.2638044168207;1487.4719474586582;971.3249291742171;979.3878825733916;989.1048601015948;997.7854761226371;998.2612866478753;4964.255361695702;5014.799408023711;5055.620828437808;5056.317397151338;5056.873578160576;5982.521398288127;5993.9700301498215;5994.760209591567;5999.70001499932;6003.009503431972;5027.572656324181;5036.798528058836;5039.823606173766;5040.823571174991;5044.394672639233;3136.40408322418;3174.4762114251353;3212.7429805615493;3228.0961330827404;3270;5718.142278658152;5718.771249149988;5721.799737009184;5731.197632331477;5767.22142510764;6261.9373806262265;6281.937180628227;6282.811515654537;6292.087647291117;6303.590266632654;5551.72241387929;5731.799387021518;5732.484076433057;5733.741981610921;5740.339860916049;6025.975584150792;6055.424734650202;6060.333363330118;6076.726547305293;6120.663363515049;5873.2658417697785;5903.055511118372;5908.793192238251;5913.2608423947;5924.140999555127;5549.361823390201;5685.374608793112;5687.829365119053;5688.800891968926;5711.914321285267;4032.1330913853662;4081.2653722330265;4083.183363327406;4086.81609327575;4087.7956102194175;6056.1824153740445;6058.969705151446;6059.939400606114;6076.483498902643;6088.726007329592;5790.044642634087;5841.561882858718;5844.94155058444;5846.649201047951;5847.590668653153;5714.628549144292;5809.738561764646;5853.619514731528;5858.47273745365;5863.208466857091;5691.060974939254;5721.542276617944;5723.8569035774435;5731.713414329351;5754.108113242454;5826.94173058264;5870.354261031369;5874.618149820248;5884;5897.262842144732;5575.414581469049;5735.36910939788;5752.906947679928;5755.71221438918;5762.596618236683 07:55:58 INFO - 2015-12-14 07:55:58,482 DEBUG : BROWSER_OUTPUT: |5;yui.html;687.7352219395534;704.6265479295972;751.7256201486457;754.4153281207067;771.5447885747408;11386.259893106942;11596.362200078993;11606.36165010924;11625.593104241343;11690.590829320976;11684.649460516199;11745.823812642817;11783.7643247135;11812.232204906675;11821.231619944698;622.554873265615;629.46181015232;804.5695552879196;809;820.2125959079291;807.7940125268049;810.1291112054565;812.2486699802688;816.5304949653972;820.122468958215;850.7702920211539;852.258535074483;854.6965827131372;856.0540602634093;856.905740368559;838.9412741108156;842.1241908415241;842.6166094427082;842.7850898021027;843.5023336231623;626.8307556959595;627.723801527331;628.4720834499043;629.6945981199115;632.9335419780949;11995.64013079609;12154.270743755404;12190.939045304805;12246.81629775554;12252.387380630933;11201.215914885961;11580;11628.127890408168;11688.181827272094;11875.0499960003;9221.585028673726;9364.204042656382;9465.479398633073;9574.952125239399;9727.805443891153;3276.1318250663594;3295.47272436409;3321.136504508821;3330.8001519908885;3440.449528075496;37509.24981500382;37673.62326376756;37696;37841.81079094615;37927.62072379296;9052.27581793455;9087.863682044775;9105.088807791917;9377.578008989612;9630.27772917034;17076.914615427093;17123.657526849394;17145.571360716083;17167.57081072983;17190.31238750461;6488.675566221765;6610.173728283965;6788.287229840796;6831.658417079226;6834.453243740489;3584.5698516178227;3614.475900994341;3614.945775813365;3696.4085746280466;3708.554973403209;2596.519643865891;2619.5546757051347;2643.0881345935622;2652.641893344374;2653.270350653586;469.80737897461876;473.6116384564624;475.40574282147315;485.74741134610514;485.9586935110555;474.9477557468676;562.4937556199371;566.4335664335664;586.3960121075299;598.2103623217398;7687.385009199251;7730.884036739453;7744.6514906829325;7756.224377562312;7972.2824945754;475.04041835492114;503.58202691765746;567.1945836911596;576.4869266352949;582.9329627092939;3829.3107240696386;3879.3405121128912;3995.220931918248;4003.3794761811964;4246.681498887596;48927;49103.75448122808;49178.50821491739;49221.50778492241;49591.75204124028;43078.138437231704;43988.12023759507;44226;45072;45095;37067.77593344354;38203;38227.23545529074;38305.425418618746;39412;7695.153533111241;7903;8015.597270477527;8051.597420129087;8167.428280020342;30505.54241686421;31442;31705.365892681555;31767.682323176472;32243.838780805945;35871.64128358683;37769.433458498694;41366.1726765469;41860.37209441922;42106.1578768429;10118.342307750267;10208.387496750218;10315.381077135396;10371.429571373646;10418.479076046318;11638.825417618573;11639.88360116388;11715.941420293186;11805.23265987708;11873.881261187278;10674.679759607225;10736.08743256832;10828.5127169276;10898.400587967737;10929.672109836718;10894.56421743153;11199.776004480027;11264.267822591506;11386.715332116763;11644.767104658029;9671.129598336183;10364.689059328231;10385.532651030571;10535.525901334611;10556.947215263874;8950.507722075348;9121.45271283725;9226.35415520907;9229.769255768391;9449.244060475008;8746.38775285724;8991.865122023306;9196.954015229881;9223.538823058954;9319.58061887203 07:55:58 INFO - 2015-12-14 07:55:58,483 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:55:58 INFO - 2015-12-14 07:55:58,484 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:55:58 INFO - 2015-12-14 07:55:58,484 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,342 07:55:58 INFO - 2015-12-14 07:55:58,484 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:55:58 INFO - 2015-12-14 07:55:58,484 DEBUG : BROWSER_OUTPUT: __startTimestamp1450108558469__endTimestamp 07:55:58 INFO - 2015-12-14 07:55:58,484 DEBUG : BROWSER_OUTPUT: 07:55:58 INFO - 2015-12-14 07:55:58,484 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:55:58 INFO - 2015-12-14 07:55:58,484 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:55:58 INFO - 2015-12-14 07:55:58,484 DEBUG : BROWSER_OUTPUT: 07:55:58 INFO - 2015-12-14 07:55:58,485 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4720.97 Median:4861.22 stddev:498.98 (10.3%) stddev-sans-first:473.63 07:55:58 INFO - 2015-12-14 07:55:58,485 DEBUG : BROWSER_OUTPUT: Values: 2661.2 2666.5 2729.4 2738.4 2743.5 4634.1 4795.3 4802.6 4820.9 4881.2 4727.3 4744.2 4755.4 4898.7 4903.0 4328.1 4389.8 4428.8 4465.0 4483.8 4370.7 4425.1 4445.8 4468.4 4504.8 4212.4 4338.9 4346.1 4391.4 4420.8 4436.6 4450.8 4451.1 4456.0 4476.4 4428.8 4442.2 4454.8 4464.5 4469.5 4503.5 4577.9 4677.5 4699.7 4746.1 5091.1 5104.8 5137.2 5173.4 5204.1 5165.5 5183.2 5183.5 5207.4 5214.7 4572.7 4656.7 4667.8 4805.2 4859.3 5202.0 5268.1 5271.3 5282.7 5309.0 4787.2 5044.7 5044.8 5050.8 5058.8 5026.5 5068.2 5098.6 5103.2 5148.0 5097.6 5114.8 5117.6 5128.6 5164.8 4845.9 4962.5 5098.0 5102.2 5105.7 4137.4 4140.9 4202.3 4267.4 4297.3 3718.7 3746.9 3757.3 3782.6 3794.3 4203.1 4448.1 4453.6 4458.6 4467.0 5068.2 5070.7 5085.2 5137.1 5195.4 4423.1 4433.8 4438.5 4442.6 4476.2 4358.6 4494.5 4543.6 4556.9 4586.8 4807.4 4811.5 4874.9 4931.5 4963.1 5120.1 5136.5 5138.7 5144.0 5209.7 4610.3 4726.9 4861.2 4891.6 4931.8 5021.8 5064.7 5080.4 5107.3 5129.0 5147.4 5177.5 5189.5 5198.3 5215.7 4774.8 4860.6 4936.3 4993.0 4995.1 4925.6 4931.1 4952.1 4952.4 4958.8 4855.0 4878.0 4891.4 4906.7 4937.3 4805.0 4916.7 4968.4 5028.5 5046.6 4915.0 4946.2 4954.2 4965.9 5002.7 07:55:58 INFO - 2015-12-14 07:55:58,485 DEBUG : BROWSER_OUTPUT: 07:55:58 INFO - 2015-12-14 07:55:58,485 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39996.33 Median:37401.94 stddev:58935.60 (157.6%) stddev-sans-first:59026.54 07:55:58 INFO - 2015-12-14 07:55:58,485 DEBUG : BROWSER_OUTPUT: Values: 559.1 570.1 575.8 581.2 595.3 35378.8 36036.3 36375.3 36415.0 36417.6 39540.2 40134.2 40284.4 40335.0 40379.8 7835.3 7977.1 7984.1 7999.1 8010.8 7818.3 7928.6 7938.7 7945.2 7974.9 7849.0 7924.9 7930.0 7931.3 7948.9 7842.6 7877.6 7923.4 7935.7 7954.0 7741.3 7832.2 7869.1 7881.3 7897.5 37285.8 37567.2 37614.0 37625.2 37652.2 2930.7 2956.3 3086.2 3339.9 3720.3 28330.2 28410.4 28761.1 29072.0 29512.3 3201.4 3347.8 3374.1 3405.5 3447.9 207460.0 208363.0 208388.0 209315.0 209549.0 50958.7 52152.5 53606.7 54030.0 56113.0 55878.7 55977.0 55986.4 56137.0 56228.0 12529.7 12697.0 12721.2 12762.7 12768.7 10189.8 10218.5 10285.6 10322.6 10448.2 19104.9 19182.4 19244.9 19337.1 19425.4 7383.7 7491.2 7547.3 7639.9 7644.1 798.4 813.9 837.8 873.5 917.8 26188.5 26331.3 27050.0 29016.9 29468.7 920.7 920.8 930.5 942.4 947.0 11979.3 12279.3 12287.5 12298.2 12355.5 264807.0 270459.0 271240.0 271240.0 271755.0 44275.8 44320.6 44590.3 44686.8 44762.8 1213.2 1279.2 1283.6 1288.1 1288.9 23869.4 29377.0 32077.4 32553.8 32606.8 42437.8 43113.0 43115.4 43142.6 43289.4 190396.0 195656.0 195778.0 196294.0 196754.1 39332.8 43948.1 44420.0 44935.0 45085.3 43593.8 43814.8 43826.8 44099.0 44215.8 36333.0 36722.8 37396.6 37503.0 37814.4 37318.8 37375.3 37407.3 37482.8 37674.0 36243.5 36328.0 36967.0 37211.0 37230.0 30780.5 31091.1 33142.2 33414.5 33512.8 25623.7 25830.6 26125.0 26327.5 26445.6 07:55:58 INFO - 2015-12-14 07:55:58,485 DEBUG : BROWSER_OUTPUT: 07:55:58 INFO - 2015-12-14 07:55:58,485 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26597.51 Median:34942.80 stddev:80418.55 (230.1%) stddev-sans-first:80619.95 07:55:58 INFO - 2015-12-14 07:55:58,485 DEBUG : BROWSER_OUTPUT: Values: 328.0 328.9 330.6 334.1 335.4 14946.9 15278.4 15419.5 16088.0 16663.9 14391.9 14763.3 15296.6 15541.8 15630.8 4712.2 5157.4 5158.7 5166.0 5167.0 5046.0 5067.5 5072.7 5073.3 5083.9 4731.6 4846.2 4885.4 4909.9 5004.0 4937.5 4945.8 4952.2 4984.3 5220.9 5123.7 5129.6 5152.8 5163.3 5163.5 11541.7 11788.0 16216.8 18983.0 19040.0 1641.1 1693.9 1769.3 1773.3 1881.1 9049.6 9073.2 9248.2 10862.8 12513.7 1722.4 1731.9 1732.1 1757.9 1785.5 52900.0 54371.0 54640.7 55549.4 55881.4 9520.6 9616.8 9793.8 9828.3 9975.6 12428.1 12461.8 12463.3 12470.6 12481.5 6565.8 6573.5 6635.2 6756.6 7196.6 6138.5 6145.9 6146.9 6439.3 6468.4 4026.3 4068.3 4100.0 4115.0 4164.6 1649.1 1714.3 1724.0 1735.1 1748.4 742.6 773.3 787.5 901.2 1009.4 13539.5 15142.8 15868.0 15882.5 15970.4 845.0 846.6 846.7 890.8 905.0 9005.8 9216.3 9216.3 9247.4 9392.5 488867.0 490529.0 490797.0 493804.0 497523.1 70047.0 70483.6 72481.6 73211.6 73588.6 1102.9 1106.3 1181.3 1196.6 1198.7 14372.9 14521.4 14523.9 14563.0 14777.6 33794.8 34027.5 34254.8 34532.5 35353.1 46247.0 46644.5 47589.0 48599.5 48695.0 8414.2 8532.2 8734.3 8785.9 8917.5 10343.6 10349.6 10424.6 10453.5 13740.8 13072.4 13463.3 13540.3 13850.0 13883.4 12869.9 13119.9 13780.2 14140.9 14335.9 14254.6 14488.6 14537.2 14683.2 15052.6 8823.6 11642.7 11741.7 11948.9 12316.6 14403.5 15326.7 15361.0 15844.8 15894.4 07:55:58 INFO - 2015-12-14 07:55:58,487 DEBUG : BROWSER_OUTPUT: 07:55:58 INFO - 2015-12-14 07:55:58,487 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4798.19 Median:6007.85 stddev:2506.74 (41.7%) stddev-sans-first:2501.26 07:55:58 INFO - 2015-12-14 07:55:58,487 DEBUG : BROWSER_OUTPUT: Values: 1466.1 1672.4 1709.5 1718.6 1739.8 6790.1 6889.7 7014.3 7023.5 7139.4 7039.0 7097.4 7106.7 7130.0 7151.7 2003.3 2045.4 2047.3 2047.4 2049.2 2033.3 2037.6 2058.3 2114.6 2117.2 1678.2 1704.9 1978.6 2028.3 2051.9 1939.1 1962.2 1963.7 1965.7 1967.7 1982.5 1986.8 2067.2 2073.7 2080.6 7007.2 7071.7 7091.0 7107.8 7123.1 4140.6 4181.6 4201.5 4219.6 4239.7 2641.1 2670.2 2702.6 2707.9 2718.3 846.5 856.6 857.4 878.1 890.5 9330.9 9354.0 9409.8 9416.5 9427.6 3640.7 3652.9 3653.8 3749.3 3814.0 7674.4 7724.7 7728.4 7728.7 7734.1 4020.8 4030.4 4041.9 4048.1 4057.9 3688.4 3711.9 3713.0 3724.3 3730.4 3026.5 3033.1 3063.6 3099.4 3100.6 902.2 902.4 904.3 905.1 907.0 753.7 773.8 960.6 1029.0 1046.0 6213.1 6338.6 6404.7 6439.7 6473.0 572.7 578.6 578.7 580.1 736.1 5100.4 5153.3 5167.8 5205.1 5208.2 7794.0 8140.1 8281.8 8293.5 8315.8 8140.1 8155.4 8159.5 8193.4 8204.1 6448.0 6561.3 6578.4 6586.3 6645.6 6098.7 6155.0 6159.1 6160.4 6165.1 7263.9 7355.9 7455.6 7467.7 7505.4 7430.7 7632.9 7677.9 7699.3 7731.3 5885.6 5923.8 5934.8 5934.9 5948.9 6050.4 6282.8 6299.6 6306.8 6555.9 6325.4 6335.1 6359.6 6465.7 6514.3 6147.3 6282.5 6310.4 6314.1 6362.5 5470.6 5829.2 5918.4 5922.7 5965.3 5835.8 5882.7 5886.7 5890.4 5890.9 5714.9 5860.5 5919.2 5936.6 5964.0 07:55:58 INFO - 2015-12-14 07:55:58,487 DEBUG : BROWSER_OUTPUT: 07:55:58 INFO - 2015-12-14 07:55:58,487 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4803.85 Median:5574.87 stddev:1437.49 (25.8%) stddev-sans-first:1401.14 07:55:58 INFO - 2015-12-14 07:55:58,487 DEBUG : BROWSER_OUTPUT: Values: 296.3 305.8 306.0 306.6 309.7 5549.0 5583.1 5621.9 5632.5 5677.3 5535.6 5565.7 5574.3 5591.7 5596.4 4213.4 4221.9 4243.3 4246.6 4248.1 4232.9 4238.4 4246.7 4252.3 4256.9 4060.8 4151.4 4171.9 4190.8 4215.8 4172.5 4196.5 4197.1 4202.7 4210.7 3631.5 3646.0 3647.3 3659.3 3676.4 5312.0 5313.7 5320.4 5326.6 5348.3 4639.4 4665.1 4820.1 4824.2 4833.5 5778.3 5782.2 5785.7 5791.9 5797.6 3953.2 3963.8 3972.3 3974.6 3982.7 6020.8 6038.9 6083.1 6094.3 6109.6 3944.6 4063.1 4077.1 4111.8 4112.4 4172.6 4173.7 4188.5 4190.8 4191.9 4792.1 4830.6 4831.8 4832.4 4837.1 5741.0 5787.3 5829.0 5832.3 5833.0 1426.9 1466.2 1473.6 1487.3 1487.5 971.3 979.4 989.1 997.8 998.3 4964.3 5014.8 5055.6 5056.3 5056.9 5982.5 5994.0 5994.8 5999.7 6003.0 5027.6 5036.8 5039.8 5040.8 5044.4 3136.4 3174.5 3212.7 3228.1 3270.0 5718.1 5718.8 5721.8 5731.2 5767.2 6261.9 6281.9 6282.8 6292.1 6303.6 5551.7 5731.8 5732.5 5733.7 5740.3 6026.0 6055.4 6060.3 6076.7 6120.7 5873.3 5903.1 5908.8 5913.3 5924.1 5549.4 5685.4 5687.8 5688.8 5711.9 4032.1 4081.3 4083.2 4086.8 4087.8 6056.2 6059.0 6059.9 6076.5 6088.7 5790.0 5841.6 5844.9 5846.6 5847.6 5714.6 5809.7 5853.6 5858.5 5863.2 5691.1 5721.5 5723.9 5731.7 5754.1 5826.9 5870.4 5874.6 5884.0 5897.3 5575.4 5735.4 5752.9 5755.7 5762.6 07:55:58 INFO - 2015-12-14 07:55:58,487 DEBUG : BROWSER_OUTPUT: 07:55:58 INFO - 2015-12-14 07:55:58,488 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12186.70 Median:44107.06 stddev:13489.68 (30.6%) stddev-sans-first:13499.88 07:55:58 INFO - 2015-12-14 07:55:58,489 DEBUG : BROWSER_OUTPUT: Values: 687.7 704.6 751.7 754.4 771.5 11386.3 11596.4 11606.4 11625.6 11690.6 11684.6 11745.8 11783.8 11812.2 11821.2 622.6 629.5 804.6 809.0 820.2 807.8 810.1 812.2 816.5 820.1 850.8 852.3 854.7 856.1 856.9 838.9 842.1 842.6 842.8 843.5 626.8 627.7 628.5 629.7 632.9 11995.6 12154.3 12190.9 12246.8 12252.4 11201.2 11580.0 11628.1 11688.2 11875.0 9221.6 9364.2 9465.5 9575.0 9727.8 3276.1 3295.5 3321.1 3330.8 3440.4 37509.2 37673.6 37696.0 37841.8 37927.6 9052.3 9087.9 9105.1 9377.6 9630.3 17076.9 17123.7 17145.6 17167.6 17190.3 6488.7 6610.2 6788.3 6831.7 6834.5 3584.6 3614.5 3614.9 3696.4 3708.6 2596.5 2619.6 2643.1 2652.6 2653.3 469.8 473.6 475.4 485.7 486.0 474.9 562.5 566.4 586.4 598.2 7687.4 7730.9 7744.7 7756.2 7972.3 475.0 503.6 567.2 576.5 582.9 3829.3 3879.3 3995.2 4003.4 4246.7 48927.0 49103.8 49178.5 49221.5 49591.8 43078.1 43988.1 44226.0 45072.0 45095.0 37067.8 38203.0 38227.2 38305.4 39412.0 7695.2 7903.0 8015.6 8051.6 8167.4 30505.5 31442.0 31705.4 31767.7 32243.8 35871.6 37769.4 41366.2 41860.4 42106.2 10118.3 10208.4 10315.4 10371.4 10418.5 11638.8 11639.9 11715.9 11805.2 11873.9 10674.7 10736.1 10828.5 10898.4 10929.7 10894.6 11199.8 11264.3 11386.7 11644.8 9671.1 10364.7 10385.5 10535.5 10556.9 8950.5 9121.5 9226.4 9229.8 9449.2 8746.4 8991.9 9197.0 9223.5 9319.6 07:55:58 INFO - 2015-12-14 07:55:58,489 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:55:58 INFO - 2015-12-14 07:55:58,489 DEBUG : BROWSER_OUTPUT: 07:55:59 INFO - 2015-12-14 07:55:59,259 INFO : Browser exited with error code: 0 07:55:59 INFO - 2015-12-14 07:55:59,282 INFO : Completed test dromaeo_css (00:18:34) 07:55:59 INFO - 2015-12-14 07:55:59,282 INFO : Starting test kraken 07:55:59 INFO - 2015-12-14 07:55:59,282 DEBUG : operating with platform_type : linux_ 07:55:59 INFO - 2015-12-14 07:55:59,282 INFO : Initialising browser for kraken test... 07:55:59 INFO - 2015-12-14 07:55:59,289 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFvhAJ8/profile http://localhost:59595/getInfo.html 07:56:04 INFO - 2015-12-14 07:56:04,138 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:56:04 INFO - 2015-12-14 07:56:04,138 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:56:04 INFO - 2015-12-14 07:56:04,138 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:56:04 INFO - 2015-12-14 07:56:04,138 DEBUG : BROWSER_OUTPUT: __metrics 07:56:04 INFO - 2015-12-14 07:56:04,267 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] 07:56:05 INFO - 2015-12-14 07:56:05,239 INFO : Browser initialized. 07:56:05 INFO - 2015-12-14 07:56:05,239 INFO : Running cycle 1/1 for kraken test... 07:56:05 INFO - 2015-12-14 07:56:05,239 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFvhAJ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:56:17 INFO - 2015-12-14 07:56:17,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 143872000 07:56:17 INFO - 2015-12-14 07:56:17,285 DEBUG : BROWSER_OUTPUT: 07:56:19 INFO - 2015-12-14 07:56:19,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59595/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:20 INFO - 2015-12-14 07:56:20,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 143618048 07:56:20 INFO - 2015-12-14 07:56:20,468 DEBUG : BROWSER_OUTPUT: 07:56:23 INFO - 2015-12-14 07:56:23,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59595/tests/kraken/driver.html?testName=audio-dft) 07:56:23 INFO - 2015-12-14 07:56:23,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 142393344 07:56:23 INFO - 2015-12-14 07:56:23,819 DEBUG : BROWSER_OUTPUT: 07:56:26 INFO - 2015-12-14 07:56:26,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59595/tests/kraken/driver.html?testName=audio-fft) 07:56:27 INFO - 2015-12-14 07:56:27,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 138567680 07:56:27 INFO - 2015-12-14 07:56:27,302 DEBUG : BROWSER_OUTPUT: 07:56:29 INFO - 2015-12-14 07:56:29,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59595/tests/kraken/driver.html?testName=audio-oscillator) 07:56:29 INFO - 2015-12-14 07:56:29,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 139812864 07:56:29 INFO - 2015-12-14 07:56:29,996 DEBUG : BROWSER_OUTPUT: 07:56:32 INFO - 2015-12-14 07:56:32,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59595/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:32 INFO - 2015-12-14 07:56:32,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 140681216 07:56:32 INFO - 2015-12-14 07:56:32,840 DEBUG : BROWSER_OUTPUT: 07:56:35 INFO - 2015-12-14 07:56:35,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59595/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:36 INFO - 2015-12-14 07:56:36,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 141291520 07:56:36 INFO - 2015-12-14 07:56:36,505 DEBUG : BROWSER_OUTPUT: 07:56:39 INFO - 2015-12-14 07:56:39,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59595/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:40 INFO - 2015-12-14 07:56:40,601 DEBUG : BROWSER_OUTPUT: RSS: Main: 139046912 07:56:40 INFO - 2015-12-14 07:56:40,601 DEBUG : BROWSER_OUTPUT: 07:56:43 INFO - 2015-12-14 07:56:43,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59595/tests/kraken/driver.html?testName=json-parse-financial) 07:56:44 INFO - 2015-12-14 07:56:44,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 139735040 07:56:44 INFO - 2015-12-14 07:56:44,101 DEBUG : BROWSER_OUTPUT: 07:56:45 INFO - 2015-12-14 07:56:45,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59595/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:46 INFO - 2015-12-14 07:56:46,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 140677120 07:56:46 INFO - 2015-12-14 07:56:46,486 DEBUG : BROWSER_OUTPUT: 07:56:48 INFO - 2015-12-14 07:56:48,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59595/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:49 INFO - 2015-12-14 07:56:49,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 141053952 07:56:49 INFO - 2015-12-14 07:56:49,005 DEBUG : BROWSER_OUTPUT: 07:56:51 INFO - 2015-12-14 07:56:51,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59595/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:51 INFO - 2015-12-14 07:56:51,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 141045760 07:56:51 INFO - 2015-12-14 07:56:51,773 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:54 INFO - 2015-12-14 07:56:54,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 141549568 07:56:54 INFO - 2015-12-14 07:56:54,983 DEBUG : BROWSER_OUTPUT: 07:56:57 INFO - 2015-12-14 07:56:57,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:58 INFO - 2015-12-14 07:56:58,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 140398592 07:56:58 INFO - 2015-12-14 07:56:58,218 DEBUG : BROWSER_OUTPUT: 07:56:59 INFO - 2015-12-14 07:56:59,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59595/tests/kraken/driver.html?testName=ai-astar) 07:57:00 INFO - 2015-12-14 07:57:00,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 140763136 07:57:00 INFO - 2015-12-14 07:57:00,239 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,239 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:57:00 INFO - 2015-12-14 07:57:00,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:57:00 INFO - 2015-12-14 07:57:00,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:57:00 INFO - 2015-12-14 07:57:00,239 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:57:00 INFO - 2015-12-14 07:57:00,239 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;108;115;114;112;123;113;112;113;112 07:57:00 INFO - 2015-12-14 07:57:00,240 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;132;159;175;132;158;154;140;172;134 07:57:00 INFO - 2015-12-14 07:57:00,240 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;163;160;162;164;168;161;163;164 07:57:00 INFO - 2015-12-14 07:57:00,240 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;77;74;140;73;79;76;72;86 07:57:00 INFO - 2015-12-14 07:57:00,240 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;132;94;95;96;132;95;97;130 07:57:00 INFO - 2015-12-14 07:57:00,240 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;109;111;110;111;110 07:57:00 INFO - 2015-12-14 07:57:00,240 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;148;149;148;149;148;149;149 07:57:00 INFO - 2015-12-14 07:57:00,240 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;96;96;96;96;96;97;96 07:57:00 INFO - 2015-12-14 07:57:00,240 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;77;74;75;74;75;74;75;76;75;73 07:57:00 INFO - 2015-12-14 07:57:00,241 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;69;70;69;69;69;68 07:57:00 INFO - 2015-12-14 07:57:00,241 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;86;84;93;88;93;85;94;85 07:57:00 INFO - 2015-12-14 07:57:00,241 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;126;130;135;126;127;123;121;130;138 07:57:00 INFO - 2015-12-14 07:57:00,241 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;151;152;149;154;140;152;150;141;154 07:57:00 INFO - 2015-12-14 07:57:00,241 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;72;74;71;74;72;73;72;71;71 07:57:00 INFO - 2015-12-14 07:57:00,241 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:57:00 INFO - 2015-12-14 07:57:00,241 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:57:00 INFO - 2015-12-14 07:57:00,242 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,788 07:57:00 INFO - 2015-12-14 07:57:00,242 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:57:00 INFO - 2015-12-14 07:57:00,242 DEBUG : BROWSER_OUTPUT: __startTimestamp1450108620236__endTimestamp 07:57:00 INFO - 2015-12-14 07:57:00,242 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,243 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:57:00 INFO - 2015-12-14 07:57:00,244 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:57:00 INFO - 2015-12-14 07:57:00,244 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,244 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:3.81 (3.4%) stddev-sans-first:4.03 07:57:00 INFO - 2015-12-14 07:57:00,244 DEBUG : BROWSER_OUTPUT: Values: 113.0 108.0 115.0 114.0 112.0 123.0 113.0 112.0 113.0 112.0 07:57:00 INFO - 2015-12-14 07:57:00,245 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,245 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.60 Median:158.50 stddev:16.15 (10.2%) stddev-sans-first:16.84 07:57:00 INFO - 2015-12-14 07:57:00,245 DEBUG : BROWSER_OUTPUT: Values: 160.0 132.0 159.0 175.0 132.0 158.0 154.0 140.0 172.0 134.0 07:57:00 INFO - 2015-12-14 07:57:00,245 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,245 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:2.15 (1.3%) stddev-sans-first:2.28 07:57:00 INFO - 2015-12-14 07:57:00,246 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 163.0 160.0 162.0 164.0 168.0 161.0 163.0 164.0 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:20.65 (27.5%) stddev-sans-first:21.68 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 77.0 74.0 140.0 73.0 79.0 76.0 72.0 86.0 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:95.00 stddev:17.37 (18.3%) stddev-sans-first:18.03 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 132.0 94.0 95.0 96.0 132.0 95.0 97.0 130.0 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 109.0 111.0 110.0 111.0 110.0 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,247 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 148.0 149.0 148.0 149.0 148.0 149.0 149.0 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.80 Median:75.00 stddev:1.14 (1.5%) stddev-sans-first:0.88 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: Values: 77.0 74.0 75.0 74.0 75.0 74.0 75.0 76.0 75.0 73.0 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 69.0 70.0 69.0 69.0 69.0 68.0 07:57:00 INFO - 2015-12-14 07:57:00,248 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.00 stddev:4.06 (4.7%) stddev-sans-first:4.08 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 86.0 84.0 93.0 88.0 93.0 85.0 94.0 85.0 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:129.00 stddev:5.15 (4.0%) stddev-sans-first:5.46 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: Values: 128.0 126.0 130.0 135.0 126.0 127.0 123.0 121.0 130.0 138.0 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:151.50 stddev:6.06 (4.0%) stddev-sans-first:5.21 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: Values: 138.0 151.0 152.0 149.0 154.0 140.0 152.0 150.0 141.0 154.0 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:1.20 (1.7%) stddev-sans-first:1.20 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 74.0 71.0 74.0 72.0 73.0 72.0 71.0 71.0 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:57:00 INFO - 2015-12-14 07:57:00,249 DEBUG : BROWSER_OUTPUT: 07:57:01 INFO - 2015-12-14 07:57:01,183 INFO : Browser exited with error code: 0 07:57:01 INFO - 2015-12-14 07:57:01,236 INFO : Completed test kraken (00:01:01) 07:57:01 INFO - 2015-12-14 07:57:01,236 INFO : Starting test v8_7 07:57:01 INFO - 2015-12-14 07:57:01,236 DEBUG : operating with platform_type : linux_ 07:57:01 INFO - 2015-12-14 07:57:01,236 INFO : Initialising browser for v8_7 test... 07:57:01 INFO - 2015-12-14 07:57:01,242 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp1PHPj/profile http://localhost:59595/getInfo.html 07:57:06 INFO - 2015-12-14 07:57:06,089 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:57:06 INFO - 2015-12-14 07:57:06,089 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:57:06 INFO - 2015-12-14 07:57:06,089 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:57:06 INFO - 2015-12-14 07:57:06,089 DEBUG : BROWSER_OUTPUT: __metrics 07:57:06 INFO - 2015-12-14 07:57:06,231 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] 07:57:07 INFO - 2015-12-14 07:57:07,198 INFO : Browser initialized. 07:57:07 INFO - 2015-12-14 07:57:07,199 INFO : Running cycle 1/1 for v8_7 test... 07:57:07 INFO - 2015-12-14 07:57:07,199 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp1PHPj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:57:19 INFO - 2015-12-14 07:57:19,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 143024128 07:57:19 INFO - 2015-12-14 07:57:19,222 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59595/tests/v8_7/run.html (next: http://localhost:59595/tests/v8_7/run.html) 07:57:40 INFO - 2015-12-14 07:57:40,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 137547776 07:57:40 INFO - 2015-12-14 07:57:40,869 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,869 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:57:40 INFO - 2015-12-14 07:57:40,869 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:57:40 INFO - 2015-12-14 07:57:40,870 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:57:40 INFO - 2015-12-14 07:57:40,870 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:57:40 INFO - 2015-12-14 07:57:40,870 DEBUG : BROWSER_OUTPUT: |0;Richards;166.55562958027983 07:57:40 INFO - 2015-12-14 07:57:40,870 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.39977872026554 07:57:40 INFO - 2015-12-14 07:57:40,870 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.79854504756577 07:57:40 INFO - 2015-12-14 07:57:40,871 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 07:57:40 INFO - 2015-12-14 07:57:40,871 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1066.0980810234541 07:57:40 INFO - 2015-12-14 07:57:40,871 DEBUG : BROWSER_OUTPUT: |5;Earley;706.2146892655368 07:57:40 INFO - 2015-12-14 07:57:40,871 DEBUG : BROWSER_OUTPUT: |6;Boyer;12390.243902439024 07:57:40 INFO - 2015-12-14 07:57:40,871 DEBUG : BROWSER_OUTPUT: |7;RegExp;26076.923076923078 07:57:40 INFO - 2015-12-14 07:57:40,871 DEBUG : BROWSER_OUTPUT: |8;Splay;603.3755274261604 07:57:40 INFO - 2015-12-14 07:57:40,872 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:57:40 INFO - 2015-12-14 07:57:40,872 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:57:40 INFO - 2015-12-14 07:57:40,872 DEBUG : BROWSER_OUTPUT: __startTimestamp1450108660866__endTimestamp 07:57:40 INFO - 2015-12-14 07:57:40,872 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,872 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:57:40 INFO - 2015-12-14 07:57:40,872 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:57:40 INFO - 2015-12-14 07:57:40,873 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,873 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 07:57:40 INFO - 2015-12-14 07:57:40,873 DEBUG : BROWSER_OUTPUT: Values: 166.6 07:57:40 INFO - 2015-12-14 07:57:40,873 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,873 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.40 Median:184.40 stddev:0.00 (0.0%) 07:57:40 INFO - 2015-12-14 07:57:40,873 DEBUG : BROWSER_OUTPUT: Values: 184.4 07:57:40 INFO - 2015-12-14 07:57:40,874 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,874 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 07:57:40 INFO - 2015-12-14 07:57:40,874 DEBUG : BROWSER_OUTPUT: Values: 279.8 07:57:40 INFO - 2015-12-14 07:57:40,874 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,875 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 07:57:40 INFO - 2015-12-14 07:57:40,875 DEBUG : BROWSER_OUTPUT: Values: 5143.6 07:57:40 INFO - 2015-12-14 07:57:40,875 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,875 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 07:57:40 INFO - 2015-12-14 07:57:40,875 DEBUG : BROWSER_OUTPUT: Values: 1066.1 07:57:40 INFO - 2015-12-14 07:57:40,876 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,876 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:706.21 Median:706.21 stddev:0.00 (0.0%) 07:57:40 INFO - 2015-12-14 07:57:40,876 DEBUG : BROWSER_OUTPUT: Values: 706.2 07:57:40 INFO - 2015-12-14 07:57:40,876 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,876 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12390.24 Median:12390.24 stddev:0.00 (0.0%) 07:57:40 INFO - 2015-12-14 07:57:40,876 DEBUG : BROWSER_OUTPUT: Values: 12390.2 07:57:40 INFO - 2015-12-14 07:57:40,876 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,877 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26076.92 Median:26076.92 stddev:0.00 (0.0%) 07:57:40 INFO - 2015-12-14 07:57:40,877 DEBUG : BROWSER_OUTPUT: Values: 26076.9 07:57:40 INFO - 2015-12-14 07:57:40,877 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,877 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.38 Median:603.38 stddev:0.00 (0.0%) 07:57:40 INFO - 2015-12-14 07:57:40,878 DEBUG : BROWSER_OUTPUT: Values: 603.4 07:57:40 INFO - 2015-12-14 07:57:40,878 DEBUG : BROWSER_OUTPUT: 07:57:40 INFO - 2015-12-14 07:57:40,879 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:57:40 INFO - 2015-12-14 07:57:40,879 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:57:40 INFO - 2015-12-14 07:57:40,879 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:57:40 INFO - 2015-12-14 07:57:40,879 DEBUG : BROWSER_OUTPUT: 07:57:41 INFO - 2015-12-14 07:57:41,803 INFO : Browser exited with error code: 0 07:57:41 INFO - 2015-12-14 07:57:41,817 INFO : Completed test v8_7 (00:00:40) 07:57:41 INFO - 2015-12-14 07:57:41,904 INFO : Completed test suite (00:20:17) 07:57:41 INFO - 2015-12-14 07:57:41,904 DEBUG : Working with test: dromaeo_css 07:57:41 INFO - 2015-12-14 07:57:41,905 DEBUG : Generating results file: dromaeo_css 07:57:41 INFO - 2015-12-14 07:57:41,906 DEBUG : Working with test: kraken 07:57:41 INFO - 2015-12-14 07:57:41,906 DEBUG : Generating results file: kraken 07:57:41 INFO - 2015-12-14 07:57:41,906 INFO : javascript benchmark 07:57:41 INFO - 2015-12-14 07:57:41,906 DEBUG : Working with test: v8_7 07:57:41 INFO - 2015-12-14 07:57:41,906 DEBUG : Generating results file: v8_7 07:57:41 INFO - 2015-12-14 07:57:41,907 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:57:41 INFO - 2015-12-14 07:57:41,955 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 07:57:41 INFO - 2015-12-14 07:57:41,956 DEBUG : process_Request line: dromaeo_css 6337.06 graph.html#tests=[[72,132,43]] 07:57:41 INFO - 2015-12-14 07:57:41,956 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:57:41 INFO - 2015-12-14 07:57:41,985 DEBUG : process_Request line: kraken 1551.60 graph.html#tests=[[232,132,43]] 07:57:41 INFO - 2015-12-14 07:57:41,985 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:57:42 INFO - 2015-12-14 07:57:42,016 DEBUG : process_Request line: v8_7 21374.18 graph.html#tests=[[230,132,43]] 07:57:42 INFO - 2015-12-14 07:57:42,018 INFO : javascript benchmark 07:57:42 INFO - 2015-12-14 07:57:42,021 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2661.214941592231, 2666.4933662604117, 2729.358600728828, 2738.383863630683, 2743.478739039583, 4634.096351211515, 4795.328653988445, 4802.567768900798, 4820.903581928359, 4881.170201065818, 4727.338172655831, 4744.240921452569, 4755.429348478179, 4898.730569818658, 4903.0, 4328.13437312538, 4389.824407023715, 4428.822847086113, 4464.955350446503, 4483.753393563353, 4370.6940514164025, 4425.137098265839, 4445.755483448409, 4468.374427580141, 4504.7747612619405, 4212.410262563244, 4338.934915976263, 4346.0655958968655, 4391.385206071152, 4420.823167073346, 4436.622887054604, 4450.799714012877, 4451.087527056946, 4456.041950980522, 4476.440444944382, 4428.778561071966, 4442.155990361821, 4454.844080457168, 4464.486584042844, 4469.508354081048, 4503.527129651372, 4577.862664120082, 4677.4854765975715, 4699.718016918961, 4746.050789842011, 5091.1090559152, 5104.795808167669, 5137.2037334213255, 5173.379194496684, 5204.115300398941, 5165.509276618753, 5183.170692689189, 5183.455737147583, 5207.3751149862255, 5214.661047031968, 4572.748498832563, 4656.697314674535, 4667.789949452283, 4805.1590971579835, 4859.319695242669, 5201.973990130101, 5268.051750684914, 5271.339389033194, 5282.656627319212, 5308.973455132699, 4787.2101103318255, 5044.722540260247, 5044.8234311798915, 5050.787810925352, 5058.822941197114, 5026.4973502649445, 5068.16375298079, 5098.566621837112, 5103.157978933435, 5148.0, 5097.592192624581, 5114.820981265712, 5117.641765076409, 5128.564072053842, 5164.8192313268855, 4845.854624361275, 4962.528559786814, 5097.9745101275, 5102.183650615883, 5105.693658380509, 4137.379393091061, 4140.855070072533, 4202.306619407825, 4267.381229721673, 4297.290946993773, 3718.7420403638225, 3746.925061498755, 3757.342465068602, 3782.583915769263, 3794.317022935843, 4203.117345357509, 4448.065906159743, 4453.554644535585, 4458.554144585581, 4467.039586488855, 5068.239764035424, 5070.670406423571, 5085.211792172219, 5137.075326441276, 5195.376554813447, 4423.071155057474, 4433.8226470941445, 4438.467383913887, 4442.555744425532, 4476.171908196994, 4358.585934336296, 4494.52807455219, 4543.591076803037, 4556.908861822745, 4586.793594288265, 4807.351007613997, 4811.4707382187935, 4874.8537543873745, 4931.506849315183, 4963.057019166491, 5120.052790233819, 5136.512031357015, 5138.743062846917, 5144.048351055067, 5209.6874187548865, 4610.2854057621125, 4726.929096063493, 4861.222204447272, 4891.559759621651, 4931.778069986931, 5021.799128034838, 5064.696118232918, 5080.415752188545, 5107.284980102714, 5128.974355128201, 5147.382314122329, 5177.4822517749435, 5189.506996835295, 5198.324217851655, 5215.687058776485, 4774.761261936958, 4860.635452341159, 4936.333594964633, 4992.975035124801, 4995.050940321327, 4925.581325587365, 4931.13705101613, 4952.083864485082, 4952.380952380952, 4958.752062396794, 4855.0, 4878.024395121061, 4891.413030436228, 4906.705597664151, 4937.308776771183, 4805.0, 4916.70499770015, 4968.403791545038, 5028.497150284942, 5046.57104146137, 4915.0, 4946.208606622923, 4954.1825598775795, 4965.925511117408, 5002.699838009731], "unit": "ms", "name": "dojo.html", "value": 4689.502278945091}, {"lowerIsBetter": false, "replicates": [559.0719405786394, 570.0679389198659, 575.8445219790657, 581.2269681323837, 595.3391735173959, 35378.82310588447, 36036.27927441456, 36375.272494550125, 36415.0, 36417.63582364176, 39540.20919581607, 40134.19731605366, 40284.39573406394, 40335.0, 40379.79810100945, 7835.333996610295, 7977.082635496934, 7984.121746607869, 7999.080105787822, 8010.759677209693, 7818.296353328199, 7928.563928983904, 7938.682452701885, 7945.205479452066, 7974.920250797476, 7848.960755196216, 7924.881126783102, 7930.048394192705, 7931.286184243446, 7948.880766788503, 7842.647080881346, 7877.566733829608, 7923.4057445691515, 7935.682572697086, 7954.045514538292, 7741.3419859312025, 7832.216778322122, 7869.095054068741, 7881.330086942617, 7897.486663366863, 37285.813570932245, 37567.24865502702, 37614.0, 37625.24749505022, 37652.24695506074, 2930.7362337389523, 2956.2609347663083, 3086.2284428892776, 3339.9499007514905, 3720.293144302601, 28330.150095497167, 28410.431791364055, 28761.137165884847, 29072.0, 29512.26219344512, 3201.3917355702574, 3347.7991320520846, 3374.0889959710985, 3405.523226748257, 3447.896563103111, 207460.0, 208362.95818520963, 208388.0, 209315.0, 209549.0, 50958.74520627373, 52152.478475215525, 53606.731966340696, 54030.0, 56113.0, 55878.72060639671, 55977.0, 55986.440135598124, 56137.0, 56228.0, 12529.686757830945, 12697.0, 12721.173123747112, 12762.68093297675, 12768.744625107445, 10189.847152292721, 10218.540165692562, 10285.588576457008, 10322.638707645196, 10448.164146868232, 19104.904475477535, 19182.424527264204, 19244.903775481314, 19337.129829157722, 19425.4172374829, 7383.704651813975, 7491.213422590658, 7547.28300811422, 7639.860838964987, 7644.0827100748265, 798.4131663227523, 813.9267465928095, 837.7905523619095, 873.4846440600077, 917.8072604753077, 26188.476230475666, 26331.34171645686, 27050.0, 29016.854915725708, 29468.705312947026, 920.7145784806731, 920.7974245665943, 930.4696323095906, 942.3827393057559, 946.9621215151454, 11979.28124312544, 12279.263244205198, 12287.508499659914, 12298.20061695987, 12355.505779768708, 264807.0, 270459.0, 271240.0, 271240.0, 271755.0, 44275.778621106685, 44320.55679443229, 44590.33114503285, 44686.77656611696, 44762.77618611951, 1213.1932265043824, 1279.2196759976407, 1283.5700040486543, 1288.1305119044794, 1288.8711128887037, 23869.403264917823, 29377.0, 32077.358452830347, 32553.837230813693, 32606.83696581502, 42437.78781106075, 43113.0, 43115.353269700354, 43142.56857431385, 43289.35065974076, 190396.0, 195656.0, 195778.0, 196294.0, 196754.0649187037, 39332.80333598428, 43948.12103757971, 44420.0, 44935.0, 45085.32372014357, 43593.78203109091, 43814.78092609517, 43826.78086609674, 44099.0, 44215.778921105186, 36333.0, 36722.8163859179, 37396.62603373932, 37503.0, 37814.43278350882, 37318.81340593279, 37375.252494950495, 37407.251854963295, 37482.812585936896, 37674.0, 36243.45634815533, 36328.0, 36967.0, 37211.0, 37230.0, 30780.53829192519, 31091.067267981998, 33142.17144571405, 33414.49878251877, 33512.83243583766, 25623.74376256288, 25830.612540811526, 26125.0, 26327.4734505305, 26445.603315950662], "unit": "ms", "name": "ext.html", "value": 17206.23798720839}, {"lowerIsBetter": false, "replicates": [328.0404815913454, 328.9375018746437, 330.60327606871755, 334.07461332110057, 335.4147013461507, 14946.925265373671, 15278.388864445422, 15419.460318888841, 16088.0, 16663.916680416613, 14391.856081439182, 14763.335649895753, 15296.617584560363, 15541.844581554182, 15630.765538516904, 4712.175369310366, 5157.432682404932, 5158.74206289684, 5166.018456493273, 5167.018266529366, 5046.0, 5067.493250674921, 5072.695638261716, 5073.289739436482, 5083.923741143867, 4731.6451266155, 4846.151923413388, 4885.413750349963, 4909.852704418873, 5004.049230646184, 4937.456879743226, 4945.77744001519, 4952.158133117378, 4984.277279794428, 5220.92168617471, 5123.666961647518, 5129.6409251352425, 5152.768125434364, 5163.251328557338, 5163.483651634844, 11541.711457213552, 11788.0, 16216.75674864878, 18983.0, 19040.0, 1641.089195496511, 1693.9322427102902, 1769.3364988129451, 1773.3084097202102, 1881.0594702648675, 9049.592768325441, 9073.228775554086, 9248.213901818353, 10862.819666271187, 12513.687157821127, 1722.4488163787594, 1731.852792512638, 1732.1425894182335, 1757.92089355978, 1785.5000599832067, 52899.97058398256, 54370.99999999961, 54640.72679636616, 55549.444505555235, 55881.44118558803, 9520.571574279174, 9616.807663846685, 9793.755156121155, 9828.262880284008, 9975.600975961026, 12428.067894907917, 12461.813072803916, 12463.255144279627, 12470.625881223577, 12481.500739970299, 6565.80302590923, 6573.5398522103, 6635.2037755469655, 6756.594604323658, 7196.64016799158, 6138.539609529304, 6145.877082458326, 6146.907796383058, 6439.291677915426, 6468.3855033771715, 4026.275270451288, 4068.267711811843, 4099.959000409957, 4114.979425102915, 4164.646005089601, 1649.0682764238406, 1714.262866967216, 1723.9827601724073, 1735.1324337831084, 1748.4404990403202, 742.6323969635065, 773.2885745114509, 787.5196130360475, 901.2474583722534, 1009.4145395670494, 13539.458421663023, 15142.772858407132, 15868.0, 15882.523524294289, 15970.441034563735, 844.9775771316653, 846.5894041389921, 846.716350022737, 890.7951171230524, 905.0451773379148, 9005.819883602291, 9216.262698984065, 9216.308776841764, 9247.445153290824, 9392.530373481299, 488867.0, 490529.0, 490797.0, 493804.0, 497523.09907604015, 70047.0, 70483.6475817628, 72481.6375918117, 73211.63394183101, 73588.63205683937, 1102.862142232237, 1106.2975010868156, 1181.3030312115893, 1196.5991392883482, 1198.6523908066738, 14372.856271437151, 14521.353166986886, 14523.927380363031, 14563.0, 14777.630559236106, 33794.831025844716, 34027.48958765571, 34254.82872585621, 34532.482012769324, 35353.116172095906, 46247.0, 46644.53355466402, 47589.0, 48599.5140048595, 48695.0, 8414.158584141536, 8532.23209911111, 8734.344924130843, 8785.868211976953, 8917.464952102895, 10343.63797267092, 10349.586016559555, 10424.635137770141, 10453.47732613351, 13740.793888091886, 13072.411741471466, 13463.259520726455, 13540.255285959367, 13850.0, 13883.375248113656, 12869.871301287241, 13119.883245534058, 13780.242086685328, 14140.858591413955, 14335.92832035833, 14254.643633909236, 14488.565343039725, 14537.20045397471, 14683.192424416333, 15052.623684407978, 8823.647054117764, 11642.708932276422, 11741.706457338634, 11948.940255298668, 12316.630501084981, 14403.495877644233, 15326.693466130839, 15361.0, 15844.841551584337, 15894.364225430852], "unit": "ms", "name": "jquery.html", "value": 8275.160433172668}, {"lowerIsBetter": false, "replicates": [1466.0690461556908, 1672.4313733330664, 1709.5213340264722, 1718.5617667494794, 1739.8260173982599, 6790.083338749268, 6889.724411023553, 7014.29857014299, 7023.508354415187, 7139.428845692345, 7039.04972828668, 7097.396721278685, 7106.680199391027, 7130.0, 7151.749688760894, 2003.2587942461273, 2045.3659365596714, 2047.2936836791282, 2047.4369548374168, 2049.221295907553, 2033.3493282149718, 2037.643412402831, 2058.3207541511265, 2114.587655407196, 2117.1637203304685, 1678.2280151130494, 1704.9062301573408, 1978.6042791441698, 2028.3205126282712, 2051.887146206958, 1939.1273926732956, 1962.1856929374292, 1963.7447131872907, 1965.705144228363, 1967.655660259456, 1982.5241941933975, 1986.7781314491629, 2067.2041264113273, 2073.668213085914, 2080.6462901306663, 7007.229204787469, 7071.717131314741, 7091.042709234239, 7107.786766397016, 7123.145222573325, 4140.648044916155, 4181.581841815824, 4201.516825565069, 4219.641330486912, 4239.724417912826, 2641.1152263991394, 2670.198940317897, 2702.594610808375, 2707.945841083167, 2718.293243756618, 846.5005646668434, 856.618804631939, 857.4126723194631, 878.0604752914384, 890.5057692980394, 9330.860037099448, 9354.017828128084, 9409.811803763887, 9416.529173541296, 9427.575759090789, 3640.7087433005295, 3652.908677283036, 3653.8355773990234, 3749.250149970017, 3814.0, 7674.386049116058, 7724.6523906424345, 7728.381729461629, 7728.690852365842, 7734.110577283572, 4020.7587544747407, 4030.375291829771, 4041.9086846551268, 4048.0689441428635, 4057.89855253621, 3688.354537955847, 3711.925761484755, 3712.9628703713156, 3724.2923844469465, 3730.3844865597416, 3026.455238057171, 3033.1203950854006, 3063.6170478690165, 3099.395617854542, 3100.612423447069, 902.2105657549644, 902.4359775140537, 904.2585080234145, 905.0949050949051, 906.9773255668529, 753.6985205917567, 773.8374941262398, 960.5564052870399, 1029.0429900192892, 1046.0480962324248, 6213.099100630474, 6338.58799178052, 6404.679766011681, 6439.742410303629, 6473.029045643191, 572.6621293436892, 578.6152208781114, 578.6875087452728, 580.0516156084832, 736.0799001248439, 5100.38795344561, 5153.2785410042625, 5167.767450464738, 5205.063088644005, 5208.244804503326, 7794.025746781653, 8140.063892652421, 8281.792955176168, 8293.543855088028, 8315.750527484186, 8140.063892652421, 8155.429119961545, 8159.46963447374, 8193.385496087818, 8204.056533498604, 6448.033349828253, 6561.2782593914635, 6578.407943285128, 6586.341365863471, 6645.568038077509, 6098.695065246631, 6155.0, 6159.1069294951085, 6160.353162918008, 6165.10605962124, 7263.891041634274, 7355.926440735739, 7455.627218639155, 7467.738629147953, 7505.437092217996, 7430.665620047002, 7632.8855067175145, 7677.884831727641, 7699.34555562761, 7731.265529774662, 5885.646861188342, 5923.763049478145, 5934.7922822701, 5934.881302374015, 5948.8810223796145, 6050.42520960508, 6282.8429289266305, 6299.559030867796, 6306.779262725782, 6555.901661474986, 6325.399087086719, 6335.113084168128, 6359.586626869239, 6465.741370345134, 6514.315996820265, 6147.293061297829, 6282.528810339151, 6310.368963103653, 6314.052892066226, 6362.491000720024, 5470.56235501151, 5829.15477255787, 5918.408159184047, 5922.73347699346, 5965.28416590012, 5835.766569337349, 5882.676452795137, 5886.676232807065, 5890.352061273171, 5890.852728681817, 5714.857128571819, 5860.501857342174, 5919.230500034968, 5936.554758393051, 5964.045752679551], "unit": "ms", "name": "mootools.html", "value": 3888.5861474378744}, {"lowerIsBetter": false, "replicates": [296.28595085843114, 305.7783107247246, 306.03903742249355, 306.6442926205601, 309.6810285406033, 5549.0, 5583.106702927533, 5621.859453513664, 5632.493075623193, 5677.261955945732, 5535.640183388087, 5565.693886836222, 5574.331080270363, 5591.713905801668, 5596.4123767004485, 4213.389058586503, 4221.852235171769, 4243.278642630745, 4246.5541118182455, 4248.107897341562, 4232.894177645553, 4238.406623072772, 4246.68149888758, 4252.277112890816, 4256.914861702764, 4060.776657283848, 4151.398047283142, 4171.874843754692, 4190.832366705328, 4215.768132752697, 4172.5410204877435, 4196.538380778112, 4197.097624010852, 4202.747835129887, 4210.726302790325, 3631.4915911772373, 3645.963540364589, 3647.3252448296885, 3659.3413185626578, 3676.448532720087, 5311.973440132774, 5313.734313284359, 5320.361556613192, 5326.573874090063, 5348.304720386363, 4639.420072490939, 4665.113628410625, 4820.084184005028, 4824.179889418772, 4833.468318484964, 5778.3354914184565, 5782.248307720011, 5785.681787501686, 5791.942080579182, 5797.623154494944, 3953.189596132786, 3963.762174269524, 3972.2651309507546, 3974.5627980922077, 3982.7012974026775, 6020.789272375446, 6038.909416358758, 6083.087536869461, 6094.299155597163, 6109.5723299369065, 3944.6055394460323, 4063.1061166543313, 4077.103037331782, 4111.835526578963, 4112.444819949268, 4172.645325147336, 4173.728707633994, 4188.476440444944, 4190.811413486401, 4191.937120943188, 4792.059216017518, 4830.565249127525, 4831.758412079453, 4832.371791667061, 4837.080954618611, 5741.0, 5787.276590426197, 5828.970855145697, 5832.3292821326095, 5833.0, 1426.8787153092103, 1466.1716130386299, 1473.5505670770517, 1487.2638044168207, 1487.4719474586582, 971.3249291742171, 979.3878825733916, 989.1048601015948, 997.7854761226371, 998.2612866478753, 4964.255361695702, 5014.799408023711, 5055.620828437808, 5056.317397151338, 5056.873578160576, 5982.521398288127, 5993.9700301498215, 5994.760209591567, 5999.70001499932, 6003.009503431972, 5027.572656324181, 5036.798528058836, 5039.823606173766, 5040.823571174991, 5044.394672639233, 3136.40408322418, 3174.4762114251353, 3212.7429805615493, 3228.0961330827404, 3270.0, 5718.142278658152, 5718.771249149988, 5721.799737009184, 5731.197632331477, 5767.22142510764, 6261.9373806262265, 6281.937180628227, 6282.811515654537, 6292.087647291117, 6303.590266632654, 5551.72241387929, 5731.799387021518, 5732.484076433057, 5733.741981610921, 5740.339860916049, 6025.975584150792, 6055.424734650202, 6060.333363330118, 6076.726547305293, 6120.663363515049, 5873.2658417697785, 5903.055511118372, 5908.793192238251, 5913.2608423947, 5924.140999555127, 5549.361823390201, 5685.374608793112, 5687.829365119053, 5688.800891968926, 5711.914321285267, 4032.1330913853662, 4081.2653722330265, 4083.183363327406, 4086.81609327575, 4087.7956102194175, 6056.1824153740445, 6058.969705151446, 6059.939400606114, 6076.483498902643, 6088.726007329592, 5790.044642634087, 5841.561882858718, 5844.94155058444, 5846.649201047951, 5847.590668653153, 5714.628549144292, 5809.738561764646, 5853.619514731528, 5858.47273745365, 5863.208466857091, 5691.060974939254, 5721.542276617944, 5723.8569035774435, 5731.713414329351, 5754.108113242454, 5826.94173058264, 5870.354261031369, 5874.618149820248, 5884.0, 5897.262842144732, 5575.414581469049, 5735.36910939788, 5752.906947679928, 5755.71221438918, 5762.596618236683], "unit": "ms", "name": "prototype.html", "value": 4337.561991065652}, {"lowerIsBetter": false, "replicates": [687.7352219395534, 704.6265479295972, 751.7256201486457, 754.4153281207067, 771.5447885747408, 11386.259893106942, 11596.362200078993, 11606.36165010924, 11625.593104241343, 11690.590829320976, 11684.649460516199, 11745.823812642817, 11783.7643247135, 11812.232204906675, 11821.231619944698, 622.554873265615, 629.46181015232, 804.5695552879196, 809.0, 820.2125959079291, 807.7940125268049, 810.1291112054565, 812.2486699802688, 816.5304949653972, 820.122468958215, 850.7702920211539, 852.258535074483, 854.6965827131372, 856.0540602634093, 856.905740368559, 838.9412741108156, 842.1241908415241, 842.6166094427082, 842.7850898021027, 843.5023336231623, 626.8307556959595, 627.723801527331, 628.4720834499043, 629.6945981199115, 632.9335419780949, 11995.64013079609, 12154.270743755404, 12190.939045304805, 12246.81629775554, 12252.387380630933, 11201.215914885961, 11580.0, 11628.127890408168, 11688.181827272094, 11875.0499960003, 9221.585028673726, 9364.204042656382, 9465.479398633073, 9574.952125239399, 9727.805443891153, 3276.1318250663594, 3295.47272436409, 3321.136504508821, 3330.8001519908885, 3440.449528075496, 37509.24981500382, 37673.62326376756, 37696.0, 37841.81079094615, 37927.62072379296, 9052.27581793455, 9087.863682044775, 9105.088807791917, 9377.578008989612, 9630.27772917034, 17076.914615427093, 17123.657526849394, 17145.571360716083, 17167.57081072983, 17190.31238750461, 6488.675566221765, 6610.173728283965, 6788.287229840796, 6831.658417079226, 6834.453243740489, 3584.5698516178227, 3614.475900994341, 3614.945775813365, 3696.4085746280466, 3708.554973403209, 2596.519643865891, 2619.5546757051347, 2643.0881345935622, 2652.641893344374, 2653.270350653586, 469.80737897461876, 473.6116384564624, 475.40574282147315, 485.74741134610514, 485.9586935110555, 474.9477557468676, 562.4937556199371, 566.4335664335664, 586.3960121075299, 598.2103623217398, 7687.385009199251, 7730.884036739453, 7744.6514906829325, 7756.224377562312, 7972.2824945754, 475.04041835492114, 503.58202691765746, 567.1945836911596, 576.4869266352949, 582.9329627092939, 3829.3107240696386, 3879.3405121128912, 3995.220931918248, 4003.3794761811964, 4246.681498887596, 48927.0, 49103.75448122808, 49178.50821491739, 49221.50778492241, 49591.75204124028, 43078.138437231704, 43988.12023759507, 44226.0, 45072.0, 45095.0, 37067.77593344354, 38203.0, 38227.23545529074, 38305.425418618746, 39412.0, 7695.153533111241, 7903.0, 8015.597270477527, 8051.597420129087, 8167.428280020342, 30505.54241686421, 31442.0, 31705.365892681555, 31767.682323176472, 32243.838780805945, 35871.64128358683, 37769.433458498694, 41366.1726765469, 41860.37209441922, 42106.1578768429, 10118.342307750267, 10208.387496750218, 10315.381077135396, 10371.429571373646, 10418.479076046318, 11638.825417618573, 11639.88360116388, 11715.941420293186, 11805.23265987708, 11873.881261187278, 10674.679759607225, 10736.08743256832, 10828.5127169276, 10898.400587967737, 10929.672109836718, 10894.56421743153, 11199.776004480027, 11264.267822591506, 11386.715332116763, 11644.767104658029, 9671.129598336183, 10364.689059328231, 10385.532651030571, 10535.525901334611, 10556.947215263874, 8950.507722075348, 9121.45271283725, 9226.35415520907, 9229.769255768391, 9449.244060475008, 8746.38775285724, 8991.865122023306, 9196.954015229881, 9223.538823058954, 9319.58061887203], "unit": "ms", "name": "yui.html", "value": 5749.843554712147}], "name": "dromaeo_css", "value": 6337.065097395669}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 115.0, 114.0, 112.0, 123.0, 113.0, 112.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.5}, {"lowerIsBetter": true, "replicates": [160.0, 132.0, 159.0, 175.0, 132.0, 158.0, 154.0, 140.0, 172.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 160.0, 162.0, 164.0, 168.0, 161.0, 163.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 77.0, 74.0, 140.0, 73.0, 79.0, 76.0, 72.0, 86.0], "unit": "ms", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 132.0, 94.0, 95.0, 96.0, 132.0, 95.0, 97.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 111.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 149.0, 148.0, 149.0, 148.0, 149.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 75.0, 74.0, 75.0, 74.0, 75.0, 76.0, 75.0, 73.0], "unit": "ms", "name": "json-parse-financial", "value": 74.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 84.0, 93.0, 88.0, 93.0, 85.0, 94.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [128.0, 126.0, 130.0, 135.0, 126.0, 127.0, 123.0, 121.0, 130.0, 138.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [138.0, 151.0, 152.0, 149.0, 154.0, 140.0, 152.0, 150.0, 141.0, 154.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 74.0, 71.0, 74.0, 72.0, 73.0, 72.0, 71.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1551.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [184.39977872026554], "unit": "score", "name": "DeltaBlue", "value": 358.5579139999999}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [706.2146892655368], "unit": "score", "name": "Earley", "value": 943.711608}, {"lowerIsBetter": false, "replicates": [12390.243902439024], "unit": "score", "name": "Boyer", "value": 53.789336614173266}, {"lowerIsBetter": false, "replicates": [26076.923076923078], "unit": "score", "name": "RegExp", "value": 34.934528023598794}, {"lowerIsBetter": false, "replicates": [603.3755274261604], "unit": "score", "name": "Splay", "value": 135.05851048951044}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21374.179345583554}]} 07:57:42 INFO - RETURN: dromaeo_css: 6337.06 07:57:42 INFO - RETURN: kraken: 1551.60 07:57:42 INFO - RETURN: v8_7: 21374.18 07:57:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21374.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1551.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6337.06"}}} 07:57:42 INFO - Return code: 0 07:57:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:57:42 INFO - # TBPL SUCCESS # 07:57:42 INFO - Running post-action listener: _resource_record_post_action 07:57:42 INFO - Running post-run listener: _resource_record_post_run 07:57:43 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 521768960; Read time: 16; Write time: 490972 07:57:43 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 244252672; Read time: 0; Write time: 311364 07:57:43 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273506304; Read time: 16; Write time: 179308 07:57:43 INFO - Running post-run listener: _upload_blobber_files 07:57:43 INFO - Blob upload gear active. 07:57:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:57:43 INFO - Copying logs to upload dir... 07:57:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1267.890641 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-14 07:57:42.948054) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:57:42.952062) ========= 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=6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009898 build_url: 'https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.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-14 07:57:43.006540) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:57:43.006860) ========= 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=6ef107882637bc5fc02d78b7000001c2-1450106525.667202-122583401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:57:43.056269) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 07:57:43.056589) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 07:57:43.056890) ========= ========= Total master_lag: 0.25 =========