builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1449195745.75 results: success (0) buildid: 20151203172317 builduid: fe95a629b4094e279219252d2745ba2c revision: a1440a731b1a7b16cb940a4f016b1fb7a726c87a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.753436) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.753866) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.754154) ========= 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-1449195744.955303-1807224540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005885 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.776411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.776717) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.789417) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.789686) ========= 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-1449195744.955303-1807224540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.838111) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.838454) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.838841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:25.839116) ========= 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-1449195744.955303-1807224540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 18:22:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 214M=0s 2015-12-03 18:22:26 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.205796 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:26.056984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:26.057289) ========= 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-1449195744.955303-1807224540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020248 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:26.107258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 18:22:26.107653) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a1440a731b1a7b16cb940a4f016b1fb7a726c87a --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 a1440a731b1a7b16cb940a4f016b1fb7a726c87a --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-1449195744.955303-1807224540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 18:22:26,241 truncating revision to first 12 chars 2015-12-03 18:22:26,241 Setting DEBUG logging. 2015-12-03 18:22:26,241 attempt 1/10 2015-12-03 18:22:26,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a1440a731b1a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 18:22:27,080 unpacking tar archive at: fx-team-a1440a731b1a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.098556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-03 18:22:27.218954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:27.219370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:27.226848) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:27.227099) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 18:22:27.227468) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-03 18:22:27.227768) ========= /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-1449195744.955303-1807224540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:22:27 INFO - MultiFileLogger online at 20151203 18:22:27 in /builds/slave/test 18:22:27 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 18:22:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:22:27 INFO - {'append_to_log': False, 18:22:27 INFO - 'base_work_dir': '/builds/slave/test', 18:22:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:22:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:22:27 INFO - 'branch': 'Fx-Team-Non-PGO', 18:22:27 INFO - 'buildbot_json_path': 'buildprops.json', 18:22:27 INFO - 'config_files': ('talos/linux_config.py',), 18:22:27 INFO - 'default_actions': ('clobber', 18:22:27 INFO - 'read-buildbot-config', 18:22:27 INFO - 'download-and-extract', 18:22:27 INFO - 'populate-webroot', 18:22:27 INFO - 'create-virtualenv', 18:22:27 INFO - 'install', 18:22:27 INFO - 'run-tests'), 18:22:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:22:27 INFO - 'download_minidump_stackwalk': True, 18:22:27 INFO - 'download_symbols': 'ondemand', 18:22:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:22:27 INFO - 'tooltool.py': '/tools/tooltool.py', 18:22:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:22:27 INFO - '/tools/misc-python/virtualenv.py')}, 18:22:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:22:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:22:27 INFO - 'installer_path': 'installer.exe', 18:22:27 INFO - 'log_level': 'info', 18:22:27 INFO - 'log_name': 'talos', 18:22:27 INFO - 'log_to_console': True, 18:22:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:22:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:22:27 INFO - 'opt_config_files': (), 18:22:27 INFO - 'pip_index': False, 18:22:27 INFO - 'sps_profile': False, 18:22:27 INFO - 'sps_profile_interval': 0, 18:22:27 INFO - 'suite': 'dromaeojs-e10s', 18:22:27 INFO - 'system_bits': '64', 18:22:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:22:27 INFO - 'title': 'talos-linux64-ix-007', 18:22:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:22:27 INFO - 'use_talos_json': True, 18:22:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:22:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:22:27 INFO - 'work_dir': 'build'} 18:22:27 INFO - ##### 18:22:27 INFO - ##### Running clobber step. 18:22:27 INFO - ##### 18:22:27 INFO - Running pre-action listener: _resource_record_pre_action 18:22:27 INFO - Running main action method: clobber 18:22:27 INFO - rmtree: /builds/slave/test/build 18:22:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:22:27 INFO - Running post-action listener: _resource_record_post_action 18:22:27 INFO - ##### 18:22:27 INFO - ##### Running read-buildbot-config step. 18:22:27 INFO - ##### 18:22:27 INFO - Running pre-action listener: _resource_record_pre_action 18:22:27 INFO - Running main action method: read_buildbot_config 18:22:27 INFO - Using buildbot properties: 18:22:27 INFO - { 18:22:27 INFO - "properties": { 18:22:27 INFO - "buildnumber": 528, 18:22:27 INFO - "product": "firefox", 18:22:27 INFO - "script_repo_revision": "production", 18:22:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:22:27 INFO - "repository": "", 18:22:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:22:27 INFO - "buildid": "20151203172317", 18:22:27 INFO - "slavename": "talos-linux64-ix-007", 18:22:27 INFO - "pgo_build": "False", 18:22:27 INFO - "basedir": "/builds/slave/test", 18:22:27 INFO - "project": "", 18:22:27 INFO - "platform": "ubuntu64_hw", 18:22:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:22:27 INFO - "slavebuilddir": "test", 18:22:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:22:27 INFO - "branch": "fx-team", 18:22:27 INFO - "repo_path": "integration/fx-team", 18:22:27 INFO - "stage_platform": "linux64", 18:22:27 INFO - "builduid": "fe95a629b4094e279219252d2745ba2c", 18:22:27 INFO - "revision": "a1440a731b1a7b16cb940a4f016b1fb7a726c87a" 18:22:27 INFO - }, 18:22:27 INFO - "sourcestamp": { 18:22:27 INFO - "repository": "", 18:22:27 INFO - "hasPatch": false, 18:22:27 INFO - "project": "", 18:22:27 INFO - "branch": "fx-team-linux64-talos", 18:22:27 INFO - "changes": [ 18:22:27 INFO - { 18:22:27 INFO - "category": null, 18:22:27 INFO - "files": [ 18:22:27 INFO - { 18:22:27 INFO - "url": null, 18:22:27 INFO - "name": "https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:22:27 INFO - } 18:22:27 INFO - ], 18:22:27 INFO - "repository": "", 18:22:27 INFO - "rev": "a1440a731b1a7b16cb940a4f016b1fb7a726c87a", 18:22:27 INFO - "who": "jlong@mozilla.com", 18:22:27 INFO - "when": 1449194901, 18:22:27 INFO - "number": 6742181, 18:22:27 INFO - "comments": "Bug 1229923 - fix the debugger flashing a paused state on startup", 18:22:27 INFO - "project": "", 18:22:27 INFO - "at": "Thu 03 Dec 2015 18:08:21", 18:22:27 INFO - "branch": "fx-team-linux64-talos", 18:22:27 INFO - "revlink": "", 18:22:27 INFO - "properties": [ 18:22:27 INFO - [ 18:22:27 INFO - "buildid", 18:22:27 INFO - "20151203172317", 18:22:27 INFO - "Change" 18:22:27 INFO - ], 18:22:27 INFO - [ 18:22:27 INFO - "builduid", 18:22:27 INFO - "fe95a629b4094e279219252d2745ba2c", 18:22:27 INFO - "Change" 18:22:27 INFO - ], 18:22:27 INFO - [ 18:22:27 INFO - "pgo_build", 18:22:27 INFO - "False", 18:22:27 INFO - "Change" 18:22:27 INFO - ] 18:22:27 INFO - ], 18:22:27 INFO - "revision": "a1440a731b1a7b16cb940a4f016b1fb7a726c87a" 18:22:27 INFO - } 18:22:27 INFO - ], 18:22:27 INFO - "revision": "a1440a731b1a7b16cb940a4f016b1fb7a726c87a" 18:22:27 INFO - } 18:22:27 INFO - } 18:22:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:22:27 INFO - Running post-action listener: _resource_record_post_action 18:22:27 INFO - ##### 18:22:27 INFO - ##### Running download-and-extract step. 18:22:27 INFO - ##### 18:22:27 INFO - Running pre-action listener: _resource_record_pre_action 18:22:27 INFO - Running main action method: download_and_extract 18:22:27 INFO - mkdir: /builds/slave/test/build/tests 18:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:27 INFO - https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:22:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/test_packages.json 18:22:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/test_packages.json 18:22:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:22:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:22:28 INFO - Downloaded 1302 bytes. 18:22:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:22:28 INFO - Using the following test package requirements: 18:22:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:22:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:28 INFO - u'jsshell-linux-x86_64.zip'], 18:22:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:22:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:22:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:22:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:22:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:22:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:22:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:22:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:28 INFO - https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/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 18:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/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 18:22:29 INFO - Downloaded 21790838 bytes. 18:22:29 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 18:22:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:22:29 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 18:22:30 INFO - Return code: 0 18:22:30 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 18:22:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:30 INFO - https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:22:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:22:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:22:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/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 18:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/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 18:22:31 INFO - Downloaded 21790838 bytes. 18:22:31 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 18:22:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:22:31 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 18:22:33 INFO - Return code: 0 18:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:33 INFO - https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:22:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:22:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:22:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/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 18:22:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/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 18:22:34 INFO - Downloaded 11132001 bytes. 18:22:34 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 18:22:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:22:34 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 18:22:34 INFO - Return code: 0 18:22:34 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')]} 18:22:34 INFO - https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:22:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:22:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:22:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/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 18:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SWL91GbgRsO6mvqr0AlcyA/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 18:22:35 INFO - Downloaded 57702191 bytes. 18:22:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:22:35 INFO - mkdir: /builds/slave/test/properties 18:22:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:22:35 INFO - Writing to file /builds/slave/test/properties/build_url 18:22:35 INFO - Contents: 18:22:35 INFO - build_url:https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:22:35 INFO - Running post-action listener: _resource_record_post_action 18:22:35 INFO - Running post-action listener: set_extra_try_arguments 18:22:35 INFO - ##### 18:22:35 INFO - ##### Running populate-webroot step. 18:22:35 INFO - ##### 18:22:35 INFO - Running pre-action listener: _resource_record_pre_action 18:22:35 INFO - Running main action method: populate_webroot 18:22:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:22:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:22:35 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:22:35 INFO - '../fennec_ids.txt'], 18:22:35 INFO - 'tests': ['tcheck2']}, 18:22:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:22:35 INFO - '--tppagecycles', 18:22:35 INFO - '7'], 18:22:35 INFO - 'tests': ['tsvgm']}}, 18:22:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:22:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:22:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:22:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:22:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:22:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:22:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:35 INFO - 'talos_options': ['--e10s'], 18:22:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:35 INFO - 'tests': ['damp', 'tps']}, 18:22:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:35 INFO - 'talos_options': ['--e10s'], 18:22:35 INFO - 'tests': ['damp', 'tps']}, 18:22:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:22:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:22:35 INFO - 'other': {'tests': ['a11yr', 18:22:35 INFO - 'ts_paint', 18:22:35 INFO - 'tpaint', 18:22:35 INFO - 'sessionrestore', 18:22:35 INFO - 'sessionrestore_no_auto_restore']}, 18:22:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:22:35 INFO - 'tests': ['a11yr', 18:22:35 INFO - 'ts_paint', 18:22:35 INFO - 'tpaint', 18:22:35 INFO - 'sessionrestore', 18:22:35 INFO - 'sessionrestore_no_auto_restore']}, 18:22:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:22:35 INFO - 'tests': ['a11yr', 18:22:35 INFO - 'ts_paint', 18:22:35 INFO - 'tpaint', 18:22:35 INFO - 'sessionrestore', 18:22:35 INFO - 'sessionrestore_no_auto_restore']}, 18:22:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:22:35 INFO - 'tests': ['a11yr', 18:22:35 INFO - 'ts_paint', 18:22:35 INFO - 'tpaint', 18:22:35 INFO - 'sessionrestore', 18:22:35 INFO - 'sessionrestore_no_auto_restore']}, 18:22:35 INFO - 'other_l64': {'tests': ['a11yr', 18:22:35 INFO - 'ts_paint', 18:22:35 INFO - 'tpaint', 18:22:35 INFO - 'sessionrestore', 18:22:35 INFO - 'sessionrestore_no_auto_restore']}, 18:22:35 INFO - 'other_nol64': {'tests': ['a11yr', 18:22:35 INFO - 'ts_paint', 18:22:35 INFO - 'tpaint', 18:22:35 INFO - 'sessionrestore', 18:22:35 INFO - 'sessionrestore_no_auto_restore']}, 18:22:35 INFO - 'svgr': {'tests': ['tsvgx', 18:22:35 INFO - 'tsvgr_opacity', 18:22:35 INFO - 'tart', 18:22:35 INFO - 'tscrollx', 18:22:35 INFO - 'cart']}, 18:22:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:22:35 INFO - 'tests': ['tsvgx', 18:22:35 INFO - 'tsvgr_opacity', 18:22:35 INFO - 'tart', 18:22:35 INFO - 'tscrollx', 18:22:35 INFO - 'cart']}, 18:22:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:35 INFO - 'tests': ['tp5o']}, 18:22:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:35 INFO - 'talos_options': ['--e10s'], 18:22:35 INFO - 'tests': ['tp5o']}, 18:22:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:35 INFO - 'talos_options': ['--xperf_path', 18:22:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:35 INFO - 'tests': ['tp5n']}, 18:22:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:35 INFO - 'talos_options': ['--e10s', 18:22:35 INFO - '--xperf_path', 18:22:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:35 INFO - 'tests': ['tp5n']}}, 18:22:35 INFO - 'talos.zip': {'path': '', 18:22:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:22:35 INFO - Running post-action listener: _resource_record_post_action 18:22:35 INFO - ##### 18:22:35 INFO - ##### Running create-virtualenv step. 18:22:35 INFO - ##### 18:22:35 INFO - Running pre-action listener: _resource_record_pre_action 18:22:35 INFO - Running main action method: create_virtualenv 18:22:35 INFO - Creating virtualenv /builds/slave/test/build/venv 18:22:35 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 18:22:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:22:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:22:35 INFO - Using real prefix '/usr' 18:22:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:22:36 INFO - Installing distribute.............................................................................................................................................................................................done. 18:22:38 INFO - Installing pip.................done. 18:22:38 INFO - Return code: 0 18:22:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:38 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 0x7f416cfa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d0b0>, '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 0x109dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e440>, '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-1449195744.955303-1807224540', '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 18:22:38 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 18:22:38 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 18:22:38 INFO - Using env: {'DISPLAY': ':0', 18:22:38 INFO - 'HOME': '/home/cltbld', 18:22:38 INFO - 'LANG': 'en_US.UTF-8', 18:22:38 INFO - 'LANGUAGE': 'en_US:en', 18:22:38 INFO - 'LOGNAME': 'cltbld', 18:22:38 INFO - 'MAIL': '/var/mail/cltbld', 18:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:38 INFO - 'MOZ_NO_REMOTE': '1', 18:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:38 INFO - 'NO_EM_RESTART': '1', 18:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:38 INFO - 'PWD': '/builds/slave/test', 18:22:38 INFO - 'SHELL': '/bin/bash', 18:22:38 INFO - 'SHLVL': '1', 18:22:38 INFO - 'TERM': 'linux', 18:22:38 INFO - 'TMOUT': '86400', 18:22:38 INFO - 'USER': 'cltbld', 18:22:38 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449195744.955303-1807224540', 18:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:38 INFO - '_': '/tools/buildbot/bin/python'} 18:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:22:38 INFO - Cleaning up... 18:22:38 INFO - Return code: 0 18:22:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:38 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 0x7f416cfa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d0b0>, '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 0x109dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e440>, '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-1449195744.955303-1807224540', '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 18:22:38 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 18:22:38 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 18:22:38 INFO - Using env: {'DISPLAY': ':0', 18:22:38 INFO - 'HOME': '/home/cltbld', 18:22:38 INFO - 'LANG': 'en_US.UTF-8', 18:22:38 INFO - 'LANGUAGE': 'en_US:en', 18:22:38 INFO - 'LOGNAME': 'cltbld', 18:22:38 INFO - 'MAIL': '/var/mail/cltbld', 18:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:38 INFO - 'MOZ_NO_REMOTE': '1', 18:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:38 INFO - 'NO_EM_RESTART': '1', 18:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:38 INFO - 'PWD': '/builds/slave/test', 18:22:38 INFO - 'SHELL': '/bin/bash', 18:22:38 INFO - 'SHLVL': '1', 18:22:38 INFO - 'TERM': 'linux', 18:22:38 INFO - 'TMOUT': '86400', 18:22:38 INFO - 'USER': 'cltbld', 18:22:38 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449195744.955303-1807224540', 18:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:38 INFO - '_': '/tools/buildbot/bin/python'} 18:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:38 INFO - Downloading/unpacking psutil>=0.7.1 18:22:38 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 18:22:38 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 18:22:38 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 18:22:38 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 18:22:38 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 18:22:38 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 18:22:40 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:22:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:22:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:40 INFO - Installing collected packages: psutil 18:22:40 INFO - Running setup.py install for psutil 18:22:40 INFO - building 'psutil._psutil_linux' extension 18:22:40 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 18:22:40 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 18:22:40 INFO - building 'psutil._psutil_posix' extension 18:22:40 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 18:22:40 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 18:22:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:41 INFO - Successfully installed psutil 18:22:41 INFO - Cleaning up... 18:22:41 INFO - Return code: 0 18:22:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:41 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 0x7f416cfa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d0b0>, '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 0x109dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e440>, '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-1449195744.955303-1807224540', '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 18:22:41 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 18:22:41 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 18:22:41 INFO - Using env: {'DISPLAY': ':0', 18:22:41 INFO - 'HOME': '/home/cltbld', 18:22:41 INFO - 'LANG': 'en_US.UTF-8', 18:22:41 INFO - 'LANGUAGE': 'en_US:en', 18:22:41 INFO - 'LOGNAME': 'cltbld', 18:22:41 INFO - 'MAIL': '/var/mail/cltbld', 18:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:41 INFO - 'MOZ_NO_REMOTE': '1', 18:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:41 INFO - 'NO_EM_RESTART': '1', 18:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:41 INFO - 'PWD': '/builds/slave/test', 18:22:41 INFO - 'SHELL': '/bin/bash', 18:22:41 INFO - 'SHLVL': '1', 18:22:41 INFO - 'TERM': 'linux', 18:22:41 INFO - 'TMOUT': '86400', 18:22:41 INFO - 'USER': 'cltbld', 18:22:41 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449195744.955303-1807224540', 18:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:41 INFO - '_': '/tools/buildbot/bin/python'} 18:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:22:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:22:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:22:42 INFO - Installing collected packages: mozsystemmonitor 18:22:42 INFO - Running setup.py install for mozsystemmonitor 18:22:43 INFO - Successfully installed mozsystemmonitor 18:22:43 INFO - Cleaning up... 18:22:43 INFO - Return code: 0 18:22:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:43 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 0x7f416cfa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d0b0>, '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 0x109dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e440>, '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-1449195744.955303-1807224540', '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 18:22:43 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 18:22:43 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 18:22:43 INFO - Using env: {'DISPLAY': ':0', 18:22:43 INFO - 'HOME': '/home/cltbld', 18:22:43 INFO - 'LANG': 'en_US.UTF-8', 18:22:43 INFO - 'LANGUAGE': 'en_US:en', 18:22:43 INFO - 'LOGNAME': 'cltbld', 18:22:43 INFO - 'MAIL': '/var/mail/cltbld', 18:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:43 INFO - 'MOZ_NO_REMOTE': '1', 18:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:43 INFO - 'NO_EM_RESTART': '1', 18:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:43 INFO - 'PWD': '/builds/slave/test', 18:22:43 INFO - 'SHELL': '/bin/bash', 18:22:43 INFO - 'SHLVL': '1', 18:22:43 INFO - 'TERM': 'linux', 18:22:43 INFO - 'TMOUT': '86400', 18:22:43 INFO - 'USER': 'cltbld', 18:22:43 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449195744.955303-1807224540', 18:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:43 INFO - '_': '/tools/buildbot/bin/python'} 18:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:43 INFO - Downloading/unpacking blobuploader==1.2.4 18:22:43 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 18:22:43 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 18:22:43 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 18:22:43 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 18:22:43 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 18:22:43 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 18:22:45 INFO - Downloading blobuploader-1.2.4.tar.gz 18:22:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:22:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:22:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:45 INFO - Downloading docopt-0.6.1.tar.gz 18:22:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:22:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:22:45 INFO - Installing collected packages: blobuploader, requests, docopt 18:22:45 INFO - Running setup.py install for blobuploader 18:22:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:22:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:22:46 INFO - Running setup.py install for requests 18:22:46 INFO - Running setup.py install for docopt 18:22:46 INFO - Successfully installed blobuploader requests docopt 18:22:46 INFO - Cleaning up... 18:22:46 INFO - Return code: 0 18:22:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:46 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 0x7f416cfa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d0b0>, '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 0x109dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e440>, '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-1449195744.955303-1807224540', '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 18:22:46 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 18:22:46 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 18:22:46 INFO - Using env: {'DISPLAY': ':0', 18:22:46 INFO - 'HOME': '/home/cltbld', 18:22:46 INFO - 'LANG': 'en_US.UTF-8', 18:22:46 INFO - 'LANGUAGE': 'en_US:en', 18:22:46 INFO - 'LOGNAME': 'cltbld', 18:22:46 INFO - 'MAIL': '/var/mail/cltbld', 18:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:46 INFO - 'MOZ_NO_REMOTE': '1', 18:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:46 INFO - 'NO_EM_RESTART': '1', 18:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:46 INFO - 'PWD': '/builds/slave/test', 18:22:46 INFO - 'SHELL': '/bin/bash', 18:22:46 INFO - 'SHLVL': '1', 18:22:46 INFO - 'TERM': 'linux', 18:22:46 INFO - 'TMOUT': '86400', 18:22:46 INFO - 'USER': 'cltbld', 18:22:46 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449195744.955303-1807224540', 18:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:46 INFO - '_': '/tools/buildbot/bin/python'} 18:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:22:46 INFO - Running setup.py (path:/tmp/pip-jAUSff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:22:46 INFO - Running setup.py (path:/tmp/pip-KfZTOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:22:46 INFO - Running setup.py (path:/tmp/pip-OUjeKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:22:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:22:46 INFO - Running setup.py (path:/tmp/pip-vhBLV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:22:47 INFO - Running setup.py (path:/tmp/pip-DisaRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:22:47 INFO - Running setup.py (path:/tmp/pip-Qu9mO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:22:47 INFO - Running setup.py (path:/tmp/pip-9VD1Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:47 INFO - Running setup.py (path:/tmp/pip-Iyta91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:47 INFO - Running setup.py (path:/tmp/pip-ZXg6bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:47 INFO - Running setup.py (path:/tmp/pip-8adD7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:47 INFO - Running setup.py (path:/tmp/pip-kqurLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:47 INFO - Running setup.py (path:/tmp/pip-DWLIEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:47 INFO - Running setup.py (path:/tmp/pip-f0c0N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:47 INFO - Running setup.py (path:/tmp/pip-8wijci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:47 INFO - Running setup.py (path:/tmp/pip-dale_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:47 INFO - Running setup.py (path:/tmp/pip-gebf9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:47 INFO - Running setup.py (path:/tmp/pip-8GE7SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:22:47 INFO - Running setup.py install for manifestparser 18:22:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:22:48 INFO - Running setup.py install for mozcrash 18:22:48 INFO - Running setup.py install for mozdebug 18:22:48 INFO - Running setup.py install for mozdevice 18:22:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:22:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:22:48 INFO - Running setup.py install for mozfile 18:22:48 INFO - Running setup.py install for mozhttpd 18:22:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:22:48 INFO - Running setup.py install for mozinfo 18:22:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:22:48 INFO - Running setup.py install for mozInstall 18:22:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:22:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:22:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:22:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:22:48 INFO - Running setup.py install for mozleak 18:22:48 INFO - Running setup.py install for mozlog 18:22:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:22:48 INFO - Running setup.py install for moznetwork 18:22:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:22:49 INFO - Running setup.py install for mozprocess 18:22:49 INFO - Running setup.py install for mozprofile 18:22:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:22:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:22:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:22:49 INFO - Running setup.py install for mozrunner 18:22:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:22:49 INFO - Running setup.py install for mozscreenshot 18:22:49 INFO - Running setup.py install for moztest 18:22:49 INFO - Running setup.py install for mozversion 18:22:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:22:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:22:49 INFO - Cleaning up... 18:22:49 INFO - Return code: 0 18:22:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f416cfa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d0b0>, '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 0x109dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e440>, '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-1449195744.955303-1807224540', '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 18:22:49 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 18:22:49 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 18:22:49 INFO - Using env: {'DISPLAY': ':0', 18:22:49 INFO - 'HOME': '/home/cltbld', 18:22:49 INFO - 'LANG': 'en_US.UTF-8', 18:22:49 INFO - 'LANGUAGE': 'en_US:en', 18:22:49 INFO - 'LOGNAME': 'cltbld', 18:22:49 INFO - 'MAIL': '/var/mail/cltbld', 18:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:49 INFO - 'MOZ_NO_REMOTE': '1', 18:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:49 INFO - 'NO_EM_RESTART': '1', 18:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:49 INFO - 'PWD': '/builds/slave/test', 18:22:49 INFO - 'SHELL': '/bin/bash', 18:22:49 INFO - 'SHLVL': '1', 18:22:49 INFO - 'TERM': 'linux', 18:22:49 INFO - 'TMOUT': '86400', 18:22:49 INFO - 'USER': 'cltbld', 18:22:49 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449195744.955303-1807224540', 18:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:49 INFO - '_': '/tools/buildbot/bin/python'} 18:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:22:49 INFO - Running setup.py (path:/tmp/pip-1kRbVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:22:49 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)) 18:22:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:22:49 INFO - Running setup.py (path:/tmp/pip-UwBNzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:22:50 INFO - Running setup.py (path:/tmp/pip-f7GJwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:22:50 INFO - Running setup.py (path:/tmp/pip-1n99Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:22:50 INFO - Running setup.py (path:/tmp/pip-X04fmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:22:50 INFO - Running setup.py (path:/tmp/pip-oy185D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:22:50 INFO - Running setup.py (path:/tmp/pip-N1LWGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:50 INFO - Running setup.py (path:/tmp/pip-73JoJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:50 INFO - Running setup.py (path:/tmp/pip-T33vqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:50 INFO - Running setup.py (path:/tmp/pip-M9NISA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:50 INFO - Running setup.py (path:/tmp/pip-8gGnLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:50 INFO - Running setup.py (path:/tmp/pip-qdPRaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:50 INFO - Running setup.py (path:/tmp/pip-m1e0Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:50 INFO - Running setup.py (path:/tmp/pip-1Jn4uX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:50 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)) 18:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:50 INFO - Running setup.py (path:/tmp/pip-PbL4Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:51 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)) 18:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:51 INFO - Running setup.py (path:/tmp/pip-4DY1I_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:51 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)) 18:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:51 INFO - Running setup.py (path:/tmp/pip-olyIYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:51 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)) 18:22:51 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)) 18:22:51 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)) 18:22:51 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)) 18:22:51 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)) 18:22:51 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)) 18:22:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22:52 INFO - Downloading blessings-1.5.1.tar.gz 18:22:52 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 18:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:22:52 INFO - Installing collected packages: blessings 18:22:52 INFO - Running setup.py install for blessings 18:22:53 INFO - Successfully installed blessings 18:22:53 INFO - Cleaning up... 18:22:53 INFO - Return code: 0 18:22:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:53 INFO - Reading from file tmpfile_stdout 18:22:53 INFO - Current package versions: 18:22:53 INFO - argparse == 1.2.1 18:22:53 INFO - blessings == 1.5.1 18:22:53 INFO - blobuploader == 1.2.4 18:22:53 INFO - docopt == 0.6.1 18:22:53 INFO - manifestparser == 1.1 18:22:53 INFO - mozInstall == 1.12 18:22:53 INFO - mozcrash == 0.16 18:22:53 INFO - mozdebug == 0.1 18:22:53 INFO - mozdevice == 0.47 18:22:53 INFO - mozfile == 1.2 18:22:53 INFO - mozhttpd == 0.7 18:22:53 INFO - mozinfo == 0.9 18:22:53 INFO - mozleak == 0.1 18:22:53 INFO - mozlog == 3.1 18:22:53 INFO - moznetwork == 0.27 18:22:53 INFO - mozprocess == 0.22 18:22:53 INFO - mozprofile == 0.27 18:22:53 INFO - mozrunner == 6.11 18:22:53 INFO - mozscreenshot == 0.1 18:22:53 INFO - mozsystemmonitor == 0.0 18:22:53 INFO - moztest == 0.7 18:22:53 INFO - mozversion == 1.4 18:22:53 INFO - psutil == 3.1.1 18:22:53 INFO - requests == 1.2.3 18:22:53 INFO - wsgiref == 0.1.2 18:22:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22: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')]} 18:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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')]} 18:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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', '-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 0x7f416cfa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d0b0>, '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 0x109dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e440>, '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-1449195744.955303-1807224540', '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 18:22:53 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 18:22:53 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 18:22:53 INFO - Using env: {'DISPLAY': ':0', 18:22:53 INFO - 'HOME': '/home/cltbld', 18:22:53 INFO - 'LANG': 'en_US.UTF-8', 18:22:53 INFO - 'LANGUAGE': 'en_US:en', 18:22:53 INFO - 'LOGNAME': 'cltbld', 18:22:53 INFO - 'MAIL': '/var/mail/cltbld', 18:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:53 INFO - 'MOZ_NO_REMOTE': '1', 18:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:53 INFO - 'NO_EM_RESTART': '1', 18:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:53 INFO - 'PWD': '/builds/slave/test', 18:22:53 INFO - 'SHELL': '/bin/bash', 18:22:53 INFO - 'SHLVL': '1', 18:22:53 INFO - 'TERM': 'linux', 18:22:53 INFO - 'TMOUT': '86400', 18:22:53 INFO - 'USER': 'cltbld', 18:22:53 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449195744.955303-1807224540', 18:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:53 INFO - '_': '/tools/buildbot/bin/python'} 18:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:53 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)) 18:22:53 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)) 18:22:53 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)) 18:22:53 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)) 18:22:53 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)) 18:22:53 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)) 18:22:53 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)) 18:22:53 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)) 18:22:53 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)) 18:22:53 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)) 18:22:53 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)) 18:22:53 INFO - Cleaning up... 18:22:53 INFO - Return code: 0 18:22:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:22: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')]} 18:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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')]} 18:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f416cfa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d0b0>, '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 0x109dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e440>, '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-1449195744.955303-1807224540', '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 18:22: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', 'jsonschema'] in /builds/slave/test/build 18:22: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 jsonschema 18:22:53 INFO - Using env: {'DISPLAY': ':0', 18:22:53 INFO - 'HOME': '/home/cltbld', 18:22:53 INFO - 'LANG': 'en_US.UTF-8', 18:22:53 INFO - 'LANGUAGE': 'en_US:en', 18:22:53 INFO - 'LOGNAME': 'cltbld', 18:22:53 INFO - 'MAIL': '/var/mail/cltbld', 18:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:53 INFO - 'MOZ_NO_REMOTE': '1', 18:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:53 INFO - 'NO_EM_RESTART': '1', 18:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:53 INFO - 'PWD': '/builds/slave/test', 18:22:53 INFO - 'SHELL': '/bin/bash', 18:22:53 INFO - 'SHLVL': '1', 18:22:53 INFO - 'TERM': 'linux', 18:22:53 INFO - 'TMOUT': '86400', 18:22:53 INFO - 'USER': 'cltbld', 18:22:53 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449195744.955303-1807224540', 18:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:53 INFO - '_': '/tools/buildbot/bin/python'} 18:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:53 INFO - Downloading/unpacking jsonschema 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:22:55 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 18:22:55 INFO - Downloading/unpacking functools32 (from jsonschema) 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22:55 INFO - Downloading functools32-3.2.3-2.tar.gz 18:22:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:22:55 INFO - warning: no files found matching '*.txt' 18:22:55 INFO - no previously-included directories found matching 'build' 18:22:55 INFO - no previously-included directories found matching 'dist' 18:22:55 INFO - no previously-included directories found matching '.git*' 18:22:55 INFO - Installing collected packages: jsonschema, functools32 18:22:55 INFO - Running setup.py install for functools32 18:22:55 INFO - warning: no files found matching '*.txt' 18:22:55 INFO - no previously-included directories found matching 'build' 18:22:55 INFO - no previously-included directories found matching 'dist' 18:22:55 INFO - no previously-included directories found matching '.git*' 18:22:55 INFO - Successfully installed jsonschema functools32 18:22:55 INFO - Cleaning up... 18:22:55 INFO - Return code: 0 18:22:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:22:55 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')]} 18:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:55 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')]} 18:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:55 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 0x7f416cfa3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d0b0>, '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 0x109dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e440>, '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-1449195744.955303-1807224540', '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 18:22:55 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 18:22:55 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 18:22:55 INFO - Using env: {'DISPLAY': ':0', 18:22:55 INFO - 'HOME': '/home/cltbld', 18:22:55 INFO - 'LANG': 'en_US.UTF-8', 18:22:55 INFO - 'LANGUAGE': 'en_US:en', 18:22:55 INFO - 'LOGNAME': 'cltbld', 18:22:55 INFO - 'MAIL': '/var/mail/cltbld', 18:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:55 INFO - 'MOZ_NO_REMOTE': '1', 18:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:55 INFO - 'NO_EM_RESTART': '1', 18:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:55 INFO - 'PWD': '/builds/slave/test', 18:22:55 INFO - 'SHELL': '/bin/bash', 18:22:55 INFO - 'SHLVL': '1', 18:22:55 INFO - 'TERM': 'linux', 18:22:55 INFO - 'TMOUT': '86400', 18:22:55 INFO - 'USER': 'cltbld', 18:22:55 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449195744.955303-1807224540', 18:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:55 INFO - '_': '/tools/buildbot/bin/python'} 18:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:56 INFO - Downloading/unpacking flake8 18:22:56 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 18:22:56 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 18:22:56 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 18:22:56 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 18:22:56 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 18:22:56 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 18:22:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:22:57 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 18:22:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:22:57 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 18:22:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:58 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 18:22:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:22:58 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 18:22:58 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 18:22:58 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 18:22:58 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 18:22:58 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 18:22:58 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 18:22:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:22:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:22:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:22:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:22:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:22:58 INFO - no previously-included directories found matching 'docs/_build' 18:22:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:22:58 INFO - Running setup.py install for pep8 18:22:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:22:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:22:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:22:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:22:58 INFO - no previously-included directories found matching 'docs/_build' 18:22:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:22:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:22:58 INFO - Cleaning up... 18:22:58 INFO - Return code: 0 18:22:58 INFO - Running post-action listener: _resource_record_post_action 18:22:58 INFO - Running post-action listener: _start_resource_monitoring 18:22:58 INFO - Starting resource monitoring. 18:22:58 INFO - ##### 18:22:58 INFO - ##### Running install step. 18:22:58 INFO - ##### 18:22:58 INFO - Running pre-action listener: _resource_record_pre_action 18:22:58 INFO - Running main action method: install 18:22:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:58 INFO - Reading from file tmpfile_stdout 18:22:58 INFO - Detecting whether we're running mozinstall >=1.0... 18:22:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:22:58 INFO - Reading from file tmpfile_stdout 18:22:58 INFO - Output received: 18:22:58 INFO - Usage: mozinstall [options] installer 18:22:58 INFO - Options: 18:22:58 INFO - -h, --help show this help message and exit 18:22:58 INFO - -d DEST, --destination=DEST 18:22:58 INFO - Directory to install application into. [default: 18:22:58 INFO - "/builds/slave/test"] 18:22:58 INFO - --app=APP Application being installed. [default: firefox] 18:22:58 INFO - mkdir: /builds/slave/test/build/application 18:22:58 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'] 18:22:58 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 18:23:13 INFO - Reading from file tmpfile_stdout 18:23:13 INFO - Output received: 18:23:13 INFO - /builds/slave/test/build/application/firefox/firefox 18:23:13 INFO - Running post-action listener: _resource_record_post_action 18:23:13 INFO - ##### 18:23:13 INFO - ##### Running run-tests step. 18:23:13 INFO - ##### 18:23:13 INFO - Running pre-action listener: _resource_record_pre_action 18:23:13 INFO - Running main action method: run_tests 18:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:23:13 INFO - Python 2.7.3 18:23:13 INFO - Return code: 0 18:23:13 INFO - grabbing minidump binary from tooltool 18:23:13 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')]} 18:23:13 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 0x109d0b0>, '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 0x109dfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:23:13 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 18:23:13 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 18:23:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:23:13 INFO - Return code: 0 18:23:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:23:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:23:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:23:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:23:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:23:14 INFO - Return code: 0 18:23:14 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/SWL91GbgRsO6mvqr0AlcyA/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 18:23:14 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/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost 18:23:14 INFO - Using env: {'DISPLAY': ':0', 18:23:14 INFO - 'HOME': '/home/cltbld', 18:23:14 INFO - 'LANG': 'en_US.UTF-8', 18:23:14 INFO - 'LANGUAGE': 'en_US:en', 18:23:14 INFO - 'LOGNAME': 'cltbld', 18:23:14 INFO - 'MAIL': '/var/mail/cltbld', 18:23:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:23:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:14 INFO - 'MOZ_NO_REMOTE': '1', 18:23:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:14 INFO - 'NO_EM_RESTART': '1', 18:23:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:14 INFO - 'PWD': '/builds/slave/test', 18:23:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:23:14 INFO - 'SHELL': '/bin/bash', 18:23:14 INFO - 'SHLVL': '1', 18:23:14 INFO - 'TERM': 'linux', 18:23:14 INFO - 'TMOUT': '86400', 18:23:14 INFO - 'USER': 'cltbld', 18:23:14 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1449195744.955303-1807224540', 18:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:14 INFO - '_': '/tools/buildbot/bin/python'} 18:23:14 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/SWL91GbgRsO6mvqr0AlcyA/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 18:23:14 INFO - mozversion INFO | application_buildid: 20151203172317 18:23:14 INFO - mozversion INFO | application_changeset: a1440a731b1a7b16cb940a4f016b1fb7a726c87a 18:23:14 INFO - mozversion INFO | application_display_name: Nightly 18:23:14 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:23:14 INFO - mozversion INFO | application_name: Firefox 18:23:14 INFO - mozversion INFO | application_remotingname: firefox 18:23:14 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:23:14 INFO - mozversion INFO | application_vendor: Mozilla 18:23:14 INFO - mozversion INFO | application_version: 45.0a1 18:23:14 INFO - mozversion INFO | platform_buildid: 20151203172317 18:23:14 INFO - mozversion INFO | platform_changeset: a1440a731b1a7b16cb940a4f016b1fb7a726c87a 18:23:14 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:23:14 INFO - mozversion INFO | platform_version: 45.0a1 18:23:14 INFO - 2015-12-03 18:23:14,778 DEBUG : using testdate: 1449195794 18:23:14 INFO - 2015-12-03 18:23:14,778 DEBUG : actual date: 1449195794 18:23:14 INFO - 2015-12-03 18:23:14,793 INFO : starting webserver on 'localhost:36329' 18:23:14 INFO - 2015-12-03 18:23:14,793 INFO : Starting test suite talos-linux64-ix-007.e 18:23:14 INFO - 2015-12-03 18:23:14,794 INFO : Starting test dromaeo_css 18:23:14 INFO - 2015-12-03 18:23:14,794 DEBUG : operating with platform_type : linux_ 18:23:14 INFO - 2015-12-03 18:23:14,794 INFO : Initialising browser for dromaeo_css test... 18:23:14 INFO - 2015-12-03 18:23:14,808 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9PDFL2/profile http://localhost:36329/getInfo.html 18:23:20 INFO - 2015-12-03 18:23:20,133 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:23:20 INFO - 2015-12-03 18:23:20,134 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:23:20 INFO - 2015-12-03 18:23:20,134 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:23:20 INFO - 2015-12-03 18:23:20,134 DEBUG : BROWSER_OUTPUT: __metrics 18:23:20 INFO - 2015-12-03 18:23:20,250 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] 18:23:21 INFO - 2015-12-03 18:23:21,210 INFO : Browser initialized. 18:23:21 INFO - 2015-12-03 18:23:21,210 INFO : Running cycle 1/1 for dromaeo_css test... 18:23:21 INFO - 2015-12-03 18:23:21,211 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9PDFL2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:23:33 INFO - 2015-12-03 18:23:33,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 143364096 18:23:33 INFO - 2015-12-03 18:23:33,251 DEBUG : BROWSER_OUTPUT: 18:24:22 INFO - 2015-12-03 18:24:22,895 DEBUG : BROWSER_OUTPUT: 1449195862894 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] 18:26:34 INFO - 2015-12-03 18:26:34,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36329/tests/dromaeo/cssquery-ext.html) 18:26:35 INFO - 2015-12-03 18:26:35,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 145920000 18:26:35 INFO - 2015-12-03 18:26:35,528 DEBUG : BROWSER_OUTPUT: 18:29:37 INFO - 2015-12-03 18:29:37,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-ext.html (next: http://localhost:36329/tests/dromaeo/cssquery-jquery.html) 18:29:38 INFO - 2015-12-03 18:29:38,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 143781888 18:29:38 INFO - 2015-12-03 18:29:38,174 DEBUG : BROWSER_OUTPUT: 18:32:39 INFO - 2015-12-03 18:32:39,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36329/tests/dromaeo/cssquery-mootools.html) 18:32:40 INFO - 2015-12-03 18:32:40,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 145887232 18:32:40 INFO - 2015-12-03 18:32:40,500 DEBUG : BROWSER_OUTPUT: 18:35:42 INFO - 2015-12-03 18:35:42,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36329/tests/dromaeo/cssquery-prototype.html) 18:35:42 INFO - 2015-12-03 18:35:42,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 144547840 18:35:42 INFO - 2015-12-03 18:35:42,881 DEBUG : BROWSER_OUTPUT: 18:38:45 INFO - 2015-12-03 18:38:45,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36329/tests/dromaeo/cssquery-yui.html) 18:38:45 INFO - 2015-12-03 18:38:45,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 145031168 18:38:45 INFO - 2015-12-03 18:38:45,967 DEBUG : BROWSER_OUTPUT: 18:41:48 INFO - 2015-12-03 18:41:48,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/dromaeo/cssquery-yui.html (next: http://localhost:36329/tests/dromaeo/cssquery-dojo.html) 18:41:48 INFO - 2015-12-03 18:41:48,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 147505152 18:41:48 INFO - 2015-12-03 18:41:48,581 DEBUG : BROWSER_OUTPUT: 18:41:48 INFO - 2015-12-03 18:41:48,581 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:41:48 INFO - 2015-12-03 18:41:48,581 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:41:48 INFO - 2015-12-03 18:41:48,582 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:41:48 INFO - 2015-12-03 18:41:48,582 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:41:48 INFO - 2015-12-03 18:41:48,582 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2611.216635009497;2639.432522007768;2691.8923243070276;2693.9595906061413;2710.8915643374266;4477.171723231205;4564.771761411928;4572.657050721193;4591.403117594712;4620.376249206356;4558.6125179359715;4591.4260717410325;4610.147122782288;4633.281841314593;4674.836380726675;4206.558311377307;4304.1606886656955;4315.805788739506;4354.303311470166;4430.9778451107695;4353.760543170124;4410.89727568108;4416.624586910117;4423.849799052254;4457.242268814293;4106.79466026699;4198.4961804583645;4232.9365059523825;4276.935845962313;4303.483581970152;4282.828686852522;4295.978520107379;4303.569643035703;4305.052888364555;4354.869353919387;4060.817263223162;4278.572142785728;4288;4297.67767417445;4298.4197133387215;4375.343698445258;4493.707908985938;4647.465541462741;4651.88370290742;4654.720716756971;4956.479569645207;4969.478204788481;4982.153033984231;4983.152864013126;4985.850424487235;4790.568848803589;4926.4827193144565;5002.59979201663;5014.34813474246;5051.6716413433005;4616.192166370872;4658.208104622222;4675.462321832964;4688.859334219979;4729.219678753036;5087.109755792721;5180.0157969985585;5193.792248310101;5199.896002079937;5204.0632686116105;4757.8096876125255;4842.491538388489;4870.464248932614;4966.279889416014;5025.3718285214345;5024.145895197825;5026.949730502722;5042.394912610437;5047.4447810740785;5057.772400241998;4989.90020199594;4993.101241776442;4995.475475075137;4996.500349964975;5017.974910125426;4688.531146885284;4808.134535783593;4917.434495033045;5011.448740638527;5047.470015648378;4051.534073581517;4063.918721625551;4072.063425412172;4080.224757296104;4100.384942258685;3592.4431713084514;3599.892003239907;3621.402468592705;3622.800745958945;3625.2930678517964;4143.37849322598;4199.139176468817;4252.085801552619;4309.224339618899;4337.240982828055;4955.529224723646;4972.7513624318635;4994.101061808909;5011.924821127686;5042.571381432546;4101.733387329814;4302.268614335508;4322.697411181187;4338.154059958341;4353.10761293934;4247.638950689165;4256.425382573313;4287.63555097814;4295.957040429618;4314.654827613784;4676.742779147179;4688.671792974459;4716.693414928019;4749.978754567785;4798;4996.450390456974;5024.196128619404;5024.497550244946;5024.598032157492;5059.367579052619;4527.139843429738;4623.075384922961;4641.164590373765;4674.205385084611;4765.26138448541;4921.31101645777;4927.679700819435;4934.777934992862;4954.455009948831;4966.478519755518;4996.400431948189;4999.675021123615;5002.074616196015;5004.749762511933;5054.519820617035;4630.58324750774;4716.481187069351;4734.431868175841;4837.612990960785;4888.071266459361;4857.854264372075;4857.878553036061;4862.222044472867;4869.9026019480125;4914.336564563738;4778.832740854054;4780.450248221499;4784.067106914257;4788.808447662054;4790.257510085942;4644.907101857876;4778.259369797687;4810.42274927011;4870.4155501340065;4921;4713.717176969393;4723.527647235249;4745.762711864462;4767;4816.109019831342 18:41:48 INFO - 2015-12-03 18:41:48,582 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.6111083352486;563.7322271920838;566.1846940405818;567.4609121334734;568.6133429268099;28616.570751438718;29161.12516624502;36468.99999999996;37128.628713712926;37285.44071838925;39180.804095979554;39728.602713972854;39730;39859.60140398595;39887.80056099715;7883.290503854652;8022.277994980451;8053.073896501889;8054.355651547862;8063.556504392256;7838.529688218725;7896.763097107096;7918.208179182065;7933.0480342359;7934.008248968879;7913.762587122395;7981.0422749270165;8008.119106898236;8025.3178479829285;8037.758867233963;7705.345045671124;7866.2527059928925;7867.724629637935;7875.094364148139;7890.56601886896;7839.25527074927;7940.205979402013;7972.282494575458;7973.441859069868;7989.880151797728;37395.62604373976;37818;37832;37853.62146378528;37982.81008594939;2878.294817769639;2917.28526511004;2918.0595351798715;3175.2061984503875;3340.9665903340897;28697.56953645697;28703.282417939718;28924.27689307763;28927.710722892713;29488.8525557373;3489.494023366623;3489.5986961499243;3523.348180586574;3542.752007359486;3599.42409214527;220209;220578;220624.8968755162;221404;221761;51725.2241216382;52487;55853.72073139608;56334.43665563292;57864.71067644719;53389;53398.73300633472;53429.46570534245;53585.1962220567;53752.19371709428;12771.872281277068;12919.483220671067;12924.289164095877;12953.676158095934;12958.935205323913;9495.14543691071;9645.565949532287;9657.420554766595;9677.951610242044;9748.853767193497;18896;19267.614647706967;19456.70814937777;19457.318993835146;19470.70793938092;7641.923580764233;7967.721129760431;8008.639611217509;8086.636101375335;8095.55474448911;843.9535825529532;867.5835598912557;891.1979218703219;903.9728808135767;965.4545181972163;26025.21924342273;26490;26666.600001;26800.731992679823;26807.731922680912;951.4481600671594;965.821323055237;968.4576637083256;997.1524204426324;1081.561967403203;13938.860611393959;13957.557427450156;13973.371198296101;13991.16053036821;14606.05060671053;214572;216933;217048;217346;218252;43011.78494107509;43073.56926430758;43256;43481.56518434775;43571.56428435739;1228.9877101229051;1243.881831226032;1262.3688155922039;1262.5644152767281;1263.059021029339;24744.25767226986;26744.59883101716;27388.452230955667;27495.725042749316;27614.861925690242;41218.1756364865;41459.792701037506;41505.16989660129;41507.792461037505;41664.58335416607;248245;250221;250568;250728;251254;28301.57547636746;29444;29956.850215748782;30004.3999120012;30113.849430752707;38094;38144.61855381522;38813.223735525695;39211.80394098011;39253.41119883147;32532.83733581317;33127.50308745419;33444.83277583597;34459.82770086134;34561.371056038755;30919;31050.378992420476;32100.19749506281;33367.83316083404;33748;31362;31494.842525787226;31620;33758.83120584382;33762.32475350529;28946.421071578872;30040.19758814478;30196.84901575566;30392.01013698847;30687.386252275275;23170.841457926697;23954.88022559876;24233.636495452934;25399.492010160062;25510.362240944123 18:41:48 INFO - 2015-12-03 18:41:48,583 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.08524851687525;313.496837575691;323.8817831491505;325.79963322556637;325.9641439441661;10531.420771857545;10697;13404.396802143914;14663.486777962773;15402;14565.12609243446;14817.55547333579;14916.179610121439;14975;15075.698486030273;5602.38373778885;5616.943830561683;5707.62900411474;5716.914246286309;5796;5704.714764261791;5766;5769.076947688371;5774.335951365605;5779.9422005779825;5651.519620832234;5832.533397328225;6090.269167699882;6291.748330066792;6342.270638876542;6209.534284928626;6226.813195604139;6273.090401891723;6326.778562750282;6621;6301.1493448384335;6322.399372059647;6324.114623952651;6328.557001009931;6343.46080583151;19115.80884191154;19783.604327913505;19862.20551177951;20710.482237944023;20731.27440539589;1990.731251281073;2043.4074118505616;2082.427332483564;2087.123408168573;2140.796624320687;13024.348782560928;13439.395227214702;13498.257595832225;13930.651733706638;14162.36269367881;1920.5006698258414;1952.726618273443;1956.2761778142037;1966.862319637626;1971.546544294806;58455.41544584585;64334.67832660853;64823.35176648221;65212.67393663049;65214.3478565213;15789.526314210363;15909.488598583117;16056.27746751399;16066.518004459886;16086.43697470583;23125.653115203284;23208.18771342995;23440.64839027416;23506.7649323508;23521.529569408514;7904;8027.598620068973;8096.068952070469;8102.432829701982;8140.267375936194;6758.797236082925;6791.219009813836;6791.796246112624;6794.252632210453;6817.045613614098;7650.579218142944;7721.112072111779;7819;7831.412644051719;7867.763967080997;1660.2528862012143;1753.5966727652456;3139.199504126433;3212.0845559016034;3270.5421241026274;354.994675079874;355.77052800943244;377.87530115061963;388.378594249199;816.3794220552094;9606.327557071078;10115.645952391778;15103.4713785017;15747;15843.207839607974;812.488132476536;826.2109685250572;892.6206362295998;908.3459908865606;912.1972664055721;8694.782630434289;9066.637334506546;9078.228350590274;9125.17873391398;9216.216621587106;481223;483096;483354;484547;494381.9213558998;68152.6592367035;69463.30536694569;70564.64717676378;70581;70794;1095.8575385200033;1098.5441041967495;1159.5999380213814;1165.8134698448207;1168.2348062019391;14376.28118594087;14391.928040359731;14466.421343146578;14585.489507867174;14801.925990369979;29877.253068673457;31190.844045780534;32454.83772581122;32638.83680581582;33197.33605327928;34318;35723.46414803728;35908.820455897556;36104.09739756422;37588.81205594064;8689.913100868911;8788.209061184523;8809.51547664859;9074.137956894085;9081.591328390106;15178.924105379403;15472.381104755683;15502.84497155014;16615.584610384838;16639.75040374371;12753.872461275269;13706.794398084236;13806;13920.721585568435;14017.579472615838;12933.676658083623;13236.867631323948;13262.933685331898;13635.522756703467;14187.858121418654;13334.533291334757;13394;13679;14645.267736612914;14655.780163297772;8609;8623.95688021581;8643.049264580764;8837.116288371111;8887.333449991147;9870.506474676382;13972.161670299814;13986.65033374133;14058.859411406163;14064.296785160906 18:41:48 INFO - 2015-12-03 18:41:48,586 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1490.4783325835965;1614.0961061805385;1682.4447932182377;1707.3000069971315;1741.756154138421;6581.901271480931;6897.689603967821;7090.4327653787705;7133.037039999598;7151.821204469891;6979.162500499947;7023.438124950005;7063.187733410659;7070.045543851578;7072.2927707229255;2033.806788355104;2044.325372627037;2065.308121779206;2066.607344604528;2078.314156328408;2064.411642681836;2076.16953218713;2080.0223894769433;2112.324056301984;2112.9329688507282;1719.1232471439594;1749.4052022312412;1957.725918371429;2065.1532871522677;2094.8743075415446;2064.9070791814406;2073.968890466644;2078.1791192478963;2088.84333674975;2091.3203208957148;2046.8157865792002;2060.206820374152;2060.2789023841688;2065.6385132601736;2066.4523901166053;6972.477064220204;7018.613976231305;7028.367446929749;7033.050538177383;7050.5769653820935;4033.515978082649;4053.5541090480024;4084.775337356444;4123.36087906375;4130.173965206971;2716.8369897806197;2746.4644394343113;2756.5313896637417;2793.4971705093076;2798.5102607043686;859.613174071664;873.8776571280026;876.7194497760719;891.1311471315415;909.8817153770034;9170.174684278447;9174.403663761834;9266.258699304108;9290.210332121778;9318.72043838686;3671.6511931366476;3727.422249551324;3770.3024940386117;3771.358868992278;3778.319902417591;7595.240475952361;7650;7657.889606007209;7671.194524574839;7676.654550545239;4015.738976966488;4023.7183397162503;4039.1921615676983;4040.595940405936;4041;3656.1956369598647;3672.3022625701565;3683.1160521474653;3683.5395575553057;3716.4611131385795;3044.0411270449736;3054.786164968431;3105.3789242151206;3117.1116231873807;3150.1337132288804;919.4299534288783;923.4044041593269;932.2122806228726;943.1841457139662;944.9055094490496;945.2485274207022;946.914777670013;1001.2990906365574;1004.7237009822211;1184.922980006314;6442.06590044441;6449.774257900951;6503.837404064936;6522.836929076811;6546.116274302908;1034.5654824973528;1035.5909415780725;1046.3094357723867;1050.175612144463;1066.962656307041;5288.444713305124;5325.121354976463;5328.3605967284175;5337.466253374709;5345.224942383333;7999.9600001999615;8240.62917168729;8262.462939908886;8390.538520381315;8440.493570385797;8108.878366824502;8178.672853085929;8210.589470526449;8216.301614362726;8234.629441675019;6134.539909506805;6202.317745048132;6223.439890409885;6245.812625621239;6298.370162983757;6640.535162538576;6678.966605166943;6698;6702.597844129368;6711.295313991961;7110.786676399716;7263.418926485762;7265.418766498773;7531.472796904164;7575.810604734926;7306.378957788647;7418.36943859778;7438.44211684115;7482.700691972478;7509.098908131059;5993.4006599341465;6068.059450785136;6071.423214794588;6088.543359248163;6088.756449741961;6465.450436712744;6471.805845824632;6484.870302594016;6492.156019717407;6559.770408035696;6091.35534903693;6181.041938499539;6197.597156184834;6258.780942666985;6329.7468101275435;5468.671879687232;5706.629069110494;6093.573449858467;6103.969480152571;6143.447089761943;6183.412575805291;6192.628442293297;6207.503399727921;6208.0998255253635;6226.12834203221;5813.447722466359;5826.796062137805;5835.4748072673665;5847;5861.882762344814;5684.886302274014;5756.798512052225;5792.189093526994;5801.709914504174;5805.709714514342 18:41:48 INFO - 2015-12-03 18:41:48,586 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.03890306122446;274.5812635730512;277.90273404308493;280.64077980185357;281.2532725613496;5204.687718736869;5377.139657654776;5497.230387745719;5574.996500629885;5593.972030139854;5426.430224826396;5506.339239291291;5533.170024496328;5538.252335934648;5542.528885044766;4240.321548552232;4249.19265339586;4251.5110762262275;4252.2345977724;4257.638100761439;4230.598093181143;4255.2978758504805;4264.701470897038;4265.466816647919;4268.061026574149;4206.179794939988;4219.43037689911;4224.831006759726;4225.746455212682;4229.767362795045;4147.087640719037;4163.958360416403;4188.895277618084;4201.6008479194425;4206.852760153411;3615.493830863681;3620.601733809279;3623.981880090609;3631.8728844490315;3636.909077273089;5345.65253258537;5359;5360.678359298455;5365;5377.7580008899695;4801.279808028824;4804.951950480486;4817.277408388734;4824.517548245182;4825.396825396825;5553.194786755897;5677.261955945742;5695.629784064023;5870.3249126350165;5872.471477566996;3795.69634429245;3817.179306449099;3822.8853134406013;3823.2162406706557;3828.3874580067054;5772.509336706385;5856.209411729405;6024.728887200086;6081.209442772411;6088.756449742005;3855.171138205243;3914.197589494204;3923.4507168996365;3930.0960779020984;3939.803009849496;3980.960190398117;3982.6614737747036;3983.3626619740703;3992.960070399317;3993.0416699991792;4623.283391074388;4636.420447444069;4641.280601506772;4675.368825208621;4690.906181876343;5587.552995760329;5791.044477661223;5791.5656325775735;5791.855203619859;5795.710214489259;1396.0716123777574;1422.11118051218;1422.409699974499;1422.8008078868966;1423.5373503611368;930.2697382554662;932.5570354081757;941.7975135345933;952.64752041745;958.4249450329746;5031.069252188284;5052.469490703496;5055.570276526463;5056.241563765465;5066.620003499752;5980.611260268069;5989.2812862456785;5989.31122920861;5991;5996.13056106862;5054.393472783289;5056.191009438472;5056.241563765465;5059.595232381401;5060.873478163002;3175.380800743879;3217.083131307566;3243.5459035734543;3247.57781488405;3250.537258233804;5663.122216056518;5678.602497825113;5685.971570142206;5686.516646085129;5690.857728556819;6156.384361563808;6178.938210617836;6189.35011823752;6198.101275315054;6199.070139479114;5547.833564993138;5624.803131890364;5668.773249070074;5670.461306175989;5675.489205971482;5928.762849485972;5929.466348028698;5976.701164941823;5994.310654274815;5998.25021872266;5813.593048486566;5821.563382746226;5862.824115276378;5865.824025279248;5885.676287804041;5580.748866300945;5608.579356548356;5645.802396916089;5674.120511320752;5678.716064196691;3956.40653901917;3998.1603863189057;4025.6578190854107;4029.435878976887;4031.879043628696;6053.515718742578;6054.394560544087;6054.697265136813;6058.242719660043;6074.3318234994995;5797.826065218051;5798.56510761703;5811.44791244848;5812.360640329476;5821.09772985188;5660.094384898396;5786.594938354443;5802.5357971361345;5810.186573879576;5811.4479124483105;5645.125005624135;5657.12314591239;5666.716664166857;5687.402822703557;5695.031844586348;5750.942490575041;5805.361410244954;5834.124881267844;5855.795047173328;5868.735906884286;5577.888442231214;5714.3714191438075;5724.398938111438;5735.340435849931;5740.655560666373 18:41:48 INFO - 2015-12-03 18:41:48,587 DEBUG : BROWSER_OUTPUT: |5;yui.html;735.9926400735991;743.4387037786473;791.5883740454964;800.0759123212688;810.278851821879;12302.753944921096;12613.243205407682;12751.681207969794;12993.675158121052;13098.279594622292;12327;12416.937915310411;12417;12443.875561244386;12450.43973021214;790.182161462886;801.218811658634;813.6013353456793;816.9387295952797;819.4059307002435;794.1224946434194;800.5236884053978;804.7223707820792;805.6575955219038;807.229096213118;847.4703310430981;853.9914600854005;854.3080105114877;854.4830377621543;855.9614817333235;841.6549214821924;843.3801156150255;843.9324854011664;845.1126317366771;845.1337379186322;627.3914303125961;628.779927025542;628.7862126876838;629.361198383641;633.3444884544474;12887.484500619965;12998.610041698765;13019.414126364336;13022.088453808237;13028.47886084565;10952.726181845437;11132.666020019413;11218.887811121947;11588.710282242928;11980.400979951055;9333.160015598629;9334.486603236886;9391.812163756755;9484.05159484053;9508.619655213783;3126.937461250762;3134.6238451385752;3153.0540837748586;3196.6483686794436;3214.1964508872784;43548.3467747984;43672.34491482662;43974.560254397365;44028.77985610051;44110.33834492485;9223.123803238681;9465.52672366379;9479.620815167316;9514.619415223313;9553.522323883779;16779.664406712043;16846.747298790528;16871.325146993982;16891.23989420479;16993;6191.19514463126;6207.782727604512;6291.087792270096;6299.874002519924;6307.085472606538;3309.7021268085505;3363.512290717881;3390.898273051763;3455.6889879910927;3517.402041652925;2709.986450067737;2729.0448343079765;2731.0441345529302;2732.740389662979;2733.139061195717;477.25548144894077;482.58015526492176;483.1207202890705;494.9356583644103;502.13381916195004;505.53238254614337;576.6338375131821;593.2406519654849;617.9340637400448;653.4445721136996;7508.3993280537425;7729.961350193213;7735.187805280477;7805.336546393507;7843.803904902423;477.9211430114062;479.63547703744706;521.8121476268541;629.9874002520015;657.3557913245047;3606.1165014571075;3623.4927110204594;3640.817959102087;3704.7221458390727;3808.1050953026015;50778;50974.49025509697;51311.74344128255;51387.48612513902;51530.742346288025;46062;46189.76905115453;46529.30206046912;46548.301775473396;47613.5238647616;42443.57556424458;43012.569874300854;43366.56633433689;43484.56515434868;43711.344329835076;7091.680874360563;7140.571565706075;7148.463865210026;7192.244814294424;7309.269073092861;31613.5257971126;31779;32315;32697;33093.66906331002;37455.62544374631;37949;40434.1913161741;41013.58986410098;41576.376354354106;9212;9401.435913845191;9452.480113593818;9453.196478299422;9534.284928630243;9675.371100878421;9835.803283934425;9884.752881178028;9917.504124793875;9941.453220072965;9522.0954009369;9524.428534287965;9589.952050239704;9682.128608425275;9750.122488975743;9455.96946489217;9627.229821614394;9680.419174849532;9702.272329575451;9766.609335626496;9466.574004169966;9578.856317155387;10070.899291007288;11055.72360690957;11106.722331941766;8932.46405215689;9103.726888193365;9108.180263776292;9505.239580833655;9681;8912.910870891468;9097.181253686935;9418.811623767624;9430;9436.669716559887 18:41:48 INFO - 2015-12-03 18:41:48,587 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:41:48 INFO - 2015-12-03 18:41:48,587 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:41:48 INFO - 2015-12-03 18:41:48,588 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,330 18:41:48 INFO - 2015-12-03 18:41:48,588 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:41:48 INFO - 2015-12-03 18:41:48,588 DEBUG : BROWSER_OUTPUT: __startTimestamp1449196908575__endTimestamp 18:41:48 INFO - 2015-12-03 18:41:48,588 DEBUG : BROWSER_OUTPUT: 18:41:48 INFO - 2015-12-03 18:41:48,589 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:41:48 INFO - 2015-12-03 18:41:48,589 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:41:48 INFO - 2015-12-03 18:41:48,589 DEBUG : BROWSER_OUTPUT: 18:41:48 INFO - 2015-12-03 18:41:48,589 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4586.36 Median:4688.86 stddev:489.37 (10.4%) stddev-sans-first:465.70 18:41:48 INFO - 2015-12-03 18:41:48,589 DEBUG : BROWSER_OUTPUT: Values: 2611.2 2639.4 2691.9 2694.0 2710.9 4477.2 4564.8 4572.7 4591.4 4620.4 4558.6 4591.4 4610.1 4633.3 4674.8 4206.6 4304.2 4315.8 4354.3 4431.0 4353.8 4410.9 4416.6 4423.8 4457.2 4106.8 4198.5 4232.9 4276.9 4303.5 4282.8 4296.0 4303.6 4305.1 4354.9 4060.8 4278.6 4288.0 4297.7 4298.4 4375.3 4493.7 4647.5 4651.9 4654.7 4956.5 4969.5 4982.2 4983.2 4985.9 4790.6 4926.5 5002.6 5014.3 5051.7 4616.2 4658.2 4675.5 4688.9 4729.2 5087.1 5180.0 5193.8 5199.9 5204.1 4757.8 4842.5 4870.5 4966.3 5025.4 5024.1 5026.9 5042.4 5047.4 5057.8 4989.9 4993.1 4995.5 4996.5 5018.0 4688.5 4808.1 4917.4 5011.4 5047.5 4051.5 4063.9 4072.1 4080.2 4100.4 3592.4 3599.9 3621.4 3622.8 3625.3 4143.4 4199.1 4252.1 4309.2 4337.2 4955.5 4972.8 4994.1 5011.9 5042.6 4101.7 4302.3 4322.7 4338.2 4353.1 4247.6 4256.4 4287.6 4296.0 4314.7 4676.7 4688.7 4716.7 4750.0 4798.0 4996.5 5024.2 5024.5 5024.6 5059.4 4527.1 4623.1 4641.2 4674.2 4765.3 4921.3 4927.7 4934.8 4954.5 4966.5 4996.4 4999.7 5002.1 5004.7 5054.5 4630.6 4716.5 4734.4 4837.6 4888.1 4857.9 4857.9 4862.2 4869.9 4914.3 4778.8 4780.5 4784.1 4788.8 4790.3 4644.9 4778.3 4810.4 4870.4 4921.0 4713.7 4723.5 4745.8 4767.0 4816.1 18:41:48 INFO - 2015-12-03 18:41:48,589 DEBUG : BROWSER_OUTPUT: 18:41:48 INFO - 2015-12-03 18:41:48,589 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39152.20 Median:3533.05 stddev:59668.76 (1688.9%) stddev-sans-first:59765.80 18:41:48 INFO - 2015-12-03 18:41:48,589 DEBUG : BROWSER_OUTPUT: Values: 563.6 563.7 566.2 567.5 568.6 28616.6 29161.1 36469.0 37128.6 37285.4 39180.8 39728.6 39730.0 39859.6 39887.8 7883.3 8022.3 8053.1 8054.4 8063.6 7838.5 7896.8 7918.2 7933.0 7934.0 7913.8 7981.0 8008.1 8025.3 8037.8 7705.3 7866.3 7867.7 7875.1 7890.6 7839.3 7940.2 7972.3 7973.4 7989.9 37395.6 37818.0 37832.0 37853.6 37982.8 2878.3 2917.3 2918.1 3175.2 3341.0 28697.6 28703.3 28924.3 28927.7 29488.9 3489.5 3489.6 3523.3 3542.8 3599.4 220209.0 220578.0 220624.9 221404.0 221761.0 51725.2 52487.0 55853.7 56334.4 57864.7 53389.0 53398.7 53429.5 53585.2 53752.2 12771.9 12919.5 12924.3 12953.7 12958.9 9495.1 9645.6 9657.4 9678.0 9748.9 18896.0 19267.6 19456.7 19457.3 19470.7 7641.9 7967.7 8008.6 8086.6 8095.6 844.0 867.6 891.2 904.0 965.5 26025.2 26490.0 26666.6 26800.7 26807.7 951.4 965.8 968.5 997.2 1081.6 13938.9 13957.6 13973.4 13991.2 14606.1 214572.0 216933.0 217048.0 217346.0 218252.0 43011.8 43073.6 43256.0 43481.6 43571.6 1229.0 1243.9 1262.4 1262.6 1263.1 24744.3 26744.6 27388.5 27495.7 27614.9 41218.2 41459.8 41505.2 41507.8 41664.6 248245.0 250221.0 250568.0 250728.0 251254.0 28301.6 29444.0 29956.9 30004.4 30113.8 38094.0 38144.6 38813.2 39211.8 39253.4 32532.8 33127.5 33444.8 34459.8 34561.4 30919.0 31050.4 32100.2 33367.8 33748.0 31362.0 31494.8 31620.0 33758.8 33762.3 28946.4 30040.2 30196.8 30392.0 30687.4 23170.8 23954.9 24233.6 25399.5 25510.4 18:41:48 INFO - 2015-12-03 18:41:48,589 DEBUG : BROWSER_OUTPUT: 18:41:48 INFO - 2015-12-03 18:41:48,591 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27060.70 Median:17954.69 stddev:79140.32 (440.8%) stddev-sans-first:79336.83 18:41:48 INFO - 2015-12-03 18:41:48,591 DEBUG : BROWSER_OUTPUT: Values: 310.1 313.5 323.9 325.8 326.0 10531.4 10697.0 13404.4 14663.5 15402.0 14565.1 14817.6 14916.2 14975.0 15075.7 5602.4 5616.9 5707.6 5716.9 5796.0 5704.7 5766.0 5769.1 5774.3 5779.9 5651.5 5832.5 6090.3 6291.7 6342.3 6209.5 6226.8 6273.1 6326.8 6621.0 6301.1 6322.4 6324.1 6328.6 6343.5 19115.8 19783.6 19862.2 20710.5 20731.3 1990.7 2043.4 2082.4 2087.1 2140.8 13024.3 13439.4 13498.3 13930.7 14162.4 1920.5 1952.7 1956.3 1966.9 1971.5 58455.4 64334.7 64823.4 65212.7 65214.3 15789.5 15909.5 16056.3 16066.5 16086.4 23125.7 23208.2 23440.6 23506.8 23521.5 7904.0 8027.6 8096.1 8102.4 8140.3 6758.8 6791.2 6791.8 6794.3 6817.0 7650.6 7721.1 7819.0 7831.4 7867.8 1660.3 1753.6 3139.2 3212.1 3270.5 355.0 355.8 377.9 388.4 816.4 9606.3 10115.6 15103.5 15747.0 15843.2 812.5 826.2 892.6 908.3 912.2 8694.8 9066.6 9078.2 9125.2 9216.2 481223.0 483096.0 483354.0 484547.0 494381.9 68152.7 69463.3 70564.6 70581.0 70794.0 1095.9 1098.5 1159.6 1165.8 1168.2 14376.3 14391.9 14466.4 14585.5 14801.9 29877.3 31190.8 32454.8 32638.8 33197.3 34318.0 35723.5 35908.8 36104.1 37588.8 8689.9 8788.2 8809.5 9074.1 9081.6 15178.9 15472.4 15502.8 16615.6 16639.8 12753.9 13706.8 13806.0 13920.7 14017.6 12933.7 13236.9 13262.9 13635.5 14187.9 13334.5 13394.0 13679.0 14645.3 14655.8 8609.0 8624.0 8643.0 8837.1 8887.3 9870.5 13972.2 13986.7 14058.9 14064.3 18:41:48 INFO - 2015-12-03 18:41:48,591 DEBUG : BROWSER_OUTPUT: 18:41:48 INFO - 2015-12-03 18:41:48,591 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4819.41 Median:6092.46 stddev:2463.98 (40.4%) stddev-sans-first:2458.19 18:41:48 INFO - 2015-12-03 18:41:48,591 DEBUG : BROWSER_OUTPUT: Values: 1490.5 1614.1 1682.4 1707.3 1741.8 6581.9 6897.7 7090.4 7133.0 7151.8 6979.2 7023.4 7063.2 7070.0 7072.3 2033.8 2044.3 2065.3 2066.6 2078.3 2064.4 2076.2 2080.0 2112.3 2112.9 1719.1 1749.4 1957.7 2065.2 2094.9 2064.9 2074.0 2078.2 2088.8 2091.3 2046.8 2060.2 2060.3 2065.6 2066.5 6972.5 7018.6 7028.4 7033.1 7050.6 4033.5 4053.6 4084.8 4123.4 4130.2 2716.8 2746.5 2756.5 2793.5 2798.5 859.6 873.9 876.7 891.1 909.9 9170.2 9174.4 9266.3 9290.2 9318.7 3671.7 3727.4 3770.3 3771.4 3778.3 7595.2 7650.0 7657.9 7671.2 7676.7 4015.7 4023.7 4039.2 4040.6 4041.0 3656.2 3672.3 3683.1 3683.5 3716.5 3044.0 3054.8 3105.4 3117.1 3150.1 919.4 923.4 932.2 943.2 944.9 945.2 946.9 1001.3 1004.7 1184.9 6442.1 6449.8 6503.8 6522.8 6546.1 1034.6 1035.6 1046.3 1050.2 1067.0 5288.4 5325.1 5328.4 5337.5 5345.2 8000.0 8240.6 8262.5 8390.5 8440.5 8108.9 8178.7 8210.6 8216.3 8234.6 6134.5 6202.3 6223.4 6245.8 6298.4 6640.5 6679.0 6698.0 6702.6 6711.3 7110.8 7263.4 7265.4 7531.5 7575.8 7306.4 7418.4 7438.4 7482.7 7509.1 5993.4 6068.1 6071.4 6088.5 6088.8 6465.5 6471.8 6484.9 6492.2 6559.8 6091.4 6181.0 6197.6 6258.8 6329.7 5468.7 5706.6 6093.6 6104.0 6143.4 6183.4 6192.6 6207.5 6208.1 6226.1 5813.4 5826.8 5835.5 5847.0 5861.9 5684.9 5756.8 5792.2 5801.7 5805.7 18:41:48 INFO - 2015-12-03 18:41:48,591 DEBUG : BROWSER_OUTPUT: 18:41:48 INFO - 2015-12-03 18:41:48,591 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4757.01 Median:5535.71 stddev:1434.35 (25.9%) stddev-sans-first:1398.33 18:41:48 INFO - 2015-12-03 18:41:48,592 DEBUG : BROWSER_OUTPUT: Values: 273.0 274.6 277.9 280.6 281.3 5204.7 5377.1 5497.2 5575.0 5594.0 5426.4 5506.3 5533.2 5538.3 5542.5 4240.3 4249.2 4251.5 4252.2 4257.6 4230.6 4255.3 4264.7 4265.5 4268.1 4206.2 4219.4 4224.8 4225.7 4229.8 4147.1 4164.0 4188.9 4201.6 4206.9 3615.5 3620.6 3624.0 3631.9 3636.9 5345.7 5359.0 5360.7 5365.0 5377.8 4801.3 4805.0 4817.3 4824.5 4825.4 5553.2 5677.3 5695.6 5870.3 5872.5 3795.7 3817.2 3822.9 3823.2 3828.4 5772.5 5856.2 6024.7 6081.2 6088.8 3855.2 3914.2 3923.5 3930.1 3939.8 3981.0 3982.7 3983.4 3993.0 3993.0 4623.3 4636.4 4641.3 4675.4 4690.9 5587.6 5791.0 5791.6 5791.9 5795.7 1396.1 1422.1 1422.4 1422.8 1423.5 930.3 932.6 941.8 952.6 958.4 5031.1 5052.5 5055.6 5056.2 5066.6 5980.6 5989.3 5989.3 5991.0 5996.1 5054.4 5056.2 5056.2 5059.6 5060.9 3175.4 3217.1 3243.5 3247.6 3250.5 5663.1 5678.6 5686.0 5686.5 5690.9 6156.4 6178.9 6189.4 6198.1 6199.1 5547.8 5624.8 5668.8 5670.5 5675.5 5928.8 5929.5 5976.7 5994.3 5998.3 5813.6 5821.6 5862.8 5865.8 5885.7 5580.7 5608.6 5645.8 5674.1 5678.7 3956.4 3998.2 4025.7 4029.4 4031.9 6053.5 6054.4 6054.7 6058.2 6074.3 5797.8 5798.6 5811.4 5812.4 5821.1 5660.1 5786.6 5802.5 5810.2 5811.4 5645.1 5657.1 5666.7 5687.4 5695.0 5750.9 5805.4 5834.1 5855.8 5868.7 5577.9 5714.4 5724.4 5735.3 5740.7 18:41:48 INFO - 2015-12-03 18:41:48,592 DEBUG : BROWSER_OUTPUT: 18:41:48 INFO - 2015-12-03 18:41:48,593 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12496.89 Median:6199.49 stddev:14479.76 (233.6%) stddev-sans-first:14493.44 18:41:48 INFO - 2015-12-03 18:41:48,593 DEBUG : BROWSER_OUTPUT: Values: 736.0 743.4 791.6 800.1 810.3 12302.8 12613.2 12751.7 12993.7 13098.3 12327.0 12416.9 12417.0 12443.9 12450.4 790.2 801.2 813.6 816.9 819.4 794.1 800.5 804.7 805.7 807.2 847.5 854.0 854.3 854.5 856.0 841.7 843.4 843.9 845.1 845.1 627.4 628.8 628.8 629.4 633.3 12887.5 12998.6 13019.4 13022.1 13028.5 10952.7 11132.7 11218.9 11588.7 11980.4 9333.2 9334.5 9391.8 9484.1 9508.6 3126.9 3134.6 3153.1 3196.6 3214.2 43548.3 43672.3 43974.6 44028.8 44110.3 9223.1 9465.5 9479.6 9514.6 9553.5 16779.7 16846.7 16871.3 16891.2 16993.0 6191.2 6207.8 6291.1 6299.9 6307.1 3309.7 3363.5 3390.9 3455.7 3517.4 2710.0 2729.0 2731.0 2732.7 2733.1 477.3 482.6 483.1 494.9 502.1 505.5 576.6 593.2 617.9 653.4 7508.4 7730.0 7735.2 7805.3 7843.8 477.9 479.6 521.8 630.0 657.4 3606.1 3623.5 3640.8 3704.7 3808.1 50778.0 50974.5 51311.7 51387.5 51530.7 46062.0 46189.8 46529.3 46548.3 47613.5 42443.6 43012.6 43366.6 43484.6 43711.3 7091.7 7140.6 7148.5 7192.2 7309.3 31613.5 31779.0 32315.0 32697.0 33093.7 37455.6 37949.0 40434.2 41013.6 41576.4 9212.0 9401.4 9452.5 9453.2 9534.3 9675.4 9835.8 9884.8 9917.5 9941.5 9522.1 9524.4 9590.0 9682.1 9750.1 9456.0 9627.2 9680.4 9702.3 9766.6 9466.6 9578.9 10070.9 11055.7 11106.7 8932.5 9103.7 9108.2 9505.2 9681.0 8912.9 9097.2 9418.8 9430.0 9436.7 18:41:48 INFO - 2015-12-03 18:41:48,593 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:41:48 INFO - 2015-12-03 18:41:48,593 DEBUG : BROWSER_OUTPUT: 18:41:49 INFO - 2015-12-03 18:41:49,326 INFO : Browser exited with error code: 0 18:41:49 INFO - 2015-12-03 18:41:49,347 INFO : Completed test dromaeo_css (00:18:34) 18:41:49 INFO - 2015-12-03 18:41:49,347 INFO : Starting test kraken 18:41:49 INFO - 2015-12-03 18:41:49,348 DEBUG : operating with platform_type : linux_ 18:41:49 INFO - 2015-12-03 18:41:49,348 INFO : Initialising browser for kraken test... 18:41:49 INFO - 2015-12-03 18:41:49,354 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkjZET6/profile http://localhost:36329/getInfo.html 18:41:54 INFO - 2015-12-03 18:41:54,280 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:41:54 INFO - 2015-12-03 18:41:54,280 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:41:54 INFO - 2015-12-03 18:41:54,280 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:41:54 INFO - 2015-12-03 18:41:54,281 DEBUG : BROWSER_OUTPUT: __metrics 18:41:54 INFO - 2015-12-03 18:41:54,397 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] 18:41:55 INFO - 2015-12-03 18:41:55,330 INFO : Browser initialized. 18:41:55 INFO - 2015-12-03 18:41:55,331 INFO : Running cycle 1/1 for kraken test... 18:41:55 INFO - 2015-12-03 18:41:55,331 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkjZET6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:42:07 INFO - 2015-12-03 18:42:07,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 142704640 18:42:07 INFO - 2015-12-03 18:42:07,431 DEBUG : BROWSER_OUTPUT: 18:42:10 INFO - 2015-12-03 18:42:10,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36329/tests/kraken/driver.html?testName=audio-beat-detection) 18:42:10 INFO - 2015-12-03 18:42:10,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 142630912 18:42:10 INFO - 2015-12-03 18:42:10,632 DEBUG : BROWSER_OUTPUT: 18:42:13 INFO - 2015-12-03 18:42:13,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36329/tests/kraken/driver.html?testName=audio-dft) 18:42:13 INFO - 2015-12-03 18:42:13,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 142901248 18:42:13 INFO - 2015-12-03 18:42:13,995 DEBUG : BROWSER_OUTPUT: 18:42:16 INFO - 2015-12-03 18:42:16,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36329/tests/kraken/driver.html?testName=audio-fft) 18:42:17 INFO - 2015-12-03 18:42:17,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 138317824 18:42:17 INFO - 2015-12-03 18:42:17,478 DEBUG : BROWSER_OUTPUT: 18:42:19 INFO - 2015-12-03 18:42:19,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36329/tests/kraken/driver.html?testName=audio-oscillator) 18:42:20 INFO - 2015-12-03 18:42:20,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 138932224 18:42:20 INFO - 2015-12-03 18:42:20,152 DEBUG : BROWSER_OUTPUT: 18:42:22 INFO - 2015-12-03 18:42:22,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36329/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:42:23 INFO - 2015-12-03 18:42:23,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 140435456 18:42:23 INFO - 2015-12-03 18:42:23,013 DEBUG : BROWSER_OUTPUT: 18:42:26 INFO - 2015-12-03 18:42:26,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36329/tests/kraken/driver.html?testName=imaging-darkroom) 18:42:26 INFO - 2015-12-03 18:42:26,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 139374592 18:42:26 INFO - 2015-12-03 18:42:26,699 DEBUG : BROWSER_OUTPUT: 18:42:30 INFO - 2015-12-03 18:42:30,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36329/tests/kraken/driver.html?testName=imaging-desaturate) 18:42:30 INFO - 2015-12-03 18:42:30,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 138031104 18:42:30 INFO - 2015-12-03 18:42:30,825 DEBUG : BROWSER_OUTPUT: 18:42:33 INFO - 2015-12-03 18:42:33,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36329/tests/kraken/driver.html?testName=json-parse-financial) 18:42:34 INFO - 2015-12-03 18:42:34,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 137539584 18:42:34 INFO - 2015-12-03 18:42:34,318 DEBUG : BROWSER_OUTPUT: 18:42:36 INFO - 2015-12-03 18:42:36,079 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36329/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:42:36 INFO - 2015-12-03 18:42:36,660 DEBUG : BROWSER_OUTPUT: RSS: Main: 140582912 18:42:36 INFO - 2015-12-03 18:42:36,661 DEBUG : BROWSER_OUTPUT: 18:42:38 INFO - 2015-12-03 18:42:38,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:42:39 INFO - 2015-12-03 18:42:39,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 140996608 18:42:39 INFO - 2015-12-03 18:42:39,143 DEBUG : BROWSER_OUTPUT: 18:42:41 INFO - 2015-12-03 18:42:41,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:42:41 INFO - 2015-12-03 18:42:41,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 140967936 18:42:41 INFO - 2015-12-03 18:42:41,918 DEBUG : BROWSER_OUTPUT: 18:42:44 INFO - 2015-12-03 18:42:44,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:42:45 INFO - 2015-12-03 18:42:45,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 141582336 18:42:45 INFO - 2015-12-03 18:42:45,095 DEBUG : BROWSER_OUTPUT: 18:42:47 INFO - 2015-12-03 18:42:47,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:42:48 INFO - 2015-12-03 18:42:48,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 140914688 18:42:48 INFO - 2015-12-03 18:42:48,337 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36329/tests/kraken/driver.html?testName=ai-astar) 18:42:50 INFO - 2015-12-03 18:42:50,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 140722176 18:42:50 INFO - 2015-12-03 18:42:50,372 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,376 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:42:50 INFO - 2015-12-03 18:42:50,376 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:42:50 INFO - 2015-12-03 18:42:50,376 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:42:50 INFO - 2015-12-03 18:42:50,376 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:42:50 INFO - 2015-12-03 18:42:50,376 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;114;115;112;124;112;113;112;113 18:42:50 INFO - 2015-12-03 18:42:50,376 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;164;139;148;169;139;159;167;131;167;139 18:42:50 INFO - 2015-12-03 18:42:50,376 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;164;167;163;165;166;163;162;165;161 18:42:50 INFO - 2015-12-03 18:42:50,376 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;73;74;149;73;74;72;73;161 18:42:50 INFO - 2015-12-03 18:42:50,377 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;133;94;95;95;144;94;94;132 18:42:50 INFO - 2015-12-03 18:42:50,377 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;113;111;110;110;110;110;109;109 18:42:50 INFO - 2015-12-03 18:42:50,377 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;149;148;147;147;147;147;149;148 18:42:50 INFO - 2015-12-03 18:42:50,377 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;95;96;96;96;97;96;96 18:42:50 INFO - 2015-12-03 18:42:50,377 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;71;72;72;71;73;78;72;72 18:42:50 INFO - 2015-12-03 18:42:50,377 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;70;68;69;69;69;69;68;71;68 18:42:50 INFO - 2015-12-03 18:42:50,377 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;86;94;84;95;85;87;84;87 18:42:50 INFO - 2015-12-03 18:42:50,377 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;130;139;126;126;124;121;127;125;131 18:42:50 INFO - 2015-12-03 18:42:50,378 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;150;146;150;164;141;147;149;146;148 18:42:50 INFO - 2015-12-03 18:42:50,378 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;70;72;73;70;71;73;70;70 18:42:50 INFO - 2015-12-03 18:42:50,378 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:42:50 INFO - 2015-12-03 18:42:50,378 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:42:50 INFO - 2015-12-03 18:42:50,379 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,783 18:42:50 INFO - 2015-12-03 18:42:50,379 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:42:50 INFO - 2015-12-03 18:42:50,379 DEBUG : BROWSER_OUTPUT: __startTimestamp1449196970374__endTimestamp 18:42:50 INFO - 2015-12-03 18:42:50,379 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,383 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:42:50 INFO - 2015-12-03 18:42:50,383 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:42:50 INFO - 2015-12-03 18:42:50,383 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,383 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:4.25 (3.8%) stddev-sans-first:4.50 18:42:50 INFO - 2015-12-03 18:42:50,384 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 114.0 115.0 112.0 124.0 112.0 113.0 112.0 113.0 18:42:50 INFO - 2015-12-03 18:42:50,384 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,384 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.20 Median:161.50 stddev:14.51 (9.0%) stddev-sans-first:14.75 18:42:50 INFO - 2015-12-03 18:42:50,385 DEBUG : BROWSER_OUTPUT: Values: 164.0 139.0 148.0 169.0 139.0 159.0 167.0 131.0 167.0 139.0 18:42:50 INFO - 2015-12-03 18:42:50,385 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,385 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:164.50 stddev:2.06 (1.3%) stddev-sans-first:1.94 18:42:50 INFO - 2015-12-03 18:42:50,386 DEBUG : BROWSER_OUTPUT: Values: 161.0 164.0 167.0 163.0 165.0 166.0 163.0 162.0 165.0 161.0 18:42:50 INFO - 2015-12-03 18:42:50,386 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,386 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.60 Median:73.00 stddev:34.59 (47.4%) stddev-sans-first:36.16 18:42:50 INFO - 2015-12-03 18:42:50,386 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 73.0 74.0 149.0 73.0 74.0 72.0 73.0 161.0 18:42:50 INFO - 2015-12-03 18:42:50,386 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,386 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.00 Median:94.00 stddev:20.49 (21.8%) stddev-sans-first:21.27 18:42:50 INFO - 2015-12-03 18:42:50,386 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 133.0 94.0 95.0 95.0 144.0 94.0 94.0 132.0 18:42:50 INFO - 2015-12-03 18:42:50,387 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,387 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:1.16 (1.1%) stddev-sans-first:1.22 18:42:50 INFO - 2015-12-03 18:42:50,387 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 113.0 111.0 110.0 110.0 110.0 110.0 109.0 109.0 18:42:50 INFO - 2015-12-03 18:42:50,387 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,387 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 18:42:50 INFO - 2015-12-03 18:42:50,387 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 149.0 148.0 147.0 147.0 147.0 147.0 149.0 148.0 18:42:50 INFO - 2015-12-03 18:42:50,387 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,388 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:42:50 INFO - 2015-12-03 18:42:50,388 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 95.0 96.0 96.0 96.0 97.0 96.0 96.0 18:42:50 INFO - 2015-12-03 18:42:50,388 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,388 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.40 Median:72.00 stddev:2.07 (2.9%) stddev-sans-first:2.13 18:42:50 INFO - 2015-12-03 18:42:50,388 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 71.0 72.0 72.0 71.0 73.0 78.0 72.0 72.0 18:42:50 INFO - 2015-12-03 18:42:50,388 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,388 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:1.14 (1.6%) stddev-sans-first:1.00 18:42:50 INFO - 2015-12-03 18:42:50,389 DEBUG : BROWSER_OUTPUT: Values: 67.0 70.0 68.0 69.0 69.0 69.0 69.0 68.0 71.0 68.0 18:42:50 INFO - 2015-12-03 18:42:50,389 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,389 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.50 stddev:3.89 (4.5%) stddev-sans-first:4.10 18:42:50 INFO - 2015-12-03 18:42:50,389 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 86.0 94.0 84.0 95.0 85.0 87.0 84.0 87.0 18:42:50 INFO - 2015-12-03 18:42:50,389 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,389 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.50 stddev:4.90 (3.8%) stddev-sans-first:5.20 18:42:50 INFO - 2015-12-03 18:42:50,389 DEBUG : BROWSER_OUTPUT: Values: 128.0 130.0 139.0 126.0 126.0 124.0 121.0 127.0 125.0 131.0 18:42:50 INFO - 2015-12-03 18:42:50,390 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,390 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:148.50 stddev:5.94 (4.0%) stddev-sans-first:6.26 18:42:50 INFO - 2015-12-03 18:42:50,390 DEBUG : BROWSER_OUTPUT: Values: 147.0 150.0 146.0 150.0 164.0 141.0 147.0 149.0 146.0 148.0 18:42:50 INFO - 2015-12-03 18:42:50,390 DEBUG : BROWSER_OUTPUT: 18:42:50 INFO - 2015-12-03 18:42:50,391 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:72.00 stddev:1.25 (1.7%) stddev-sans-first:1.30 18:42:50 INFO - 2015-12-03 18:42:50,391 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 70.0 72.0 73.0 70.0 71.0 73.0 70.0 70.0 18:42:50 INFO - 2015-12-03 18:42:50,391 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:42:50 INFO - 2015-12-03 18:42:50,392 DEBUG : BROWSER_OUTPUT: 18:42:51 INFO - 2015-12-03 18:42:51,286 INFO : Browser exited with error code: 0 18:42:51 INFO - 2015-12-03 18:42:51,337 INFO : Completed test kraken (00:01:01) 18:42:51 INFO - 2015-12-03 18:42:51,337 INFO : Starting test v8_7 18:42:51 INFO - 2015-12-03 18:42:51,337 DEBUG : operating with platform_type : linux_ 18:42:51 INFO - 2015-12-03 18:42:51,337 INFO : Initialising browser for v8_7 test... 18:42:51 INFO - 2015-12-03 18:42:51,343 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5DOvJq/profile http://localhost:36329/getInfo.html 18:42:56 INFO - 2015-12-03 18:42:56,228 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:42:56 INFO - 2015-12-03 18:42:56,228 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:42:56 INFO - 2015-12-03 18:42:56,228 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:42:56 INFO - 2015-12-03 18:42:56,228 DEBUG : BROWSER_OUTPUT: __metrics 18:42:56 INFO - 2015-12-03 18:42:56,365 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] 18:42:57 INFO - 2015-12-03 18:42:57,306 INFO : Browser initialized. 18:42:57 INFO - 2015-12-03 18:42:57,306 INFO : Running cycle 1/1 for v8_7 test... 18:42:57 INFO - 2015-12-03 18:42:57,306 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5DOvJq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:43:09 INFO - 2015-12-03 18:43:09,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 142802944 18:43:09 INFO - 2015-12-03 18:43:09,282 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,643 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36329/tests/v8_7/run.html (next: http://localhost:36329/tests/v8_7/run.html) 18:43:30 INFO - 2015-12-03 18:43:30,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 138498048 18:43:30 INFO - 2015-12-03 18:43:30,901 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,901 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:43:30 INFO - 2015-12-03 18:43:30,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:43:30 INFO - 2015-12-03 18:43:30,901 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:43:30 INFO - 2015-12-03 18:43:30,901 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:43:30 INFO - 2015-12-03 18:43:30,901 DEBUG : BROWSER_OUTPUT: |0;Richards;164.446637066272 18:43:30 INFO - 2015-12-03 18:43:30,902 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.39977872026554 18:43:30 INFO - 2015-12-03 18:43:30,902 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 18:43:30 INFO - 2015-12-03 18:43:30,902 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 18:43:30 INFO - 2015-12-03 18:43:30,902 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1066.0980810234541 18:43:30 INFO - 2015-12-03 18:43:30,902 DEBUG : BROWSER_OUTPUT: |5;Earley;700.2801120448179 18:43:30 INFO - 2015-12-03 18:43:30,902 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 18:43:30 INFO - 2015-12-03 18:43:30,902 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 18:43:30 INFO - 2015-12-03 18:43:30,902 DEBUG : BROWSER_OUTPUT: |8;Splay;598.8023952095808 18:43:30 INFO - 2015-12-03 18:43:30,903 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 18:43:30 INFO - 2015-12-03 18:43:30,903 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:43:30 INFO - 2015-12-03 18:43:30,903 DEBUG : BROWSER_OUTPUT: __startTimestamp1449197010894__endTimestamp 18:43:30 INFO - 2015-12-03 18:43:30,903 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,903 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:43:30 INFO - 2015-12-03 18:43:30,903 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:43:30 INFO - 2015-12-03 18:43:30,904 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,904 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.45 Median:164.45 stddev:0.00 (0.0%) 18:43:30 INFO - 2015-12-03 18:43:30,904 DEBUG : BROWSER_OUTPUT: Values: 164.4 18:43:30 INFO - 2015-12-03 18:43:30,904 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,904 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.40 Median:184.40 stddev:0.00 (0.0%) 18:43:30 INFO - 2015-12-03 18:43:30,904 DEBUG : BROWSER_OUTPUT: Values: 184.4 18:43:30 INFO - 2015-12-03 18:43:30,904 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,904 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 18:43:30 INFO - 2015-12-03 18:43:30,905 DEBUG : BROWSER_OUTPUT: Values: 279.1 18:43:30 INFO - 2015-12-03 18:43:30,905 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,905 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 18:43:30 INFO - 2015-12-03 18:43:30,905 DEBUG : BROWSER_OUTPUT: Values: 5208.3 18:43:30 INFO - 2015-12-03 18:43:30,905 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,905 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 18:43:30 INFO - 2015-12-03 18:43:30,905 DEBUG : BROWSER_OUTPUT: Values: 1066.1 18:43:30 INFO - 2015-12-03 18:43:30,906 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,906 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:700.28 Median:700.28 stddev:0.00 (0.0%) 18:43:30 INFO - 2015-12-03 18:43:30,906 DEBUG : BROWSER_OUTPUT: Values: 700.3 18:43:30 INFO - 2015-12-03 18:43:30,906 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,906 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 18:43:30 INFO - 2015-12-03 18:43:30,906 DEBUG : BROWSER_OUTPUT: Values: 12096.4 18:43:30 INFO - 2015-12-03 18:43:30,906 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,907 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 18:43:30 INFO - 2015-12-03 18:43:30,907 DEBUG : BROWSER_OUTPUT: Values: 26000.0 18:43:30 INFO - 2015-12-03 18:43:30,907 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,907 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:598.80 Median:598.80 stddev:0.00 (0.0%) 18:43:30 INFO - 2015-12-03 18:43:30,907 DEBUG : BROWSER_OUTPUT: Values: 598.8 18:43:30 INFO - 2015-12-03 18:43:30,907 DEBUG : BROWSER_OUTPUT: 18:43:30 INFO - 2015-12-03 18:43:30,907 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 18:43:30 INFO - 2015-12-03 18:43:30,907 DEBUG : BROWSER_OUTPUT: Values: 4835.7 18:43:30 INFO - 2015-12-03 18:43:30,908 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:43:30 INFO - 2015-12-03 18:43:30,908 DEBUG : BROWSER_OUTPUT: 18:43:31 INFO - 2015-12-03 18:43:31,834 INFO : Browser exited with error code: 0 18:43:31 INFO - 2015-12-03 18:43:31,848 INFO : Completed test v8_7 (00:00:40) 18:43:31 INFO - 2015-12-03 18:43:31,934 INFO : Completed test suite (00:20:17) 18:43:31 INFO - 2015-12-03 18:43:31,934 DEBUG : Working with test: dromaeo_css 18:43:31 INFO - 2015-12-03 18:43:31,934 DEBUG : Generating results file: dromaeo_css 18:43:31 INFO - 2015-12-03 18:43:31,935 DEBUG : Working with test: kraken 18:43:31 INFO - 2015-12-03 18:43:31,935 DEBUG : Generating results file: kraken 18:43:31 INFO - 2015-12-03 18:43:31,936 INFO : javascript benchmark 18:43:31 INFO - 2015-12-03 18:43:31,936 DEBUG : Working with test: v8_7 18:43:31 INFO - 2015-12-03 18:43:31,936 DEBUG : Generating results file: v8_7 18:43:31 INFO - 2015-12-03 18:43:31,936 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:43:32 INFO - 2015-12-03 18:43:32,003 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 18:43:32 INFO - 2015-12-03 18:43:32,004 DEBUG : process_Request line: dromaeo_css 6367.96 graph.html#tests=[[72,132,43]] 18:43:32 INFO - 2015-12-03 18:43:32,004 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:43:32 INFO - 2015-12-03 18:43:32,036 DEBUG : process_Request line: kraken 1556.70 graph.html#tests=[[232,132,43]] 18:43:32 INFO - 2015-12-03 18:43:32,036 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:43:32 INFO - 2015-12-03 18:43:32,067 DEBUG : process_Request line: v8_7 21469.64 graph.html#tests=[[230,132,43]] 18:43:32 INFO - 2015-12-03 18:43:32,068 INFO : javascript benchmark 18:43:32 INFO - 2015-12-03 18:43:32,072 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2611.216635009497, 2639.432522007768, 2691.8923243070276, 2693.9595906061413, 2710.8915643374266, 4477.171723231205, 4564.771761411928, 4572.657050721193, 4591.403117594712, 4620.376249206356, 4558.6125179359715, 4591.4260717410325, 4610.147122782288, 4633.281841314593, 4674.836380726675, 4206.558311377307, 4304.1606886656955, 4315.805788739506, 4354.303311470166, 4430.9778451107695, 4353.760543170124, 4410.89727568108, 4416.624586910117, 4423.849799052254, 4457.242268814293, 4106.79466026699, 4198.4961804583645, 4232.9365059523825, 4276.935845962313, 4303.483581970152, 4282.828686852522, 4295.978520107379, 4303.569643035703, 4305.052888364555, 4354.869353919387, 4060.817263223162, 4278.572142785728, 4288.0, 4297.67767417445, 4298.4197133387215, 4375.343698445258, 4493.707908985938, 4647.465541462741, 4651.88370290742, 4654.720716756971, 4956.479569645207, 4969.478204788481, 4982.153033984231, 4983.152864013126, 4985.850424487235, 4790.568848803589, 4926.4827193144565, 5002.59979201663, 5014.34813474246, 5051.6716413433005, 4616.192166370872, 4658.208104622222, 4675.462321832964, 4688.859334219979, 4729.219678753036, 5087.109755792721, 5180.0157969985585, 5193.792248310101, 5199.896002079937, 5204.0632686116105, 4757.8096876125255, 4842.491538388489, 4870.464248932614, 4966.279889416014, 5025.3718285214345, 5024.145895197825, 5026.949730502722, 5042.394912610437, 5047.4447810740785, 5057.772400241998, 4989.90020199594, 4993.101241776442, 4995.475475075137, 4996.500349964975, 5017.974910125426, 4688.531146885284, 4808.134535783593, 4917.434495033045, 5011.448740638527, 5047.470015648378, 4051.534073581517, 4063.918721625551, 4072.063425412172, 4080.224757296104, 4100.384942258685, 3592.4431713084514, 3599.892003239907, 3621.402468592705, 3622.800745958945, 3625.2930678517964, 4143.37849322598, 4199.139176468817, 4252.085801552619, 4309.224339618899, 4337.240982828055, 4955.529224723646, 4972.7513624318635, 4994.101061808909, 5011.924821127686, 5042.571381432546, 4101.733387329814, 4302.268614335508, 4322.697411181187, 4338.154059958341, 4353.10761293934, 4247.638950689165, 4256.425382573313, 4287.63555097814, 4295.957040429618, 4314.654827613784, 4676.742779147179, 4688.671792974459, 4716.693414928019, 4749.978754567785, 4798.0, 4996.450390456974, 5024.196128619404, 5024.497550244946, 5024.598032157492, 5059.367579052619, 4527.139843429738, 4623.075384922961, 4641.164590373765, 4674.205385084611, 4765.26138448541, 4921.31101645777, 4927.679700819435, 4934.777934992862, 4954.455009948831, 4966.478519755518, 4996.400431948189, 4999.675021123615, 5002.074616196015, 5004.749762511933, 5054.519820617035, 4630.58324750774, 4716.481187069351, 4734.431868175841, 4837.612990960785, 4888.071266459361, 4857.854264372075, 4857.878553036061, 4862.222044472867, 4869.9026019480125, 4914.336564563738, 4778.832740854054, 4780.450248221499, 4784.067106914257, 4788.808447662054, 4790.257510085942, 4644.907101857876, 4778.259369797687, 4810.42274927011, 4870.4155501340065, 4921.0, 4713.717176969393, 4723.527647235249, 4745.762711864462, 4767.0, 4816.109019831342], "unit": "ms", "name": "dojo.html", "value": 4555.6029604190535}, {"lowerIsBetter": false, "replicates": [563.6111083352486, 563.7322271920838, 566.1846940405818, 567.4609121334734, 568.6133429268099, 28616.570751438718, 29161.12516624502, 36468.99999999996, 37128.628713712926, 37285.44071838925, 39180.804095979554, 39728.602713972854, 39730.0, 39859.60140398595, 39887.80056099715, 7883.290503854652, 8022.277994980451, 8053.073896501889, 8054.355651547862, 8063.556504392256, 7838.529688218725, 7896.763097107096, 7918.208179182065, 7933.0480342359, 7934.008248968879, 7913.762587122395, 7981.0422749270165, 8008.119106898236, 8025.3178479829285, 8037.758867233963, 7705.345045671124, 7866.2527059928925, 7867.724629637935, 7875.094364148139, 7890.56601886896, 7839.25527074927, 7940.205979402013, 7972.282494575458, 7973.441859069868, 7989.880151797728, 37395.62604373976, 37818.0, 37832.0, 37853.62146378528, 37982.81008594939, 2878.294817769639, 2917.28526511004, 2918.0595351798715, 3175.2061984503875, 3340.9665903340897, 28697.56953645697, 28703.282417939718, 28924.27689307763, 28927.710722892713, 29488.8525557373, 3489.494023366623, 3489.5986961499243, 3523.348180586574, 3542.752007359486, 3599.42409214527, 220209.0, 220578.0, 220624.8968755162, 221404.0, 221761.0, 51725.2241216382, 52487.0, 55853.72073139608, 56334.43665563292, 57864.71067644719, 53389.0, 53398.73300633472, 53429.46570534245, 53585.1962220567, 53752.19371709428, 12771.872281277068, 12919.483220671067, 12924.289164095877, 12953.676158095934, 12958.935205323913, 9495.14543691071, 9645.565949532287, 9657.420554766595, 9677.951610242044, 9748.853767193497, 18896.0, 19267.614647706967, 19456.70814937777, 19457.318993835146, 19470.70793938092, 7641.923580764233, 7967.721129760431, 8008.639611217509, 8086.636101375335, 8095.55474448911, 843.9535825529532, 867.5835598912557, 891.1979218703219, 903.9728808135767, 965.4545181972163, 26025.21924342273, 26490.0, 26666.600001, 26800.731992679823, 26807.731922680912, 951.4481600671594, 965.821323055237, 968.4576637083256, 997.1524204426324, 1081.561967403203, 13938.860611393959, 13957.557427450156, 13973.371198296101, 13991.16053036821, 14606.05060671053, 214572.0, 216933.0, 217048.0, 217346.0, 218252.0, 43011.78494107509, 43073.56926430758, 43256.0, 43481.56518434775, 43571.56428435739, 1228.9877101229051, 1243.881831226032, 1262.3688155922039, 1262.5644152767281, 1263.059021029339, 24744.25767226986, 26744.59883101716, 27388.452230955667, 27495.725042749316, 27614.861925690242, 41218.1756364865, 41459.792701037506, 41505.16989660129, 41507.792461037505, 41664.58335416607, 248245.0, 250221.0, 250568.0, 250728.0, 251254.0, 28301.57547636746, 29444.0, 29956.850215748782, 30004.3999120012, 30113.849430752707, 38094.0, 38144.61855381522, 38813.223735525695, 39211.80394098011, 39253.41119883147, 32532.83733581317, 33127.50308745419, 33444.83277583597, 34459.82770086134, 34561.371056038755, 30919.0, 31050.378992420476, 32100.19749506281, 33367.83316083404, 33748.0, 31362.0, 31494.842525787226, 31620.0, 33758.83120584382, 33762.32475350529, 28946.421071578872, 30040.19758814478, 30196.84901575566, 30392.01013698847, 30687.386252275275, 23170.841457926697, 23954.88022559876, 24233.636495452934, 25399.492010160062, 25510.362240944123], "unit": "ms", "name": "ext.html", "value": 16734.711698138057}, {"lowerIsBetter": false, "replicates": [310.08524851687525, 313.496837575691, 323.8817831491505, 325.79963322556637, 325.9641439441661, 10531.420771857545, 10697.0, 13404.396802143914, 14663.486777962773, 15402.0, 14565.12609243446, 14817.55547333579, 14916.179610121439, 14975.0, 15075.698486030273, 5602.38373778885, 5616.943830561683, 5707.62900411474, 5716.914246286309, 5796.0, 5704.714764261791, 5766.0, 5769.076947688371, 5774.335951365605, 5779.9422005779825, 5651.519620832234, 5832.533397328225, 6090.269167699882, 6291.748330066792, 6342.270638876542, 6209.534284928626, 6226.813195604139, 6273.090401891723, 6326.778562750282, 6621.0, 6301.1493448384335, 6322.399372059647, 6324.114623952651, 6328.557001009931, 6343.46080583151, 19115.80884191154, 19783.604327913505, 19862.20551177951, 20710.482237944023, 20731.27440539589, 1990.731251281073, 2043.4074118505616, 2082.427332483564, 2087.123408168573, 2140.796624320687, 13024.348782560928, 13439.395227214702, 13498.257595832225, 13930.651733706638, 14162.36269367881, 1920.5006698258414, 1952.726618273443, 1956.2761778142037, 1966.862319637626, 1971.546544294806, 58455.41544584585, 64334.67832660853, 64823.35176648221, 65212.67393663049, 65214.3478565213, 15789.526314210363, 15909.488598583117, 16056.27746751399, 16066.518004459886, 16086.43697470583, 23125.653115203284, 23208.18771342995, 23440.64839027416, 23506.7649323508, 23521.529569408514, 7904.0, 8027.598620068973, 8096.068952070469, 8102.432829701982, 8140.267375936194, 6758.797236082925, 6791.219009813836, 6791.796246112624, 6794.252632210453, 6817.045613614098, 7650.579218142944, 7721.112072111779, 7819.0, 7831.412644051719, 7867.763967080997, 1660.2528862012143, 1753.5966727652456, 3139.199504126433, 3212.0845559016034, 3270.5421241026274, 354.994675079874, 355.77052800943244, 377.87530115061963, 388.378594249199, 816.3794220552094, 9606.327557071078, 10115.645952391778, 15103.4713785017, 15747.0, 15843.207839607974, 812.488132476536, 826.2109685250572, 892.6206362295998, 908.3459908865606, 912.1972664055721, 8694.782630434289, 9066.637334506546, 9078.228350590274, 9125.17873391398, 9216.216621587106, 481223.0, 483096.0, 483354.0, 484547.0, 494381.9213558998, 68152.6592367035, 69463.30536694569, 70564.64717676378, 70581.0, 70794.0, 1095.8575385200033, 1098.5441041967495, 1159.5999380213814, 1165.8134698448207, 1168.2348062019391, 14376.28118594087, 14391.928040359731, 14466.421343146578, 14585.489507867174, 14801.925990369979, 29877.253068673457, 31190.844045780534, 32454.83772581122, 32638.83680581582, 33197.33605327928, 34318.0, 35723.46414803728, 35908.820455897556, 36104.09739756422, 37588.81205594064, 8689.913100868911, 8788.209061184523, 8809.51547664859, 9074.137956894085, 9081.591328390106, 15178.924105379403, 15472.381104755683, 15502.84497155014, 16615.584610384838, 16639.75040374371, 12753.872461275269, 13706.794398084236, 13806.0, 13920.721585568435, 14017.579472615838, 12933.676658083623, 13236.867631323948, 13262.933685331898, 13635.522756703467, 14187.858121418654, 13334.533291334757, 13394.0, 13679.0, 14645.267736612914, 14655.780163297772, 8609.0, 8623.95688021581, 8643.049264580764, 8837.116288371111, 8887.333449991147, 9870.506474676382, 13972.161670299814, 13986.65033374133, 14058.859411406163, 14064.296785160906], "unit": "ms", "name": "jquery.html", "value": 8947.153008326402}, {"lowerIsBetter": false, "replicates": [1490.4783325835965, 1614.0961061805385, 1682.4447932182377, 1707.3000069971315, 1741.756154138421, 6581.901271480931, 6897.689603967821, 7090.4327653787705, 7133.037039999598, 7151.821204469891, 6979.162500499947, 7023.438124950005, 7063.187733410659, 7070.045543851578, 7072.2927707229255, 2033.806788355104, 2044.325372627037, 2065.308121779206, 2066.607344604528, 2078.314156328408, 2064.411642681836, 2076.16953218713, 2080.0223894769433, 2112.324056301984, 2112.9329688507282, 1719.1232471439594, 1749.4052022312412, 1957.725918371429, 2065.1532871522677, 2094.8743075415446, 2064.9070791814406, 2073.968890466644, 2078.1791192478963, 2088.84333674975, 2091.3203208957148, 2046.8157865792002, 2060.206820374152, 2060.2789023841688, 2065.6385132601736, 2066.4523901166053, 6972.477064220204, 7018.613976231305, 7028.367446929749, 7033.050538177383, 7050.5769653820935, 4033.515978082649, 4053.5541090480024, 4084.775337356444, 4123.36087906375, 4130.173965206971, 2716.8369897806197, 2746.4644394343113, 2756.5313896637417, 2793.4971705093076, 2798.5102607043686, 859.613174071664, 873.8776571280026, 876.7194497760719, 891.1311471315415, 909.8817153770034, 9170.174684278447, 9174.403663761834, 9266.258699304108, 9290.210332121778, 9318.72043838686, 3671.6511931366476, 3727.422249551324, 3770.3024940386117, 3771.358868992278, 3778.319902417591, 7595.240475952361, 7650.0, 7657.889606007209, 7671.194524574839, 7676.654550545239, 4015.738976966488, 4023.7183397162503, 4039.1921615676983, 4040.595940405936, 4041.0, 3656.1956369598647, 3672.3022625701565, 3683.1160521474653, 3683.5395575553057, 3716.4611131385795, 3044.0411270449736, 3054.786164968431, 3105.3789242151206, 3117.1116231873807, 3150.1337132288804, 919.4299534288783, 923.4044041593269, 932.2122806228726, 943.1841457139662, 944.9055094490496, 945.2485274207022, 946.914777670013, 1001.2990906365574, 1004.7237009822211, 1184.922980006314, 6442.06590044441, 6449.774257900951, 6503.837404064936, 6522.836929076811, 6546.116274302908, 1034.5654824973528, 1035.5909415780725, 1046.3094357723867, 1050.175612144463, 1066.962656307041, 5288.444713305124, 5325.121354976463, 5328.3605967284175, 5337.466253374709, 5345.224942383333, 7999.9600001999615, 8240.62917168729, 8262.462939908886, 8390.538520381315, 8440.493570385797, 8108.878366824502, 8178.672853085929, 8210.589470526449, 8216.301614362726, 8234.629441675019, 6134.539909506805, 6202.317745048132, 6223.439890409885, 6245.812625621239, 6298.370162983757, 6640.535162538576, 6678.966605166943, 6698.0, 6702.597844129368, 6711.295313991961, 7110.786676399716, 7263.418926485762, 7265.418766498773, 7531.472796904164, 7575.810604734926, 7306.378957788647, 7418.36943859778, 7438.44211684115, 7482.700691972478, 7509.098908131059, 5993.4006599341465, 6068.059450785136, 6071.423214794588, 6088.543359248163, 6088.756449741961, 6465.450436712744, 6471.805845824632, 6484.870302594016, 6492.156019717407, 6559.770408035696, 6091.35534903693, 6181.041938499539, 6197.597156184834, 6258.780942666985, 6329.7468101275435, 5468.671879687232, 5706.629069110494, 6093.573449858467, 6103.969480152571, 6143.447089761943, 6183.412575805291, 6192.628442293297, 6207.503399727921, 6208.0998255253635, 6226.12834203221, 5813.447722466359, 5826.796062137805, 5835.4748072673665, 5847.0, 5861.882762344814, 5684.886302274014, 5756.798512052225, 5792.189093526994, 5801.709914504174, 5805.709714514342], "unit": "ms", "name": "mootools.html", "value": 3978.025595778487}, {"lowerIsBetter": false, "replicates": [273.03890306122446, 274.5812635730512, 277.90273404308493, 280.64077980185357, 281.2532725613496, 5204.687718736869, 5377.139657654776, 5497.230387745719, 5574.996500629885, 5593.972030139854, 5426.430224826396, 5506.339239291291, 5533.170024496328, 5538.252335934648, 5542.528885044766, 4240.321548552232, 4249.19265339586, 4251.5110762262275, 4252.2345977724, 4257.638100761439, 4230.598093181143, 4255.2978758504805, 4264.701470897038, 4265.466816647919, 4268.061026574149, 4206.179794939988, 4219.43037689911, 4224.831006759726, 4225.746455212682, 4229.767362795045, 4147.087640719037, 4163.958360416403, 4188.895277618084, 4201.6008479194425, 4206.852760153411, 3615.493830863681, 3620.601733809279, 3623.981880090609, 3631.8728844490315, 3636.909077273089, 5345.65253258537, 5359.0, 5360.678359298455, 5365.0, 5377.7580008899695, 4801.279808028824, 4804.951950480486, 4817.277408388734, 4824.517548245182, 4825.396825396825, 5553.194786755897, 5677.261955945742, 5695.629784064023, 5870.3249126350165, 5872.471477566996, 3795.69634429245, 3817.179306449099, 3822.8853134406013, 3823.2162406706557, 3828.3874580067054, 5772.509336706385, 5856.209411729405, 6024.728887200086, 6081.209442772411, 6088.756449742005, 3855.171138205243, 3914.197589494204, 3923.4507168996365, 3930.0960779020984, 3939.803009849496, 3980.960190398117, 3982.6614737747036, 3983.3626619740703, 3992.960070399317, 3993.0416699991792, 4623.283391074388, 4636.420447444069, 4641.280601506772, 4675.368825208621, 4690.906181876343, 5587.552995760329, 5791.044477661223, 5791.5656325775735, 5791.855203619859, 5795.710214489259, 1396.0716123777574, 1422.11118051218, 1422.409699974499, 1422.8008078868966, 1423.5373503611368, 930.2697382554662, 932.5570354081757, 941.7975135345933, 952.64752041745, 958.4249450329746, 5031.069252188284, 5052.469490703496, 5055.570276526463, 5056.241563765465, 5066.620003499752, 5980.611260268069, 5989.2812862456785, 5989.31122920861, 5991.0, 5996.13056106862, 5054.393472783289, 5056.191009438472, 5056.241563765465, 5059.595232381401, 5060.873478163002, 3175.380800743879, 3217.083131307566, 3243.5459035734543, 3247.57781488405, 3250.537258233804, 5663.122216056518, 5678.602497825113, 5685.971570142206, 5686.516646085129, 5690.857728556819, 6156.384361563808, 6178.938210617836, 6189.35011823752, 6198.101275315054, 6199.070139479114, 5547.833564993138, 5624.803131890364, 5668.773249070074, 5670.461306175989, 5675.489205971482, 5928.762849485972, 5929.466348028698, 5976.701164941823, 5994.310654274815, 5998.25021872266, 5813.593048486566, 5821.563382746226, 5862.824115276378, 5865.824025279248, 5885.676287804041, 5580.748866300945, 5608.579356548356, 5645.802396916089, 5674.120511320752, 5678.716064196691, 3956.40653901917, 3998.1603863189057, 4025.6578190854107, 4029.435878976887, 4031.879043628696, 6053.515718742578, 6054.394560544087, 6054.697265136813, 6058.242719660043, 6074.3318234994995, 5797.826065218051, 5798.56510761703, 5811.44791244848, 5812.360640329476, 5821.09772985188, 5660.094384898396, 5786.594938354443, 5802.5357971361345, 5810.186573879576, 5811.4479124483105, 5645.125005624135, 5657.12314591239, 5666.716664166857, 5687.402822703557, 5695.031844586348, 5750.942490575041, 5805.361410244954, 5834.124881267844, 5855.795047173328, 5868.735906884286, 5577.888442231214, 5714.3714191438075, 5724.398938111438, 5735.340435849931, 5740.655560666373], "unit": "ms", "name": "prototype.html", "value": 4279.457136070121}, {"lowerIsBetter": false, "replicates": [735.9926400735991, 743.4387037786473, 791.5883740454964, 800.0759123212688, 810.278851821879, 12302.753944921096, 12613.243205407682, 12751.681207969794, 12993.675158121052, 13098.279594622292, 12327.0, 12416.937915310411, 12417.0, 12443.875561244386, 12450.43973021214, 790.182161462886, 801.218811658634, 813.6013353456793, 816.9387295952797, 819.4059307002435, 794.1224946434194, 800.5236884053978, 804.7223707820792, 805.6575955219038, 807.229096213118, 847.4703310430981, 853.9914600854005, 854.3080105114877, 854.4830377621543, 855.9614817333235, 841.6549214821924, 843.3801156150255, 843.9324854011664, 845.1126317366771, 845.1337379186322, 627.3914303125961, 628.779927025542, 628.7862126876838, 629.361198383641, 633.3444884544474, 12887.484500619965, 12998.610041698765, 13019.414126364336, 13022.088453808237, 13028.47886084565, 10952.726181845437, 11132.666020019413, 11218.887811121947, 11588.710282242928, 11980.400979951055, 9333.160015598629, 9334.486603236886, 9391.812163756755, 9484.05159484053, 9508.619655213783, 3126.937461250762, 3134.6238451385752, 3153.0540837748586, 3196.6483686794436, 3214.1964508872784, 43548.3467747984, 43672.34491482662, 43974.560254397365, 44028.77985610051, 44110.33834492485, 9223.123803238681, 9465.52672366379, 9479.620815167316, 9514.619415223313, 9553.522323883779, 16779.664406712043, 16846.747298790528, 16871.325146993982, 16891.23989420479, 16993.0, 6191.19514463126, 6207.782727604512, 6291.087792270096, 6299.874002519924, 6307.085472606538, 3309.7021268085505, 3363.512290717881, 3390.898273051763, 3455.6889879910927, 3517.402041652925, 2709.986450067737, 2729.0448343079765, 2731.0441345529302, 2732.740389662979, 2733.139061195717, 477.25548144894077, 482.58015526492176, 483.1207202890705, 494.9356583644103, 502.13381916195004, 505.53238254614337, 576.6338375131821, 593.2406519654849, 617.9340637400448, 653.4445721136996, 7508.3993280537425, 7729.961350193213, 7735.187805280477, 7805.336546393507, 7843.803904902423, 477.9211430114062, 479.63547703744706, 521.8121476268541, 629.9874002520015, 657.3557913245047, 3606.1165014571075, 3623.4927110204594, 3640.817959102087, 3704.7221458390727, 3808.1050953026015, 50778.0, 50974.49025509697, 51311.74344128255, 51387.48612513902, 51530.742346288025, 46062.0, 46189.76905115453, 46529.30206046912, 46548.301775473396, 47613.5238647616, 42443.57556424458, 43012.569874300854, 43366.56633433689, 43484.56515434868, 43711.344329835076, 7091.680874360563, 7140.571565706075, 7148.463865210026, 7192.244814294424, 7309.269073092861, 31613.5257971126, 31779.0, 32315.0, 32697.0, 33093.66906331002, 37455.62544374631, 37949.0, 40434.1913161741, 41013.58986410098, 41576.376354354106, 9212.0, 9401.435913845191, 9452.480113593818, 9453.196478299422, 9534.284928630243, 9675.371100878421, 9835.803283934425, 9884.752881178028, 9917.504124793875, 9941.453220072965, 9522.0954009369, 9524.428534287965, 9589.952050239704, 9682.128608425275, 9750.122488975743, 9455.96946489217, 9627.229821614394, 9680.419174849532, 9702.272329575451, 9766.609335626496, 9466.574004169966, 9578.856317155387, 10070.899291007288, 11055.72360690957, 11106.722331941766, 8932.46405215689, 9103.726888193365, 9108.180263776292, 9505.239580833655, 9681.0, 8912.910870891468, 9097.181253686935, 9418.811623767624, 9430.0, 9436.669716559887], "unit": "ms", "name": "yui.html", "value": 5741.8312517013055}], "name": "dromaeo_css", "value": 6367.9614367866825}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 114.0, 115.0, 112.0, 124.0, 112.0, 113.0, 112.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.5}, {"lowerIsBetter": true, "replicates": [164.0, 139.0, 148.0, 169.0, 139.0, 159.0, 167.0, 131.0, 167.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.2}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 167.0, 163.0, 165.0, 166.0, 163.0, 162.0, 165.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 74.0, 149.0, 73.0, 74.0, 72.0, 73.0, 161.0], "unit": "ms", "name": "audio-fft", "value": 89.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 133.0, 94.0, 95.0, 95.0, 144.0, 94.0, 94.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 113.0, 111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 149.0, 148.0, 147.0, 147.0, 147.0, 147.0, 149.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 72.0, 72.0, 71.0, 73.0, 78.0, 72.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 72.4}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0, 71.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 86.0, 94.0, 84.0, 95.0, 85.0, 87.0, 84.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [128.0, 130.0, 139.0, 126.0, 126.0, 124.0, 121.0, 127.0, 125.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [147.0, 150.0, 146.0, 150.0, 164.0, 141.0, 147.0, 149.0, 146.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 70.0, 72.0, 73.0, 70.0, 71.0, 73.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1556.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.446637066272], "unit": "score", "name": "Richards", "value": 214.67146200000008}, {"lowerIsBetter": false, "replicates": [184.39977872026554], "unit": "score", "name": "DeltaBlue", "value": 358.5579139999999}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [700.2801120448179], "unit": "score", "name": "Earley", "value": 951.7091640000002}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [598.8023952095808], "unit": "score", "name": "Splay", "value": 136.08996999999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21469.63755462092}]} 18:43:32 INFO - RETURN: dromaeo_css: 6367.96 18:43:32 INFO - RETURN: kraken: 1556.70 18:43:32 INFO - RETURN: v8_7: 21469.64 18:43:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21469.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1556.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6367.96"}}} 18:43:32 INFO - Return code: 0 18:43:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:43:32 INFO - # TBPL SUCCESS # 18:43:32 INFO - Running post-action listener: _resource_record_post_action 18:43:32 INFO - Running post-run listener: _resource_record_post_run 18:43:33 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510361600; Read time: 12; Write time: 417420 18:43:33 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231129088; Read time: 0; Write time: 223152 18:43:33 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275181568; Read time: 12; Write time: 193388 18:43:33 INFO - Running post-run listener: _upload_blobber_files 18:43:33 INFO - Blob upload gear active. 18:43:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:43:33 INFO - Copying logs to upload dir... 18:43:33 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.016005 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-03 18:43:33.257356) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 18:43:33.260773) ========= 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-1449195744.955303-1807224540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009976 build_url: 'https://queue.taskcluster.net/v1/task/SWL91GbgRsO6mvqr0AlcyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 18:43:33.316371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:43:33.316708) ========= 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-1449195744.955303-1807224540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 18:43:33.368860) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 18:43:33.369559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 18:43:33.370080) ========= ========= Total master_lag: 0.22 =========