builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1450107342.74 results: success (0) buildid: 20151214064631 builduid: caac47663f4d4d9aad9ee7399a5927c8 revision: 3fc5a790f110ff1eca34684041fd9f48eb4119f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.741981) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.742360) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.742661) ========= 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=5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004979 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.805619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.805898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.827561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.827824) ========= 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=5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.875888) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.876155) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.876506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:42.876791) ========= 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=5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-14 07:35:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.0M=0s 2015-12-14 07:35:43 (31.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.241327 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:43.198153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:43.198457) ========= 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=5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021009 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:43.248271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-14 07:35:43.248626) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3fc5a790f110ff1eca34684041fd9f48eb4119f2 --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 3fc5a790f110ff1eca34684041fd9f48eb4119f2 --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=5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-14 07:35:43,537 truncating revision to first 12 chars 2015-12-14 07:35:43,537 Setting DEBUG logging. 2015-12-14 07:35:43,537 attempt 1/10 2015-12-14 07:35:43,537 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3fc5a790f110?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-14 07:35:44,362 unpacking tar archive at: fx-team-3fc5a790f110/testing/mozharness/ program finished with exit code 0 elapsedTime=1.106072 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-14 07:35:44.367784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:44.368076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:44.377967) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:44.378225) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 07:35:44.378619) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-14 07:35:44.378908) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:35:44 INFO - MultiFileLogger online at 20151214 07:35:44 in /builds/slave/test 07:35:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:35:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:44 INFO - {'append_to_log': False, 07:35:44 INFO - 'base_work_dir': '/builds/slave/test', 07:35:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:35:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:44 INFO - 'branch': 'Fx-Team-Non-PGO', 07:35:44 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:44 INFO - 'config_files': ('talos/linux_config.py',), 07:35:44 INFO - 'default_actions': ('clobber', 07:35:44 INFO - 'read-buildbot-config', 07:35:44 INFO - 'download-and-extract', 07:35:44 INFO - 'populate-webroot', 07:35:44 INFO - 'create-virtualenv', 07:35:44 INFO - 'install', 07:35:44 INFO - 'run-tests'), 07:35:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:44 INFO - 'download_minidump_stackwalk': True, 07:35:44 INFO - 'download_symbols': 'ondemand', 07:35:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:44 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:44 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:44 INFO - 'installer_path': 'installer.exe', 07:35:44 INFO - 'log_level': 'info', 07:35:44 INFO - 'log_name': 'talos', 07:35:44 INFO - 'log_to_console': True, 07:35:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:35:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:35:44 INFO - 'opt_config_files': (), 07:35:44 INFO - 'pip_index': False, 07:35:44 INFO - 'sps_profile': False, 07:35:44 INFO - 'sps_profile_interval': 0, 07:35:44 INFO - 'suite': 'dromaeojs-e10s', 07:35:44 INFO - 'system_bits': '64', 07:35:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:44 INFO - 'title': 'talos-linux64-ix-061', 07:35:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:44 INFO - 'use_talos_json': True, 07:35:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:44 INFO - 'work_dir': 'build'} 07:35:44 INFO - ##### 07:35:44 INFO - ##### Running clobber step. 07:35:44 INFO - ##### 07:35:44 INFO - Running pre-action listener: _resource_record_pre_action 07:35:44 INFO - Running main action method: clobber 07:35:44 INFO - rmtree: /builds/slave/test/build 07:35:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:45 INFO - Running post-action listener: _resource_record_post_action 07:35:45 INFO - ##### 07:35:45 INFO - ##### Running read-buildbot-config step. 07:35:45 INFO - ##### 07:35:45 INFO - Running pre-action listener: _resource_record_pre_action 07:35:45 INFO - Running main action method: read_buildbot_config 07:35:45 INFO - Using buildbot properties: 07:35:45 INFO - { 07:35:45 INFO - "properties": { 07:35:45 INFO - "buildnumber": 572, 07:35:45 INFO - "product": "firefox", 07:35:45 INFO - "script_repo_revision": "production", 07:35:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:35:45 INFO - "repository": "", 07:35:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:35:45 INFO - "buildid": "20151214064631", 07:35:45 INFO - "slavename": "talos-linux64-ix-061", 07:35:45 INFO - "pgo_build": "False", 07:35:45 INFO - "basedir": "/builds/slave/test", 07:35:45 INFO - "project": "", 07:35:45 INFO - "platform": "ubuntu64_hw", 07:35:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:35:45 INFO - "slavebuilddir": "test", 07:35:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:35:45 INFO - "branch": "fx-team", 07:35:45 INFO - "repo_path": "integration/fx-team", 07:35:45 INFO - "stage_platform": "linux64", 07:35:45 INFO - "builduid": "caac47663f4d4d9aad9ee7399a5927c8", 07:35:45 INFO - "revision": "3fc5a790f110ff1eca34684041fd9f48eb4119f2" 07:35:45 INFO - }, 07:35:45 INFO - "sourcestamp": { 07:35:45 INFO - "repository": "", 07:35:45 INFO - "hasPatch": false, 07:35:45 INFO - "project": "", 07:35:45 INFO - "branch": "fx-team-linux64-talos", 07:35:45 INFO - "changes": [ 07:35:45 INFO - { 07:35:45 INFO - "category": null, 07:35:45 INFO - "files": [ 07:35:45 INFO - { 07:35:45 INFO - "url": null, 07:35:45 INFO - "name": "https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:35:45 INFO - } 07:35:45 INFO - ], 07:35:45 INFO - "repository": "", 07:35:45 INFO - "rev": "3fc5a790f110ff1eca34684041fd9f48eb4119f2", 07:35:45 INFO - "who": "cbook@mozilla.com", 07:35:45 INFO - "when": 1450107227, 07:35:45 INFO - "number": 7357367, 07:35:45 INFO - "comments": "Bug 1191230 - Add Windows 10 twisties. r=Gijs", 07:35:45 INFO - "project": "", 07:35:45 INFO - "at": "Mon 14 Dec 2015 07:33:47", 07:35:45 INFO - "branch": "fx-team-linux64-talos", 07:35:45 INFO - "revlink": "", 07:35:45 INFO - "properties": [ 07:35:45 INFO - [ 07:35:45 INFO - "buildid", 07:35:45 INFO - "20151214064631", 07:35:45 INFO - "Change" 07:35:45 INFO - ], 07:35:45 INFO - [ 07:35:45 INFO - "builduid", 07:35:45 INFO - "caac47663f4d4d9aad9ee7399a5927c8", 07:35:45 INFO - "Change" 07:35:45 INFO - ], 07:35:45 INFO - [ 07:35:45 INFO - "pgo_build", 07:35:45 INFO - "False", 07:35:45 INFO - "Change" 07:35:45 INFO - ] 07:35:45 INFO - ], 07:35:45 INFO - "revision": "3fc5a790f110ff1eca34684041fd9f48eb4119f2" 07:35:45 INFO - } 07:35:45 INFO - ], 07:35:45 INFO - "revision": "3fc5a790f110ff1eca34684041fd9f48eb4119f2" 07:35:45 INFO - } 07:35:45 INFO - } 07:35:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:35:45 INFO - Running post-action listener: _resource_record_post_action 07:35:45 INFO - ##### 07:35:45 INFO - ##### Running download-and-extract step. 07:35:45 INFO - ##### 07:35:45 INFO - Running pre-action listener: _resource_record_pre_action 07:35:45 INFO - Running main action method: download_and_extract 07:35:45 INFO - mkdir: /builds/slave/test/build/tests 07:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:45 INFO - https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:35:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/test_packages.json 07:35:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/test_packages.json 07:35:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:35:48 INFO - Downloaded 1302 bytes. 07:35:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:35:48 INFO - Using the following test package requirements: 07:35:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:35:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:48 INFO - u'jsshell-linux-x86_64.zip'], 07:35:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:35:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:35:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:35:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:35:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:35:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:35:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:35:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:48 INFO - https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:35:50 INFO - Downloaded 21869925 bytes. 07:35:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:35:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:35:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:35:51 INFO - Return code: 0 07:35:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:51 INFO - https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:35:52 INFO - Downloaded 21869925 bytes. 07:35:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:35:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:35:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:35:54 INFO - Return code: 0 07:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:35:54 INFO - https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:35:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:35:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:35:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:35:55 INFO - Downloaded 11132038 bytes. 07:35:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 07:35:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:35:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:35:55 INFO - Return code: 0 07:35: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')]} 07:35:55 INFO - https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:35:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:35:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:35:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:35:56 INFO - Downloaded 57745934 bytes. 07:35:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:35:56 INFO - mkdir: /builds/slave/test/properties 07:35:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:35:56 INFO - Writing to file /builds/slave/test/properties/build_url 07:35:56 INFO - Contents: 07:35:56 INFO - build_url:https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:35:56 INFO - Running post-action listener: _resource_record_post_action 07:35:56 INFO - Running post-action listener: set_extra_try_arguments 07:35:56 INFO - ##### 07:35:56 INFO - ##### Running populate-webroot step. 07:35:56 INFO - ##### 07:35:56 INFO - Running pre-action listener: _resource_record_pre_action 07:35:56 INFO - Running main action method: populate_webroot 07:35:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:35:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:35:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:35:56 INFO - '--tppagecycles', 07:35:56 INFO - '7'], 07:35:56 INFO - 'tests': ['tsvgm']}}, 07:35:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:35:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:35:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:35:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:35:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:35:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:35:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'talos_options': ['--e10s'], 07:35:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:35:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'tests': ['damp', 'tps']}, 07:35:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'talos_options': ['--e10s'], 07:35:56 INFO - 'tests': ['damp', 'tps']}, 07:35:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:35:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:35:56 INFO - 'other': {'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore']}, 07:35:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:35:56 INFO - 'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore']}, 07:35:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:35:56 INFO - 'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore']}, 07:35:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:35:56 INFO - 'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore']}, 07:35:56 INFO - 'other_l64': {'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore']}, 07:35:56 INFO - 'other_nol64': {'tests': ['a11yr', 07:35:56 INFO - 'ts_paint', 07:35:56 INFO - 'tpaint', 07:35:56 INFO - 'sessionrestore', 07:35:56 INFO - 'sessionrestore_no_auto_restore']}, 07:35:56 INFO - 'svgr': {'tests': ['tsvgx', 07:35:56 INFO - 'tsvgr_opacity', 07:35:56 INFO - 'tart', 07:35:56 INFO - 'tscrollx', 07:35:56 INFO - 'cart']}, 07:35:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:35:56 INFO - 'tests': ['tsvgx', 07:35:56 INFO - 'tsvgr_opacity', 07:35:56 INFO - 'tart', 07:35:56 INFO - 'tscrollx', 07:35:56 INFO - 'cart']}, 07:35:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'tests': ['tp5o']}, 07:35:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'talos_options': ['--e10s'], 07:35:56 INFO - 'tests': ['tp5o']}, 07:35:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'talos_options': ['--xperf_path', 07:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:56 INFO - 'tests': ['tp5n']}, 07:35:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:35:56 INFO - 'talos_options': ['--e10s', 07:35:56 INFO - '--xperf_path', 07:35:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:35:56 INFO - 'tests': ['tp5n']}}, 07:35:56 INFO - 'talos.zip': {'path': '', 07:35:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:35:56 INFO - Running post-action listener: _resource_record_post_action 07:35:56 INFO - ##### 07:35:56 INFO - ##### Running create-virtualenv step. 07:35:56 INFO - ##### 07:35:56 INFO - Running pre-action listener: _resource_record_pre_action 07:35:56 INFO - Running main action method: create_virtualenv 07:35:56 INFO - Creating virtualenv /builds/slave/test/build/venv 07:35:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:35:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:35:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:35:56 INFO - Using real prefix '/usr' 07:35:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:35:57 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:00 INFO - Installing pip.................done. 07:36:00 INFO - Return code: 0 07:36:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2550c73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b0b0>, '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 0x277bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c440>, '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': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:36:00 INFO - Using env: {'DISPLAY': ':0', 07:36:00 INFO - 'HOME': '/home/cltbld', 07:36:00 INFO - 'LANG': 'en_US.UTF-8', 07:36:00 INFO - 'LANGUAGE': 'en_US:en', 07:36:00 INFO - 'LOGNAME': 'cltbld', 07:36:00 INFO - 'MAIL': '/var/mail/cltbld', 07:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:00 INFO - 'MOZ_NO_REMOTE': '1', 07:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:00 INFO - 'NO_EM_RESTART': '1', 07:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:00 INFO - 'PWD': '/builds/slave/test', 07:36:00 INFO - 'SHELL': '/bin/bash', 07:36:00 INFO - 'SHLVL': '1', 07:36:00 INFO - 'TERM': 'linux', 07:36:00 INFO - 'TMOUT': '86400', 07:36:00 INFO - 'USER': 'cltbld', 07:36:00 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 07:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:00 INFO - '_': '/tools/buildbot/bin/python'} 07:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:36:00 INFO - Cleaning up... 07:36:00 INFO - Return code: 0 07:36:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2550c73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b0b0>, '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 0x277bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c440>, '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': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:36:00 INFO - Using env: {'DISPLAY': ':0', 07:36:00 INFO - 'HOME': '/home/cltbld', 07:36:00 INFO - 'LANG': 'en_US.UTF-8', 07:36:00 INFO - 'LANGUAGE': 'en_US:en', 07:36:00 INFO - 'LOGNAME': 'cltbld', 07:36:00 INFO - 'MAIL': '/var/mail/cltbld', 07:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:00 INFO - 'MOZ_NO_REMOTE': '1', 07:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:00 INFO - 'NO_EM_RESTART': '1', 07:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:00 INFO - 'PWD': '/builds/slave/test', 07:36:00 INFO - 'SHELL': '/bin/bash', 07:36:00 INFO - 'SHLVL': '1', 07:36:00 INFO - 'TERM': 'linux', 07:36:00 INFO - 'TMOUT': '86400', 07:36:00 INFO - 'USER': 'cltbld', 07:36:00 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 07:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:00 INFO - '_': '/tools/buildbot/bin/python'} 07:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:00 INFO - Downloading/unpacking psutil>=0.7.1 07:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:36:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:02 INFO - Installing collected packages: psutil 07:36:02 INFO - Running setup.py install for psutil 07:36:02 INFO - building 'psutil._psutil_linux' extension 07:36:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:36:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:36:03 INFO - building 'psutil._psutil_posix' extension 07:36:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:36:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:36:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:04 INFO - Successfully installed psutil 07:36:04 INFO - Cleaning up... 07:36:04 INFO - Return code: 0 07:36:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:04 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 0x7f2550c73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b0b0>, '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 0x277bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c440>, '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': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:36:04 INFO - Using env: {'DISPLAY': ':0', 07:36:04 INFO - 'HOME': '/home/cltbld', 07:36:04 INFO - 'LANG': 'en_US.UTF-8', 07:36:04 INFO - 'LANGUAGE': 'en_US:en', 07:36:04 INFO - 'LOGNAME': 'cltbld', 07:36:04 INFO - 'MAIL': '/var/mail/cltbld', 07:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:04 INFO - 'MOZ_NO_REMOTE': '1', 07:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:04 INFO - 'NO_EM_RESTART': '1', 07:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:04 INFO - 'PWD': '/builds/slave/test', 07:36:04 INFO - 'SHELL': '/bin/bash', 07:36:04 INFO - 'SHLVL': '1', 07:36:04 INFO - 'TERM': 'linux', 07:36:04 INFO - 'TMOUT': '86400', 07:36:04 INFO - 'USER': 'cltbld', 07:36:04 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 07:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:04 INFO - '_': '/tools/buildbot/bin/python'} 07:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:36:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:36:06 INFO - Installing collected packages: mozsystemmonitor 07:36:06 INFO - Running setup.py install for mozsystemmonitor 07:36:06 INFO - Successfully installed mozsystemmonitor 07:36:06 INFO - Cleaning up... 07:36:06 INFO - Return code: 0 07:36:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:06 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 0x7f2550c73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b0b0>, '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 0x277bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c440>, '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': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:36:06 INFO - Using env: {'DISPLAY': ':0', 07:36:06 INFO - 'HOME': '/home/cltbld', 07:36:06 INFO - 'LANG': 'en_US.UTF-8', 07:36:06 INFO - 'LANGUAGE': 'en_US:en', 07:36:06 INFO - 'LOGNAME': 'cltbld', 07:36:06 INFO - 'MAIL': '/var/mail/cltbld', 07:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:06 INFO - 'MOZ_NO_REMOTE': '1', 07:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:06 INFO - 'NO_EM_RESTART': '1', 07:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:06 INFO - 'PWD': '/builds/slave/test', 07:36:06 INFO - 'SHELL': '/bin/bash', 07:36:06 INFO - 'SHLVL': '1', 07:36:06 INFO - 'TERM': 'linux', 07:36:06 INFO - 'TMOUT': '86400', 07:36:06 INFO - 'USER': 'cltbld', 07:36:06 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 07:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:06 INFO - '_': '/tools/buildbot/bin/python'} 07:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:08 INFO - Downloading docopt-0.6.1.tar.gz 07:36:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:08 INFO - Running setup.py install for blobuploader 07:36:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:08 INFO - Running setup.py install for requests 07:36:09 INFO - Running setup.py install for docopt 07:36:09 INFO - Successfully installed blobuploader requests docopt 07:36:09 INFO - Cleaning up... 07:36:09 INFO - Return code: 0 07:36:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:09 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 0x7f2550c73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b0b0>, '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 0x277bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c440>, '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': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:36:09 INFO - Using env: {'DISPLAY': ':0', 07:36:09 INFO - 'HOME': '/home/cltbld', 07:36:09 INFO - 'LANG': 'en_US.UTF-8', 07:36:09 INFO - 'LANGUAGE': 'en_US:en', 07:36:09 INFO - 'LOGNAME': 'cltbld', 07:36:09 INFO - 'MAIL': '/var/mail/cltbld', 07:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:09 INFO - 'MOZ_NO_REMOTE': '1', 07:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:09 INFO - 'NO_EM_RESTART': '1', 07:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:09 INFO - 'PWD': '/builds/slave/test', 07:36:09 INFO - 'SHELL': '/bin/bash', 07:36:09 INFO - 'SHLVL': '1', 07:36:09 INFO - 'TERM': 'linux', 07:36:09 INFO - 'TMOUT': '86400', 07:36:09 INFO - 'USER': 'cltbld', 07:36:09 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 07:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:09 INFO - '_': '/tools/buildbot/bin/python'} 07:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:09 INFO - Running setup.py (path:/tmp/pip-46lV7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:09 INFO - Running setup.py (path:/tmp/pip-MokL3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:09 INFO - Running setup.py (path:/tmp/pip-xAQyKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:09 INFO - Running setup.py (path:/tmp/pip-FMD591-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:09 INFO - Running setup.py (path:/tmp/pip-dQUv6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:10 INFO - Running setup.py (path:/tmp/pip-41STHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:10 INFO - Running setup.py (path:/tmp/pip-9f_c0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:10 INFO - Running setup.py (path:/tmp/pip-Q3malU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:10 INFO - Running setup.py (path:/tmp/pip-lnH0n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:10 INFO - Running setup.py (path:/tmp/pip-xfTebe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:10 INFO - Running setup.py (path:/tmp/pip-D7bYFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:10 INFO - Running setup.py (path:/tmp/pip-hbBL6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:10 INFO - Running setup.py (path:/tmp/pip-gOEUF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:10 INFO - Running setup.py (path:/tmp/pip-s2LXkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:10 INFO - Running setup.py (path:/tmp/pip-FTqUrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:10 INFO - Running setup.py (path:/tmp/pip-QZgV3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:10 INFO - Running setup.py (path:/tmp/pip-lE2gkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:10 INFO - Running setup.py install for manifestparser 07:36:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:10 INFO - Running setup.py install for mozcrash 07:36:11 INFO - Running setup.py install for mozdebug 07:36:11 INFO - Running setup.py install for mozdevice 07:36:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozfile 07:36:11 INFO - Running setup.py install for mozhttpd 07:36:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozinfo 07:36:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozInstall 07:36:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozleak 07:36:11 INFO - Running setup.py install for mozlog 07:36:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for moznetwork 07:36:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:11 INFO - Running setup.py install for mozprocess 07:36:12 INFO - Running setup.py install for mozprofile 07:36:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozrunner 07:36:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Running setup.py install for mozscreenshot 07:36:12 INFO - Running setup.py install for moztest 07:36:12 INFO - Running setup.py install for mozversion 07:36:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:12 INFO - Cleaning up... 07:36:12 INFO - Return code: 0 07:36:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:12 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 0x7f2550c73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b0b0>, '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 0x277bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c440>, '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': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:36:12 INFO - Using env: {'DISPLAY': ':0', 07:36:12 INFO - 'HOME': '/home/cltbld', 07:36:12 INFO - 'LANG': 'en_US.UTF-8', 07:36:12 INFO - 'LANGUAGE': 'en_US:en', 07:36:12 INFO - 'LOGNAME': 'cltbld', 07:36:12 INFO - 'MAIL': '/var/mail/cltbld', 07:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:12 INFO - 'MOZ_NO_REMOTE': '1', 07:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:12 INFO - 'NO_EM_RESTART': '1', 07:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:12 INFO - 'PWD': '/builds/slave/test', 07:36:12 INFO - 'SHELL': '/bin/bash', 07:36:12 INFO - 'SHLVL': '1', 07:36:12 INFO - 'TERM': 'linux', 07:36:12 INFO - 'TMOUT': '86400', 07:36:12 INFO - 'USER': 'cltbld', 07:36:12 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 07:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:12 INFO - '_': '/tools/buildbot/bin/python'} 07:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:12 INFO - Running setup.py (path:/tmp/pip-MLZLDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:12 INFO - Running setup.py (path:/tmp/pip-kbpadU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:13 INFO - Running setup.py (path:/tmp/pip-vbgYeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:13 INFO - Running setup.py (path:/tmp/pip-cOClfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:13 INFO - Running setup.py (path:/tmp/pip-WeQIjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:13 INFO - Running setup.py (path:/tmp/pip-9vRUvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:13 INFO - Running setup.py (path:/tmp/pip-o3n6ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:13 INFO - Running setup.py (path:/tmp/pip-IINsxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:13 INFO - Running setup.py (path:/tmp/pip-kazILa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:13 INFO - Running setup.py (path:/tmp/pip-OwBbgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:13 INFO - Running setup.py (path:/tmp/pip-PVN04L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:13 INFO - Running setup.py (path:/tmp/pip-gpux0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:13 INFO - Running setup.py (path:/tmp/pip-COYTvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:13 INFO - Running setup.py (path:/tmp/pip-JcHO4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:13 INFO - Running setup.py (path:/tmp/pip-TBs_YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:13 INFO - Running setup.py (path:/tmp/pip-Pw7uFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:36:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:14 INFO - Running setup.py (path:/tmp/pip-HLsc46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:15 INFO - Downloading blessings-1.5.1.tar.gz 07:36:15 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:15 INFO - Installing collected packages: blessings 07:36:15 INFO - Running setup.py install for blessings 07:36:16 INFO - Successfully installed blessings 07:36:16 INFO - Cleaning up... 07:36:16 INFO - Return code: 0 07:36:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:16 INFO - Reading from file tmpfile_stdout 07:36:16 INFO - Current package versions: 07:36:16 INFO - argparse == 1.2.1 07:36:16 INFO - blessings == 1.5.1 07:36:16 INFO - blobuploader == 1.2.4 07:36:16 INFO - docopt == 0.6.1 07:36:16 INFO - manifestparser == 1.1 07:36:16 INFO - mozInstall == 1.12 07:36:16 INFO - mozcrash == 0.16 07:36:16 INFO - mozdebug == 0.1 07:36:16 INFO - mozdevice == 0.47 07:36:16 INFO - mozfile == 1.2 07:36:16 INFO - mozhttpd == 0.7 07:36:16 INFO - mozinfo == 0.9 07:36:16 INFO - mozleak == 0.1 07:36:16 INFO - mozlog == 3.1 07:36:16 INFO - moznetwork == 0.27 07:36:16 INFO - mozprocess == 0.22 07:36:16 INFO - mozprofile == 0.27 07:36:16 INFO - mozrunner == 6.11 07:36:16 INFO - mozscreenshot == 0.1 07:36:16 INFO - mozsystemmonitor == 0.0 07:36:16 INFO - moztest == 0.7 07:36:16 INFO - mozversion == 1.4 07:36:16 INFO - psutil == 3.1.1 07:36:16 INFO - requests == 1.2.3 07:36:16 INFO - wsgiref == 0.1.2 07:36:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:16 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 0x7f2550c73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b0b0>, '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 0x277bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c440>, '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': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:36:16 INFO - Using env: {'DISPLAY': ':0', 07:36:16 INFO - 'HOME': '/home/cltbld', 07:36:16 INFO - 'LANG': 'en_US.UTF-8', 07:36:16 INFO - 'LANGUAGE': 'en_US:en', 07:36:16 INFO - 'LOGNAME': 'cltbld', 07:36:16 INFO - 'MAIL': '/var/mail/cltbld', 07:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:16 INFO - 'MOZ_NO_REMOTE': '1', 07:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:16 INFO - 'NO_EM_RESTART': '1', 07:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:16 INFO - 'PWD': '/builds/slave/test', 07:36:16 INFO - 'SHELL': '/bin/bash', 07:36:16 INFO - 'SHLVL': '1', 07:36:16 INFO - 'TERM': 'linux', 07:36:16 INFO - 'TMOUT': '86400', 07:36:16 INFO - 'USER': 'cltbld', 07:36:16 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 07:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:16 INFO - '_': '/tools/buildbot/bin/python'} 07:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:36:16 INFO - Cleaning up... 07:36:16 INFO - Return code: 0 07:36:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:16 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 0x7f2550c73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b0b0>, '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 0x277bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c440>, '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': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:36:16 INFO - Using env: {'DISPLAY': ':0', 07:36:16 INFO - 'HOME': '/home/cltbld', 07:36:16 INFO - 'LANG': 'en_US.UTF-8', 07:36:16 INFO - 'LANGUAGE': 'en_US:en', 07:36:16 INFO - 'LOGNAME': 'cltbld', 07:36:16 INFO - 'MAIL': '/var/mail/cltbld', 07:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:16 INFO - 'MOZ_NO_REMOTE': '1', 07:36:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:16 INFO - 'NO_EM_RESTART': '1', 07:36:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:16 INFO - 'PWD': '/builds/slave/test', 07:36:16 INFO - 'SHELL': '/bin/bash', 07:36:16 INFO - 'SHLVL': '1', 07:36:16 INFO - 'TERM': 'linux', 07:36:16 INFO - 'TMOUT': '86400', 07:36:16 INFO - 'USER': 'cltbld', 07:36:16 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 07:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:16 INFO - '_': '/tools/buildbot/bin/python'} 07:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:16 INFO - Downloading/unpacking jsonschema 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:36:18 INFO - Downloading/unpacking functools32 (from jsonschema) 07:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:18 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:18 INFO - warning: no files found matching '*.txt' 07:36:18 INFO - no previously-included directories found matching 'build' 07:36:18 INFO - no previously-included directories found matching 'dist' 07:36:18 INFO - no previously-included directories found matching '.git*' 07:36:18 INFO - Installing collected packages: jsonschema, functools32 07:36:18 INFO - Running setup.py install for functools32 07:36:18 INFO - warning: no files found matching '*.txt' 07:36:18 INFO - no previously-included directories found matching 'build' 07:36:18 INFO - no previously-included directories found matching 'dist' 07:36:18 INFO - no previously-included directories found matching '.git*' 07:36:18 INFO - Successfully installed jsonschema functools32 07:36:18 INFO - Cleaning up... 07:36:18 INFO - Return code: 0 07:36:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:18 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 0x7f2550c73f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ec240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277b0b0>, '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 0x277bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c440>, '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': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:36:18 INFO - Using env: {'DISPLAY': ':0', 07:36:18 INFO - 'HOME': '/home/cltbld', 07:36:18 INFO - 'LANG': 'en_US.UTF-8', 07:36:18 INFO - 'LANGUAGE': 'en_US:en', 07:36:18 INFO - 'LOGNAME': 'cltbld', 07:36:18 INFO - 'MAIL': '/var/mail/cltbld', 07:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:18 INFO - 'MOZ_NO_REMOTE': '1', 07:36:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:18 INFO - 'NO_EM_RESTART': '1', 07:36:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:18 INFO - 'PWD': '/builds/slave/test', 07:36:18 INFO - 'SHELL': '/bin/bash', 07:36:18 INFO - 'SHLVL': '1', 07:36:18 INFO - 'TERM': 'linux', 07:36:18 INFO - 'TMOUT': '86400', 07:36:18 INFO - 'USER': 'cltbld', 07:36:18 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 07:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:18 INFO - '_': '/tools/buildbot/bin/python'} 07:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:19 INFO - Downloading/unpacking flake8 07:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:36:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:36:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:36:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:36:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:36:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:36:21 INFO - no previously-included directories found matching 'docs/_build' 07:36:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:36:21 INFO - Running setup.py install for pep8 07:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:36:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:36:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:36:21 INFO - no previously-included directories found matching 'docs/_build' 07:36:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:36:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:36:21 INFO - Cleaning up... 07:36:21 INFO - Return code: 0 07:36:21 INFO - Running post-action listener: _resource_record_post_action 07:36:21 INFO - Running post-action listener: _start_resource_monitoring 07:36:21 INFO - Starting resource monitoring. 07:36:21 INFO - ##### 07:36:21 INFO - ##### Running install step. 07:36:21 INFO - ##### 07:36:21 INFO - Running pre-action listener: _resource_record_pre_action 07:36:21 INFO - Running main action method: install 07:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:21 INFO - Reading from file tmpfile_stdout 07:36:21 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:22 INFO - Reading from file tmpfile_stdout 07:36:22 INFO - Output received: 07:36:22 INFO - Usage: mozinstall [options] installer 07:36:22 INFO - Options: 07:36:22 INFO - -h, --help show this help message and exit 07:36:22 INFO - -d DEST, --destination=DEST 07:36:22 INFO - Directory to install application into. [default: 07:36:22 INFO - "/builds/slave/test"] 07:36:22 INFO - --app=APP Application being installed. [default: firefox] 07:36:22 INFO - mkdir: /builds/slave/test/build/application 07:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:36:36 INFO - Reading from file tmpfile_stdout 07:36:36 INFO - Output received: 07:36:36 INFO - /builds/slave/test/build/application/firefox/firefox 07:36:36 INFO - Running post-action listener: _resource_record_post_action 07:36:36 INFO - ##### 07:36:36 INFO - ##### Running run-tests step. 07:36:36 INFO - ##### 07:36:36 INFO - Running pre-action listener: _resource_record_pre_action 07:36:36 INFO - Running main action method: run_tests 07:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:36:36 INFO - Python 2.7.3 07:36:36 INFO - Return code: 0 07:36:36 INFO - grabbing minidump binary from tooltool 07:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:36 INFO - 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 0x277b0b0>, '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 0x277bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x277c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:36:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:36:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:36:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:36:36 INFO - Return code: 0 07:36:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:36:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:36:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:36:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:36:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:36:37 INFO - Return code: 0 07:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test/build 07:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 07:36:37 INFO - Using env: {'DISPLAY': ':0', 07:36:37 INFO - 'HOME': '/home/cltbld', 07:36:37 INFO - 'LANG': 'en_US.UTF-8', 07:36:37 INFO - 'LANGUAGE': 'en_US:en', 07:36:37 INFO - 'LOGNAME': 'cltbld', 07:36:37 INFO - 'MAIL': '/var/mail/cltbld', 07:36:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:36:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:37 INFO - 'MOZ_NO_REMOTE': '1', 07:36:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:37 INFO - 'NO_EM_RESTART': '1', 07:36:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:37 INFO - 'PWD': '/builds/slave/test', 07:36:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:36:37 INFO - 'SHELL': '/bin/bash', 07:36:37 INFO - 'SHLVL': '1', 07:36:37 INFO - 'TERM': 'linux', 07:36:37 INFO - 'TMOUT': '86400', 07:36:37 INFO - 'USER': 'cltbld', 07:36:37 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651', 07:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:37 INFO - '_': '/tools/buildbot/bin/python'} 07:36:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 07:36:37 INFO - mozversion INFO | application_buildid: 20151214064631 07:36:37 INFO - mozversion INFO | application_changeset: 3fc5a790f110ff1eca34684041fd9f48eb4119f2 07:36:37 INFO - mozversion INFO | application_display_name: Nightly 07:36:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:36:37 INFO - mozversion INFO | application_name: Firefox 07:36:37 INFO - mozversion INFO | application_remotingname: firefox 07:36:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:36:37 INFO - mozversion INFO | application_vendor: Mozilla 07:36:37 INFO - mozversion INFO | application_version: 45.0a1 07:36:37 INFO - mozversion INFO | platform_buildid: 20151214064631 07:36:37 INFO - mozversion INFO | platform_changeset: 3fc5a790f110ff1eca34684041fd9f48eb4119f2 07:36:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:36:37 INFO - mozversion INFO | platform_version: 45.0a1 07:36:37 INFO - 2015-12-14 07:36:37,870 DEBUG : using testdate: 1450107397 07:36:37 INFO - 2015-12-14 07:36:37,870 DEBUG : actual date: 1450107397 07:36:37 INFO - 2015-12-14 07:36:37,878 INFO : starting webserver on 'localhost:47262' 07:36:37 INFO - 2015-12-14 07:36:37,879 INFO : Starting test suite talos-linux64-ix-061.e 07:36:37 INFO - 2015-12-14 07:36:37,879 INFO : Starting test dromaeo_css 07:36:37 INFO - 2015-12-14 07:36:37,880 DEBUG : operating with platform_type : linux_ 07:36:37 INFO - 2015-12-14 07:36:37,880 INFO : Initialising browser for dromaeo_css test... 07:36:37 INFO - 2015-12-14 07:36:37,897 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqaS3Gu/profile http://localhost:47262/getInfo.html 07:36:44 INFO - 2015-12-14 07:36:44,809 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:36:44 INFO - 2015-12-14 07:36:44,809 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:36:44 INFO - 2015-12-14 07:36:44,810 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:36:44 INFO - 2015-12-14 07:36:44,810 DEBUG : BROWSER_OUTPUT: __metrics 07:36:44 INFO - 2015-12-14 07:36:44,926 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:36:45 INFO - 2015-12-14 07:36:45,785 INFO : Browser initialized. 07:36:45 INFO - 2015-12-14 07:36:45,786 INFO : Running cycle 1/1 for dromaeo_css test... 07:36:45 INFO - 2015-12-14 07:36:45,786 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqaS3Gu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:36:57 INFO - 2015-12-14 07:36:57,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 142979072 07:36:57 INFO - 2015-12-14 07:36:57,826 DEBUG : BROWSER_OUTPUT: 07:37:47 INFO - 2015-12-14 07:37:47,472 DEBUG : BROWSER_OUTPUT: 1450107467469 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:39:59 INFO - 2015-12-14 07:39:59,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47262/tests/dromaeo/cssquery-ext.html) 07:40:00 INFO - 2015-12-14 07:40:00,183 DEBUG : BROWSER_OUTPUT: RSS: Main: 144412672 07:40:00 INFO - 2015-12-14 07:40:00,184 DEBUG : BROWSER_OUTPUT: 07:43:02 INFO - 2015-12-14 07:43:02,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/dromaeo/cssquery-ext.html (next: http://localhost:47262/tests/dromaeo/cssquery-jquery.html) 07:43:02 INFO - 2015-12-14 07:43:02,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 144793600 07:43:02 INFO - 2015-12-14 07:43:02,910 DEBUG : BROWSER_OUTPUT: 07:46:04 INFO - 2015-12-14 07:46:04,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47262/tests/dromaeo/cssquery-mootools.html) 07:46:05 INFO - 2015-12-14 07:46:05,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 144560128 07:46:05 INFO - 2015-12-14 07:46:05,283 DEBUG : BROWSER_OUTPUT: 07:49:07 INFO - 2015-12-14 07:49:07,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47262/tests/dromaeo/cssquery-prototype.html) 07:49:07 INFO - 2015-12-14 07:49:07,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 144343040 07:49:07 INFO - 2015-12-14 07:49:07,655 DEBUG : BROWSER_OUTPUT: 07:52:10 INFO - 2015-12-14 07:52:10,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47262/tests/dromaeo/cssquery-yui.html) 07:52:10 INFO - 2015-12-14 07:52:10,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 144670720 07:52:10 INFO - 2015-12-14 07:52:10,900 DEBUG : BROWSER_OUTPUT: 07:55:13 INFO - 2015-12-14 07:55:13,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/dromaeo/cssquery-yui.html (next: http://localhost:47262/tests/dromaeo/cssquery-dojo.html) 07:55:13 INFO - 2015-12-14 07:55:13,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 147623936 07:55:13 INFO - 2015-12-14 07:55:13,599 DEBUG : BROWSER_OUTPUT: 07:55:13 INFO - 2015-12-14 07:55:13,600 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:55:13 INFO - 2015-12-14 07:55:13,600 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:55:13 INFO - 2015-12-14 07:55:13,600 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:55:13 INFO - 2015-12-14 07:55:13,600 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:55:13 INFO - 2015-12-14 07:55:13,601 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2632.3682316244103;2699.500592390409;2725.727427257276;2725.7546820786138;2749.6837863645674;4603.838865639704;4834.057358815028;4844.781984810683;4865.172920603497;4894.070126675938;4683.367745354376;4716.9292460613115;4736.692115012522;4809.9519004809945;4821.300911367858;4224.72539284947;4313.460817397825;4350.977520282731;4397.890052748675;4412.911741765162;4421.09367579647;4458.450624094034;4468.620167285784;4482.327650852382;4529.139463501924;4175.958240417587;4280.828766849322;4476.171908196994;4495.348174514694;4508.977455112704;4306.935395969063;4395.934060989088;4397.890052748707;4423.867283981485;4427.712198707074;4340.565943405666;4361.3457981302745;4365.4106695596;4369.880607905164;4427.203103441379;4436.0906014267;4613.423322084739;4651.837185698518;4695.835645752416;4722.929156062662;5103.948960510422;5127.9230811537855;5134.05020071288;5144.61415393847;5169.56058735008;5158.380994280673;5178.948210517922;5183.714895680736;5193.454687257859;5226.137687281594;4572.588467037949;4679.64902632304;4707.952920470751;4739.170645137122;4801.399825021872;5265.420803711589;5301.54936830366;5320.414754377015;5327.094393953037;5333;5053.620978426559;5107;5110.977804439127;5127.9230811537855;5145.536901678867;4859.70841749489;4973.005398920231;5014;5204.0892843752945;5264.31563896691;5044.571211446994;5067.721275329893;5069.518395752398;5080.364954380702;5105.668131571436;4825.4933232010835;5013.523715247119;5022.573081288058;5024.32171656829;5026.271190677405;4093.488313960755;4184.644305234089;4211.347241177622;4280.229558679405;4306.935395969063;3733.4586484959527;3737.159139193714;3751.81240937952;3753.7560058596105;3766.37854753968;4208.642265407413;4317.481902171759;4445.1998640245065;4471;4500.819967201275;5023.6483446159145;5040.974795126001;5046.899062018739;5125.615578831603;5165.638405311592;4440.111977604492;4449.354843547732;4488.573585509372;4499.302608095751;4554.521775213621;4276.486821581368;4579.839705610288;4591.173588754056;4596.931046034312;4619.1685496610935;4700.942287985176;4709.340692303081;4743.217369134192;4750.07373562152;4879.634027448026;5144.536991670768;5150.742462876916;5156.61325400589;5172.586193104467;5198.209782402784;4874.293227482066;4877.170880950176;4882.438519570295;4901.485344038967;4940.2342636891335;4836.685615434985;4933.309336692794;4938.9259161111895;5001.824936127218;5013;5071.061853557104;5074.7716352764955;5075.3148324975655;5103.336566246364;5157.968406318826;4649;4926.088673595396;4937.474227060317;4946.233333833262;4954.281629163679;4800.3759511263315;4863.270509423473;4870.391201099863;4897.926531101965;4921.680090794087;4871.780769865435;4874.390701162355;4881.780319885685;4895.951040489692;4964.280179374043;4750.596199323097;5019.924701129559;5038.1183292924325;5047.697138171721;5078.771455284447;4740.336352910526;4749.691270067435;4835.540623640749;4853.902921941471;4895.975520122377 07:55:13 INFO - 2015-12-14 07:55:13,602 DEBUG : BROWSER_OUTPUT: |1;ext.html;575.6057100885894;580.9397848925709;581.1689284323421;582.0570675505681;583.4107551373113;35438.11404714883;36353.81823090881;36598;36655.63344366559;36689.44965825515;40799.184016319654;41290.793546032306;41515.79242103793;41600.37599436011;41692;7938.722144724936;8076.515409075474;8113.959430202841;8136.593170341489;8146.674133034671;7989.760307190764;8034.196580341948;8103;8104.230098140697;8107.878381824277;7986.121526632066;8098.190180981884;8105.1489593592705;8132.674693012273;8134.145914678962;8047.436679432442;8083.151269116746;8129.796755081111;8130.065042520067;8161.795955101111;7950.56271905045;8040.115587285394;8085.272325490675;8092.838143237162;8095.82610521477;36781.63218367835;37778.24443511142;37808.24383512315;37840.243195136216;37969.24061518782;2811.690714021456;2933.6332958380203;2939.6031535742827;2947.808392454505;3629.383004889175;27806;28036.43927121446;28350.29124271889;28448.431031379463;28669.426611467654;3537.0626783902285;3539.203679172191;3547.8048707321086;3551.5915669698056;3595.2070516030376;212239;213837.99999999846;214151;214348;214662;53408.73295633497;54562.45437545574;56126.15810762842;57709;59009.70495147497;50215.74892125516;50247.49752502501;50282;50373.49626503688;50381.49618503768;13642.727145457035;13653.453861845614;13714.314284285745;13776.24230667323;13938.860611393959;9523.619055237852;9529.047095290416;9580.712578622653;9611.086946740048;9649.807003859883;19467.90266048661;19554.413367598994;19731.506712332306;19991.800081999285;20009.399718008484;7521.435892307989;7696.692132314756;7705.345045671181;7811.960940195377;7888.723894663659;752.6011214056559;795.3756301303449;851.5614458553725;899.6851102114339;925.4123631493915;22761.886190569272;22962.42593935165;22964.540709185723;23033.309000730005;23257.7674223259;895.8969718482327;927.9304052195977;939.8825146856643;1026.3995562595817;1058.3226734889677;12341.321227332583;12400.75198496043;12503.686817938711;12518.74962500745;12622.242665439919;267359;274393;275683;276144;276705;46570.76714616405;46808;46901;46996.29505557419;47486.76256618764;1197.8083506638895;1209.7640960012889;1214.9331786751814;1225.8467691538378;1227.5580790915262;23856.88071559631;25776.226713198634;25940.8702956484;28427.857860710563;29211.85394073016;40821.79589102035;40987.38518922278;41396.586034139276;41397.586024139375;41426.585734142274;205491;207623;207963;208654;208798;28194.43611127725;29148.813838961738;29310.482742071086;29475.115746527637;29490;37166.814165929;37193.81403092967;38135.42796858105;38513.614863851006;38747.41878871763;32065;32175.839120804245;32184.678153218167;32791.836040819646;33189.834050830555;32759.67240327566;32824.50763238601;32906.17734556655;33054.834725826215;33432.1641958953;32791.37668986428;33345.166370840925;33416.49875251922;33505.49741753827;33840.49239261462;26401.4719705601;26998;27468.313292167855;27509;27515;23368.182113625942;23399.649005265273;23673.40816479602;23707.1702490412;23909.760902390753 07:55:13 INFO - 2015-12-14 07:55:13,604 DEBUG : BROWSER_OUTPUT: |2;jquery.html;321.511302819714;325.37852701340444;327.2620241355742;328.0924192863001;329.5238380540119;15643.608909777247;16119.91940040301;16148.677026459463;16573.50279491614;16658.333666653318;15369.231538423062;15409.229538523085;15445;15510.844891551082;15674.686506269867;4239.40648309237;4423.049044455442;4427.645788336926;4431.3131464622875;4433.758547606675;3747.906302342436;4332.718373305725;4358.237308471005;4376.452943382077;4831.637627177958;4740.691855029412;4756.262779269219;4880.316755654211;5016.097102521545;5042.621803364762;4822.831200907952;4880.145974454492;4895.9510404895855;4906.509349065101;4921.212605983043;5003.074431230234;5121.180611102243;5124.564412024983;5125.051865404912;5128.640995130342;18670.43988680342;18679.439616811516;18721.719174212398;19211.32760353381;19222.135003924857;1738.8087310395847;1751.5533538947614;1768.7877454705517;1786.499780061585;1807.7830660320715;8796.428232164888;8956.8656470153;9038.231750301233;9131.086891310882;12795.744085118338;1664.8335166483375;1699.5326285271526;1726.6633006563725;1770.3361239535175;1822.1618055694396;54497;55309;55800.72099639476;56635;57443.425565744226;9525.237980961645;9653.1794797443;9755.317127800985;9764.462954537426;9846.901530984598;12198.39008049594;12226.20529665569;12274.140810143204;12319.876801232052;12336.889679928849;6780.7287708492095;6810.965945170243;6828.7609933653075;6895.379415852597;6972.407345375598;6626.966865165643;6684.799456016327;6701.262861085277;6718;6734.8989765153565;4018.738781979162;4044.6157615026527;4066.796660167039;4077.531083925327;4078.3882417636996;1671.156066186568;1695.8473737363697;1706.240722878332;1721.5954250751063;1740.2516917725247;353.853150942356;359.06284597201284;362.03698162886593;387.2100914135133;391.19999600816396;8819.338549608805;9725.6596019139;9791.363561368487;9870;10011.149052330633;381.7823840410939;382.16115626200224;384.2008622066096;386.7254249482842;387.7712149831613;5343.839684809384;5344.893102138013;5385.434529374437;5432.022235997559;5443.564514838803;481518;482108;489645;490089;490105;61449.38550614526;72583.27416725871;72719.27280727231;72873.27126728665;74842.25157748353;1078.4338222433284;1080.4543705428707;1109.2734259060328;1136.8063533290012;1140.7832511822728;14351.787522083374;14379.568612941628;14493.7825932609;14524.564263072125;14803.629909252355;29794;31496.212594685316;32271.67728322687;32536.186595335304;33611.83194084014;36276;37128.44307335338;40938.385924211754;41841.58158418377;42697.78651106849;8596.183362580545;8740.868886966828;8928.642854285756;8930.330225233003;8953.104689530996;10359.533820977924;10436.217283703601;10526;16620.750688739437;16659.16704164811;13135.211887286794;13523.59429217125;13878.653033674238;13896.444142234197;13999.860001399855;12768.233905965672;13880.861191387958;14124.576262712135;14372.425102995763;14471.059381140192;14546.199959002357;14650.194239316514;15038.624034399227;15045.774313385089;15090.396384144951;8666.176713212235;8734.21392074691;8802.515861627417;8839.425437346552;8954.955225223832;9473.384230025027;9651.71044868655;14028.368723407675;14094.647633809236;14194.503192388216 07:55:13 INFO - 2015-12-14 07:55:13,604 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1372.101273665749;1430.0847457627117;1530.502586659336;1598.8800839937007;1688.2149800342845;6094.055421409688;6242.406971337727;7054.611996340205;7201.315874991874;7242.601656908868;6514.576552524082;6581.868362632745;6620.702068406921;6624.039514270428;6682.164729408824;1917.1085445267913;1946.7177259297393;1968.9310874119408;1969.8719583227044;1973.0825166297668;2050.4361300642367;2069.8758074515504;2074.52285974226;2086.9791302086937;2093.5708179823177;2068.265765653194;2073.813356797888;2075.180303780006;2085.6662933930575;2092.780258072903;2012.748406449194;2024.8987550622483;2033.1664017752723;2034.5727397246596;2039.2964427272568;2004.4487765864358;2049.5695903860205;2049.928252511155;2062.979370206294;2070.440980935139;6994.6152961587095;7071.858562828715;7085.964570177116;7093.929060709378;7101.680424380864;4132.793360331972;4186.434831297766;4198.9370159447635;4203.4115223868685;4220.155968806251;2568.691756989155;2599.3891435512637;2609.8173127881055;2630.040035387089;2636.5781474963915;846.0608724316004;869.2437579306044;874.4709450782312;892.205936716323;906.6083561732709;9242.168204861595;9267.814643707155;9268.536573171314;9286.907130928672;9312.068793120701;3781.149241420658;3813.389857622767;3859.710521710827;3877.96122038776;3879.941800872989;8053.798655033671;8065.798355041054;8076.232757888109;8077.35381169505;8085.151059138823;4148.460700108966;4155.771432571177;4174.833006679699;4194.706370554093;4221.176870510282;3689.1330537323706;3796.8481260749813;3812.7521711089244;3823.25446537928;3824.7513911595656;3194.1535493094348;3206.3587282543117;3242.4649932761304;3245.7078862902454;3249.415105281025;972.3922548407245;977.022977022977;978.4276198424002;978.6232300564192;979.9657012004545;984.2519685039279;987.683941138843;999.7700528878253;1006.3961623026125;1083.5990683447017;6472.611643301417;6474.741010359627;6478.060681201199;6484.902726459107;6499.675016249169;406.179517374901;409.5351775734503;432.8961049348197;434.092746160526;435.31872619350617;4971.676841005323;4974.726390048582;4981.476944920803;4984.27727979441;5032.899342013139;7852.450328477066;8069.677212911535;8114.391420643476;8175.100738918714;8234;8045.396595255379;8058.677652893819;8076.152004039492;8124.2688158064875;8156.510609363457;6422.903656445157;6467.417932386108;6517.120188774549;6581.638009909501;6647.368499992493;6646.667666616553;6681.465482761465;6692.330766923269;6714.7314107437105;6749.5612785168805;7343.77968660941;7410.703571857065;7493.475456717977;7564.903089052166;7596.582187979714;7585.962070189835;7667.501612395399;7874.094479134744;7885.329746971572;7887.369010479033;5313.362396512443;5415.241866138665;6053;6110.388961104032;6125.387461253839;6399.360063993563;6457.321981191907;6461.935380646133;6509.511786615928;6566.80299591013;6180.7527698891545;6204.441600255998;6246.875062498633;6439.549231553746;6491.935080649133;6069.2716873975405;6073.423024812636;6077.27072751255;6156.199694039746;6179.011358182669;6288.213973253343;6323.08315294289;6328.968355158195;6336.7148478319505;6339.302676705651;5815.447532484407;5836.912446313394;5850.853728656818;5851.356350801493;5862.794802181903;5546.694931778629;5737.91393129095;5769.221155144001;5872.500837428866;5894.793682221101 07:55:13 INFO - 2015-12-14 07:55:13,605 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.8453219793509;299.69580875411464;300.5836915871518;304.3805855084901;306.4851050235603;5509.201165830952;5522.30971128609;5598.664080155194;5612.158176273561;5645.2096706461125;5539.639923404986;5547.278853749017;5552.4169962154;5554.055810512213;5563.193336966137;4070.7354021988476;4265.509466411356;4270.188664153817;4270.871873843789;4274.230638485079;4166.749995000295;4169.541350451448;4181.142865712537;4181.832726690929;4182.100848317611;4134.855280065199;4141.088960428716;4141.7514949103;4146.3780432935155;4150.460440142777;4174.686898482611;4176.1230141670285;4184.4141820145205;4190.769507677077;4193.993441574031;3640.490331353586;3650.689691376236;3653.4702468142236;3654.3056819204267;3655.7258205634685;5211.765470553834;5242.082635538765;5309.946900530984;5381.112116500812;5402.189671549259;4800.879978000543;4803.7357945313;4811.374521312242;4814.951850481485;4822.975885120587;5813.418658134153;5827.592068555203;5840.123981402781;5845.1232315153065;5849.444302791228;3869.8839034829;3935.5080614923136;3940.349842276021;3943.250782351373;3952.3873799561115;6042.57701960863;6136.693165341715;6143.293521245069;6144.600600960968;6152.292486364081;4038.5557588665224;4039.3940908863906;4039.818208180639;4041.6362527372676;4054.189162167578;4100.815463304159;4109.773962432035;4110.198511290329;4110.568390319033;4114.814833332447;4779.996200797871;4780.1873681474235;4780.689255198401;4787.353707249476;4791.688540244873;5585.385607583163;5781.248437703071;5806.44838740319;5809.767609295581;5818.80714453536;1439.604108870048;1466.8166479190102;1468.3392473386805;1469.162577330911;1473.8378778334375;961.3126614470686;962.629387685746;974.8294048541619;977.4184360305607;979.6081567373108;5066.620003499752;5097.770600322994;5109.4379618241965;5114.9232761507865;5116.232565115262;6017.729202185912;6073.665948372882;6074.939250607437;6078.574499785061;6087.269527656709;5046.142155833517;5084.186530155157;5091.1854103343285;5100.183970564692;5106.387233531926;3197.7281931036123;3249.1064957136505;3275.3776782411264;3278.9344213115605;3286.4577344738327;5700.743466544015;5702.8289151325525;5708.686022268815;5711.086226203787;5713.800016999385;6012.639241645428;6139.47814435769;6168.660723660152;6265.906011409833;6325.746970121144;5703.230063941315;5724.856878578069;5725.971370143123;5727.255456790591;5750.884982300414;6024.578279520391;6046.365131661289;6089.695515224133;6094.146819445193;6120.693965301806;5731.8567035824435;5893;5920.940790592212;5960.940390596039;5969.373215812451;5752;5752.6836024019085;5765.279340082489;5766.3368712598585;5777.91333129995;4028.3151864183747;4066.837326507025;4076.470058892325;4077.9796101019306;4086.9795651021554;5975.850603734942;6105.633661980295;6113.816585502442;6116.35778243278;6128.540359472968;5846.239988801429;5850.882982340415;5851.531877449879;5852.209951656472;5859.20900678403;5784.913226301524;5811.854703632443;5815.79644712433;5826;5848.970755146197;5584.162375643686;5666;5704.686242256716;5710;5718.571107167062;5849.766009359578;5905.4685078343155;5913.881722365614;5934.881302373842;5941.702914854326;5748.195252664714;5775;5786.739596718242;5792;5799.681017544076 07:55:13 INFO - 2015-12-14 07:55:13,606 DEBUG : BROWSER_OUTPUT: |5;yui.html;643.2763141465849;715.0775499605509;752.5033477904584;759.7181019924028;765.1353970013884;10802;11334.149938754606;11403.828942565868;11428.200025998183;11431.828522572168;11345.773084538305;11436.656900293005;11441.485133169006;11444.542218311279;11485.483153258103;787.1695361393728;793.1275596843469;808.7331180710352;809.017044291186;810.6878851642101;815.2988429950238;817.3134566963749;819.4223072733738;822.0341099208437;822.6709316273509;859.0250066174905;861.6381119929613;864.3301441382915;865.9480431174118;867.535868310454;848.8344772769312;850.808568072185;852.0457088061349;853.1255463150289;858.2318824651933;628.0516420205477;634.2674211285972;634.9904751428733;635.8315046512678;639.2041907824741;12230;12300.507979680802;12363.134580579363;12425.31660758658;12444;10726.517306721216;10998.450077496092;11014.669559913216;11058.557657693682;12066.758664826742;9400.717978460658;9607.423554586678;9619.56711947964;9619.615215391375;9679.564419601134;3312.1719570107475;3354.480055591387;3360.075979105741;3379.6620337966006;3393.830308484566;40049.39925901114;40198.79900600507;40566;40701.796491017354;40710;9274.21169200612;9320.580573874191;9441.716748497556;9446.95276523613;9478.289128315404;15913.283902224428;15944.681106378039;15950.680986380208;15972.121533315547;15980.360785568679;6439.452646525097;6583.967080164569;6661.367170118831;6719.966400167968;6766.966165169143;3553.182767963331;3649.9635003650155;3654.689351405107;3677.7793332400142;3713.8885833425043;2602.921912342595;2609.1389841352307;2609.8695065247043;2609.9217023488945;2626.7241939596065;461.69528111446283;464.2525533890434;467.96256299495957;469.16020323620336;474.01168563544707;440.6518850108379;517.5419753518164;562.7945799783132;565.3103214078817;592.5407808948014;7039.472039597051;7129.607871567114;7210.206877243499;7235.095613048369;7305.780826575211;463.2610985478157;513.3147248423396;568.7184843502492;576.6568891509545;578.2973686970352;3481.234128491728;3537.8231088445473;3570.9285814283567;3611.656892595199;3707.443883417509;49179.50820491821;49257.014859702605;49278.50721492811;49291.507084929406;49293;44876.77561612171;45219.09561808746;45236;45350;45468;39828.2034359317;40317.39523907144;41069.589304107176;41187.58812411898;42077.15845683069;7796.181400953045;7818.257265559762;8033.1565185657;8085.151059138941;8201.42590018693;30530.542041869834;30881.845590771904;30887.845560772952;31125.377492450476;31239.219019524695;38100.428493572064;38363.80818095891;38560.03599910025;39036.414453783786;39459;10052.597896084075;10198.18414526851;10256.58973641046;10566.154707623526;10631.149508039183;11424.543018279175;11488.310701357945;11647.30116193031;12183.086268529718;12311.384430778604;9477.194438472807;9515.524223788922;9571.234301255743;9582.568784404857;9658.806823863342;10659.680209593724;10857.945710271399;11176.832347514632;11225.214235003798;11332.263402878787;10615.681529554126;10654.946725266323;10881.836772448261;10973.945130274298;11086.944565277123;8521;8810.515421651871;8908.10918908104;9053.094690531158;9409.905900940903;8079.919200807916;8654.610542525475;8656.567171641267;8730.345224108345;8832.29341652679 07:55:13 INFO - 2015-12-14 07:55:13,606 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:55:13 INFO - 2015-12-14 07:55:13,606 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:55:13 INFO - 2015-12-14 07:55:13,606 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,322 07:55:13 INFO - 2015-12-14 07:55:13,607 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:55:13 INFO - 2015-12-14 07:55:13,607 DEBUG : BROWSER_OUTPUT: __startTimestamp1450108513598__endTimestamp 07:55:13 INFO - 2015-12-14 07:55:13,607 DEBUG : BROWSER_OUTPUT: 07:55:13 INFO - 2015-12-14 07:55:13,607 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:55:13 INFO - 2015-12-14 07:55:13,607 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:55:13 INFO - 2015-12-14 07:55:13,607 DEBUG : BROWSER_OUTPUT: 07:55:13 INFO - 2015-12-14 07:55:13,607 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4702.42 Median:4835.54 stddev:496.77 (10.3%) stddev-sans-first:471.01 07:55:13 INFO - 2015-12-14 07:55:13,608 DEBUG : BROWSER_OUTPUT: Values: 2632.4 2699.5 2725.7 2725.8 2749.7 4603.8 4834.1 4844.8 4865.2 4894.1 4683.4 4716.9 4736.7 4810.0 4821.3 4224.7 4313.5 4351.0 4397.9 4412.9 4421.1 4458.5 4468.6 4482.3 4529.1 4176.0 4280.8 4476.2 4495.3 4509.0 4306.9 4395.9 4397.9 4423.9 4427.7 4340.6 4361.3 4365.4 4369.9 4427.2 4436.1 4613.4 4651.8 4695.8 4722.9 5103.9 5127.9 5134.1 5144.6 5169.6 5158.4 5178.9 5183.7 5193.5 5226.1 4572.6 4679.6 4708.0 4739.2 4801.4 5265.4 5301.5 5320.4 5327.1 5333.0 5053.6 5107.0 5111.0 5127.9 5145.5 4859.7 4973.0 5014.0 5204.1 5264.3 5044.6 5067.7 5069.5 5080.4 5105.7 4825.5 5013.5 5022.6 5024.3 5026.3 4093.5 4184.6 4211.3 4280.2 4306.9 3733.5 3737.2 3751.8 3753.8 3766.4 4208.6 4317.5 4445.2 4471.0 4500.8 5023.6 5041.0 5046.9 5125.6 5165.6 4440.1 4449.4 4488.6 4499.3 4554.5 4276.5 4579.8 4591.2 4596.9 4619.2 4700.9 4709.3 4743.2 4750.1 4879.6 5144.5 5150.7 5156.6 5172.6 5198.2 4874.3 4877.2 4882.4 4901.5 4940.2 4836.7 4933.3 4938.9 5001.8 5013.0 5071.1 5074.8 5075.3 5103.3 5158.0 4649.0 4926.1 4937.5 4946.2 4954.3 4800.4 4863.3 4870.4 4897.9 4921.7 4871.8 4874.4 4881.8 4896.0 4964.3 4750.6 5019.9 5038.1 5047.7 5078.8 4740.3 4749.7 4835.5 4853.9 4896.0 07:55:13 INFO - 2015-12-14 07:55:13,608 DEBUG : BROWSER_OUTPUT: 07:55:13 INFO - 2015-12-14 07:55:13,608 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39281.00 Median:3573.40 stddev:60862.19 (1703.2%) stddev-sans-first:60963.54 07:55:13 INFO - 2015-12-14 07:55:13,608 DEBUG : BROWSER_OUTPUT: Values: 575.6 580.9 581.2 582.1 583.4 35438.1 36353.8 36598.0 36655.6 36689.4 40799.2 41290.8 41515.8 41600.4 41692.0 7938.7 8076.5 8114.0 8136.6 8146.7 7989.8 8034.2 8103.0 8104.2 8107.9 7986.1 8098.2 8105.1 8132.7 8134.1 8047.4 8083.2 8129.8 8130.1 8161.8 7950.6 8040.1 8085.3 8092.8 8095.8 36781.6 37778.2 37808.2 37840.2 37969.2 2811.7 2933.6 2939.6 2947.8 3629.4 27806.0 28036.4 28350.3 28448.4 28669.4 3537.1 3539.2 3547.8 3551.6 3595.2 212239.0 213838.0 214151.0 214348.0 214662.0 53408.7 54562.5 56126.2 57709.0 59009.7 50215.7 50247.5 50282.0 50373.5 50381.5 13642.7 13653.5 13714.3 13776.2 13938.9 9523.6 9529.0 9580.7 9611.1 9649.8 19467.9 19554.4 19731.5 19991.8 20009.4 7521.4 7696.7 7705.3 7812.0 7888.7 752.6 795.4 851.6 899.7 925.4 22761.9 22962.4 22964.5 23033.3 23257.8 895.9 927.9 939.9 1026.4 1058.3 12341.3 12400.8 12503.7 12518.7 12622.2 267359.0 274393.0 275683.0 276144.0 276705.0 46570.8 46808.0 46901.0 46996.3 47486.8 1197.8 1209.8 1214.9 1225.8 1227.6 23856.9 25776.2 25940.9 28427.9 29211.9 40821.8 40987.4 41396.6 41397.6 41426.6 205491.0 207623.0 207963.0 208654.0 208798.0 28194.4 29148.8 29310.5 29475.1 29490.0 37166.8 37193.8 38135.4 38513.6 38747.4 32065.0 32175.8 32184.7 32791.8 33189.8 32759.7 32824.5 32906.2 33054.8 33432.2 32791.4 33345.2 33416.5 33505.5 33840.5 26401.5 26998.0 27468.3 27509.0 27515.0 23368.2 23399.6 23673.4 23707.2 23909.8 07:55:13 INFO - 2015-12-14 07:55:13,608 DEBUG : BROWSER_OUTPUT: 07:55:13 INFO - 2015-12-14 07:55:13,608 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25862.52 Median:387.49 stddev:79533.07 (20525.2%) stddev-sans-first:79733.06 07:55:13 INFO - 2015-12-14 07:55:13,609 DEBUG : BROWSER_OUTPUT: Values: 321.5 325.4 327.3 328.1 329.5 15643.6 16119.9 16148.7 16573.5 16658.3 15369.2 15409.2 15445.0 15510.8 15674.7 4239.4 4423.0 4427.6 4431.3 4433.8 3747.9 4332.7 4358.2 4376.5 4831.6 4740.7 4756.3 4880.3 5016.1 5042.6 4822.8 4880.1 4896.0 4906.5 4921.2 5003.1 5121.2 5124.6 5125.1 5128.6 18670.4 18679.4 18721.7 19211.3 19222.1 1738.8 1751.6 1768.8 1786.5 1807.8 8796.4 8956.9 9038.2 9131.1 12795.7 1664.8 1699.5 1726.7 1770.3 1822.2 54497.0 55309.0 55800.7 56635.0 57443.4 9525.2 9653.2 9755.3 9764.5 9846.9 12198.4 12226.2 12274.1 12319.9 12336.9 6780.7 6811.0 6828.8 6895.4 6972.4 6627.0 6684.8 6701.3 6718.0 6734.9 4018.7 4044.6 4066.8 4077.5 4078.4 1671.2 1695.8 1706.2 1721.6 1740.3 353.9 359.1 362.0 387.2 391.2 8819.3 9725.7 9791.4 9870.0 10011.1 381.8 382.2 384.2 386.7 387.8 5343.8 5344.9 5385.4 5432.0 5443.6 481518.0 482108.0 489645.0 490089.0 490105.0 61449.4 72583.3 72719.3 72873.3 74842.3 1078.4 1080.5 1109.3 1136.8 1140.8 14351.8 14379.6 14493.8 14524.6 14803.6 29794.0 31496.2 32271.7 32536.2 33611.8 36276.0 37128.4 40938.4 41841.6 42697.8 8596.2 8740.9 8928.6 8930.3 8953.1 10359.5 10436.2 10526.0 16620.8 16659.2 13135.2 13523.6 13878.7 13896.4 13999.9 12768.2 13880.9 14124.6 14372.4 14471.1 14546.2 14650.2 15038.6 15045.8 15090.4 8666.2 8734.2 8802.5 8839.4 8955.0 9473.4 9651.7 14028.4 14094.6 14194.5 07:55:13 INFO - 2015-12-14 07:55:13,609 DEBUG : BROWSER_OUTPUT: 07:55:13 INFO - 2015-12-14 07:55:13,610 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4816.68 Median:6140.79 stddev:2508.20 (40.8%) stddev-sans-first:2501.88 07:55:13 INFO - 2015-12-14 07:55:13,610 DEBUG : BROWSER_OUTPUT: Values: 1372.1 1430.1 1530.5 1598.9 1688.2 6094.1 6242.4 7054.6 7201.3 7242.6 6514.6 6581.9 6620.7 6624.0 6682.2 1917.1 1946.7 1968.9 1969.9 1973.1 2050.4 2069.9 2074.5 2087.0 2093.6 2068.3 2073.8 2075.2 2085.7 2092.8 2012.7 2024.9 2033.2 2034.6 2039.3 2004.4 2049.6 2049.9 2063.0 2070.4 6994.6 7071.9 7086.0 7093.9 7101.7 4132.8 4186.4 4198.9 4203.4 4220.2 2568.7 2599.4 2609.8 2630.0 2636.6 846.1 869.2 874.5 892.2 906.6 9242.2 9267.8 9268.5 9286.9 9312.1 3781.1 3813.4 3859.7 3878.0 3879.9 8053.8 8065.8 8076.2 8077.4 8085.2 4148.5 4155.8 4174.8 4194.7 4221.2 3689.1 3796.8 3812.8 3823.3 3824.8 3194.2 3206.4 3242.5 3245.7 3249.4 972.4 977.0 978.4 978.6 980.0 984.3 987.7 999.8 1006.4 1083.6 6472.6 6474.7 6478.1 6484.9 6499.7 406.2 409.5 432.9 434.1 435.3 4971.7 4974.7 4981.5 4984.3 5032.9 7852.5 8069.7 8114.4 8175.1 8234.0 8045.4 8058.7 8076.2 8124.3 8156.5 6422.9 6467.4 6517.1 6581.6 6647.4 6646.7 6681.5 6692.3 6714.7 6749.6 7343.8 7410.7 7493.5 7564.9 7596.6 7586.0 7667.5 7874.1 7885.3 7887.4 5313.4 5415.2 6053.0 6110.4 6125.4 6399.4 6457.3 6461.9 6509.5 6566.8 6180.8 6204.4 6246.9 6439.5 6491.9 6069.3 6073.4 6077.3 6156.2 6179.0 6288.2 6323.1 6329.0 6336.7 6339.3 5815.4 5836.9 5850.9 5851.4 5862.8 5546.7 5737.9 5769.2 5872.5 5894.8 07:55:13 INFO - 2015-12-14 07:55:13,610 DEBUG : BROWSER_OUTPUT: 07:55:13 INFO - 2015-12-14 07:55:13,610 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4805.65 Median:5558.62 stddev:1444.71 (26.0%) stddev-sans-first:1408.48 07:55:13 INFO - 2015-12-14 07:55:13,611 DEBUG : BROWSER_OUTPUT: Values: 291.8 299.7 300.6 304.4 306.5 5509.2 5522.3 5598.7 5612.2 5645.2 5539.6 5547.3 5552.4 5554.1 5563.2 4070.7 4265.5 4270.2 4270.9 4274.2 4166.7 4169.5 4181.1 4181.8 4182.1 4134.9 4141.1 4141.8 4146.4 4150.5 4174.7 4176.1 4184.4 4190.8 4194.0 3640.5 3650.7 3653.5 3654.3 3655.7 5211.8 5242.1 5309.9 5381.1 5402.2 4800.9 4803.7 4811.4 4815.0 4823.0 5813.4 5827.6 5840.1 5845.1 5849.4 3869.9 3935.5 3940.3 3943.3 3952.4 6042.6 6136.7 6143.3 6144.6 6152.3 4038.6 4039.4 4039.8 4041.6 4054.2 4100.8 4109.8 4110.2 4110.6 4114.8 4780.0 4780.2 4780.7 4787.4 4791.7 5585.4 5781.2 5806.4 5809.8 5818.8 1439.6 1466.8 1468.3 1469.2 1473.8 961.3 962.6 974.8 977.4 979.6 5066.6 5097.8 5109.4 5114.9 5116.2 6017.7 6073.7 6074.9 6078.6 6087.3 5046.1 5084.2 5091.2 5100.2 5106.4 3197.7 3249.1 3275.4 3278.9 3286.5 5700.7 5702.8 5708.7 5711.1 5713.8 6012.6 6139.5 6168.7 6265.9 6325.7 5703.2 5724.9 5726.0 5727.3 5750.9 6024.6 6046.4 6089.7 6094.1 6120.7 5731.9 5893.0 5920.9 5960.9 5969.4 5752.0 5752.7 5765.3 5766.3 5777.9 4028.3 4066.8 4076.5 4078.0 4087.0 5975.9 6105.6 6113.8 6116.4 6128.5 5846.2 5850.9 5851.5 5852.2 5859.2 5784.9 5811.9 5815.8 5826.0 5849.0 5584.2 5666.0 5704.7 5710.0 5718.6 5849.8 5905.5 5913.9 5934.9 5941.7 5748.2 5775.0 5786.7 5792.0 5799.7 07:55:13 INFO - 2015-12-14 07:55:13,611 DEBUG : BROWSER_OUTPUT: 07:55:13 INFO - 2015-12-14 07:55:13,611 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12195.07 Median:22964.85 stddev:13774.58 (60.0%) stddev-sans-first:13785.91 07:55:13 INFO - 2015-12-14 07:55:13,613 DEBUG : BROWSER_OUTPUT: Values: 643.3 715.1 752.5 759.7 765.1 10802.0 11334.1 11403.8 11428.2 11431.8 11345.8 11436.7 11441.5 11444.5 11485.5 787.2 793.1 808.7 809.0 810.7 815.3 817.3 819.4 822.0 822.7 859.0 861.6 864.3 865.9 867.5 848.8 850.8 852.0 853.1 858.2 628.1 634.3 635.0 635.8 639.2 12230.0 12300.5 12363.1 12425.3 12444.0 10726.5 10998.5 11014.7 11058.6 12066.8 9400.7 9607.4 9619.6 9619.6 9679.6 3312.2 3354.5 3360.1 3379.7 3393.8 40049.4 40198.8 40566.0 40701.8 40710.0 9274.2 9320.6 9441.7 9447.0 9478.3 15913.3 15944.7 15950.7 15972.1 15980.4 6439.5 6584.0 6661.4 6720.0 6767.0 3553.2 3650.0 3654.7 3677.8 3713.9 2602.9 2609.1 2609.9 2609.9 2626.7 461.7 464.3 468.0 469.2 474.0 440.7 517.5 562.8 565.3 592.5 7039.5 7129.6 7210.2 7235.1 7305.8 463.3 513.3 568.7 576.7 578.3 3481.2 3537.8 3570.9 3611.7 3707.4 49179.5 49257.0 49278.5 49291.5 49293.0 44876.8 45219.1 45236.0 45350.0 45468.0 39828.2 40317.4 41069.6 41187.6 42077.2 7796.2 7818.3 8033.2 8085.2 8201.4 30530.5 30881.8 30887.8 31125.4 31239.2 38100.4 38363.8 38560.0 39036.4 39459.0 10052.6 10198.2 10256.6 10566.2 10631.1 11424.5 11488.3 11647.3 12183.1 12311.4 9477.2 9515.5 9571.2 9582.6 9658.8 10659.7 10857.9 11176.8 11225.2 11332.3 10615.7 10654.9 10881.8 10973.9 11086.9 8521.0 8810.5 8908.1 9053.1 9409.9 8079.9 8654.6 8656.6 8730.3 8832.3 07:55:13 INFO - 2015-12-14 07:55:13,613 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:55:13 INFO - 2015-12-14 07:55:13,613 DEBUG : BROWSER_OUTPUT: 07:55:14 INFO - 2015-12-14 07:55:14,218 INFO : Browser exited with error code: 0 07:55:14 INFO - 2015-12-14 07:55:14,234 INFO : Completed test dromaeo_css (00:18:36) 07:55:14 INFO - 2015-12-14 07:55:14,234 INFO : Starting test kraken 07:55:14 INFO - 2015-12-14 07:55:14,234 DEBUG : operating with platform_type : linux_ 07:55:14 INFO - 2015-12-14 07:55:14,234 INFO : Initialising browser for kraken test... 07:55:14 INFO - 2015-12-14 07:55:14,240 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBx28YE/profile http://localhost:47262/getInfo.html 07:55:18 INFO - 2015-12-14 07:55:18,581 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:55:18 INFO - 2015-12-14 07:55:18,582 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:55:18 INFO - 2015-12-14 07:55:18,582 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:55:18 INFO - 2015-12-14 07:55:18,582 DEBUG : BROWSER_OUTPUT: __metrics 07:55:18 INFO - 2015-12-14 07:55:18,699 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:55:19 INFO - 2015-12-14 07:55:19,605 INFO : Browser initialized. 07:55:19 INFO - 2015-12-14 07:55:19,606 INFO : Running cycle 1/1 for kraken test... 07:55:19 INFO - 2015-12-14 07:55:19,606 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBx28YE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:55:31 INFO - 2015-12-14 07:55:31,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 143826944 07:55:31 INFO - 2015-12-14 07:55:31,631 DEBUG : BROWSER_OUTPUT: 07:55:34 INFO - 2015-12-14 07:55:34,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47262/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:34 INFO - 2015-12-14 07:55:34,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 143290368 07:55:34 INFO - 2015-12-14 07:55:34,866 DEBUG : BROWSER_OUTPUT: 07:55:37 INFO - 2015-12-14 07:55:37,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47262/tests/kraken/driver.html?testName=audio-dft) 07:55:38 INFO - 2015-12-14 07:55:38,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 141836288 07:55:38 INFO - 2015-12-14 07:55:38,191 DEBUG : BROWSER_OUTPUT: 07:55:41 INFO - 2015-12-14 07:55:41,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47262/tests/kraken/driver.html?testName=audio-fft) 07:55:41 INFO - 2015-12-14 07:55:41,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 138412032 07:55:41 INFO - 2015-12-14 07:55:41,689 DEBUG : BROWSER_OUTPUT: 07:55:43 INFO - 2015-12-14 07:55:43,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47262/tests/kraken/driver.html?testName=audio-oscillator) 07:55:44 INFO - 2015-12-14 07:55:44,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 139599872 07:55:44 INFO - 2015-12-14 07:55:44,394 DEBUG : BROWSER_OUTPUT: 07:55:46 INFO - 2015-12-14 07:55:46,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:55:47 INFO - 2015-12-14 07:55:47,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 140795904 07:55:47 INFO - 2015-12-14 07:55:47,261 DEBUG : BROWSER_OUTPUT: 07:55:50 INFO - 2015-12-14 07:55:50,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47262/tests/kraken/driver.html?testName=imaging-darkroom) 07:55:50 INFO - 2015-12-14 07:55:50,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 140849152 07:55:50 INFO - 2015-12-14 07:55:50,909 DEBUG : BROWSER_OUTPUT: 07:55:54 INFO - 2015-12-14 07:55:54,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47262/tests/kraken/driver.html?testName=imaging-desaturate) 07:55:54 INFO - 2015-12-14 07:55:54,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 141254656 07:55:54 INFO - 2015-12-14 07:55:54,966 DEBUG : BROWSER_OUTPUT: 07:55:57 INFO - 2015-12-14 07:55:57,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47262/tests/kraken/driver.html?testName=json-parse-financial) 07:55:58 INFO - 2015-12-14 07:55:58,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 141926400 07:55:58 INFO - 2015-12-14 07:55:58,457 DEBUG : BROWSER_OUTPUT: 07:56:00 INFO - 2015-12-14 07:56:00,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:00 INFO - 2015-12-14 07:56:00,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 142561280 07:56:00 INFO - 2015-12-14 07:56:00,824 DEBUG : BROWSER_OUTPUT: 07:56:02 INFO - 2015-12-14 07:56:02,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47262/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:03 INFO - 2015-12-14 07:56:03,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 142020608 07:56:03 INFO - 2015-12-14 07:56:03,345 DEBUG : BROWSER_OUTPUT: 07:56:05 INFO - 2015-12-14 07:56:05,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:06 INFO - 2015-12-14 07:56:06,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 142012416 07:56:06 INFO - 2015-12-14 07:56:06,104 DEBUG : BROWSER_OUTPUT: 07:56:08 INFO - 2015-12-14 07:56:08,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:09 INFO - 2015-12-14 07:56:09,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 142614528 07:56:09 INFO - 2015-12-14 07:56:09,312 DEBUG : BROWSER_OUTPUT: 07:56:11 INFO - 2015-12-14 07:56:11,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:12 INFO - 2015-12-14 07:56:12,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 141451264 07:56:12 INFO - 2015-12-14 07:56:12,590 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47262/tests/kraken/driver.html?testName=ai-astar) 07:56:14 INFO - 2015-12-14 07:56:14,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 141697024 07:56:14 INFO - 2015-12-14 07:56:14,645 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,645 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:56:14 INFO - 2015-12-14 07:56:14,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:56:14 INFO - 2015-12-14 07:56:14,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;108;113;115;115;124;112;113;114;115 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;135;152;160;132;155;158;136;167;133 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;161;161;170;165;172;168;162;163;162 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;71;72;75;72;144;72;72;72 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;138;96;95;96;141;95;95;139 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;111;112;111;111;111;110;111;110;109 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;149;152;147;147;147;147;147;147;147 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;96;96;96;96;96;96 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;74;74;76;75;75;74;74;72 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;68;70;70;70;69 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;85;87;86;95;85;95;86;86 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;126;140;121;133;132;129;136;124;128 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;158;161;155;154;149;152;153;167;141 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;73;74;71;72;74;70;74;70;71 07:56:14 INFO - 2015-12-14 07:56:14,646 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:56:14 INFO - 2015-12-14 07:56:14,647 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:56:14 INFO - 2015-12-14 07:56:14,647 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,780 07:56:14 INFO - 2015-12-14 07:56:14,647 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:56:14 INFO - 2015-12-14 07:56:14,647 DEBUG : BROWSER_OUTPUT: __startTimestamp1450108574640__endTimestamp 07:56:14 INFO - 2015-12-14 07:56:14,647 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,648 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:56:14 INFO - 2015-12-14 07:56:14,648 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:56:14 INFO - 2015-12-14 07:56:14,648 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,648 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:4.01 (3.5%) stddev-sans-first:4.24 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: Values: 115.0 108.0 113.0 115.0 115.0 124.0 112.0 113.0 114.0 115.0 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.00 Median:156.50 stddev:13.54 (8.7%) stddev-sans-first:13.52 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: Values: 162.0 135.0 152.0 160.0 132.0 155.0 158.0 136.0 167.0 133.0 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.91 (2.4%) stddev-sans-first:4.14 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: Values: 164.0 161.0 161.0 170.0 165.0 172.0 168.0 162.0 163.0 162.0 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:72.00 stddev:22.66 (31.5%) stddev-sans-first:23.86 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 71.0 72.0 75.0 72.0 144.0 72.0 72.0 72.0 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.30 Median:95.00 stddev:21.44 (22.6%) stddev-sans-first:22.10 07:56:14 INFO - 2015-12-14 07:56:14,649 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 138.0 96.0 95.0 96.0 141.0 95.0 95.0 139.0 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:111.00 stddev:0.97 (0.9%) stddev-sans-first:0.87 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 112.0 111.0 111.0 111.0 110.0 111.0 110.0 109.0 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:1.64 (1.1%) stddev-sans-first:1.72 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: Values: 147.0 149.0 152.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,650 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.10 Median:74.00 stddev:1.10 (1.5%) stddev-sans-first:1.17 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 74.0 74.0 76.0 75.0 75.0 74.0 74.0 72.0 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 68.0 70.0 70.0 70.0 69.0 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.00 stddev:4.19 (4.9%) stddev-sans-first:4.15 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 85.0 87.0 86.0 95.0 85.0 95.0 86.0 86.0 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:130.50 stddev:6.78 (5.2%) stddev-sans-first:5.99 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: Values: 118.0 126.0 140.0 121.0 133.0 132.0 129.0 136.0 124.0 128.0 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,651 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:154.50 stddev:8.30 (5.4%) stddev-sans-first:7.35 07:56:14 INFO - 2015-12-14 07:56:14,652 DEBUG : BROWSER_OUTPUT: Values: 140.0 158.0 161.0 155.0 154.0 149.0 152.0 153.0 167.0 141.0 07:56:14 INFO - 2015-12-14 07:56:14,652 DEBUG : BROWSER_OUTPUT: 07:56:14 INFO - 2015-12-14 07:56:14,652 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:73.00 stddev:1.62 (2.2%) stddev-sans-first:1.69 07:56:14 INFO - 2015-12-14 07:56:14,652 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 74.0 71.0 72.0 74.0 70.0 74.0 70.0 71.0 07:56:14 INFO - 2015-12-14 07:56:14,652 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:56:14 INFO - 2015-12-14 07:56:14,652 DEBUG : BROWSER_OUTPUT: 07:56:15 INFO - 2015-12-14 07:56:15,546 INFO : Browser exited with error code: 0 07:56:15 INFO - 2015-12-14 07:56:15,594 INFO : Completed test kraken (00:01:01) 07:56:15 INFO - 2015-12-14 07:56:15,594 INFO : Starting test v8_7 07:56:15 INFO - 2015-12-14 07:56:15,594 DEBUG : operating with platform_type : linux_ 07:56:15 INFO - 2015-12-14 07:56:15,594 INFO : Initialising browser for v8_7 test... 07:56:15 INFO - 2015-12-14 07:56:15,600 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWZ0WkH/profile http://localhost:47262/getInfo.html 07:56:19 INFO - 2015-12-14 07:56:19,896 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:56:19 INFO - 2015-12-14 07:56:19,897 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:56:19 INFO - 2015-12-14 07:56:19,897 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:56:19 INFO - 2015-12-14 07:56:19,897 DEBUG : BROWSER_OUTPUT: __metrics 07:56:20 INFO - 2015-12-14 07:56:20,021 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:56:20 INFO - 2015-12-14 07:56:20,889 INFO : Browser initialized. 07:56:20 INFO - 2015-12-14 07:56:20,890 INFO : Running cycle 1/1 for v8_7 test... 07:56:20 INFO - 2015-12-14 07:56:20,890 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWZ0WkH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:56:32 INFO - 2015-12-14 07:56:32,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 143294464 07:56:32 INFO - 2015-12-14 07:56:32,927 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47262/tests/v8_7/run.html (next: http://localhost:47262/tests/v8_7/run.html) 07:56:54 INFO - 2015-12-14 07:56:54,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 137523200 07:56:54 INFO - 2015-12-14 07:56:54,621 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,621 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:56:54 INFO - 2015-12-14 07:56:54,621 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:56:54 INFO - 2015-12-14 07:56:54,621 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:56:54 INFO - 2015-12-14 07:56:54,621 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:56:54 INFO - 2015-12-14 07:56:54,621 DEBUG : BROWSER_OUTPUT: |0;Richards;168.89039013680122 07:56:54 INFO - 2015-12-14 07:56:54,622 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.76688286913392 07:56:54 INFO - 2015-12-14 07:56:54,622 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.39643652561244 07:56:54 INFO - 2015-12-14 07:56:54,622 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5263.1578947368425 07:56:54 INFO - 2015-12-14 07:56:54,622 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1071.8113612004288 07:56:54 INFO - 2015-12-14 07:56:54,622 DEBUG : BROWSER_OUTPUT: |5;Earley;694.4444444444445 07:56:54 INFO - 2015-12-14 07:56:54,622 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 07:56:54 INFO - 2015-12-14 07:56:54,622 DEBUG : BROWSER_OUTPUT: |7;RegExp;26179.48717948718 07:56:54 INFO - 2015-12-14 07:56:54,622 DEBUG : BROWSER_OUTPUT: |8;Splay;600.6006006006006 07:56:54 INFO - 2015-12-14 07:56:54,622 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: __startTimestamp1450108614620__endTimestamp 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.89 Median:168.89 stddev:0.00 (0.0%) 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: Values: 168.9 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.77 Median:190.77 stddev:0.00 (0.0%) 07:56:54 INFO - 2015-12-14 07:56:54,623 DEBUG : BROWSER_OUTPUT: Values: 190.8 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: Values: 278.4 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: Values: 5263.2 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: Values: 1071.8 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:694.44 Median:694.44 stddev:0.00 (0.0%) 07:56:54 INFO - 2015-12-14 07:56:54,624 DEBUG : BROWSER_OUTPUT: Values: 694.4 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: Values: 12132.5 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26179.49 Median:26179.49 stddev:0.00 (0.0%) 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: Values: 26179.5 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.60 Median:600.60 stddev:0.00 (0.0%) 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: Values: 600.6 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: Values: 4835.7 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:56:54 INFO - 2015-12-14 07:56:54,625 DEBUG : BROWSER_OUTPUT: 07:56:55 INFO - 2015-12-14 07:56:55,497 INFO : Browser exited with error code: 0 07:56:55 INFO - 2015-12-14 07:56:55,510 INFO : Completed test v8_7 (00:00:39) 07:56:55 INFO - 2015-12-14 07:56:55,622 INFO : Completed test suite (00:20:17) 07:56:55 INFO - 2015-12-14 07:56:55,623 DEBUG : Working with test: dromaeo_css 07:56:55 INFO - 2015-12-14 07:56:55,623 DEBUG : Generating results file: dromaeo_css 07:56:55 INFO - 2015-12-14 07:56:55,624 DEBUG : Working with test: kraken 07:56:55 INFO - 2015-12-14 07:56:55,624 DEBUG : Generating results file: kraken 07:56:55 INFO - 2015-12-14 07:56:55,624 INFO : javascript benchmark 07:56:55 INFO - 2015-12-14 07:56:55,624 DEBUG : Working with test: v8_7 07:56:55 INFO - 2015-12-14 07:56:55,625 DEBUG : Generating results file: v8_7 07:56:55 INFO - 2015-12-14 07:56:55,625 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:56:55 INFO - 2015-12-14 07:56:55,675 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 07:56:55 INFO - 2015-12-14 07:56:55,675 DEBUG : process_Request line: dromaeo_css 6192.25 graph.html#tests=[[72,132,43]] 07:56:55 INFO - 2015-12-14 07:56:55,676 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:56:55 INFO - 2015-12-14 07:56:55,706 DEBUG : process_Request line: kraken 1554.70 graph.html#tests=[[232,132,43]] 07:56:55 INFO - 2015-12-14 07:56:55,706 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:56:55 INFO - 2015-12-14 07:56:55,740 DEBUG : process_Request line: v8_7 21302.64 graph.html#tests=[[230,132,43]] 07:56:55 INFO - 2015-12-14 07:56:55,741 INFO : javascript benchmark 07:56:55 INFO - 2015-12-14 07:56:55,745 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2632.3682316244103, 2699.500592390409, 2725.727427257276, 2725.7546820786138, 2749.6837863645674, 4603.838865639704, 4834.057358815028, 4844.781984810683, 4865.172920603497, 4894.070126675938, 4683.367745354376, 4716.9292460613115, 4736.692115012522, 4809.9519004809945, 4821.300911367858, 4224.72539284947, 4313.460817397825, 4350.977520282731, 4397.890052748675, 4412.911741765162, 4421.09367579647, 4458.450624094034, 4468.620167285784, 4482.327650852382, 4529.139463501924, 4175.958240417587, 4280.828766849322, 4476.171908196994, 4495.348174514694, 4508.977455112704, 4306.935395969063, 4395.934060989088, 4397.890052748707, 4423.867283981485, 4427.712198707074, 4340.565943405666, 4361.3457981302745, 4365.4106695596, 4369.880607905164, 4427.203103441379, 4436.0906014267, 4613.423322084739, 4651.837185698518, 4695.835645752416, 4722.929156062662, 5103.948960510422, 5127.9230811537855, 5134.05020071288, 5144.61415393847, 5169.56058735008, 5158.380994280673, 5178.948210517922, 5183.714895680736, 5193.454687257859, 5226.137687281594, 4572.588467037949, 4679.64902632304, 4707.952920470751, 4739.170645137122, 4801.399825021872, 5265.420803711589, 5301.54936830366, 5320.414754377015, 5327.094393953037, 5333.0, 5053.620978426559, 5107.0, 5110.977804439127, 5127.9230811537855, 5145.536901678867, 4859.70841749489, 4973.005398920231, 5014.0, 5204.0892843752945, 5264.31563896691, 5044.571211446994, 5067.721275329893, 5069.518395752398, 5080.364954380702, 5105.668131571436, 4825.4933232010835, 5013.523715247119, 5022.573081288058, 5024.32171656829, 5026.271190677405, 4093.488313960755, 4184.644305234089, 4211.347241177622, 4280.229558679405, 4306.935395969063, 3733.4586484959527, 3737.159139193714, 3751.81240937952, 3753.7560058596105, 3766.37854753968, 4208.642265407413, 4317.481902171759, 4445.1998640245065, 4471.0, 4500.819967201275, 5023.6483446159145, 5040.974795126001, 5046.899062018739, 5125.615578831603, 5165.638405311592, 4440.111977604492, 4449.354843547732, 4488.573585509372, 4499.302608095751, 4554.521775213621, 4276.486821581368, 4579.839705610288, 4591.173588754056, 4596.931046034312, 4619.1685496610935, 4700.942287985176, 4709.340692303081, 4743.217369134192, 4750.07373562152, 4879.634027448026, 5144.536991670768, 5150.742462876916, 5156.61325400589, 5172.586193104467, 5198.209782402784, 4874.293227482066, 4877.170880950176, 4882.438519570295, 4901.485344038967, 4940.2342636891335, 4836.685615434985, 4933.309336692794, 4938.9259161111895, 5001.824936127218, 5013.0, 5071.061853557104, 5074.7716352764955, 5075.3148324975655, 5103.336566246364, 5157.968406318826, 4649.0, 4926.088673595396, 4937.474227060317, 4946.233333833262, 4954.281629163679, 4800.3759511263315, 4863.270509423473, 4870.391201099863, 4897.926531101965, 4921.680090794087, 4871.780769865435, 4874.390701162355, 4881.780319885685, 4895.951040489692, 4964.280179374043, 4750.596199323097, 5019.924701129559, 5038.1183292924325, 5047.697138171721, 5078.771455284447, 4740.336352910526, 4749.691270067435, 4835.540623640749, 4853.902921941471, 4895.975520122377], "unit": "ms", "name": "dojo.html", "value": 4671.366893471718}, {"lowerIsBetter": false, "replicates": [575.6057100885894, 580.9397848925709, 581.1689284323421, 582.0570675505681, 583.4107551373113, 35438.11404714883, 36353.81823090881, 36598.0, 36655.63344366559, 36689.44965825515, 40799.184016319654, 41290.793546032306, 41515.79242103793, 41600.37599436011, 41692.0, 7938.722144724936, 8076.515409075474, 8113.959430202841, 8136.593170341489, 8146.674133034671, 7989.760307190764, 8034.196580341948, 8103.0, 8104.230098140697, 8107.878381824277, 7986.121526632066, 8098.190180981884, 8105.1489593592705, 8132.674693012273, 8134.145914678962, 8047.436679432442, 8083.151269116746, 8129.796755081111, 8130.065042520067, 8161.795955101111, 7950.56271905045, 8040.115587285394, 8085.272325490675, 8092.838143237162, 8095.82610521477, 36781.63218367835, 37778.24443511142, 37808.24383512315, 37840.243195136216, 37969.24061518782, 2811.690714021456, 2933.6332958380203, 2939.6031535742827, 2947.808392454505, 3629.383004889175, 27806.0, 28036.43927121446, 28350.29124271889, 28448.431031379463, 28669.426611467654, 3537.0626783902285, 3539.203679172191, 3547.8048707321086, 3551.5915669698056, 3595.2070516030376, 212239.0, 213837.99999999846, 214151.0, 214348.0, 214662.0, 53408.73295633497, 54562.45437545574, 56126.15810762842, 57709.0, 59009.70495147497, 50215.74892125516, 50247.49752502501, 50282.0, 50373.49626503688, 50381.49618503768, 13642.727145457035, 13653.453861845614, 13714.314284285745, 13776.24230667323, 13938.860611393959, 9523.619055237852, 9529.047095290416, 9580.712578622653, 9611.086946740048, 9649.807003859883, 19467.90266048661, 19554.413367598994, 19731.506712332306, 19991.800081999285, 20009.399718008484, 7521.435892307989, 7696.692132314756, 7705.345045671181, 7811.960940195377, 7888.723894663659, 752.6011214056559, 795.3756301303449, 851.5614458553725, 899.6851102114339, 925.4123631493915, 22761.886190569272, 22962.42593935165, 22964.540709185723, 23033.309000730005, 23257.7674223259, 895.8969718482327, 927.9304052195977, 939.8825146856643, 1026.3995562595817, 1058.3226734889677, 12341.321227332583, 12400.75198496043, 12503.686817938711, 12518.74962500745, 12622.242665439919, 267359.0, 274393.0, 275683.0, 276144.0, 276705.0, 46570.76714616405, 46808.0, 46901.0, 46996.29505557419, 47486.76256618764, 1197.8083506638895, 1209.7640960012889, 1214.9331786751814, 1225.8467691538378, 1227.5580790915262, 23856.88071559631, 25776.226713198634, 25940.8702956484, 28427.857860710563, 29211.85394073016, 40821.79589102035, 40987.38518922278, 41396.586034139276, 41397.586024139375, 41426.585734142274, 205491.0, 207623.0, 207963.0, 208654.0, 208798.0, 28194.43611127725, 29148.813838961738, 29310.482742071086, 29475.115746527637, 29490.0, 37166.814165929, 37193.81403092967, 38135.42796858105, 38513.614863851006, 38747.41878871763, 32065.0, 32175.839120804245, 32184.678153218167, 32791.836040819646, 33189.834050830555, 32759.67240327566, 32824.50763238601, 32906.17734556655, 33054.834725826215, 33432.1641958953, 32791.37668986428, 33345.166370840925, 33416.49875251922, 33505.49741753827, 33840.49239261462, 26401.4719705601, 26998.0, 27468.313292167855, 27509.0, 27515.0, 23368.182113625942, 23399.649005265273, 23673.40816479602, 23707.1702490412, 23909.760902390753], "unit": "ms", "name": "ext.html", "value": 16632.588292845376}, {"lowerIsBetter": false, "replicates": [321.511302819714, 325.37852701340444, 327.2620241355742, 328.0924192863001, 329.5238380540119, 15643.608909777247, 16119.91940040301, 16148.677026459463, 16573.50279491614, 16658.333666653318, 15369.231538423062, 15409.229538523085, 15445.0, 15510.844891551082, 15674.686506269867, 4239.40648309237, 4423.049044455442, 4427.645788336926, 4431.3131464622875, 4433.758547606675, 3747.906302342436, 4332.718373305725, 4358.237308471005, 4376.452943382077, 4831.637627177958, 4740.691855029412, 4756.262779269219, 4880.316755654211, 5016.097102521545, 5042.621803364762, 4822.831200907952, 4880.145974454492, 4895.9510404895855, 4906.509349065101, 4921.212605983043, 5003.074431230234, 5121.180611102243, 5124.564412024983, 5125.051865404912, 5128.640995130342, 18670.43988680342, 18679.439616811516, 18721.719174212398, 19211.32760353381, 19222.135003924857, 1738.8087310395847, 1751.5533538947614, 1768.7877454705517, 1786.499780061585, 1807.7830660320715, 8796.428232164888, 8956.8656470153, 9038.231750301233, 9131.086891310882, 12795.744085118338, 1664.8335166483375, 1699.5326285271526, 1726.6633006563725, 1770.3361239535175, 1822.1618055694396, 54497.0, 55309.0, 55800.72099639476, 56635.0, 57443.425565744226, 9525.237980961645, 9653.1794797443, 9755.317127800985, 9764.462954537426, 9846.901530984598, 12198.39008049594, 12226.20529665569, 12274.140810143204, 12319.876801232052, 12336.889679928849, 6780.7287708492095, 6810.965945170243, 6828.7609933653075, 6895.379415852597, 6972.407345375598, 6626.966865165643, 6684.799456016327, 6701.262861085277, 6718.0, 6734.8989765153565, 4018.738781979162, 4044.6157615026527, 4066.796660167039, 4077.531083925327, 4078.3882417636996, 1671.156066186568, 1695.8473737363697, 1706.240722878332, 1721.5954250751063, 1740.2516917725247, 353.853150942356, 359.06284597201284, 362.03698162886593, 387.2100914135133, 391.19999600816396, 8819.338549608805, 9725.6596019139, 9791.363561368487, 9870.0, 10011.149052330633, 381.7823840410939, 382.16115626200224, 384.2008622066096, 386.7254249482842, 387.7712149831613, 5343.839684809384, 5344.893102138013, 5385.434529374437, 5432.022235997559, 5443.564514838803, 481518.0, 482108.0, 489645.0, 490089.0, 490105.0, 61449.38550614526, 72583.27416725871, 72719.27280727231, 72873.27126728665, 74842.25157748353, 1078.4338222433284, 1080.4543705428707, 1109.2734259060328, 1136.8063533290012, 1140.7832511822728, 14351.787522083374, 14379.568612941628, 14493.7825932609, 14524.564263072125, 14803.629909252355, 29794.0, 31496.212594685316, 32271.67728322687, 32536.186595335304, 33611.83194084014, 36276.0, 37128.44307335338, 40938.385924211754, 41841.58158418377, 42697.78651106849, 8596.183362580545, 8740.868886966828, 8928.642854285756, 8930.330225233003, 8953.104689530996, 10359.533820977924, 10436.217283703601, 10526.0, 16620.750688739437, 16659.16704164811, 13135.211887286794, 13523.59429217125, 13878.653033674238, 13896.444142234197, 13999.860001399855, 12768.233905965672, 13880.861191387958, 14124.576262712135, 14372.425102995763, 14471.059381140192, 14546.199959002357, 14650.194239316514, 15038.624034399227, 15045.774313385089, 15090.396384144951, 8666.176713212235, 8734.21392074691, 8802.515861627417, 8839.425437346552, 8954.955225223832, 9473.384230025027, 9651.71044868655, 14028.368723407675, 14094.647633809236, 14194.503192388216], "unit": "ms", "name": "jquery.html", "value": 7558.386065204552}, {"lowerIsBetter": false, "replicates": [1372.101273665749, 1430.0847457627117, 1530.502586659336, 1598.8800839937007, 1688.2149800342845, 6094.055421409688, 6242.406971337727, 7054.611996340205, 7201.315874991874, 7242.601656908868, 6514.576552524082, 6581.868362632745, 6620.702068406921, 6624.039514270428, 6682.164729408824, 1917.1085445267913, 1946.7177259297393, 1968.9310874119408, 1969.8719583227044, 1973.0825166297668, 2050.4361300642367, 2069.8758074515504, 2074.52285974226, 2086.9791302086937, 2093.5708179823177, 2068.265765653194, 2073.813356797888, 2075.180303780006, 2085.6662933930575, 2092.780258072903, 2012.748406449194, 2024.8987550622483, 2033.1664017752723, 2034.5727397246596, 2039.2964427272568, 2004.4487765864358, 2049.5695903860205, 2049.928252511155, 2062.979370206294, 2070.440980935139, 6994.6152961587095, 7071.858562828715, 7085.964570177116, 7093.929060709378, 7101.680424380864, 4132.793360331972, 4186.434831297766, 4198.9370159447635, 4203.4115223868685, 4220.155968806251, 2568.691756989155, 2599.3891435512637, 2609.8173127881055, 2630.040035387089, 2636.5781474963915, 846.0608724316004, 869.2437579306044, 874.4709450782312, 892.205936716323, 906.6083561732709, 9242.168204861595, 9267.814643707155, 9268.536573171314, 9286.907130928672, 9312.068793120701, 3781.149241420658, 3813.389857622767, 3859.710521710827, 3877.96122038776, 3879.941800872989, 8053.798655033671, 8065.798355041054, 8076.232757888109, 8077.35381169505, 8085.151059138823, 4148.460700108966, 4155.771432571177, 4174.833006679699, 4194.706370554093, 4221.176870510282, 3689.1330537323706, 3796.8481260749813, 3812.7521711089244, 3823.25446537928, 3824.7513911595656, 3194.1535493094348, 3206.3587282543117, 3242.4649932761304, 3245.7078862902454, 3249.415105281025, 972.3922548407245, 977.022977022977, 978.4276198424002, 978.6232300564192, 979.9657012004545, 984.2519685039279, 987.683941138843, 999.7700528878253, 1006.3961623026125, 1083.5990683447017, 6472.611643301417, 6474.741010359627, 6478.060681201199, 6484.902726459107, 6499.675016249169, 406.179517374901, 409.5351775734503, 432.8961049348197, 434.092746160526, 435.31872619350617, 4971.676841005323, 4974.726390048582, 4981.476944920803, 4984.27727979441, 5032.899342013139, 7852.450328477066, 8069.677212911535, 8114.391420643476, 8175.100738918714, 8234.0, 8045.396595255379, 8058.677652893819, 8076.152004039492, 8124.2688158064875, 8156.510609363457, 6422.903656445157, 6467.417932386108, 6517.120188774549, 6581.638009909501, 6647.368499992493, 6646.667666616553, 6681.465482761465, 6692.330766923269, 6714.7314107437105, 6749.5612785168805, 7343.77968660941, 7410.703571857065, 7493.475456717977, 7564.903089052166, 7596.582187979714, 7585.962070189835, 7667.501612395399, 7874.094479134744, 7885.329746971572, 7887.369010479033, 5313.362396512443, 5415.241866138665, 6053.0, 6110.388961104032, 6125.387461253839, 6399.360063993563, 6457.321981191907, 6461.935380646133, 6509.511786615928, 6566.80299591013, 6180.7527698891545, 6204.441600255998, 6246.875062498633, 6439.549231553746, 6491.935080649133, 6069.2716873975405, 6073.423024812636, 6077.27072751255, 6156.199694039746, 6179.011358182669, 6288.213973253343, 6323.08315294289, 6328.968355158195, 6336.7148478319505, 6339.302676705651, 5815.447532484407, 5836.912446313394, 5850.853728656818, 5851.356350801493, 5862.794802181903, 5546.694931778629, 5737.91393129095, 5769.221155144001, 5872.500837428866, 5894.793682221101], "unit": "ms", "name": "mootools.html", "value": 3885.904451452207}, {"lowerIsBetter": false, "replicates": [291.8453219793509, 299.69580875411464, 300.5836915871518, 304.3805855084901, 306.4851050235603, 5509.201165830952, 5522.30971128609, 5598.664080155194, 5612.158176273561, 5645.2096706461125, 5539.639923404986, 5547.278853749017, 5552.4169962154, 5554.055810512213, 5563.193336966137, 4070.7354021988476, 4265.509466411356, 4270.188664153817, 4270.871873843789, 4274.230638485079, 4166.749995000295, 4169.541350451448, 4181.142865712537, 4181.832726690929, 4182.100848317611, 4134.855280065199, 4141.088960428716, 4141.7514949103, 4146.3780432935155, 4150.460440142777, 4174.686898482611, 4176.1230141670285, 4184.4141820145205, 4190.769507677077, 4193.993441574031, 3640.490331353586, 3650.689691376236, 3653.4702468142236, 3654.3056819204267, 3655.7258205634685, 5211.765470553834, 5242.082635538765, 5309.946900530984, 5381.112116500812, 5402.189671549259, 4800.879978000543, 4803.7357945313, 4811.374521312242, 4814.951850481485, 4822.975885120587, 5813.418658134153, 5827.592068555203, 5840.123981402781, 5845.1232315153065, 5849.444302791228, 3869.8839034829, 3935.5080614923136, 3940.349842276021, 3943.250782351373, 3952.3873799561115, 6042.57701960863, 6136.693165341715, 6143.293521245069, 6144.600600960968, 6152.292486364081, 4038.5557588665224, 4039.3940908863906, 4039.818208180639, 4041.6362527372676, 4054.189162167578, 4100.815463304159, 4109.773962432035, 4110.198511290329, 4110.568390319033, 4114.814833332447, 4779.996200797871, 4780.1873681474235, 4780.689255198401, 4787.353707249476, 4791.688540244873, 5585.385607583163, 5781.248437703071, 5806.44838740319, 5809.767609295581, 5818.80714453536, 1439.604108870048, 1466.8166479190102, 1468.3392473386805, 1469.162577330911, 1473.8378778334375, 961.3126614470686, 962.629387685746, 974.8294048541619, 977.4184360305607, 979.6081567373108, 5066.620003499752, 5097.770600322994, 5109.4379618241965, 5114.9232761507865, 5116.232565115262, 6017.729202185912, 6073.665948372882, 6074.939250607437, 6078.574499785061, 6087.269527656709, 5046.142155833517, 5084.186530155157, 5091.1854103343285, 5100.183970564692, 5106.387233531926, 3197.7281931036123, 3249.1064957136505, 3275.3776782411264, 3278.9344213115605, 3286.4577344738327, 5700.743466544015, 5702.8289151325525, 5708.686022268815, 5711.086226203787, 5713.800016999385, 6012.639241645428, 6139.47814435769, 6168.660723660152, 6265.906011409833, 6325.746970121144, 5703.230063941315, 5724.856878578069, 5725.971370143123, 5727.255456790591, 5750.884982300414, 6024.578279520391, 6046.365131661289, 6089.695515224133, 6094.146819445193, 6120.693965301806, 5731.8567035824435, 5893.0, 5920.940790592212, 5960.940390596039, 5969.373215812451, 5752.0, 5752.6836024019085, 5765.279340082489, 5766.3368712598585, 5777.91333129995, 4028.3151864183747, 4066.837326507025, 4076.470058892325, 4077.9796101019306, 4086.9795651021554, 5975.850603734942, 6105.633661980295, 6113.816585502442, 6116.35778243278, 6128.540359472968, 5846.239988801429, 5850.882982340415, 5851.531877449879, 5852.209951656472, 5859.20900678403, 5784.913226301524, 5811.854703632443, 5815.79644712433, 5826.0, 5848.970755146197, 5584.162375643686, 5666.0, 5704.686242256716, 5710.0, 5718.571107167062, 5849.766009359578, 5905.4685078343155, 5913.881722365614, 5934.881302373842, 5941.702914854326, 5748.195252664714, 5775.0, 5786.739596718242, 5792.0, 5799.681017544076], "unit": "ms", "name": "prototype.html", "value": 4334.565904416036}, {"lowerIsBetter": false, "replicates": [643.2763141465849, 715.0775499605509, 752.5033477904584, 759.7181019924028, 765.1353970013884, 10802.0, 11334.149938754606, 11403.828942565868, 11428.200025998183, 11431.828522572168, 11345.773084538305, 11436.656900293005, 11441.485133169006, 11444.542218311279, 11485.483153258103, 787.1695361393728, 793.1275596843469, 808.7331180710352, 809.017044291186, 810.6878851642101, 815.2988429950238, 817.3134566963749, 819.4223072733738, 822.0341099208437, 822.6709316273509, 859.0250066174905, 861.6381119929613, 864.3301441382915, 865.9480431174118, 867.535868310454, 848.8344772769312, 850.808568072185, 852.0457088061349, 853.1255463150289, 858.2318824651933, 628.0516420205477, 634.2674211285972, 634.9904751428733, 635.8315046512678, 639.2041907824741, 12230.0, 12300.507979680802, 12363.134580579363, 12425.31660758658, 12444.0, 10726.517306721216, 10998.450077496092, 11014.669559913216, 11058.557657693682, 12066.758664826742, 9400.717978460658, 9607.423554586678, 9619.56711947964, 9619.615215391375, 9679.564419601134, 3312.1719570107475, 3354.480055591387, 3360.075979105741, 3379.6620337966006, 3393.830308484566, 40049.39925901114, 40198.79900600507, 40566.0, 40701.796491017354, 40710.0, 9274.21169200612, 9320.580573874191, 9441.716748497556, 9446.95276523613, 9478.289128315404, 15913.283902224428, 15944.681106378039, 15950.680986380208, 15972.121533315547, 15980.360785568679, 6439.452646525097, 6583.967080164569, 6661.367170118831, 6719.966400167968, 6766.966165169143, 3553.182767963331, 3649.9635003650155, 3654.689351405107, 3677.7793332400142, 3713.8885833425043, 2602.921912342595, 2609.1389841352307, 2609.8695065247043, 2609.9217023488945, 2626.7241939596065, 461.69528111446283, 464.2525533890434, 467.96256299495957, 469.16020323620336, 474.01168563544707, 440.6518850108379, 517.5419753518164, 562.7945799783132, 565.3103214078817, 592.5407808948014, 7039.472039597051, 7129.607871567114, 7210.206877243499, 7235.095613048369, 7305.780826575211, 463.2610985478157, 513.3147248423396, 568.7184843502492, 576.6568891509545, 578.2973686970352, 3481.234128491728, 3537.8231088445473, 3570.9285814283567, 3611.656892595199, 3707.443883417509, 49179.50820491821, 49257.014859702605, 49278.50721492811, 49291.507084929406, 49293.0, 44876.77561612171, 45219.09561808746, 45236.0, 45350.0, 45468.0, 39828.2034359317, 40317.39523907144, 41069.589304107176, 41187.58812411898, 42077.15845683069, 7796.181400953045, 7818.257265559762, 8033.1565185657, 8085.151059138941, 8201.42590018693, 30530.542041869834, 30881.845590771904, 30887.845560772952, 31125.377492450476, 31239.219019524695, 38100.428493572064, 38363.80818095891, 38560.03599910025, 39036.414453783786, 39459.0, 10052.597896084075, 10198.18414526851, 10256.58973641046, 10566.154707623526, 10631.149508039183, 11424.543018279175, 11488.310701357945, 11647.30116193031, 12183.086268529718, 12311.384430778604, 9477.194438472807, 9515.524223788922, 9571.234301255743, 9582.568784404857, 9658.806823863342, 10659.680209593724, 10857.945710271399, 11176.832347514632, 11225.214235003798, 11332.263402878787, 10615.681529554126, 10654.946725266323, 10881.836772448261, 10973.945130274298, 11086.944565277123, 8521.0, 8810.515421651871, 8908.10918908104, 9053.094690531158, 9409.905900940903, 8079.919200807916, 8654.610542525475, 8656.567171641267, 8730.345224108345, 8832.29341652679], "unit": "ms", "name": "yui.html", "value": 5698.686329996752}], "name": "dromaeo_css", "value": 6192.246094177372}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 113.0, 115.0, 115.0, 124.0, 112.0, 113.0, 114.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [162.0, 135.0, 152.0, 160.0, 132.0, 155.0, 158.0, 136.0, 167.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 161.0, 170.0, 165.0, 172.0, 168.0, 162.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 71.0, 72.0, 75.0, 72.0, 144.0, 72.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 138.0, 96.0, 95.0, 96.0, 141.0, 95.0, 95.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 112.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [147.0, 149.0, 152.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 74.0, 74.0, 76.0, 75.0, 75.0, 74.0, 74.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 70.0, 70.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 87.0, 86.0, 95.0, 85.0, 95.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [118.0, 126.0, 140.0, 121.0, 133.0, 132.0, 129.0, 136.0, 124.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.7}, {"lowerIsBetter": true, "replicates": [140.0, 158.0, 161.0, 155.0, 154.0, 149.0, 152.0, 153.0, 167.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 74.0, 71.0, 72.0, 74.0, 70.0, 74.0, 70.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.2}], "name": "kraken", "value": 1554.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.89039013680122], "unit": "score", "name": "Richards", "value": 209.0231420000001}, {"lowerIsBetter": false, "replicates": [190.76688286913392], "unit": "score", "name": "DeltaBlue", "value": 346.59055600000005}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [694.4444444444445], "unit": "score", "name": "Earley", "value": 959.7067199999997}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [26179.48717948718], "unit": "score", "name": "RegExp", "value": 34.79766405484819}, {"lowerIsBetter": false, "replicates": [600.6006006006006], "unit": "score", "name": "Splay", "value": 135.68251500000005}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21302.638835596383}]} 07:56:55 INFO - RETURN: dromaeo_css: 6192.25 07:56:55 INFO - RETURN: kraken: 1554.70 07:56:55 INFO - RETURN: v8_7: 21302.64 07:56:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21302.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1554.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6192.25"}}} 07:56:55 INFO - Return code: 0 07:56:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:56:55 INFO - # TBPL SUCCESS # 07:56:55 INFO - Running post-action listener: _resource_record_post_action 07:56:55 INFO - Running post-run listener: _resource_record_post_run 07:56:56 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 10289152; Write bytes: 411971584; Read time: 2896; Write time: 249704 07:56:56 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 13680640; Read time: 0; Write time: 21456 07:56:56 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8527872; Write bytes: 398290944; Read time: 2848; Write time: 228248 07:56:56 INFO - Running post-run listener: _upload_blobber_files 07:56:56 INFO - Blob upload gear active. 07:56:56 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:56:56 INFO - Copying logs to upload dir... 07:56:56 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.374438 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-14 07:56:56.758114) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:56:56.761791) ========= 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=5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009759 build_url: 'https://queue.taskcluster.net/v1/task/srNviTI1SnmPKr221wOh8w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:56:56.812162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:56:56.815484) ========= 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=5804b9f07a53938c557deee7000001c5-1450092990.495450-527700651 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:56:56.863824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 07:56:56.864092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 07:56:56.864344) ========= ========= Total master_lag: 0.31 =========