builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1449855766.12 results: success (0) buildid: 20151211083202 builduid: e69bdc5b86cb46699cff39c07c3c6e2b revision: c56806034eda39d8275a071152eb2704411906a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.121855) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.122540) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.122841) ========= 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=256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006396 basedir: '/builds/slave/test' ========= master_lag: 0.38 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.510925) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.511265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.548131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.548376) ========= 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=256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.616496) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.616782) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.617148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.617439) ========= 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=256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 09:42:47-- 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% 226M=0s 2015-12-11 09:42:47 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183808 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.819965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.822222) ========= 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=256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019517 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.903895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:46.907327) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c56806034eda39d8275a071152eb2704411906a9 --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 c56806034eda39d8275a071152eb2704411906a9 --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=256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 09:42:47,614 truncating revision to first 12 chars 2015-12-11 09:42:47,614 Setting DEBUG logging. 2015-12-11 09:42:47,614 attempt 1/10 2015-12-11 09:42:47,614 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c56806034eda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 09:42:47,929 unpacking tar archive at: fx-team-c56806034eda/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:47.491464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:47.491755) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:47.500779) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:47.501123) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 09:42:47.501819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2015-12-11 09:42:47.502121) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:42:48 INFO - MultiFileLogger online at 20151211 09:42:48 in /builds/slave/test 09:42:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:42:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:42:48 INFO - {'append_to_log': False, 09:42:48 INFO - 'base_work_dir': '/builds/slave/test', 09:42:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:42:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:42:48 INFO - 'branch': 'Fx-Team-Non-PGO', 09:42:48 INFO - 'buildbot_json_path': 'buildprops.json', 09:42:48 INFO - 'config_files': ('talos/linux_config.py',), 09:42:48 INFO - 'default_actions': ('clobber', 09:42:48 INFO - 'read-buildbot-config', 09:42:48 INFO - 'download-and-extract', 09:42:48 INFO - 'populate-webroot', 09:42:48 INFO - 'create-virtualenv', 09:42:48 INFO - 'install', 09:42:48 INFO - 'run-tests'), 09:42:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:42:48 INFO - 'download_minidump_stackwalk': True, 09:42:48 INFO - 'download_symbols': 'ondemand', 09:42:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:42:48 INFO - 'tooltool.py': '/tools/tooltool.py', 09:42:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:42:48 INFO - '/tools/misc-python/virtualenv.py')}, 09:42:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:42:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:42:48 INFO - 'installer_path': 'installer.exe', 09:42:48 INFO - 'log_level': 'info', 09:42:48 INFO - 'log_name': 'talos', 09:42:48 INFO - 'log_to_console': True, 09:42:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:42:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:42:48 INFO - 'opt_config_files': (), 09:42:48 INFO - 'pip_index': False, 09:42:48 INFO - 'sps_profile': False, 09:42:48 INFO - 'sps_profile_interval': 0, 09:42:48 INFO - 'suite': 'dromaeojs', 09:42:48 INFO - 'system_bits': '64', 09:42:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:42:48 INFO - 'title': 'talos-linux64-ix-013', 09:42:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:42:48 INFO - 'use_talos_json': True, 09:42:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:42:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:42:48 INFO - 'work_dir': 'build'} 09:42:48 INFO - ##### 09:42:48 INFO - ##### Running clobber step. 09:42:48 INFO - ##### 09:42:48 INFO - Running pre-action listener: _resource_record_pre_action 09:42:48 INFO - Running main action method: clobber 09:42:48 INFO - rmtree: /builds/slave/test/build 09:42:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:42:48 INFO - Running post-action listener: _resource_record_post_action 09:42:48 INFO - ##### 09:42:48 INFO - ##### Running read-buildbot-config step. 09:42:48 INFO - ##### 09:42:48 INFO - Running pre-action listener: _resource_record_pre_action 09:42:48 INFO - Running main action method: read_buildbot_config 09:42:48 INFO - Using buildbot properties: 09:42:48 INFO - { 09:42:48 INFO - "properties": { 09:42:48 INFO - "buildnumber": 2202, 09:42:48 INFO - "product": "firefox", 09:42:48 INFO - "script_repo_revision": "production", 09:42:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:42:48 INFO - "repository": "", 09:42:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:42:48 INFO - "buildid": "20151211083202", 09:42:48 INFO - "slavename": "talos-linux64-ix-013", 09:42:48 INFO - "pgo_build": "False", 09:42:48 INFO - "basedir": "/builds/slave/test", 09:42:48 INFO - "project": "", 09:42:48 INFO - "platform": "ubuntu64_hw", 09:42:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:42:48 INFO - "slavebuilddir": "test", 09:42:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:42:48 INFO - "branch": "fx-team", 09:42:48 INFO - "repo_path": "integration/fx-team", 09:42:48 INFO - "stage_platform": "linux64", 09:42:48 INFO - "builduid": "e69bdc5b86cb46699cff39c07c3c6e2b", 09:42:48 INFO - "revision": "c56806034eda39d8275a071152eb2704411906a9" 09:42:48 INFO - }, 09:42:48 INFO - "sourcestamp": { 09:42:48 INFO - "repository": "", 09:42:48 INFO - "hasPatch": false, 09:42:48 INFO - "project": "", 09:42:48 INFO - "branch": "fx-team-linux64-talos", 09:42:48 INFO - "changes": [ 09:42:48 INFO - { 09:42:48 INFO - "category": null, 09:42:48 INFO - "files": [ 09:42:48 INFO - { 09:42:48 INFO - "url": null, 09:42:48 INFO - "name": "https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:42:48 INFO - } 09:42:48 INFO - ], 09:42:48 INFO - "repository": "", 09:42:48 INFO - "rev": "c56806034eda39d8275a071152eb2704411906a9", 09:42:48 INFO - "who": "maglione.k@gmail.com", 09:42:48 INFO - "when": 1449855743, 09:42:48 INFO - "number": 7350103, 09:42:48 INFO - "comments": "Bug 1231827: Fix ESLint regressions in toolkit/components/extensions. r=trivial", 09:42:48 INFO - "project": "", 09:42:48 INFO - "at": "Fri 11 Dec 2015 09:42:23", 09:42:48 INFO - "branch": "fx-team-linux64-talos", 09:42:48 INFO - "revlink": "", 09:42:48 INFO - "properties": [ 09:42:48 INFO - [ 09:42:48 INFO - "buildid", 09:42:48 INFO - "20151211083202", 09:42:48 INFO - "Change" 09:42:48 INFO - ], 09:42:48 INFO - [ 09:42:48 INFO - "builduid", 09:42:48 INFO - "e69bdc5b86cb46699cff39c07c3c6e2b", 09:42:48 INFO - "Change" 09:42:48 INFO - ], 09:42:48 INFO - [ 09:42:48 INFO - "pgo_build", 09:42:48 INFO - "False", 09:42:48 INFO - "Change" 09:42:48 INFO - ] 09:42:48 INFO - ], 09:42:48 INFO - "revision": "c56806034eda39d8275a071152eb2704411906a9" 09:42:48 INFO - } 09:42:48 INFO - ], 09:42:48 INFO - "revision": "c56806034eda39d8275a071152eb2704411906a9" 09:42:48 INFO - } 09:42:48 INFO - } 09:42:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:42:48 INFO - Running post-action listener: _resource_record_post_action 09:42:48 INFO - ##### 09:42:48 INFO - ##### Running download-and-extract step. 09:42:48 INFO - ##### 09:42:48 INFO - Running pre-action listener: _resource_record_pre_action 09:42:48 INFO - Running main action method: download_and_extract 09:42:48 INFO - mkdir: /builds/slave/test/build/tests 09:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:42:48 INFO - https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:42:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/test_packages.json 09:42:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/test_packages.json 09:42:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:42:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:42:53 INFO - Downloaded 1302 bytes. 09:42:53 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:42:53 INFO - Using the following test package requirements: 09:42:53 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:53 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:42:53 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:53 INFO - u'jsshell-linux-x86_64.zip'], 09:42:53 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:42:53 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:53 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:42:53 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:42:53 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:42:53 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:42:53 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:42:53 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:42:53 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:42: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')]} 09:42:53 INFO - https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:42:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:42:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:42:54 INFO - Downloaded 21874385 bytes. 09:42:54 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 09:42:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:54 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 09:42:55 INFO - Return code: 0 09:42:55 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 09:42: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')]} 09:42:55 INFO - https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:42:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:42:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:42:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:01 INFO - Downloaded 21874385 bytes. 09:43:01 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 09:43:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:43:01 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 09:43:02 INFO - Return code: 0 09:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:02 INFO - https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:43:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:03 INFO - Downloaded 11132038 bytes. 09:43:03 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 09:43:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:43:03 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 09:43:04 INFO - Return code: 0 09:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:04 INFO - https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:43:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tOzhRjFVRmutytLRo2Q9YA/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 09:43:05 INFO - Downloaded 57727543 bytes. 09:43:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:05 INFO - mkdir: /builds/slave/test/properties 09:43:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:43:05 INFO - Writing to file /builds/slave/test/properties/build_url 09:43:05 INFO - Contents: 09:43:05 INFO - build_url:https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:43:05 INFO - Running post-action listener: _resource_record_post_action 09:43:05 INFO - Running post-action listener: set_extra_try_arguments 09:43:05 INFO - ##### 09:43:05 INFO - ##### Running populate-webroot step. 09:43:05 INFO - ##### 09:43:05 INFO - Running pre-action listener: _resource_record_pre_action 09:43:05 INFO - Running main action method: populate_webroot 09:43:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:43:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:43:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:43:05 INFO - '--tppagecycles', 09:43:05 INFO - '7'], 09:43:05 INFO - 'tests': ['tsvgm']}}, 09:43:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:43:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:43:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:43:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:43:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:43:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:43:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:05 INFO - 'talos_options': ['--e10s'], 09:43:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:05 INFO - 'tests': ['damp', 'tps']}, 09:43:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:05 INFO - 'talos_options': ['--e10s'], 09:43:05 INFO - 'tests': ['damp', 'tps']}, 09:43:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:43:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:43:05 INFO - 'other': {'tests': ['a11yr', 09:43:05 INFO - 'ts_paint', 09:43:05 INFO - 'tpaint', 09:43:05 INFO - 'sessionrestore', 09:43:05 INFO - 'sessionrestore_no_auto_restore']}, 09:43:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:43:05 INFO - 'tests': ['a11yr', 09:43:05 INFO - 'ts_paint', 09:43:05 INFO - 'tpaint', 09:43:05 INFO - 'sessionrestore', 09:43:05 INFO - 'sessionrestore_no_auto_restore']}, 09:43:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:43:05 INFO - 'tests': ['a11yr', 09:43:05 INFO - 'ts_paint', 09:43:05 INFO - 'tpaint', 09:43:05 INFO - 'sessionrestore', 09:43:05 INFO - 'sessionrestore_no_auto_restore']}, 09:43:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:43:05 INFO - 'tests': ['a11yr', 09:43:05 INFO - 'ts_paint', 09:43:05 INFO - 'tpaint', 09:43:05 INFO - 'sessionrestore', 09:43:05 INFO - 'sessionrestore_no_auto_restore']}, 09:43:05 INFO - 'other_l64': {'tests': ['a11yr', 09:43:05 INFO - 'ts_paint', 09:43:05 INFO - 'tpaint', 09:43:05 INFO - 'sessionrestore', 09:43:05 INFO - 'sessionrestore_no_auto_restore']}, 09:43:05 INFO - 'other_nol64': {'tests': ['a11yr', 09:43:05 INFO - 'ts_paint', 09:43:05 INFO - 'tpaint', 09:43:05 INFO - 'sessionrestore', 09:43:05 INFO - 'sessionrestore_no_auto_restore']}, 09:43:05 INFO - 'svgr': {'tests': ['tsvgx', 09:43:05 INFO - 'tsvgr_opacity', 09:43:05 INFO - 'tart', 09:43:05 INFO - 'tscrollx', 09:43:05 INFO - 'cart']}, 09:43:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:43:05 INFO - 'tests': ['tsvgx', 09:43:05 INFO - 'tsvgr_opacity', 09:43:05 INFO - 'tart', 09:43:05 INFO - 'tscrollx', 09:43:05 INFO - 'cart']}, 09:43:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:05 INFO - 'tests': ['tp5o']}, 09:43:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:05 INFO - 'talos_options': ['--e10s'], 09:43:05 INFO - 'tests': ['tp5o']}, 09:43:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:05 INFO - 'talos_options': ['--xperf_path', 09:43:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:05 INFO - 'tests': ['tp5n']}, 09:43:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:05 INFO - 'talos_options': ['--e10s', 09:43:05 INFO - '--xperf_path', 09:43:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:05 INFO - 'tests': ['tp5n']}}, 09:43:05 INFO - 'talos.zip': {'path': '', 09:43:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:43:05 INFO - Running post-action listener: _resource_record_post_action 09:43:05 INFO - ##### 09:43:05 INFO - ##### Running create-virtualenv step. 09:43:05 INFO - ##### 09:43:05 INFO - Running pre-action listener: _resource_record_pre_action 09:43:05 INFO - Running main action method: create_virtualenv 09:43:05 INFO - Creating virtualenv /builds/slave/test/build/venv 09:43:05 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 09:43:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:43:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:43:05 INFO - Using real prefix '/usr' 09:43:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:43:07 INFO - Installing distribute.............................................................................................................................................................................................done. 09:43:09 INFO - Installing pip.................done. 09:43:09 INFO - Return code: 0 09:43:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:43:09 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')]} 09:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:09 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')]} 09:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:09 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 0x7fb703d3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29300b0>, '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 0x2930fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931440>, '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': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', '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 09:43:09 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 09:43:09 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 09:43:09 INFO - Using env: {'DISPLAY': ':0', 09:43:09 INFO - 'HOME': '/home/cltbld', 09:43:09 INFO - 'LANG': 'en_US.UTF-8', 09:43:09 INFO - 'LANGUAGE': 'en_US:en', 09:43:09 INFO - 'LOGNAME': 'cltbld', 09:43:09 INFO - 'MAIL': '/var/mail/cltbld', 09:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:09 INFO - 'MOZ_NO_REMOTE': '1', 09:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:09 INFO - 'NO_EM_RESTART': '1', 09:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:09 INFO - 'PWD': '/builds/slave/test', 09:43:09 INFO - 'SHELL': '/bin/bash', 09:43:09 INFO - 'SHLVL': '1', 09:43:09 INFO - 'TERM': 'linux', 09:43:09 INFO - 'TMOUT': '86400', 09:43:09 INFO - 'USER': 'cltbld', 09:43:09 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', 09:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:09 INFO - '_': '/tools/buildbot/bin/python'} 09:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:09 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 09:43:09 INFO - Cleaning up... 09:43:09 INFO - Return code: 0 09:43:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:43:09 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')]} 09:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:09 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')]} 09:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:09 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 0x7fb703d3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29300b0>, '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 0x2930fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931440>, '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': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', '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 09:43:09 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 09:43:09 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 09:43:09 INFO - Using env: {'DISPLAY': ':0', 09:43:09 INFO - 'HOME': '/home/cltbld', 09:43:09 INFO - 'LANG': 'en_US.UTF-8', 09:43:09 INFO - 'LANGUAGE': 'en_US:en', 09:43:09 INFO - 'LOGNAME': 'cltbld', 09:43:09 INFO - 'MAIL': '/var/mail/cltbld', 09:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:09 INFO - 'MOZ_NO_REMOTE': '1', 09:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:09 INFO - 'NO_EM_RESTART': '1', 09:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:09 INFO - 'PWD': '/builds/slave/test', 09:43:09 INFO - 'SHELL': '/bin/bash', 09:43:09 INFO - 'SHLVL': '1', 09:43:09 INFO - 'TERM': 'linux', 09:43:09 INFO - 'TMOUT': '86400', 09:43:09 INFO - 'USER': 'cltbld', 09:43:09 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', 09:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:09 INFO - '_': '/tools/buildbot/bin/python'} 09:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:09 INFO - Downloading/unpacking psutil>=0.7.1 09:43:09 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 09:43:09 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 09:43:09 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 09:43:09 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 09:43:09 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 09:43:09 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 09:43:11 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:43:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:43:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:11 INFO - Installing collected packages: psutil 09:43:11 INFO - Running setup.py install for psutil 09:43:11 INFO - building 'psutil._psutil_linux' extension 09:43:11 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 09:43:11 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 09:43:11 INFO - building 'psutil._psutil_posix' extension 09:43:11 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 09:43:11 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 09:43:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:11 INFO - Successfully installed psutil 09:43:11 INFO - Cleaning up... 09:43:11 INFO - Return code: 0 09:43:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:43:11 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')]} 09:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:11 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')]} 09:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:11 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 0x7fb703d3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29300b0>, '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 0x2930fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931440>, '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': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', '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 09:43:11 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 09:43:11 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 09:43:11 INFO - Using env: {'DISPLAY': ':0', 09:43:11 INFO - 'HOME': '/home/cltbld', 09:43:11 INFO - 'LANG': 'en_US.UTF-8', 09:43:11 INFO - 'LANGUAGE': 'en_US:en', 09:43:11 INFO - 'LOGNAME': 'cltbld', 09:43:11 INFO - 'MAIL': '/var/mail/cltbld', 09:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:11 INFO - 'MOZ_NO_REMOTE': '1', 09:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:11 INFO - 'NO_EM_RESTART': '1', 09:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:11 INFO - 'PWD': '/builds/slave/test', 09:43:11 INFO - 'SHELL': '/bin/bash', 09:43:11 INFO - 'SHLVL': '1', 09:43:11 INFO - 'TERM': 'linux', 09:43:11 INFO - 'TMOUT': '86400', 09:43:11 INFO - 'USER': 'cltbld', 09:43:11 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', 09:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:11 INFO - '_': '/tools/buildbot/bin/python'} 09:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:43:12 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 09:43:12 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 09:43:12 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 09:43:12 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 09:43:12 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 09:43:12 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 09:43:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:43:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:43:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:43:13 INFO - Installing collected packages: mozsystemmonitor 09:43:13 INFO - Running setup.py install for mozsystemmonitor 09:43:13 INFO - Successfully installed mozsystemmonitor 09:43:13 INFO - Cleaning up... 09:43:14 INFO - Return code: 0 09:43:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:43:14 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')]} 09:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:14 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')]} 09:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:14 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 0x7fb703d3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29300b0>, '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 0x2930fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931440>, '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': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', '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 09:43:14 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 09:43:14 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 09:43:14 INFO - Using env: {'DISPLAY': ':0', 09:43:14 INFO - 'HOME': '/home/cltbld', 09:43:14 INFO - 'LANG': 'en_US.UTF-8', 09:43:14 INFO - 'LANGUAGE': 'en_US:en', 09:43:14 INFO - 'LOGNAME': 'cltbld', 09:43:14 INFO - 'MAIL': '/var/mail/cltbld', 09:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:14 INFO - 'MOZ_NO_REMOTE': '1', 09:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:14 INFO - 'NO_EM_RESTART': '1', 09:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:14 INFO - 'PWD': '/builds/slave/test', 09:43:14 INFO - 'SHELL': '/bin/bash', 09:43:14 INFO - 'SHLVL': '1', 09:43:14 INFO - 'TERM': 'linux', 09:43:14 INFO - 'TMOUT': '86400', 09:43:14 INFO - 'USER': 'cltbld', 09:43:14 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', 09:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:14 INFO - '_': '/tools/buildbot/bin/python'} 09:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:14 INFO - Downloading/unpacking blobuploader==1.2.4 09:43:14 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 09:43:14 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 09:43:14 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 09:43:14 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 09:43:14 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 09:43:14 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 09:43:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:43:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:43:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:43:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:43:15 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 09:43:15 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 09:43:15 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 09:43:15 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 09:43:15 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 09:43:15 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 09:43:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:43:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:43:16 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 09:43:16 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 09:43:16 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 09:43:16 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 09:43:16 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 09:43:16 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 09:43:16 INFO - Downloading docopt-0.6.1.tar.gz 09:43:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:43:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:43:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:43:16 INFO - Running setup.py install for blobuploader 09:43:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:43:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:43:16 INFO - Running setup.py install for requests 09:43:17 INFO - Running setup.py install for docopt 09:43:17 INFO - Successfully installed blobuploader requests docopt 09:43:17 INFO - Cleaning up... 09:43:17 INFO - Return code: 0 09:43:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:17 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')]} 09:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:17 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')]} 09:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:17 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 0x7fb703d3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29300b0>, '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 0x2930fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931440>, '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': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', '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 09:43:17 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 09:43:17 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 09:43:17 INFO - Using env: {'DISPLAY': ':0', 09:43:17 INFO - 'HOME': '/home/cltbld', 09:43:17 INFO - 'LANG': 'en_US.UTF-8', 09:43:17 INFO - 'LANGUAGE': 'en_US:en', 09:43:17 INFO - 'LOGNAME': 'cltbld', 09:43:17 INFO - 'MAIL': '/var/mail/cltbld', 09:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:17 INFO - 'MOZ_NO_REMOTE': '1', 09:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:17 INFO - 'NO_EM_RESTART': '1', 09:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:17 INFO - 'PWD': '/builds/slave/test', 09:43:17 INFO - 'SHELL': '/bin/bash', 09:43:17 INFO - 'SHLVL': '1', 09:43:17 INFO - 'TERM': 'linux', 09:43:17 INFO - 'TMOUT': '86400', 09:43:17 INFO - 'USER': 'cltbld', 09:43:17 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', 09:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:17 INFO - '_': '/tools/buildbot/bin/python'} 09:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:43:17 INFO - Running setup.py (path:/tmp/pip-5kYn6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:43:17 INFO - Running setup.py (path:/tmp/pip-v37evw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:43:17 INFO - Running setup.py (path:/tmp/pip-fX4vVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:43:17 INFO - Running setup.py (path:/tmp/pip-Lndp8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:43:17 INFO - Running setup.py (path:/tmp/pip-PfgIx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:43:17 INFO - Running setup.py (path:/tmp/pip-QNGxqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:43:17 INFO - Running setup.py (path:/tmp/pip-ROQPPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:43:17 INFO - Running setup.py (path:/tmp/pip-xa6Ytc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:43:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:43:17 INFO - Running setup.py (path:/tmp/pip-CKJr8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:43:18 INFO - Running setup.py (path:/tmp/pip-T1FN5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:43:18 INFO - Running setup.py (path:/tmp/pip-lS9OYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:43:18 INFO - Running setup.py (path:/tmp/pip-KZvm_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:43:18 INFO - Running setup.py (path:/tmp/pip-UGelyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:43:18 INFO - Running setup.py (path:/tmp/pip-iKbENF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:18 INFO - Running setup.py (path:/tmp/pip-uTbjhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:18 INFO - Running setup.py (path:/tmp/pip-DcTAFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:18 INFO - Running setup.py (path:/tmp/pip-HJeVkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:43:18 INFO - Running setup.py install for manifestparser 09:43:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:43:18 INFO - Running setup.py install for mozcrash 09:43:18 INFO - Running setup.py install for mozdebug 09:43:18 INFO - Running setup.py install for mozdevice 09:43:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Running setup.py install for mozfile 09:43:19 INFO - Running setup.py install for mozhttpd 09:43:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Running setup.py install for mozinfo 09:43:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Running setup.py install for mozInstall 09:43:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Running setup.py install for mozleak 09:43:19 INFO - Running setup.py install for mozlog 09:43:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Running setup.py install for moznetwork 09:43:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Running setup.py install for mozprocess 09:43:19 INFO - Running setup.py install for mozprofile 09:43:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:43:19 INFO - Running setup.py install for mozrunner 09:43:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:43:20 INFO - Running setup.py install for mozscreenshot 09:43:20 INFO - Running setup.py install for moztest 09:43:20 INFO - Running setup.py install for mozversion 09:43:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:43:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:43:20 INFO - Cleaning up... 09:43:20 INFO - Return code: 0 09:43:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:20 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 0x7fb703d3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29300b0>, '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 0x2930fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931440>, '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': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', '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 09:43:20 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 09:43:20 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 09:43:20 INFO - Using env: {'DISPLAY': ':0', 09:43:20 INFO - 'HOME': '/home/cltbld', 09:43:20 INFO - 'LANG': 'en_US.UTF-8', 09:43:20 INFO - 'LANGUAGE': 'en_US:en', 09:43:20 INFO - 'LOGNAME': 'cltbld', 09:43:20 INFO - 'MAIL': '/var/mail/cltbld', 09:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:20 INFO - 'MOZ_NO_REMOTE': '1', 09:43:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:20 INFO - 'NO_EM_RESTART': '1', 09:43:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:20 INFO - 'PWD': '/builds/slave/test', 09:43:20 INFO - 'SHELL': '/bin/bash', 09:43:20 INFO - 'SHLVL': '1', 09:43:20 INFO - 'TERM': 'linux', 09:43:20 INFO - 'TMOUT': '86400', 09:43:20 INFO - 'USER': 'cltbld', 09:43:20 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', 09:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:20 INFO - '_': '/tools/buildbot/bin/python'} 09:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:43:20 INFO - Running setup.py (path:/tmp/pip-lRu7Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:43:20 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)) 09:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:43:20 INFO - Running setup.py (path:/tmp/pip-kI8JOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:43:20 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)) 09:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:43:20 INFO - Running setup.py (path:/tmp/pip-XvW_XQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:43:20 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)) 09:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:43:20 INFO - Running setup.py (path:/tmp/pip-rKBFpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:43:20 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)) 09:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:43:20 INFO - Running setup.py (path:/tmp/pip-hrChcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:43:20 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)) 09:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:43:20 INFO - Running setup.py (path:/tmp/pip-KlOjQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:43:21 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)) 09:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:43:21 INFO - Running setup.py (path:/tmp/pip-e49khy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:43:21 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)) 09:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:43:21 INFO - Running setup.py (path:/tmp/pip-9tvxRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:43:21 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)) 09:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:43:21 INFO - Running setup.py (path:/tmp/pip-Z0K6Lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:43:21 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)) 09:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:43:21 INFO - Running setup.py (path:/tmp/pip-SdVcT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:43:21 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)) 09:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:43:21 INFO - Running setup.py (path:/tmp/pip-o4KMXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:43:21 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)) 09:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:43:21 INFO - Running setup.py (path:/tmp/pip-3GWwZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:43:21 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)) 09:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:43:21 INFO - Running setup.py (path:/tmp/pip-QmWnn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:43:21 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)) 09:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:43:21 INFO - Running setup.py (path:/tmp/pip-Myunl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:43:21 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)) 09:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:21 INFO - Running setup.py (path:/tmp/pip-kuvvC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:43:21 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)) 09:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:43:21 INFO - Running setup.py (path:/tmp/pip-RLlb5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:43:22 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)) 09:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:43:22 INFO - Running setup.py (path:/tmp/pip-g8jvKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:43:22 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)) 09:43:22 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)) 09:43:22 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)) 09:43:22 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)) 09:43:22 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)) 09:43:22 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)) 09:43:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 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 09:43:22 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 09:43:23 INFO - Downloading blessings-1.5.1.tar.gz 09:43:23 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 09:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:43:23 INFO - Installing collected packages: blessings 09:43:23 INFO - Running setup.py install for blessings 09:43:23 INFO - Successfully installed blessings 09:43:23 INFO - Cleaning up... 09:43:23 INFO - Return code: 0 09:43:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:43:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:24 INFO - Reading from file tmpfile_stdout 09:43:24 INFO - Current package versions: 09:43:24 INFO - argparse == 1.2.1 09:43:24 INFO - blessings == 1.5.1 09:43:24 INFO - blobuploader == 1.2.4 09:43:24 INFO - docopt == 0.6.1 09:43:24 INFO - manifestparser == 1.1 09:43:24 INFO - mozInstall == 1.12 09:43:24 INFO - mozcrash == 0.16 09:43:24 INFO - mozdebug == 0.1 09:43:24 INFO - mozdevice == 0.47 09:43:24 INFO - mozfile == 1.2 09:43:24 INFO - mozhttpd == 0.7 09:43:24 INFO - mozinfo == 0.9 09:43:24 INFO - mozleak == 0.1 09:43:24 INFO - mozlog == 3.1 09:43:24 INFO - moznetwork == 0.27 09:43:24 INFO - mozprocess == 0.22 09:43:24 INFO - mozprofile == 0.27 09:43:24 INFO - mozrunner == 6.11 09:43:24 INFO - mozscreenshot == 0.1 09:43:24 INFO - mozsystemmonitor == 0.0 09:43:24 INFO - moztest == 0.7 09:43:24 INFO - mozversion == 1.4 09:43:24 INFO - psutil == 3.1.1 09:43:24 INFO - requests == 1.2.3 09:43:24 INFO - wsgiref == 0.1.2 09:43:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:24 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 0x7fb703d3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29300b0>, '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 0x2930fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931440>, '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': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', '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 09:43:24 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 09:43:24 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 09:43:24 INFO - Using env: {'DISPLAY': ':0', 09:43:24 INFO - 'HOME': '/home/cltbld', 09:43:24 INFO - 'LANG': 'en_US.UTF-8', 09:43:24 INFO - 'LANGUAGE': 'en_US:en', 09:43:24 INFO - 'LOGNAME': 'cltbld', 09:43:24 INFO - 'MAIL': '/var/mail/cltbld', 09:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:24 INFO - 'MOZ_NO_REMOTE': '1', 09:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:24 INFO - 'NO_EM_RESTART': '1', 09:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:24 INFO - 'PWD': '/builds/slave/test', 09:43:24 INFO - 'SHELL': '/bin/bash', 09:43:24 INFO - 'SHLVL': '1', 09:43:24 INFO - 'TERM': 'linux', 09:43:24 INFO - 'TMOUT': '86400', 09:43:24 INFO - 'USER': 'cltbld', 09:43:24 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', 09:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:24 INFO - '_': '/tools/buildbot/bin/python'} 09:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:24 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)) 09:43:24 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)) 09:43:24 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)) 09:43:24 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)) 09:43:24 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)) 09:43:24 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)) 09:43:24 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)) 09:43:24 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)) 09:43:24 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)) 09:43:24 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)) 09:43:24 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)) 09:43:24 INFO - Cleaning up... 09:43:24 INFO - Return code: 0 09:43:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:24 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 0x7fb703d3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29300b0>, '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 0x2930fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931440>, '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': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', '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 09:43:24 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 09:43:24 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 09:43:24 INFO - Using env: {'DISPLAY': ':0', 09:43:24 INFO - 'HOME': '/home/cltbld', 09:43:24 INFO - 'LANG': 'en_US.UTF-8', 09:43:24 INFO - 'LANGUAGE': 'en_US:en', 09:43:24 INFO - 'LOGNAME': 'cltbld', 09:43:24 INFO - 'MAIL': '/var/mail/cltbld', 09:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:24 INFO - 'MOZ_NO_REMOTE': '1', 09:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:24 INFO - 'NO_EM_RESTART': '1', 09:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:24 INFO - 'PWD': '/builds/slave/test', 09:43:24 INFO - 'SHELL': '/bin/bash', 09:43:24 INFO - 'SHLVL': '1', 09:43:24 INFO - 'TERM': 'linux', 09:43:24 INFO - 'TMOUT': '86400', 09:43:24 INFO - 'USER': 'cltbld', 09:43:24 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', 09:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:24 INFO - '_': '/tools/buildbot/bin/python'} 09:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:24 INFO - Downloading/unpacking jsonschema 09:43:24 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 09:43:24 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 09:43:24 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 09:43:24 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 09:43:24 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 09:43:24 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 09:43:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:43:26 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 09:43:26 INFO - Downloading/unpacking functools32 (from jsonschema) 09:43:26 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 09:43:26 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 09:43:26 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 09:43:26 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 09:43:26 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 09:43:26 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 09:43:26 INFO - Downloading functools32-3.2.3-2.tar.gz 09:43:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:43:26 INFO - warning: no files found matching '*.txt' 09:43:26 INFO - no previously-included directories found matching 'build' 09:43:26 INFO - no previously-included directories found matching 'dist' 09:43:26 INFO - no previously-included directories found matching '.git*' 09:43:26 INFO - Installing collected packages: jsonschema, functools32 09:43:26 INFO - Running setup.py install for functools32 09:43:27 INFO - warning: no files found matching '*.txt' 09:43:27 INFO - no previously-included directories found matching 'build' 09:43:27 INFO - no previously-included directories found matching 'dist' 09:43:27 INFO - no previously-included directories found matching '.git*' 09:43:27 INFO - Successfully installed jsonschema functools32 09:43:27 INFO - Cleaning up... 09:43:27 INFO - Return code: 0 09:43:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:43: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')]} 09:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43: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')]} 09:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:27 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 0x7fb703d3ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28a1240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29300b0>, '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 0x2930fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931440>, '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': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', '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 09:43:27 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 09:43:27 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 09:43:27 INFO - Using env: {'DISPLAY': ':0', 09:43:27 INFO - 'HOME': '/home/cltbld', 09:43:27 INFO - 'LANG': 'en_US.UTF-8', 09:43:27 INFO - 'LANGUAGE': 'en_US:en', 09:43:27 INFO - 'LOGNAME': 'cltbld', 09:43:27 INFO - 'MAIL': '/var/mail/cltbld', 09:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:27 INFO - 'MOZ_NO_REMOTE': '1', 09:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:27 INFO - 'NO_EM_RESTART': '1', 09:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:27 INFO - 'PWD': '/builds/slave/test', 09:43:27 INFO - 'SHELL': '/bin/bash', 09:43:27 INFO - 'SHLVL': '1', 09:43:27 INFO - 'TERM': 'linux', 09:43:27 INFO - 'TMOUT': '86400', 09:43:27 INFO - 'USER': 'cltbld', 09:43:27 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', 09:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:27 INFO - '_': '/tools/buildbot/bin/python'} 09:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:27 INFO - Downloading/unpacking flake8 09:43:27 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 09:43:27 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 09:43:27 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 09:43:27 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 09:43:27 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 09:43:27 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 09:43:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:43:28 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 09:43:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:43:28 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 09:43:28 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 09:43:28 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 09:43:28 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 09:43:28 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 09:43:28 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 09:43:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:43:29 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 09:43:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:43:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:43:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:43:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:43:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:43:29 INFO - no previously-included directories found matching 'docs/_build' 09:43:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:43:29 INFO - Running setup.py install for pep8 09:43:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:43:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:43:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:43:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:43:29 INFO - no previously-included directories found matching 'docs/_build' 09:43:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:43:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:43:29 INFO - Cleaning up... 09:43:29 INFO - Return code: 0 09:43:29 INFO - Running post-action listener: _resource_record_post_action 09:43:29 INFO - Running post-action listener: _start_resource_monitoring 09:43:29 INFO - Starting resource monitoring. 09:43:29 INFO - ##### 09:43:29 INFO - ##### Running install step. 09:43:29 INFO - ##### 09:43:29 INFO - Running pre-action listener: _resource_record_pre_action 09:43:29 INFO - Running main action method: install 09:43:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:43:30 INFO - Reading from file tmpfile_stdout 09:43:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:43:30 INFO - Reading from file tmpfile_stdout 09:43:30 INFO - Output received: 09:43:30 INFO - Usage: mozinstall [options] installer 09:43:30 INFO - Options: 09:43:30 INFO - -h, --help show this help message and exit 09:43:30 INFO - -d DEST, --destination=DEST 09:43:30 INFO - Directory to install application into. [default: 09:43:30 INFO - "/builds/slave/test"] 09:43:30 INFO - --app=APP Application being installed. [default: firefox] 09:43:30 INFO - mkdir: /builds/slave/test/build/application 09:43:30 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'] 09:43:30 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 09:43:49 INFO - Reading from file tmpfile_stdout 09:43:49 INFO - Output received: 09:43:49 INFO - /builds/slave/test/build/application/firefox/firefox 09:43:49 INFO - Running post-action listener: _resource_record_post_action 09:43:49 INFO - ##### 09:43:49 INFO - ##### Running run-tests step. 09:43:49 INFO - ##### 09:43:49 INFO - Running pre-action listener: _resource_record_pre_action 09:43:49 INFO - Running main action method: run_tests 09:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:43:49 INFO - Python 2.7.3 09:43:49 INFO - Return code: 0 09:43:49 INFO - grabbing minidump binary from tooltool 09:43: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')]} 09:43:49 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 0x29300b0>, '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 0x2930fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2931440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:43:49 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 09:43:49 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 09:43:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:43:49 INFO - Return code: 0 09:43:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:43:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:43:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:43:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:43:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:43:50 INFO - Return code: 0 09:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] in /builds/slave/test/build 09:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost 09:43:50 INFO - Using env: {'DISPLAY': ':0', 09:43:50 INFO - 'HOME': '/home/cltbld', 09:43:50 INFO - 'LANG': 'en_US.UTF-8', 09:43:50 INFO - 'LANGUAGE': 'en_US:en', 09:43:50 INFO - 'LOGNAME': 'cltbld', 09:43:50 INFO - 'MAIL': '/var/mail/cltbld', 09:43:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:43:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:50 INFO - 'MOZ_NO_REMOTE': '1', 09:43:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:50 INFO - 'NO_EM_RESTART': '1', 09:43:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:50 INFO - 'PWD': '/builds/slave/test', 09:43:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:43:50 INFO - 'SHELL': '/bin/bash', 09:43:50 INFO - 'SHLVL': '1', 09:43:50 INFO - 'TERM': 'linux', 09:43:50 INFO - 'TMOUT': '86400', 09:43:50 INFO - 'USER': 'cltbld', 09:43:50 INFO - 'XDG_SESSION_COOKIE': '256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191', 09:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:50 INFO - '_': '/tools/buildbot/bin/python'} 09:43:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost'] with output_timeout 3600 09:43:50 INFO - mozversion INFO | application_buildid: 20151211083202 09:43:50 INFO - mozversion INFO | application_changeset: c56806034eda39d8275a071152eb2704411906a9 09:43:50 INFO - mozversion INFO | application_display_name: Nightly 09:43:50 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:43:50 INFO - mozversion INFO | application_name: Firefox 09:43:50 INFO - mozversion INFO | application_remotingname: firefox 09:43:50 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:43:50 INFO - mozversion INFO | application_vendor: Mozilla 09:43:50 INFO - mozversion INFO | application_version: 45.0a1 09:43:50 INFO - mozversion INFO | platform_buildid: 20151211083202 09:43:50 INFO - mozversion INFO | platform_changeset: c56806034eda39d8275a071152eb2704411906a9 09:43:50 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:43:50 INFO - mozversion INFO | platform_version: 45.0a1 09:43:50 INFO - 2015-12-11 09:43:50,799 DEBUG : using testdate: 1449855830 09:43:50 INFO - 2015-12-11 09:43:50,799 DEBUG : actual date: 1449855830 09:43:50 INFO - 2015-12-11 09:43:50,808 INFO : starting webserver on 'localhost:51833' 09:43:50 INFO - 2015-12-11 09:43:50,809 INFO : Starting test suite talos-linux64-ix-013 09:43:50 INFO - 2015-12-11 09:43:50,809 INFO : Starting test dromaeo_css 09:43:50 INFO - 2015-12-11 09:43:50,809 DEBUG : operating with platform_type : linux_ 09:43:50 INFO - 2015-12-11 09:43:50,809 INFO : Initialising browser for dromaeo_css test... 09:43:50 INFO - 2015-12-11 09:43:50,816 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPZF1E/profile http://localhost:51833/getInfo.html 09:44:47 INFO - 2015-12-11 09:44:47,899 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:44:47 INFO - 2015-12-11 09:44:47,899 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:44:47 INFO - 2015-12-11 09:44:47,899 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:44:47 INFO - 2015-12-11 09:44:47,899 DEBUG : BROWSER_OUTPUT: __metrics 09:44:48 INFO - 2015-12-11 09:44:48,581 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] 09:44:48 INFO - 2015-12-11 09:44:48,649 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:54 INFO - 2015-12-11 09:44:54,025 INFO : Browser initialized. 09:44:54 INFO - 2015-12-11 09:44:54,026 INFO : Running cycle 1/1 for dromaeo_css test... 09:44:54 INFO - 2015-12-11 09:44:54,026 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPZF1E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:45:06 INFO - 2015-12-11 09:45:06,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 142843904 09:45:06 INFO - 2015-12-11 09:45:06,478 DEBUG : BROWSER_OUTPUT: 09:45:57 INFO - 2015-12-11 09:45:57,682 DEBUG : BROWSER_OUTPUT: 1449855957676 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] 09:48:12 INFO - 2015-12-11 09:48:12,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51833/tests/dromaeo/cssquery-ext.html) 09:48:14 INFO - 2015-12-11 09:48:14,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 259264512 09:48:14 INFO - 2015-12-11 09:48:14,094 DEBUG : BROWSER_OUTPUT: 09:51:16 INFO - 2015-12-11 09:51:16,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/dromaeo/cssquery-ext.html (next: http://localhost:51833/tests/dromaeo/cssquery-jquery.html) 09:51:17 INFO - 2015-12-11 09:51:17,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 220336128 09:51:17 INFO - 2015-12-11 09:51:17,358 DEBUG : BROWSER_OUTPUT: 09:54:19 INFO - 2015-12-11 09:54:19,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51833/tests/dromaeo/cssquery-mootools.html) 09:54:19 INFO - 2015-12-11 09:54:19,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 214016000 09:54:19 INFO - 2015-12-11 09:54:19,883 DEBUG : BROWSER_OUTPUT: 09:57:21 INFO - 2015-12-11 09:57:21,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51833/tests/dromaeo/cssquery-prototype.html) 09:57:22 INFO - 2015-12-11 09:57:22,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 205295616 09:57:22 INFO - 2015-12-11 09:57:22,482 DEBUG : BROWSER_OUTPUT: 10:00:25 INFO - 2015-12-11 10:00:25,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51833/tests/dromaeo/cssquery-yui.html) 10:00:25 INFO - 2015-12-11 10:00:25,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 181407744 10:00:25 INFO - 2015-12-11 10:00:25,806 DEBUG : BROWSER_OUTPUT: 10:03:28 INFO - 2015-12-11 10:03:28,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/dromaeo/cssquery-yui.html (next: http://localhost:51833/tests/dromaeo/cssquery-dojo.html) 10:03:28 INFO - 2015-12-11 10:03:28,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 248860672 10:03:28 INFO - 2015-12-11 10:03:28,604 DEBUG : BROWSER_OUTPUT: 10:03:28 INFO - 2015-12-11 10:03:28,604 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:03:28 INFO - 2015-12-11 10:03:28,604 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:03:28 INFO - 2015-12-11 10:03:28,605 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:03:28 INFO - 2015-12-11 10:03:28,605 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:03:28 INFO - 2015-12-11 10:03:28,605 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2629.2375211188755;2709.7832173426127;2711.539038363478;2726.972730272698;2743.3964527803882;4457.353683715859;4581.88545286368;4614.2155833508305;4676.74277914715;4690.648201384897;4551.6358691304695;4562.384078149449;4620.122176786416;4630.259158534635;4632.490426053131;4291.120320334339;4338.262495375778;4343.956560434387;4412.933805992912;4446.1107778444275;4161.292580261363;4370.257056300421;4388.6050255477;4452.933206001912;4468.374427580141;4249.681273904439;4323.546027667113;4336.457942757155;4354.368616550582;4366.4105345778235;4320.654347652212;4326.8269269229195;4334.154839806239;4343.370211319372;4358.193734159191;4127;4297.656187504992;4305.97847010763;4321.913561728779;4361.498427680825;4564.657650676212;4565.7260564365915;4578.885527861797;4579.084183163381;4587.632989360844;4900.166971614834;4910.877228069291;4928.162212423861;4937.6049916007;5033.723145227011;5076.13705670037;5087.542121209109;5100.719460429675;5128.640995130342;5129.6409251352425;4726.6927649703;4737.573618374363;4739.881502962454;4740.715557066518;4780.808767649255;4979.30289759434;5119.846404607868;5125.718085505333;5214.582833373321;5229.215617657382;4837.346958160673;4889.804407823718;4896.681715688469;4897.14299997499;4948.802047918043;5021.472745361684;5043.646944713835;5085.389753229636;5087.236914462786;5090.643654944192;4770.785314660849;4884.145274577006;4885.560299573055;4990.2764099205415;5000.746380056696;4890.095332363524;4941.382327209099;4966.279889416087;4994.700317980933;4999.950000499948;4214.030772922245;4215.683823713172;4220.052725741392;4223.852165174204;4252.914941701149;3560.964390356063;3700.0379901225338;3702.3705969985167;3736.75711078779;3737.9065523362133;4191.97904010478;4281.2293787118615;4284.828606855691;4288.571142885687;4293.034067334887;5030.622703297267;5058.570021548136;5063.392392912874;5068;5111.7699703513435;4327.0480494291205;4335.111302183045;4340.066885619607;4342.761148136819;4377.102693947733;4286.5070516890955;4331.696781225284;4388.078503514298;4397.824087036547;4438.1567502174485;4728.125296820031;4740.976295118502;4753.049390121921;4764.595009424238;4802.543758342952;4965.106280869478;5023.7488125592845;5025.321581586439;5028.522290382408;5070.188769796815;4630.143423466669;4711.740854253049;4756.191447453872;4756.904861902812;4765;5009.624278179224;5009.649324547247;5014.52362025607;5028.220625803006;5063.443021267732;5028.698278103326;5057.216131499624;5068.746562671926;5070.492950705047;5123.308353372247;4689.859304220879;4805.471398146131;4809.134355815987;4918.262260660929;4921.557059864629;4792.041591681608;4873.4882837301575;4880.829170978998;4883.87790305231;4919.508049195052;4747.928781068218;4806.615470762401;4819.49395313487;4821.2045012573935;4824.131656301899;4726.19654658702;4815.133276010351;4820.975895120502;4823.421189457287;4952.950470495393;4843;4850.7817148227705;4854.17479028559;4854.611631069435;4913.3121363008495 10:03:28 INFO - 2015-12-11 10:03:28,605 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.4237934927024;568.3889818445167;570.167555369161;581.2647001543049;581.2821165860163;24276.27171184865;34501.82749086254;35151.82424087882;35160.2967940641;35166.824165879196;37959.810200949025;38556;38618.613813861855;38631.22737545247;38755.22489550207;7032.542884712503;7135.03677003603;7898.4865983711015;8083.514989100643;8084.1107478177355;7126.572405655651;10052.49737513125;10229.897701023006;10230.232732545051;10231;9888.258380621446;10005.699829005142;10006.849897251546;10014.499275036256;10018.398896066223;7226.3857572106435;7425.925740742578;9526.666566670168;9628.18160456362;9700.320977531575;10017.849732254022;10285.125764310043;10321.896781032168;10322.7419314517;10334.586616535329;34796.30407391838;35137.82431087854;35236.64763352359;35290.470642940374;35314.82342588271;2816.788740844445;2843.9146825595267;3437.9312413751586;3552.0054384772307;3563.6436356364416;26669.866650666816;26831.597526037123;27158.45683086347;27191;28054.913959464648;3157.2422618571377;3167.081546351555;3197.6802319767835;3219.806811591312;3276.9344613107605;319472;326407.9999999976;326790;327380;327531;49405.50594494081;50784.492155077976;50786;53137.468625314024;53892.730536347066;64467.35532644614;65062;65741.67129164323;65743;65755;12830.230186188859;12944;12957.157784743962;13053.804192937114;13055.21668699881;8594.398392112616;8950.910490895138;9350;9537.141657250742;9575.856362154573;18745.812541874406;18815.435536933914;18910;18949.90525047366;18950.620987580172;7575.6969721210535;7651.846963060819;7789.766307010798;7889.64496597643;7914.683412663544;795.8090058385945;878.9516576588348;881.6341218394294;978.1148061004802;985.5811280206027;25567.360815979377;25958.480830383287;25962.610560841604;25995.870020649774;26017;906.2795077913075;932.6735642525198;988.3476905242505;1040.9902394677151;1042.5673345561506;13523.188608683511;13994.580162595139;14019.859801401855;14217.36021879018;14224.786628200585;292251;298454;298549;299437;299593;44388.3341749874;44785;44877.551224487994;44945;45086.549134508234;1139.9943000285111;1171.9920868053637;1172.6657902497748;1216.7809794237123;1231.759806837658;24933.875330623232;25955.48089038171;26399.34001649974;26446.206613801616;26508.7349126514;34688.132796680286;35575.288494229455;38568.228635426574;39885;40905.59094409137;191670;192969;193109;193174;194294;26671.066512671965;26946;26969.73030269672;26987.865060674572;27023.054193103148;29372.853135734185;29625.85187074051;32317;34145;36225.637743622225;27571;30093.548596771503;36803;38100.237995240495;38399.80800096093;36569.45145822868;38192;38440.80779596084;38591.80704096462;38984.220315594095;31222;31553.368932621677;31863.362732745678;31952.680473195902;32007.039788806374;27535.86232068827;29196.708032920247;32904.50643240305;34701.82649086738;34811.825940870134;22933.082676692746;22962.40071835039;23011.769882300963;23076.653850191924;23381.41546461352 10:03:28 INFO - 2015-12-11 10:03:28,605 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.8035549203716;335.80858910421057;338.9084947064292;340.0851708903052;345.83227134839615;12385.628431147057;12753;13715.794263086049;14375.712485750291;14812.185329806856;12736.363181840894;15071.849281507182;15336.386544538205;15689.29398177082;15779.60550986226;4823.204171311738;4967.552920237178;5049.368828896388;5202.583793296527;5212.400573934008;3529.2412131391748;3632.0738211755965;5100.770465329069;5159.535641792238;5211.1922651989;5216.973915130438;5227.581793456515;5230.372355317368;5241.50205730455;5244.68531888086;5228.189630607243;5403.405625381224;5770.798022069207;5780.7687692492245;5787.508061814729;5124.205748109049;5132.948670513284;5133.050385678662;5134.871628209325;5139.563137133311;11463.254888432226;12007;12015.519379224821;12026.278423294543;12031.759364812742;1735.8437740603406;1765.5430487962644;1800.612868233323;1806.051822793031;1823.4985379020875;8832.072632373636;9804.901950980542;10061.14480269178;12849.229046257162;13168.604941851663;1667.7665126882246;1724.146547459016;1758.085795386392;1777.0315178227897;1788.6959216933153;50505.74747126241;52425.47574524244;52621.2106818398;52684.999999999614;53246;9752.46361450127;9783.36408133469;9802.46086465237;9809.509524523888;9822.459764712867;12311.815322770166;12316.199447035913;12348.567800126952;12358.258504489759;12361.196522226026;6733.393994540417;6781.457483401415;6793.694283757242;6827.351401616838;6906.37842594169;6404.199475065617;6407.070974708641;6411.807645770635;6442.226932768098;6484.740610375532;4137.668986481074;4147.2534943710425;4158.106007208404;4162.9791851041155;4189.392538081961;1477.2909003678294;1533.5859317984082;1663.7920259967505;1734.4016314371522;1736.3662263273814;801.2708435323827;835.9842791008954;862.8748831419409;928.1229238369676;958.6357184270072;13332.400041998133;15143;15874.920625396799;16034.518964431085;16328.101954392385;805.8589746794405;810.8135128920381;824.814416756237;834.170000849159;837.899452065756;9036.412633178823;9248.121428464285;9297.163255307054;9313.813723725487;9399.34204605671;431033;447268;451632;451694;455202;64952;66539.33460665429;66745;67110.32889671139;67606;1040.3549799124592;1044.9111825494917;1045.8169820281573;1050.3540322701483;1087.5921529426464;14228.644283892985;14448.133112013313;14469.348879300247;14552.126872387691;14661.120332780067;33625.32749345048;34046;34202.48696269508;34237;34736.131596710286;42139;42231;42288;43536.56463435325;44546.77726611346;9099.818003639757;9104.863427048467;9246.167844893991;9268.165865072177;9274.165325120503;12182.817257740964;16287.59281017984;16410;16437.09595972233;16794.328226870788;12949.676258093623;13062;13389;13419.060665753304;13533.661658458617;12527.624171274876;12843.357832108544;13095.279759613313;13165.078444508792;13182.802257965946;13102.868971310165;13238.205707657571;13678.768910798077;13913.304334783423;13994.300284985506;8901.73294801157;8906.332025098014;8940.5082720451;8952.641894324153;9000.864987025068;9055.773605659911;9149.359544831797;9176.08239176077;12656.936715316364;14084.15495070299 10:03:28 INFO - 2015-12-11 10:03:28,605 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1240.4851986425633;1652.3886162120014;1705.4713038957923;1732.7660765796618;1749.029288744747;5916.467517923386;6547;6694.263631000592;6702.5978441293555;6706.597604143755;6595.274519802818;6706.597604143755;6740.494462915289;6743.460523158148;6754.594724316545;1693.5512089296346;1725.2753843385744;2045.3557129504234;2073.751149862011;2078.0337143228394;2041.5304479969616;2072.1504183284856;2082.66677331627;2083.333333333334;2086.238522939124;2089.4880754215237;2096.7149480288754;2102.6005059038735;2115.640341142002;2132.3922682035545;2112.566923780629;2138.914443422269;2139.21918499748;2140.2295173737443;2143.024923659731;2041.9183232670675;2068.0280268273887;2071.068019391265;2074.543600407908;2076.2214169686367;6728.629925354104;6785.898211526831;6790.354916282945;6790.7623233186605;6791.898121528181;4051.696122790773;4118.938215926763;4119.217348703737;4121.155163191538;4121.855735049259;2574.060467929211;2613.1768492924857;2616.973830261692;2625.868706564683;2658.694250161237;781.503745121846;785.3206975965805;788.2590365056885;797.2346547314585;816.848882956655;9205.677801276923;9345.859812102824;9350.67272645454;9352;9355.859662105075;3867.16855875988;3915.334393153171;3970.563238043813;3970.9602903971168;4004.8598299059395;8254.669813207405;8264.21489958453;8284.25441710237;8295.211954864279;8299.087100418948;4300.397944287803;4302.010537576375;4303.870883873489;4310.676699247569;4314.676399270067;3811.942820857689;3857.8071096445065;3862.7102967277565;3867.613238676166;3867.7292589518465;2901.5937768712397;3230.4831227003565;3248.5289633003554;3275.6724327567053;3279.0326853578254;938.3244064273712;1026.225199974015;1056.7569459024467;1056.7886422715487;1066.2536224642781;848.719922425598;852.6291063387322;852.671721387258;917.9810410444402;985.5860538573817;6545.803625891231;6670.96664516684;6697.263301036882;6700.195976482853;6717.429018533479;1048.9737756556146;1050.107408702612;1061.124572227915;1075.1022895882027;1082.9891701083045;5070.935103628206;5118.309028281209;5129.589632829365;5136.51203135709;5154.458781827929;7856.33221176195;8153.429259951865;8182.345412366996;8280.089190189074;8305;7945.32464740492;8001.599920003977;8086.110527841933;8088.191180881982;8097.2307630774985;6208.50331973441;6225.937740622627;6317.936820631827;6321.1150438938585;6334;6622.536422450382;6712.798616041527;6716.328367163244;6719.328067193242;6722.2605513394465;7409.147947986051;7460.253974602496;7548.320651141424;7638.656260468403;7647;7628.961855190689;7715.537067775951;7766.262205090507;7805.453618246668;7864.606769661608;6215.254169499689;6278;6314.810555683337;6317.4630156437215;6326.588771729823;5369.221462887781;6488.772892948724;6555.180602424697;6608.173978252718;6627.50293727982;5132.076226279156;5744.856378590402;5917.556183286185;6041.728122234598;6055.182550355822;5858.384869588632;5936.821895343147;6035.818925432244;6036.3058248302;6117.837610853923;6242.469390101892;6264.624122552661;6295.181626388723;6298.244210694746;6302.275238347649;5812;5826.621269617462;5833.591648584558;5840.649561026352;5864.530837533072;5917.822465326047;5998.130271110577;6006.87986240264;6014.789482368096;6015.2781666200335 10:03:28 INFO - 2015-12-11 10:03:28,607 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.7344736631764;305.3435114503815;308.64814111912426;308.70981277599054;308.7267768025297;5253.605979551535;5337.14605663094;5381.730913454327;5393.865153371167;5397.325334333208;5260.579153667707;5273.288106105674;5273.367195936493;5275.050490911634;5307.336582927134;3917.334053210947;4127.607877251657;4128.843923701368;4138.8137533810905;4146.875593732186;4007.418924255981;4038.818253178614;4132;4153.480814898137;4169.791510424482;4089.5705950875176;4090.509138903321;4099.057216840129;4119.073208528087;4122.113745544707;3911.159100793343;3997.540282867449;4009.0979529605897;4107.383892416146;4122.525909520398;3628.4738712886747;3628.6552777486095;3642.4900513928073;3643.6720695137565;3651.014226158949;5094.59243260542;5101.336826212606;5102.795888164469;5104.081265372269;5107.897842043176;4758.333833263311;4759.16714574948;4769.379980602499;4772.308015337791;4778.832740854054;5460.781568737246;5593.496585307301;5605.047141985872;5605.7197140143235;5614.775408983635;3980.1641655252433;3982.5021872265966;3984.86052988144;3986.063275130342;3987.202559488114;5870.941290587082;5918.053111502139;5919.999999999957;5924.437178468039;5929.199558059693;4112.054227527686;4114.074333274989;4118.135191609796;4119.7940102994735;4120.402541631447;3925.803709814498;4077.7553346799286;4185.686073544496;4186.28833098374;4189.643880270211;4656.883577910512;4660.673752837337;4662.7202367858035;4664.160451118763;4666.976665116653;5604.859878502988;5606.859828504238;5608.186812912105;5613.410591887875;5617.129344951539;1415.1226239731227;1440.1215258692189;1441.9062760920506;1442.1995792335144;1442.8557144285487;966.463612694947;968.2641192693603;976.7606936300651;992.8609994600762;995.9502024898871;4918.926216106761;4921.434035086011;4929.950700493021;4935.950640493621;4937.185364414903;5792.9710351447975;5825.50483208932;5833.7083145842535;5835.562332825055;5855.3851845556455;4910.582600479;4920.5571498565305;4922.606191504671;4927.556519913225;4933.432655244621;3065.294982154117;3112.704293092198;3131.65551789303;3143.6227652681823;3145.653978062411;5501.449855014546;5514.8069817557;5553.250311208016;5562.749676264578;5568.359638641608;6073.939260607426;6077.301110372364;6077.696115194222;6077.878442431127;6078.969605151946;5544.500994910478;5552.41699621542;5553.750081246354;5556.111022236423;5561.721913904369;5701.401352858056;5879.970600147143;5884.735186916685;5888.087346461305;5889.587728858939;5732.340780810094;5735.569832262514;5735.942640573708;5740.225069615549;5744.597878148489;5542.445755424425;5550.5282051026115;5553.4724201200825;5555.611107222618;5557.138643510262;3859.2281543691934;3988.760674359548;3999.5600483947323;4034.7780872051144;4038.151988082418;5830.854228644318;5835.649861008353;5837.6497410155525;5839.970800145972;5840.8247752567495;5610.551155907599;5613.073842815889;5626.465485778845;5629.183768353484;5633.141063449134;5514.283143191359;5618.044932361427;5620.494155526022;5630.071038278802;5632.859178520406;5438.293021907127;5452.509274165344;5454.481824226692;5484.122540393518;5491.395946445808;5434.782608695766;5595.552355811444;5627.437256274504;5633.661980281032;5636.943630563642;5359.571234301325;5517.475839795213;5549.112142057252;5579.107342825291;5579.60942734021 10:03:28 INFO - 2015-12-11 10:03:28,608 DEBUG : BROWSER_OUTPUT: |5;yui.html;745.4632664481571;748.3265061444699;752.2477522477523;767.205941850185;769.8652735771238;12434;12991.545295914644;13002.609921702353;13025.544105956293;13033.54382596608;13277.269750163761;13293.800592991089;13392.397342119604;13392.598222053353;13396.464141434331;633.9936600634004;641.7753786174848;817.824167803922;832.8417600655886;833.0295206084934;810.4691427115249;812.1715849833166;820.4789958376444;825.3067423364403;825.7398919340419;844.1558441558442;845.7420486751538;850.056437354536;850.1710831938841;850.3027517435705;655.577152736487;662.9867402651944;833.9583020848934;834.7161964931892;853.3599800149888;628.0641843652925;632.7911789109583;632.9082283068975;633.1136409027398;633.6356594957917;11194.160437967104;11292.26600270988;11306.604268850633;11321.094312455067;11355.205135640508;10372.63695770652;10547.947260263649;10689.251752377337;10921.617743378943;11705.473253703603;9007.099290071006;9332.860007099898;9513.381630194015;9536.761580960461;9826.803463930753;3008.3327539801485;3131.1545882611567;3168.3821654777325;3200.5839240898536;3225.629052658951;40155.799221004;40304.59695403067;40340.39489407661;40486.59513404858;40629.59370406288;9102.226310763526;9482.241420686329;9482.38364506305;9532.142107210246;9707.417554946725;15840.683186336439;15893.602659933595;15896.12571308566;15922.601934951486;15928.681426371408;6316.810495685137;6415.711292991827;6420.133282006869;6477.4170324671;6479.352064793483;3470.6182319944787;3510.84201210941;3580.9104772380897;3583.122135076923;3596.964030359663;2654.6947101083238;2672.665916760405;2682.919512414631;2683.5437975544205;2685.207863680219;464.68865859873966;466.8856130248043;469.83790592245623;472.4448772692073;479.8392538499572;483.6541872561136;515.3429377543662;543.4402565357688;550.3176061683483;560.6776103740366;7063.046488723957;7082.716691332392;7298.4891057625455;7335.3293413173105;7442.144153422318;419.4945091165139;484.7576211894053;517.7411294352823;527.5937528103339;541.6398095266683;3233.935321293561;3462.324846654878;3493.650634936537;3533.0813988362697;3862.304785138702;44129.77935110304;47024.7648761754;47064.05871882612;47383.28925066127;49945;39790.80104599459;40112.59887401089;40284.798576006935;40549.39175912364;40652.39021414681;38622.6137738619;39118;39303.60696393;39626.801865990485;41282.38076428856;7286.599237041802;7363.889541656772;7792.337651299703;7865.84268314619;7917.802054948673;29284.707152928197;29376.7062329374;30010.54984175283;30574.541381879735;30656.846715766278;37353.2529349406;37761;37843.05392365103;38297.23405531929;38394.42408363821;9855.852162217428;9870.555824987749;10025.598976040877;10033.297669163088;10147.16506833702;11182.720431989266;11195.160362972647;11204.271722338022;11219.1024718024;11420.714482138013;9897.65358212488;10146.594136234467;10250.846237306596;10315.329503582243;10346.896531034594;9673.564689588844;9878.901210987799;9897.208223341971;10182.287239893136;10598.20513461509;7911.762647120596;9094.545272736468;9999.55002024896;10289;10627.36235825853;8787.692430764893;8795.868061979203;9043.412178208395;9209.907900920905;9294.814103717752;8751.956240218758;8855.114488551093;8962.955185224033;9058.411203271766;9399.671011514563 10:03:28 INFO - 2015-12-11 10:03:28,608 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:03:28 INFO - 2015-12-11 10:03:28,608 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:03:28 INFO - 2015-12-11 10:03:28,608 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1015 10:03:28 INFO - 2015-12-11 10:03:28,608 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:03:28 INFO - 2015-12-11 10:03:28,608 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857008597__endTimestamp 10:03:28 INFO - 2015-12-11 10:03:28,608 DEBUG : BROWSER_OUTPUT: 10:03:28 INFO - 2015-12-11 10:03:28,609 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:03:28 INFO - 2015-12-11 10:03:28,609 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:03:28 INFO - 2015-12-11 10:03:28,609 DEBUG : BROWSER_OUTPUT: 10:03:28 INFO - 2015-12-11 10:03:28,609 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4626.25 Median:4756.19 stddev:479.54 (10.1%) stddev-sans-first:454.70 10:03:28 INFO - 2015-12-11 10:03:28,609 DEBUG : BROWSER_OUTPUT: Values: 2629.2 2709.8 2711.5 2727.0 2743.4 4457.4 4581.9 4614.2 4676.7 4690.6 4551.6 4562.4 4620.1 4630.3 4632.5 4291.1 4338.3 4344.0 4412.9 4446.1 4161.3 4370.3 4388.6 4452.9 4468.4 4249.7 4323.5 4336.5 4354.4 4366.4 4320.7 4326.8 4334.2 4343.4 4358.2 4127.0 4297.7 4306.0 4321.9 4361.5 4564.7 4565.7 4578.9 4579.1 4587.6 4900.2 4910.9 4928.2 4937.6 5033.7 5076.1 5087.5 5100.7 5128.6 5129.6 4726.7 4737.6 4739.9 4740.7 4780.8 4979.3 5119.8 5125.7 5214.6 5229.2 4837.3 4889.8 4896.7 4897.1 4948.8 5021.5 5043.6 5085.4 5087.2 5090.6 4770.8 4884.1 4885.6 4990.3 5000.7 4890.1 4941.4 4966.3 4994.7 5000.0 4214.0 4215.7 4220.1 4223.9 4252.9 3561.0 3700.0 3702.4 3736.8 3737.9 4192.0 4281.2 4284.8 4288.6 4293.0 5030.6 5058.6 5063.4 5068.0 5111.8 4327.0 4335.1 4340.1 4342.8 4377.1 4286.5 4331.7 4388.1 4397.8 4438.2 4728.1 4741.0 4753.0 4764.6 4802.5 4965.1 5023.7 5025.3 5028.5 5070.2 4630.1 4711.7 4756.2 4756.9 4765.0 5009.6 5009.6 5014.5 5028.2 5063.4 5028.7 5057.2 5068.7 5070.5 5123.3 4689.9 4805.5 4809.1 4918.3 4921.6 4792.0 4873.5 4880.8 4883.9 4919.5 4747.9 4806.6 4819.5 4821.2 4824.1 4726.2 4815.1 4821.0 4823.4 4953.0 4843.0 4850.8 4854.2 4854.6 4913.3 10:03:28 INFO - 2015-12-11 10:03:28,609 DEBUG : BROWSER_OUTPUT: 10:03:28 INFO - 2015-12-11 10:03:28,609 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42745.65 Median:326599.00 stddev:72978.63 (22.3%) stddev-sans-first:73114.62 10:03:28 INFO - 2015-12-11 10:03:28,611 DEBUG : BROWSER_OUTPUT: Values: 559.4 568.4 570.2 581.3 581.3 24276.3 34501.8 35151.8 35160.3 35166.8 37959.8 38556.0 38618.6 38631.2 38755.2 7032.5 7135.0 7898.5 8083.5 8084.1 7126.6 10052.5 10229.9 10230.2 10231.0 9888.3 10005.7 10006.8 10014.5 10018.4 7226.4 7425.9 9526.7 9628.2 9700.3 10017.8 10285.1 10321.9 10322.7 10334.6 34796.3 35137.8 35236.6 35290.5 35314.8 2816.8 2843.9 3437.9 3552.0 3563.6 26669.9 26831.6 27158.5 27191.0 28054.9 3157.2 3167.1 3197.7 3219.8 3276.9 319472.0 326408.0 326790.0 327380.0 327531.0 49405.5 50784.5 50786.0 53137.5 53892.7 64467.4 65062.0 65741.7 65743.0 65755.0 12830.2 12944.0 12957.2 13053.8 13055.2 8594.4 8950.9 9350.0 9537.1 9575.9 18745.8 18815.4 18910.0 18949.9 18950.6 7575.7 7651.8 7789.8 7889.6 7914.7 795.8 879.0 881.6 978.1 985.6 25567.4 25958.5 25962.6 25995.9 26017.0 906.3 932.7 988.3 1041.0 1042.6 13523.2 13994.6 14019.9 14217.4 14224.8 292251.0 298454.0 298549.0 299437.0 299593.0 44388.3 44785.0 44877.6 44945.0 45086.5 1140.0 1172.0 1172.7 1216.8 1231.8 24933.9 25955.5 26399.3 26446.2 26508.7 34688.1 35575.3 38568.2 39885.0 40905.6 191670.0 192969.0 193109.0 193174.0 194294.0 26671.1 26946.0 26969.7 26987.9 27023.1 29372.9 29625.9 32317.0 34145.0 36225.6 27571.0 30093.5 36803.0 38100.2 38399.8 36569.5 38192.0 38440.8 38591.8 38984.2 31222.0 31553.4 31863.4 31952.7 32007.0 27535.9 29196.7 32904.5 34701.8 34811.8 22933.1 22962.4 23011.8 23076.7 23381.4 10:03:28 INFO - 2015-12-11 10:03:28,611 DEBUG : BROWSER_OUTPUT: 10:03:28 INFO - 2015-12-11 10:03:28,611 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24765.32 Median:4176.19 stddev:73057.48 (1749.4%) stddev-sans-first:73239.40 10:03:28 INFO - 2015-12-11 10:03:28,611 DEBUG : BROWSER_OUTPUT: Values: 335.8 335.8 338.9 340.1 345.8 12385.6 12753.0 13715.8 14375.7 14812.2 12736.4 15071.8 15336.4 15689.3 15779.6 4823.2 4967.6 5049.4 5202.6 5212.4 3529.2 3632.1 5100.8 5159.5 5211.2 5217.0 5227.6 5230.4 5241.5 5244.7 5228.2 5403.4 5770.8 5780.8 5787.5 5124.2 5132.9 5133.1 5134.9 5139.6 11463.3 12007.0 12015.5 12026.3 12031.8 1735.8 1765.5 1800.6 1806.1 1823.5 8832.1 9804.9 10061.1 12849.2 13168.6 1667.8 1724.1 1758.1 1777.0 1788.7 50505.7 52425.5 52621.2 52685.0 53246.0 9752.5 9783.4 9802.5 9809.5 9822.5 12311.8 12316.2 12348.6 12358.3 12361.2 6733.4 6781.5 6793.7 6827.4 6906.4 6404.2 6407.1 6411.8 6442.2 6484.7 4137.7 4147.3 4158.1 4163.0 4189.4 1477.3 1533.6 1663.8 1734.4 1736.4 801.3 836.0 862.9 928.1 958.6 13332.4 15143.0 15874.9 16034.5 16328.1 805.9 810.8 824.8 834.2 837.9 9036.4 9248.1 9297.2 9313.8 9399.3 431033.0 447268.0 451632.0 451694.0 455202.0 64952.0 66539.3 66745.0 67110.3 67606.0 1040.4 1044.9 1045.8 1050.4 1087.6 14228.6 14448.1 14469.3 14552.1 14661.1 33625.3 34046.0 34202.5 34237.0 34736.1 42139.0 42231.0 42288.0 43536.6 44546.8 9099.8 9104.9 9246.2 9268.2 9274.2 12182.8 16287.6 16410.0 16437.1 16794.3 12949.7 13062.0 13389.0 13419.1 13533.7 12527.6 12843.4 13095.3 13165.1 13182.8 13102.9 13238.2 13678.8 13913.3 13994.3 8901.7 8906.3 8940.5 8952.6 9000.9 9055.8 9149.4 9176.1 12656.9 14084.2 10:03:28 INFO - 2015-12-11 10:03:28,611 DEBUG : BROWSER_OUTPUT: 10:03:28 INFO - 2015-12-11 10:03:28,611 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4835.64 Median:6025.55 stddev:2476.47 (41.1%) stddev-sans-first:2468.67 10:03:28 INFO - 2015-12-11 10:03:28,612 DEBUG : BROWSER_OUTPUT: Values: 1240.5 1652.4 1705.5 1732.8 1749.0 5916.5 6547.0 6694.3 6702.6 6706.6 6595.3 6706.6 6740.5 6743.5 6754.6 1693.6 1725.3 2045.4 2073.8 2078.0 2041.5 2072.2 2082.7 2083.3 2086.2 2089.5 2096.7 2102.6 2115.6 2132.4 2112.6 2138.9 2139.2 2140.2 2143.0 2041.9 2068.0 2071.1 2074.5 2076.2 6728.6 6785.9 6790.4 6790.8 6791.9 4051.7 4118.9 4119.2 4121.2 4121.9 2574.1 2613.2 2617.0 2625.9 2658.7 781.5 785.3 788.3 797.2 816.8 9205.7 9345.9 9350.7 9352.0 9355.9 3867.2 3915.3 3970.6 3971.0 4004.9 8254.7 8264.2 8284.3 8295.2 8299.1 4300.4 4302.0 4303.9 4310.7 4314.7 3811.9 3857.8 3862.7 3867.6 3867.7 2901.6 3230.5 3248.5 3275.7 3279.0 938.3 1026.2 1056.8 1056.8 1066.3 848.7 852.6 852.7 918.0 985.6 6545.8 6671.0 6697.3 6700.2 6717.4 1049.0 1050.1 1061.1 1075.1 1083.0 5070.9 5118.3 5129.6 5136.5 5154.5 7856.3 8153.4 8182.3 8280.1 8305.0 7945.3 8001.6 8086.1 8088.2 8097.2 6208.5 6225.9 6317.9 6321.1 6334.0 6622.5 6712.8 6716.3 6719.3 6722.3 7409.1 7460.3 7548.3 7638.7 7647.0 7629.0 7715.5 7766.3 7805.5 7864.6 6215.3 6278.0 6314.8 6317.5 6326.6 5369.2 6488.8 6555.2 6608.2 6627.5 5132.1 5744.9 5917.6 6041.7 6055.2 5858.4 5936.8 6035.8 6036.3 6117.8 6242.5 6264.6 6295.2 6298.2 6302.3 5812.0 5826.6 5833.6 5840.6 5864.5 5917.8 5998.1 6006.9 6014.8 6015.3 10:03:28 INFO - 2015-12-11 10:03:28,613 DEBUG : BROWSER_OUTPUT: 10:03:28 INFO - 2015-12-11 10:03:28,613 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4663.50 Median:5322.24 stddev:1373.03 (25.8%) stddev-sans-first:1337.28 10:03:28 INFO - 2015-12-11 10:03:28,613 DEBUG : BROWSER_OUTPUT: Values: 301.7 305.3 308.6 308.7 308.7 5253.6 5337.1 5381.7 5393.9 5397.3 5260.6 5273.3 5273.4 5275.1 5307.3 3917.3 4127.6 4128.8 4138.8 4146.9 4007.4 4038.8 4132.0 4153.5 4169.8 4089.6 4090.5 4099.1 4119.1 4122.1 3911.2 3997.5 4009.1 4107.4 4122.5 3628.5 3628.7 3642.5 3643.7 3651.0 5094.6 5101.3 5102.8 5104.1 5107.9 4758.3 4759.2 4769.4 4772.3 4778.8 5460.8 5593.5 5605.0 5605.7 5614.8 3980.2 3982.5 3984.9 3986.1 3987.2 5870.9 5918.1 5920.0 5924.4 5929.2 4112.1 4114.1 4118.1 4119.8 4120.4 3925.8 4077.8 4185.7 4186.3 4189.6 4656.9 4660.7 4662.7 4664.2 4667.0 5604.9 5606.9 5608.2 5613.4 5617.1 1415.1 1440.1 1441.9 1442.2 1442.9 966.5 968.3 976.8 992.9 996.0 4918.9 4921.4 4930.0 4936.0 4937.2 5793.0 5825.5 5833.7 5835.6 5855.4 4910.6 4920.6 4922.6 4927.6 4933.4 3065.3 3112.7 3131.7 3143.6 3145.7 5501.4 5514.8 5553.3 5562.7 5568.4 6073.9 6077.3 6077.7 6077.9 6079.0 5544.5 5552.4 5553.8 5556.1 5561.7 5701.4 5880.0 5884.7 5888.1 5889.6 5732.3 5735.6 5735.9 5740.2 5744.6 5542.4 5550.5 5553.5 5555.6 5557.1 3859.2 3988.8 3999.6 4034.8 4038.2 5830.9 5835.6 5837.6 5840.0 5840.8 5610.6 5613.1 5626.5 5629.2 5633.1 5514.3 5618.0 5620.5 5630.1 5632.9 5438.3 5452.5 5454.5 5484.1 5491.4 5434.8 5595.6 5627.4 5633.7 5636.9 5359.6 5517.5 5549.1 5579.1 5579.6 10:03:28 INFO - 2015-12-11 10:03:28,613 DEBUG : BROWSER_OUTPUT: 10:03:28 INFO - 2015-12-11 10:03:28,613 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11883.94 Median:23747.30 stddev:13165.01 (55.4%) stddev-sans-first:13175.36 10:03:28 INFO - 2015-12-11 10:03:28,613 DEBUG : BROWSER_OUTPUT: Values: 745.5 748.3 752.2 767.2 769.9 12434.0 12991.5 13002.6 13025.5 13033.5 13277.3 13293.8 13392.4 13392.6 13396.5 634.0 641.8 817.8 832.8 833.0 810.5 812.2 820.5 825.3 825.7 844.2 845.7 850.1 850.2 850.3 655.6 663.0 834.0 834.7 853.4 628.1 632.8 632.9 633.1 633.6 11194.2 11292.3 11306.6 11321.1 11355.2 10372.6 10547.9 10689.3 10921.6 11705.5 9007.1 9332.9 9513.4 9536.8 9826.8 3008.3 3131.2 3168.4 3200.6 3225.6 40155.8 40304.6 40340.4 40486.6 40629.6 9102.2 9482.2 9482.4 9532.1 9707.4 15840.7 15893.6 15896.1 15922.6 15928.7 6316.8 6415.7 6420.1 6477.4 6479.4 3470.6 3510.8 3580.9 3583.1 3597.0 2654.7 2672.7 2682.9 2683.5 2685.2 464.7 466.9 469.8 472.4 479.8 483.7 515.3 543.4 550.3 560.7 7063.0 7082.7 7298.5 7335.3 7442.1 419.5 484.8 517.7 527.6 541.6 3233.9 3462.3 3493.7 3533.1 3862.3 44129.8 47024.8 47064.1 47383.3 49945.0 39790.8 40112.6 40284.8 40549.4 40652.4 38622.6 39118.0 39303.6 39626.8 41282.4 7286.6 7363.9 7792.3 7865.8 7917.8 29284.7 29376.7 30010.5 30574.5 30656.8 37353.3 37761.0 37843.1 38297.2 38394.4 9855.9 9870.6 10025.6 10033.3 10147.2 11182.7 11195.2 11204.3 11219.1 11420.7 9897.7 10146.6 10250.8 10315.3 10346.9 9673.6 9878.9 9897.2 10182.3 10598.2 7911.8 9094.5 9999.6 10289.0 10627.4 8787.7 8795.9 9043.4 9209.9 9294.8 8752.0 8855.1 8963.0 9058.4 9399.7 10:03:28 INFO - 2015-12-11 10:03:28,613 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:03:28 INFO - 2015-12-11 10:03:28,613 DEBUG : BROWSER_OUTPUT: 10:03:30 INFO - 2015-12-11 10:03:30,230 INFO : Browser exited with error code: 0 10:03:30 INFO - 2015-12-11 10:03:30,246 INFO : Completed test dromaeo_css (00:19:39) 10:03:30 INFO - 2015-12-11 10:03:30,246 INFO : Starting test kraken 10:03:30 INFO - 2015-12-11 10:03:30,246 DEBUG : operating with platform_type : linux_ 10:03:30 INFO - 2015-12-11 10:03:30,246 INFO : Initialising browser for kraken test... 10:03:30 INFO - 2015-12-11 10:03:30,252 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw3zLHb/profile http://localhost:51833/getInfo.html 10:03:44 INFO - 2015-12-11 10:03:44,551 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:03:44 INFO - 2015-12-11 10:03:44,551 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:03:44 INFO - 2015-12-11 10:03:44,551 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:03:44 INFO - 2015-12-11 10:03:44,551 DEBUG : BROWSER_OUTPUT: __metrics 10:03:45 INFO - 2015-12-11 10:03:45,132 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] 10:03:45 INFO - 2015-12-11 10:03:45,228 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:03:50 INFO - 2015-12-11 10:03:50,633 INFO : Browser initialized. 10:03:50 INFO - 2015-12-11 10:03:50,634 INFO : Running cycle 1/1 for kraken test... 10:03:50 INFO - 2015-12-11 10:03:50,634 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw3zLHb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:04:02 INFO - 2015-12-11 10:04:02,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 143224832 10:04:02 INFO - 2015-12-11 10:04:02,630 DEBUG : BROWSER_OUTPUT: 10:04:05 INFO - 2015-12-11 10:04:05,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51833/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:05 INFO - 2015-12-11 10:04:05,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 178847744 10:04:05 INFO - 2015-12-11 10:04:05,811 DEBUG : BROWSER_OUTPUT: 10:04:08 INFO - 2015-12-11 10:04:08,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51833/tests/kraken/driver.html?testName=audio-dft) 10:04:09 INFO - 2015-12-11 10:04:09,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 169287680 10:04:09 INFO - 2015-12-11 10:04:09,126 DEBUG : BROWSER_OUTPUT: 10:04:12 INFO - 2015-12-11 10:04:12,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51833/tests/kraken/driver.html?testName=audio-fft) 10:04:12 INFO - 2015-12-11 10:04:12,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 152518656 10:04:12 INFO - 2015-12-11 10:04:12,718 DEBUG : BROWSER_OUTPUT: 10:04:15 INFO - 2015-12-11 10:04:15,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51833/tests/kraken/driver.html?testName=audio-oscillator) 10:04:15 INFO - 2015-12-11 10:04:15,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 156221440 10:04:15 INFO - 2015-12-11 10:04:15,680 DEBUG : BROWSER_OUTPUT: 10:04:17 INFO - 2015-12-11 10:04:17,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51833/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:04:18 INFO - 2015-12-11 10:04:18,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 156811264 10:04:18 INFO - 2015-12-11 10:04:18,508 DEBUG : BROWSER_OUTPUT: 10:04:21 INFO - 2015-12-11 10:04:21,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51833/tests/kraken/driver.html?testName=imaging-darkroom) 10:04:22 INFO - 2015-12-11 10:04:22,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 157536256 10:04:22 INFO - 2015-12-11 10:04:22,080 DEBUG : BROWSER_OUTPUT: 10:04:25 INFO - 2015-12-11 10:04:25,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51833/tests/kraken/driver.html?testName=imaging-desaturate) 10:04:26 INFO - 2015-12-11 10:04:26,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 155025408 10:04:26 INFO - 2015-12-11 10:04:26,325 DEBUG : BROWSER_OUTPUT: 10:04:29 INFO - 2015-12-11 10:04:29,223 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51833/tests/kraken/driver.html?testName=json-parse-financial) 10:04:29 INFO - 2015-12-11 10:04:29,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 154820608 10:04:29 INFO - 2015-12-11 10:04:29,797 DEBUG : BROWSER_OUTPUT: 10:04:31 INFO - 2015-12-11 10:04:31,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51833/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:04:32 INFO - 2015-12-11 10:04:32,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 167698432 10:04:32 INFO - 2015-12-11 10:04:32,119 DEBUG : BROWSER_OUTPUT: 10:04:33 INFO - 2015-12-11 10:04:33,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51833/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:04:34 INFO - 2015-12-11 10:04:34,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 165916672 10:04:34 INFO - 2015-12-11 10:04:34,597 DEBUG : BROWSER_OUTPUT: 10:04:36 INFO - 2015-12-11 10:04:36,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51833/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:04:37 INFO - 2015-12-11 10:04:37,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 178909184 10:04:37 INFO - 2015-12-11 10:04:37,290 DEBUG : BROWSER_OUTPUT: 10:04:39 INFO - 2015-12-11 10:04:39,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:04:40 INFO - 2015-12-11 10:04:40,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 186253312 10:04:40 INFO - 2015-12-11 10:04:40,383 DEBUG : BROWSER_OUTPUT: 10:04:42 INFO - 2015-12-11 10:04:42,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:04:43 INFO - 2015-12-11 10:04:43,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 182960128 10:04:43 INFO - 2015-12-11 10:04:43,569 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51833/tests/kraken/driver.html?testName=ai-astar) 10:04:45 INFO - 2015-12-11 10:04:45,569 DEBUG : BROWSER_OUTPUT: RSS: Main: 239538176 10:04:45 INFO - 2015-12-11 10:04:45,569 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,570 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:04:45 INFO - 2015-12-11 10:04:45,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:04:45 INFO - 2015-12-11 10:04:45,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:04:45 INFO - 2015-12-11 10:04:45,571 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:04:45 INFO - 2015-12-11 10:04:45,571 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;107;112;113;113;101;112;112;111 10:04:45 INFO - 2015-12-11 10:04:45,571 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;129;152;167;137;152;152;145;164;131 10:04:45 INFO - 2015-12-11 10:04:45,571 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;165;160;159;160;159;162;160;162;162 10:04:45 INFO - 2015-12-11 10:04:45,571 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;88;97;71;75;74;104;97;73 10:04:45 INFO - 2015-12-11 10:04:45,572 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;135;95;95;102;134;95;95;132 10:04:45 INFO - 2015-12-11 10:04:45,572 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;109;109;109;109;109;110;109 10:04:45 INFO - 2015-12-11 10:04:45,572 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;148;147;147;147;147;147;146;146 10:04:45 INFO - 2015-12-11 10:04:45,572 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;95;95;95;96;95 10:04:45 INFO - 2015-12-11 10:04:45,572 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;70;72;71;70;70;72;78;69;68 10:04:45 INFO - 2015-12-11 10:04:45,572 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;69;70;69;69;70 10:04:45 INFO - 2015-12-11 10:04:45,572 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;82;83;83;83;84;91;85;83 10:04:45 INFO - 2015-12-11 10:04:45,572 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;120;116;119;121;120;128;125;125;127 10:04:45 INFO - 2015-12-11 10:04:45,573 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;148;149;149;147;139;149;137;145;140 10:04:45 INFO - 2015-12-11 10:04:45,573 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;73;69;71;68;70;71;69;69 10:04:45 INFO - 2015-12-11 10:04:45,573 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:04:45 INFO - 2015-12-11 10:04:45,573 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:04:45 INFO - 2015-12-11 10:04:45,573 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,984 10:04:45 INFO - 2015-12-11 10:04:45,573 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:04:45 INFO - 2015-12-11 10:04:45,573 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857085569__endTimestamp 10:04:45 INFO - 2015-12-11 10:04:45,573 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.86 (3.5%) stddev-sans-first:4.10 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 107.0 112.0 113.0 113.0 101.0 112.0 112.0 111.0 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.10 Median:152.00 stddev:13.45 (8.9%) stddev-sans-first:13.44 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: Values: 162.0 129.0 152.0 167.0 137.0 152.0 152.0 145.0 164.0 131.0 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.83 (1.1%) stddev-sans-first:1.94 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: Values: 161.0 165.0 160.0 159.0 160.0 159.0 162.0 160.0 162.0 162.0 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.50 Median:74.50 stddev:12.67 (17.0%) stddev-sans-first:12.96 10:04:45 INFO - 2015-12-11 10:04:45,577 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 88.0 97.0 71.0 75.0 74.0 104.0 97.0 73.0 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:95.00 stddev:18.34 (19.3%) stddev-sans-first:18.90 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 135.0 95.0 95.0 102.0 134.0 95.0 95.0 132.0 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 148.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.50 stddev:2.74 (3.8%) stddev-sans-first:2.89 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 72.0 71.0 70.0 70.0 72.0 78.0 69.0 68.0 10:04:45 INFO - 2015-12-11 10:04:45,578 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 69.0 70.0 69.0 69.0 70.0 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:2.70 (3.3%) stddev-sans-first:2.78 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 82.0 83.0 83.0 83.0 84.0 91.0 85.0 83.0 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:125.00 stddev:4.23 (3.4%) stddev-sans-first:4.06 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: Values: 128.0 120.0 116.0 119.0 121.0 120.0 128.0 125.0 125.0 127.0 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:147.50 stddev:4.89 (3.3%) stddev-sans-first:4.82 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: Values: 139.0 148.0 149.0 149.0 147.0 139.0 149.0 137.0 145.0 140.0 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.45 (2.1%) stddev-sans-first:1.54 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 73.0 69.0 71.0 68.0 70.0 71.0 69.0 69.0 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:04:45 INFO - 2015-12-11 10:04:45,579 DEBUG : BROWSER_OUTPUT: 10:04:46 INFO - 2015-12-11 10:04:46,997 INFO : Browser exited with error code: 0 10:04:47 INFO - 2015-12-11 10:04:47,051 INFO : Completed test kraken (00:01:16) 10:04:47 INFO - 2015-12-11 10:04:47,051 INFO : Starting test v8_7 10:04:47 INFO - 2015-12-11 10:04:47,051 DEBUG : operating with platform_type : linux_ 10:04:47 INFO - 2015-12-11 10:04:47,052 INFO : Initialising browser for v8_7 test... 10:04:47 INFO - 2015-12-11 10:04:47,058 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQ83Oj/profile http://localhost:51833/getInfo.html 10:05:02 INFO - 2015-12-11 10:05:02,634 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:05:02 INFO - 2015-12-11 10:05:02,635 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:05:02 INFO - 2015-12-11 10:05:02,635 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:05:02 INFO - 2015-12-11 10:05:02,635 DEBUG : BROWSER_OUTPUT: __metrics 10:05:03 INFO - 2015-12-11 10:05:03,180 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] 10:05:03 INFO - 2015-12-11 10:05:03,256 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:03 ERROR - 2015-12-11 10:05:03,272 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:05:09 INFO - 2015-12-11 10:05:09,365 INFO : Browser initialized. 10:05:09 INFO - 2015-12-11 10:05:09,366 INFO : Running cycle 1/1 for v8_7 test... 10:05:09 INFO - 2015-12-11 10:05:09,366 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQ83Oj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:21 INFO - 2015-12-11 10:05:21,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 142450688 10:05:21 INFO - 2015-12-11 10:05:21,361 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51833/tests/v8_7/run.html (next: http://localhost:51833/tests/v8_7/run.html) 10:05:43 INFO - 2015-12-11 10:05:43,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 442777600 10:05:43 INFO - 2015-12-11 10:05:43,300 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,301 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:43 INFO - 2015-12-11 10:05:43,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:43 INFO - 2015-12-11 10:05:43,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:43 INFO - 2015-12-11 10:05:43,302 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:43 INFO - 2015-12-11 10:05:43,302 DEBUG : BROWSER_OUTPUT: |0;Richards;166.55562958027983 10:05:43 INFO - 2015-12-11 10:05:43,302 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.42803877703207 10:05:43 INFO - 2015-12-11 10:05:43,302 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 10:05:43 INFO - 2015-12-11 10:05:43,302 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 10:05:43 INFO - 2015-12-11 10:05:43,303 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1953.125 10:05:43 INFO - 2015-12-11 10:05:43,303 DEBUG : BROWSER_OUTPUT: |5;Earley;798.2456140350877 10:05:43 INFO - 2015-12-11 10:05:43,303 DEBUG : BROWSER_OUTPUT: |6;Boyer;11964.285714285714 10:05:43 INFO - 2015-12-11 10:05:43,303 DEBUG : BROWSER_OUTPUT: |7;RegExp;26368.42105263158 10:05:43 INFO - 2015-12-11 10:05:43,303 DEBUG : BROWSER_OUTPUT: |8;Splay;602.7727546714889 10:05:43 INFO - 2015-12-11 10:05:43,303 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 10:05:43 INFO - 2015-12-11 10:05:43,303 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:43 INFO - 2015-12-11 10:05:43,304 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857143300__endTimestamp 10:05:43 INFO - 2015-12-11 10:05:43,304 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,305 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:43 INFO - 2015-12-11 10:05:43,305 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:05:43 INFO - 2015-12-11 10:05:43,305 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,305 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 10:05:43 INFO - 2015-12-11 10:05:43,305 DEBUG : BROWSER_OUTPUT: Values: 166.6 10:05:43 INFO - 2015-12-11 10:05:43,305 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,305 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.43 Median:186.43 stddev:0.00 (0.0%) 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: Values: 186.4 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: Values: 279.2 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: Values: 5186.5 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1953.13 Median:1953.13 stddev:0.00 (0.0%) 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: Values: 1953.1 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.25 Median:798.25 stddev:0.00 (0.0%) 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: Values: 798.2 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 10:05:43 INFO - 2015-12-11 10:05:43,306 DEBUG : BROWSER_OUTPUT: Values: 11964.3 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26368.42 Median:26368.42 stddev:0.00 (0.0%) 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: Values: 26368.4 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.77 Median:602.77 stddev:0.00 (0.0%) 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: Values: 602.8 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: Values: 4835.7 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:43 INFO - 2015-12-11 10:05:43,307 DEBUG : BROWSER_OUTPUT: 10:05:45 INFO - 2015-12-11 10:05:45,497 INFO : Browser exited with error code: 0 10:05:45 INFO - 2015-12-11 10:05:45,516 INFO : Completed test v8_7 (00:00:58) 10:05:45 INFO - 2015-12-11 10:05:45,741 INFO : Completed test suite (00:21:54) 10:05:45 INFO - 2015-12-11 10:05:45,741 DEBUG : Working with test: dromaeo_css 10:05:45 INFO - 2015-12-11 10:05:45,741 DEBUG : Generating results file: dromaeo_css 10:05:45 INFO - 2015-12-11 10:05:45,742 DEBUG : Working with test: kraken 10:05:45 INFO - 2015-12-11 10:05:45,742 DEBUG : Generating results file: kraken 10:05:45 INFO - 2015-12-11 10:05:45,743 INFO : javascript benchmark 10:05:45 INFO - 2015-12-11 10:05:45,743 DEBUG : Working with test: v8_7 10:05:45 INFO - 2015-12-11 10:05:45,743 DEBUG : Generating results file: v8_7 10:05:45 INFO - 2015-12-11 10:05:45,743 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:45 INFO - 2015-12-11 10:05:45,886 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 10:05:45 INFO - 2015-12-11 10:05:45,887 DEBUG : process_Request line: dromaeo_css 6246.90 graph.html#tests=[[72,132,35]] 10:05:45 INFO - 2015-12-11 10:05:45,887 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:45 INFO - 2015-12-11 10:05:45,994 DEBUG : process_Request line: kraken 1523.60 graph.html#tests=[[232,132,35]] 10:05:45 INFO - 2015-12-11 10:05:45,994 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:46 INFO - 2015-12-11 10:05:46,025 DEBUG : process_Request line: v8_7 19882.64 graph.html#tests=[[230,132,35]] 10:05:46 INFO - 2015-12-11 10:05:46,026 INFO : javascript benchmark 10:05:46 INFO - 2015-12-11 10:05:46,029 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.2375211188755, 2709.7832173426127, 2711.539038363478, 2726.972730272698, 2743.3964527803882, 4457.353683715859, 4581.88545286368, 4614.2155833508305, 4676.74277914715, 4690.648201384897, 4551.6358691304695, 4562.384078149449, 4620.122176786416, 4630.259158534635, 4632.490426053131, 4291.120320334339, 4338.262495375778, 4343.956560434387, 4412.933805992912, 4446.1107778444275, 4161.292580261363, 4370.257056300421, 4388.6050255477, 4452.933206001912, 4468.374427580141, 4249.681273904439, 4323.546027667113, 4336.457942757155, 4354.368616550582, 4366.4105345778235, 4320.654347652212, 4326.8269269229195, 4334.154839806239, 4343.370211319372, 4358.193734159191, 4127.0, 4297.656187504992, 4305.97847010763, 4321.913561728779, 4361.498427680825, 4564.657650676212, 4565.7260564365915, 4578.885527861797, 4579.084183163381, 4587.632989360844, 4900.166971614834, 4910.877228069291, 4928.162212423861, 4937.6049916007, 5033.723145227011, 5076.13705670037, 5087.542121209109, 5100.719460429675, 5128.640995130342, 5129.6409251352425, 4726.6927649703, 4737.573618374363, 4739.881502962454, 4740.715557066518, 4780.808767649255, 4979.30289759434, 5119.846404607868, 5125.718085505333, 5214.582833373321, 5229.215617657382, 4837.346958160673, 4889.804407823718, 4896.681715688469, 4897.14299997499, 4948.802047918043, 5021.472745361684, 5043.646944713835, 5085.389753229636, 5087.236914462786, 5090.643654944192, 4770.785314660849, 4884.145274577006, 4885.560299573055, 4990.2764099205415, 5000.746380056696, 4890.095332363524, 4941.382327209099, 4966.279889416087, 4994.700317980933, 4999.950000499948, 4214.030772922245, 4215.683823713172, 4220.052725741392, 4223.852165174204, 4252.914941701149, 3560.964390356063, 3700.0379901225338, 3702.3705969985167, 3736.75711078779, 3737.9065523362133, 4191.97904010478, 4281.2293787118615, 4284.828606855691, 4288.571142885687, 4293.034067334887, 5030.622703297267, 5058.570021548136, 5063.392392912874, 5068.0, 5111.7699703513435, 4327.0480494291205, 4335.111302183045, 4340.066885619607, 4342.761148136819, 4377.102693947733, 4286.5070516890955, 4331.696781225284, 4388.078503514298, 4397.824087036547, 4438.1567502174485, 4728.125296820031, 4740.976295118502, 4753.049390121921, 4764.595009424238, 4802.543758342952, 4965.106280869478, 5023.7488125592845, 5025.321581586439, 5028.522290382408, 5070.188769796815, 4630.143423466669, 4711.740854253049, 4756.191447453872, 4756.904861902812, 4765.0, 5009.624278179224, 5009.649324547247, 5014.52362025607, 5028.220625803006, 5063.443021267732, 5028.698278103326, 5057.216131499624, 5068.746562671926, 5070.492950705047, 5123.308353372247, 4689.859304220879, 4805.471398146131, 4809.134355815987, 4918.262260660929, 4921.557059864629, 4792.041591681608, 4873.4882837301575, 4880.829170978998, 4883.87790305231, 4919.508049195052, 4747.928781068218, 4806.615470762401, 4819.49395313487, 4821.2045012573935, 4824.131656301899, 4726.19654658702, 4815.133276010351, 4820.975895120502, 4823.421189457287, 4952.950470495393, 4843.0, 4850.7817148227705, 4854.17479028559, 4854.611631069435, 4913.3121363008495], "unit": "ms", "name": "dojo.html", "value": 4596.748787363256}, {"lowerIsBetter": false, "replicates": [559.4237934927024, 568.3889818445167, 570.167555369161, 581.2647001543049, 581.2821165860163, 24276.27171184865, 34501.82749086254, 35151.82424087882, 35160.2967940641, 35166.824165879196, 37959.810200949025, 38556.0, 38618.613813861855, 38631.22737545247, 38755.22489550207, 7032.542884712503, 7135.03677003603, 7898.4865983711015, 8083.514989100643, 8084.1107478177355, 7126.572405655651, 10052.49737513125, 10229.897701023006, 10230.232732545051, 10231.0, 9888.258380621446, 10005.699829005142, 10006.849897251546, 10014.499275036256, 10018.398896066223, 7226.3857572106435, 7425.925740742578, 9526.666566670168, 9628.18160456362, 9700.320977531575, 10017.849732254022, 10285.125764310043, 10321.896781032168, 10322.7419314517, 10334.586616535329, 34796.30407391838, 35137.82431087854, 35236.64763352359, 35290.470642940374, 35314.82342588271, 2816.788740844445, 2843.9146825595267, 3437.9312413751586, 3552.0054384772307, 3563.6436356364416, 26669.866650666816, 26831.597526037123, 27158.45683086347, 27191.0, 28054.913959464648, 3157.2422618571377, 3167.081546351555, 3197.6802319767835, 3219.806811591312, 3276.9344613107605, 319472.0, 326407.9999999976, 326790.0, 327380.0, 327531.0, 49405.50594494081, 50784.492155077976, 50786.0, 53137.468625314024, 53892.730536347066, 64467.35532644614, 65062.0, 65741.67129164323, 65743.0, 65755.0, 12830.230186188859, 12944.0, 12957.157784743962, 13053.804192937114, 13055.21668699881, 8594.398392112616, 8950.910490895138, 9350.0, 9537.141657250742, 9575.856362154573, 18745.812541874406, 18815.435536933914, 18910.0, 18949.90525047366, 18950.620987580172, 7575.6969721210535, 7651.846963060819, 7789.766307010798, 7889.64496597643, 7914.683412663544, 795.8090058385945, 878.9516576588348, 881.6341218394294, 978.1148061004802, 985.5811280206027, 25567.360815979377, 25958.480830383287, 25962.610560841604, 25995.870020649774, 26017.0, 906.2795077913075, 932.6735642525198, 988.3476905242505, 1040.9902394677151, 1042.5673345561506, 13523.188608683511, 13994.580162595139, 14019.859801401855, 14217.36021879018, 14224.786628200585, 292251.0, 298454.0, 298549.0, 299437.0, 299593.0, 44388.3341749874, 44785.0, 44877.551224487994, 44945.0, 45086.549134508234, 1139.9943000285111, 1171.9920868053637, 1172.6657902497748, 1216.7809794237123, 1231.759806837658, 24933.875330623232, 25955.48089038171, 26399.34001649974, 26446.206613801616, 26508.7349126514, 34688.132796680286, 35575.288494229455, 38568.228635426574, 39885.0, 40905.59094409137, 191670.0, 192969.0, 193109.0, 193174.0, 194294.0, 26671.066512671965, 26946.0, 26969.73030269672, 26987.865060674572, 27023.054193103148, 29372.853135734185, 29625.85187074051, 32317.0, 34145.0, 36225.637743622225, 27571.0, 30093.548596771503, 36803.0, 38100.237995240495, 38399.80800096093, 36569.45145822868, 38192.0, 38440.80779596084, 38591.80704096462, 38984.220315594095, 31222.0, 31553.368932621677, 31863.362732745678, 31952.680473195902, 32007.039788806374, 27535.86232068827, 29196.708032920247, 32904.50643240305, 34701.82649086738, 34811.825940870134, 22933.082676692746, 22962.40071835039, 23011.769882300963, 23076.653850191924, 23381.41546461352], "unit": "ms", "name": "ext.html", "value": 17076.43095745743}, {"lowerIsBetter": false, "replicates": [335.8035549203716, 335.80858910421057, 338.9084947064292, 340.0851708903052, 345.83227134839615, 12385.628431147057, 12753.0, 13715.794263086049, 14375.712485750291, 14812.185329806856, 12736.363181840894, 15071.849281507182, 15336.386544538205, 15689.29398177082, 15779.60550986226, 4823.204171311738, 4967.552920237178, 5049.368828896388, 5202.583793296527, 5212.400573934008, 3529.2412131391748, 3632.0738211755965, 5100.770465329069, 5159.535641792238, 5211.1922651989, 5216.973915130438, 5227.581793456515, 5230.372355317368, 5241.50205730455, 5244.68531888086, 5228.189630607243, 5403.405625381224, 5770.798022069207, 5780.7687692492245, 5787.508061814729, 5124.205748109049, 5132.948670513284, 5133.050385678662, 5134.871628209325, 5139.563137133311, 11463.254888432226, 12007.0, 12015.519379224821, 12026.278423294543, 12031.759364812742, 1735.8437740603406, 1765.5430487962644, 1800.612868233323, 1806.051822793031, 1823.4985379020875, 8832.072632373636, 9804.901950980542, 10061.14480269178, 12849.229046257162, 13168.604941851663, 1667.7665126882246, 1724.146547459016, 1758.085795386392, 1777.0315178227897, 1788.6959216933153, 50505.74747126241, 52425.47574524244, 52621.2106818398, 52684.999999999614, 53246.0, 9752.46361450127, 9783.36408133469, 9802.46086465237, 9809.509524523888, 9822.459764712867, 12311.815322770166, 12316.199447035913, 12348.567800126952, 12358.258504489759, 12361.196522226026, 6733.393994540417, 6781.457483401415, 6793.694283757242, 6827.351401616838, 6906.37842594169, 6404.199475065617, 6407.070974708641, 6411.807645770635, 6442.226932768098, 6484.740610375532, 4137.668986481074, 4147.2534943710425, 4158.106007208404, 4162.9791851041155, 4189.392538081961, 1477.2909003678294, 1533.5859317984082, 1663.7920259967505, 1734.4016314371522, 1736.3662263273814, 801.2708435323827, 835.9842791008954, 862.8748831419409, 928.1229238369676, 958.6357184270072, 13332.400041998133, 15143.0, 15874.920625396799, 16034.518964431085, 16328.101954392385, 805.8589746794405, 810.8135128920381, 824.814416756237, 834.170000849159, 837.899452065756, 9036.412633178823, 9248.121428464285, 9297.163255307054, 9313.813723725487, 9399.34204605671, 431033.0, 447268.0, 451632.0, 451694.0, 455202.0, 64952.0, 66539.33460665429, 66745.0, 67110.32889671139, 67606.0, 1040.3549799124592, 1044.9111825494917, 1045.8169820281573, 1050.3540322701483, 1087.5921529426464, 14228.644283892985, 14448.133112013313, 14469.348879300247, 14552.126872387691, 14661.120332780067, 33625.32749345048, 34046.0, 34202.48696269508, 34237.0, 34736.131596710286, 42139.0, 42231.0, 42288.0, 43536.56463435325, 44546.77726611346, 9099.818003639757, 9104.863427048467, 9246.167844893991, 9268.165865072177, 9274.165325120503, 12182.817257740964, 16287.59281017984, 16410.0, 16437.09595972233, 16794.328226870788, 12949.676258093623, 13062.0, 13389.0, 13419.060665753304, 13533.661658458617, 12527.624171274876, 12843.357832108544, 13095.279759613313, 13165.078444508792, 13182.802257965946, 13102.868971310165, 13238.205707657571, 13678.768910798077, 13913.304334783423, 13994.300284985506, 8901.73294801157, 8906.332025098014, 8940.5082720451, 8952.641894324153, 9000.864987025068, 9055.773605659911, 9149.359544831797, 9176.08239176077, 12656.936715316364, 14084.15495070299], "unit": "ms", "name": "jquery.html", "value": 8048.088347386556}, {"lowerIsBetter": false, "replicates": [1240.4851986425633, 1652.3886162120014, 1705.4713038957923, 1732.7660765796618, 1749.029288744747, 5916.467517923386, 6547.0, 6694.263631000592, 6702.5978441293555, 6706.597604143755, 6595.274519802818, 6706.597604143755, 6740.494462915289, 6743.460523158148, 6754.594724316545, 1693.5512089296346, 1725.2753843385744, 2045.3557129504234, 2073.751149862011, 2078.0337143228394, 2041.5304479969616, 2072.1504183284856, 2082.66677331627, 2083.333333333334, 2086.238522939124, 2089.4880754215237, 2096.7149480288754, 2102.6005059038735, 2115.640341142002, 2132.3922682035545, 2112.566923780629, 2138.914443422269, 2139.21918499748, 2140.2295173737443, 2143.024923659731, 2041.9183232670675, 2068.0280268273887, 2071.068019391265, 2074.543600407908, 2076.2214169686367, 6728.629925354104, 6785.898211526831, 6790.354916282945, 6790.7623233186605, 6791.898121528181, 4051.696122790773, 4118.938215926763, 4119.217348703737, 4121.155163191538, 4121.855735049259, 2574.060467929211, 2613.1768492924857, 2616.973830261692, 2625.868706564683, 2658.694250161237, 781.503745121846, 785.3206975965805, 788.2590365056885, 797.2346547314585, 816.848882956655, 9205.677801276923, 9345.859812102824, 9350.67272645454, 9352.0, 9355.859662105075, 3867.16855875988, 3915.334393153171, 3970.563238043813, 3970.9602903971168, 4004.8598299059395, 8254.669813207405, 8264.21489958453, 8284.25441710237, 8295.211954864279, 8299.087100418948, 4300.397944287803, 4302.010537576375, 4303.870883873489, 4310.676699247569, 4314.676399270067, 3811.942820857689, 3857.8071096445065, 3862.7102967277565, 3867.613238676166, 3867.7292589518465, 2901.5937768712397, 3230.4831227003565, 3248.5289633003554, 3275.6724327567053, 3279.0326853578254, 938.3244064273712, 1026.225199974015, 1056.7569459024467, 1056.7886422715487, 1066.2536224642781, 848.719922425598, 852.6291063387322, 852.671721387258, 917.9810410444402, 985.5860538573817, 6545.803625891231, 6670.96664516684, 6697.263301036882, 6700.195976482853, 6717.429018533479, 1048.9737756556146, 1050.107408702612, 1061.124572227915, 1075.1022895882027, 1082.9891701083045, 5070.935103628206, 5118.309028281209, 5129.589632829365, 5136.51203135709, 5154.458781827929, 7856.33221176195, 8153.429259951865, 8182.345412366996, 8280.089190189074, 8305.0, 7945.32464740492, 8001.599920003977, 8086.110527841933, 8088.191180881982, 8097.2307630774985, 6208.50331973441, 6225.937740622627, 6317.936820631827, 6321.1150438938585, 6334.0, 6622.536422450382, 6712.798616041527, 6716.328367163244, 6719.328067193242, 6722.2605513394465, 7409.147947986051, 7460.253974602496, 7548.320651141424, 7638.656260468403, 7647.0, 7628.961855190689, 7715.537067775951, 7766.262205090507, 7805.453618246668, 7864.606769661608, 6215.254169499689, 6278.0, 6314.810555683337, 6317.4630156437215, 6326.588771729823, 5369.221462887781, 6488.772892948724, 6555.180602424697, 6608.173978252718, 6627.50293727982, 5132.076226279156, 5744.856378590402, 5917.556183286185, 6041.728122234598, 6055.182550355822, 5858.384869588632, 5936.821895343147, 6035.818925432244, 6036.3058248302, 6117.837610853923, 6242.469390101892, 6264.624122552661, 6295.181626388723, 6298.244210694746, 6302.275238347649, 5812.0, 5826.621269617462, 5833.591648584558, 5840.649561026352, 5864.530837533072, 5917.822465326047, 5998.130271110577, 6006.87986240264, 6014.789482368096, 6015.2781666200335], "unit": "ms", "name": "mootools.html", "value": 3981.1467180783784}, {"lowerIsBetter": false, "replicates": [301.7344736631764, 305.3435114503815, 308.64814111912426, 308.70981277599054, 308.7267768025297, 5253.605979551535, 5337.14605663094, 5381.730913454327, 5393.865153371167, 5397.325334333208, 5260.579153667707, 5273.288106105674, 5273.367195936493, 5275.050490911634, 5307.336582927134, 3917.334053210947, 4127.607877251657, 4128.843923701368, 4138.8137533810905, 4146.875593732186, 4007.418924255981, 4038.818253178614, 4132.0, 4153.480814898137, 4169.791510424482, 4089.5705950875176, 4090.509138903321, 4099.057216840129, 4119.073208528087, 4122.113745544707, 3911.159100793343, 3997.540282867449, 4009.0979529605897, 4107.383892416146, 4122.525909520398, 3628.4738712886747, 3628.6552777486095, 3642.4900513928073, 3643.6720695137565, 3651.014226158949, 5094.59243260542, 5101.336826212606, 5102.795888164469, 5104.081265372269, 5107.897842043176, 4758.333833263311, 4759.16714574948, 4769.379980602499, 4772.308015337791, 4778.832740854054, 5460.781568737246, 5593.496585307301, 5605.047141985872, 5605.7197140143235, 5614.775408983635, 3980.1641655252433, 3982.5021872265966, 3984.86052988144, 3986.063275130342, 3987.202559488114, 5870.941290587082, 5918.053111502139, 5919.999999999957, 5924.437178468039, 5929.199558059693, 4112.054227527686, 4114.074333274989, 4118.135191609796, 4119.7940102994735, 4120.402541631447, 3925.803709814498, 4077.7553346799286, 4185.686073544496, 4186.28833098374, 4189.643880270211, 4656.883577910512, 4660.673752837337, 4662.7202367858035, 4664.160451118763, 4666.976665116653, 5604.859878502988, 5606.859828504238, 5608.186812912105, 5613.410591887875, 5617.129344951539, 1415.1226239731227, 1440.1215258692189, 1441.9062760920506, 1442.1995792335144, 1442.8557144285487, 966.463612694947, 968.2641192693603, 976.7606936300651, 992.8609994600762, 995.9502024898871, 4918.926216106761, 4921.434035086011, 4929.950700493021, 4935.950640493621, 4937.185364414903, 5792.9710351447975, 5825.50483208932, 5833.7083145842535, 5835.562332825055, 5855.3851845556455, 4910.582600479, 4920.5571498565305, 4922.606191504671, 4927.556519913225, 4933.432655244621, 3065.294982154117, 3112.704293092198, 3131.65551789303, 3143.6227652681823, 3145.653978062411, 5501.449855014546, 5514.8069817557, 5553.250311208016, 5562.749676264578, 5568.359638641608, 6073.939260607426, 6077.301110372364, 6077.696115194222, 6077.878442431127, 6078.969605151946, 5544.500994910478, 5552.41699621542, 5553.750081246354, 5556.111022236423, 5561.721913904369, 5701.401352858056, 5879.970600147143, 5884.735186916685, 5888.087346461305, 5889.587728858939, 5732.340780810094, 5735.569832262514, 5735.942640573708, 5740.225069615549, 5744.597878148489, 5542.445755424425, 5550.5282051026115, 5553.4724201200825, 5555.611107222618, 5557.138643510262, 3859.2281543691934, 3988.760674359548, 3999.5600483947323, 4034.7780872051144, 4038.151988082418, 5830.854228644318, 5835.649861008353, 5837.6497410155525, 5839.970800145972, 5840.8247752567495, 5610.551155907599, 5613.073842815889, 5626.465485778845, 5629.183768353484, 5633.141063449134, 5514.283143191359, 5618.044932361427, 5620.494155526022, 5630.071038278802, 5632.859178520406, 5438.293021907127, 5452.509274165344, 5454.481824226692, 5484.122540393518, 5491.395946445808, 5434.782608695766, 5595.552355811444, 5627.437256274504, 5633.661980281032, 5636.943630563642, 5359.571234301325, 5517.475839795213, 5549.112142057252, 5579.107342825291, 5579.60942734021], "unit": "ms", "name": "prototype.html", "value": 4222.478939046439}, {"lowerIsBetter": false, "replicates": [745.4632664481571, 748.3265061444699, 752.2477522477523, 767.205941850185, 769.8652735771238, 12434.0, 12991.545295914644, 13002.609921702353, 13025.544105956293, 13033.54382596608, 13277.269750163761, 13293.800592991089, 13392.397342119604, 13392.598222053353, 13396.464141434331, 633.9936600634004, 641.7753786174848, 817.824167803922, 832.8417600655886, 833.0295206084934, 810.4691427115249, 812.1715849833166, 820.4789958376444, 825.3067423364403, 825.7398919340419, 844.1558441558442, 845.7420486751538, 850.056437354536, 850.1710831938841, 850.3027517435705, 655.577152736487, 662.9867402651944, 833.9583020848934, 834.7161964931892, 853.3599800149888, 628.0641843652925, 632.7911789109583, 632.9082283068975, 633.1136409027398, 633.6356594957917, 11194.160437967104, 11292.26600270988, 11306.604268850633, 11321.094312455067, 11355.205135640508, 10372.63695770652, 10547.947260263649, 10689.251752377337, 10921.617743378943, 11705.473253703603, 9007.099290071006, 9332.860007099898, 9513.381630194015, 9536.761580960461, 9826.803463930753, 3008.3327539801485, 3131.1545882611567, 3168.3821654777325, 3200.5839240898536, 3225.629052658951, 40155.799221004, 40304.59695403067, 40340.39489407661, 40486.59513404858, 40629.59370406288, 9102.226310763526, 9482.241420686329, 9482.38364506305, 9532.142107210246, 9707.417554946725, 15840.683186336439, 15893.602659933595, 15896.12571308566, 15922.601934951486, 15928.681426371408, 6316.810495685137, 6415.711292991827, 6420.133282006869, 6477.4170324671, 6479.352064793483, 3470.6182319944787, 3510.84201210941, 3580.9104772380897, 3583.122135076923, 3596.964030359663, 2654.6947101083238, 2672.665916760405, 2682.919512414631, 2683.5437975544205, 2685.207863680219, 464.68865859873966, 466.8856130248043, 469.83790592245623, 472.4448772692073, 479.8392538499572, 483.6541872561136, 515.3429377543662, 543.4402565357688, 550.3176061683483, 560.6776103740366, 7063.046488723957, 7082.716691332392, 7298.4891057625455, 7335.3293413173105, 7442.144153422318, 419.4945091165139, 484.7576211894053, 517.7411294352823, 527.5937528103339, 541.6398095266683, 3233.935321293561, 3462.324846654878, 3493.650634936537, 3533.0813988362697, 3862.304785138702, 44129.77935110304, 47024.7648761754, 47064.05871882612, 47383.28925066127, 49945.0, 39790.80104599459, 40112.59887401089, 40284.798576006935, 40549.39175912364, 40652.39021414681, 38622.6137738619, 39118.0, 39303.60696393, 39626.801865990485, 41282.38076428856, 7286.599237041802, 7363.889541656772, 7792.337651299703, 7865.84268314619, 7917.802054948673, 29284.707152928197, 29376.7062329374, 30010.54984175283, 30574.541381879735, 30656.846715766278, 37353.2529349406, 37761.0, 37843.05392365103, 38297.23405531929, 38394.42408363821, 9855.852162217428, 9870.555824987749, 10025.598976040877, 10033.297669163088, 10147.16506833702, 11182.720431989266, 11195.160362972647, 11204.271722338022, 11219.1024718024, 11420.714482138013, 9897.65358212488, 10146.594136234467, 10250.846237306596, 10315.329503582243, 10346.896531034594, 9673.564689588844, 9878.901210987799, 9897.208223341971, 10182.287239893136, 10598.20513461509, 7911.762647120596, 9094.545272736468, 9999.55002024896, 10289.0, 10627.36235825853, 8787.692430764893, 8795.868061979203, 9043.412178208395, 9209.907900920905, 9294.814103717752, 8751.956240218758, 8855.114488551093, 8962.955185224033, 9058.411203271766, 9399.671011514563], "unit": "ms", "name": "yui.html", "value": 5595.319008593684}], "name": "dromaeo_css", "value": 6246.900250392111}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 107.0, 112.0, 113.0, 113.0, 101.0, 112.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [162.0, 129.0, 152.0, 167.0, 137.0, 152.0, 152.0, 145.0, 164.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [161.0, 165.0, 160.0, 159.0, 160.0, 159.0, 162.0, 160.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 88.0, 97.0, 71.0, 75.0, 74.0, 104.0, 97.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 135.0, 95.0, 95.0, 102.0, 134.0, 95.0, 95.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 72.0, 71.0, 70.0, 70.0, 72.0, 78.0, 69.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 83.0, 83.0, 83.0, 84.0, 91.0, 85.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [128.0, 120.0, 116.0, 119.0, 121.0, 120.0, 128.0, 125.0, 125.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [139.0, 148.0, 149.0, 149.0, 147.0, 139.0, 149.0, 137.0, 145.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 73.0, 69.0, 71.0, 68.0, 70.0, 71.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1523.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [186.42803877703207], "unit": "score", "name": "DeltaBlue", "value": 354.6569519999998}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1953.125], "unit": "score", "name": "RayTrace", "value": 378.87436799999995}, {"lowerIsBetter": false, "replicates": [798.2456140350877], "unit": "score", "name": "Earley", "value": 834.909692307692}, {"lowerIsBetter": false, "replicates": [11964.285714285714], "unit": "score", "name": "Boyer", "value": 55.704370149253705}, {"lowerIsBetter": false, "replicates": [26368.42105263158], "unit": "score", "name": "RegExp", "value": 34.54833333333334}, {"lowerIsBetter": false, "replicates": [602.7727546714889], "unit": "score", "name": "Splay", "value": 135.19356900000005}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19882.642887516016}]} 10:05:46 INFO - RETURN: dromaeo_css: 6246.90 10:05:46 INFO - RETURN: kraken: 1523.60 10:05:46 INFO - RETURN: v8_7: 19882.64 10:05:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19882.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6246.90"}}} 10:05:46 INFO - Return code: 0 10:05:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:05:46 ERROR - # TBPL SUCCESS # 10:05:46 INFO - Running post-action listener: _resource_record_post_action 10:05:46 INFO - Running post-run listener: _resource_record_post_run 10:05:47 INFO - Total resource usage - Wall time: 1336s; CPU: 14.0%; Read bytes: 8192; Write bytes: 503861248; Read time: 8932; Write time: 6916856 10:05:47 INFO - install - Wall time: 20s; CPU: 23.0%; Read bytes: 0; Write bytes: 139915264; Read time: 0; Write time: 1390836 10:05:47 INFO - run-tests - Wall time: 1317s; CPU: 13.0%; Read bytes: 8192; Write bytes: 354959360; Read time: 8932; Write time: 4865628 10:05:47 INFO - Running post-run listener: _upload_blobber_files 10:05:47 INFO - Blob upload gear active. 10:05:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:05:47 INFO - Copying logs to upload dir... 10:05:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1379.133844 ========= master_lag: 4.90 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2015-12-11 10:05:51.538757) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:05:51.542494) ========= 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=256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009967 build_url: 'https://queue.taskcluster.net/v1/task/tOzhRjFVRmutytLRo2Q9YA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.12 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:05:51.669609) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:05:51.669963) ========= 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=256b35f542ca8bede9e27f1f00000291-1449855121.458349-984788191 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:05:51.821331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 10:05:51.821681) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 10:05:51.821963) ========= ========= Total master_lag: 5.71 =========