builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1449783744.05 results: success (0) buildid: 20151210130140 builduid: 79a25ca2a6d54e44a53a677b7fb9b9b7 revision: 760f2be9b5490933e5c64dfab9e39b620b57c945 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.054493) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.055012) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.055375) ========= 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=b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006202 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.078721) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.079658) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.095509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.096203) ========= 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=b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.148874) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.149686) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.150514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.151177) ========= 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=b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-10 13:42:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2015-12-10 13:42:25 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117563 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.283195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.283574) ========= 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=b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022365 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:24.334246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-10 13:42:24.334662) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 760f2be9b5490933e5c64dfab9e39b620b57c945 --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 760f2be9b5490933e5c64dfab9e39b620b57c945 --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=b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-10 13:42:25,813 truncating revision to first 12 chars 2015-12-10 13:42:25,813 Setting DEBUG logging. 2015-12-10 13:42:25,813 attempt 1/10 2015-12-10 13:42:25,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/760f2be9b549?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-10 13:42:27,098 unpacking tar archive at: fx-team-760f2be9b549/testing/mozharness/ program finished with exit code 0 elapsedTime=1.593403 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-10 13:42:25.941762) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:25.942133) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:25.952203) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:25.952546) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-10 13:42:25.953025) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-10 13:42:25.953355) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:42:27 INFO - MultiFileLogger online at 20151210 13:42:27 in /builds/slave/test 13:42:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:42:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:42:27 INFO - {'append_to_log': False, 13:42:27 INFO - 'base_work_dir': '/builds/slave/test', 13:42:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:42:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:42:27 INFO - 'branch': 'Fx-Team-Non-PGO', 13:42:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:42:27 INFO - 'config_files': ('talos/linux_config.py',), 13:42:27 INFO - 'default_actions': ('clobber', 13:42:27 INFO - 'read-buildbot-config', 13:42:27 INFO - 'download-and-extract', 13:42:27 INFO - 'populate-webroot', 13:42:27 INFO - 'create-virtualenv', 13:42:27 INFO - 'install', 13:42:27 INFO - 'run-tests'), 13:42:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:42:27 INFO - 'download_minidump_stackwalk': True, 13:42:27 INFO - 'download_symbols': 'ondemand', 13:42:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:42:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:42:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:42:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:42:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:42:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:42:27 INFO - 'installer_path': 'installer.exe', 13:42:27 INFO - 'log_level': 'info', 13:42:27 INFO - 'log_name': 'talos', 13:42:27 INFO - 'log_to_console': True, 13:42:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:42:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:42:27 INFO - 'opt_config_files': (), 13:42:27 INFO - 'pip_index': False, 13:42:27 INFO - 'sps_profile': False, 13:42:27 INFO - 'sps_profile_interval': 0, 13:42:27 INFO - 'suite': 'dromaeojs', 13:42:27 INFO - 'system_bits': '64', 13:42:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:42:27 INFO - 'title': 'talos-linux64-ix-028', 13:42:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:42:27 INFO - 'use_talos_json': True, 13:42:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:42:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:42:27 INFO - 'work_dir': 'build'} 13:42:27 INFO - ##### 13:42:27 INFO - ##### Running clobber step. 13:42:27 INFO - ##### 13:42:27 INFO - Running pre-action listener: _resource_record_pre_action 13:42:27 INFO - Running main action method: clobber 13:42:27 INFO - rmtree: /builds/slave/test/build 13:42:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:42:27 INFO - Running post-action listener: _resource_record_post_action 13:42:27 INFO - ##### 13:42:27 INFO - ##### Running read-buildbot-config step. 13:42:27 INFO - ##### 13:42:27 INFO - Running pre-action listener: _resource_record_pre_action 13:42:27 INFO - Running main action method: read_buildbot_config 13:42:27 INFO - Using buildbot properties: 13:42:27 INFO - { 13:42:27 INFO - "properties": { 13:42:27 INFO - "buildnumber": 1190, 13:42:27 INFO - "product": "firefox", 13:42:27 INFO - "script_repo_revision": "production", 13:42:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:42:27 INFO - "repository": "", 13:42:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:42:27 INFO - "buildid": "20151210130140", 13:42:27 INFO - "slavename": "talos-linux64-ix-028", 13:42:27 INFO - "pgo_build": "False", 13:42:27 INFO - "basedir": "/builds/slave/test", 13:42:27 INFO - "project": "", 13:42:27 INFO - "platform": "ubuntu64_hw", 13:42:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:42:27 INFO - "slavebuilddir": "test", 13:42:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:42:27 INFO - "branch": "fx-team", 13:42:27 INFO - "repo_path": "integration/fx-team", 13:42:27 INFO - "stage_platform": "linux64", 13:42:27 INFO - "builduid": "79a25ca2a6d54e44a53a677b7fb9b9b7", 13:42:27 INFO - "revision": "760f2be9b5490933e5c64dfab9e39b620b57c945" 13:42:27 INFO - }, 13:42:27 INFO - "sourcestamp": { 13:42:27 INFO - "repository": "", 13:42:27 INFO - "hasPatch": false, 13:42:27 INFO - "project": "", 13:42:27 INFO - "branch": "fx-team-linux64-talos", 13:42:27 INFO - "changes": [ 13:42:27 INFO - { 13:42:27 INFO - "category": null, 13:42:27 INFO - "files": [ 13:42:27 INFO - { 13:42:27 INFO - "url": null, 13:42:27 INFO - "name": "https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:42:27 INFO - } 13:42:27 INFO - ], 13:42:27 INFO - "repository": "", 13:42:27 INFO - "rev": "760f2be9b5490933e5c64dfab9e39b620b57c945", 13:42:27 INFO - "who": "pbrosset@mozilla.com", 13:42:27 INFO - "when": 1449783316, 13:42:27 INFO - "number": 7273089, 13:42:27 INFO - "comments": "Bug 1229859 - Introduce new import-globals-from eslint rule to import globals from other modules; r=Mossop", 13:42:27 INFO - "project": "", 13:42:27 INFO - "at": "Thu 10 Dec 2015 13:35:16", 13:42:27 INFO - "branch": "fx-team-linux64-talos", 13:42:27 INFO - "revlink": "", 13:42:27 INFO - "properties": [ 13:42:27 INFO - [ 13:42:27 INFO - "buildid", 13:42:27 INFO - "20151210130140", 13:42:27 INFO - "Change" 13:42:27 INFO - ], 13:42:27 INFO - [ 13:42:27 INFO - "builduid", 13:42:27 INFO - "79a25ca2a6d54e44a53a677b7fb9b9b7", 13:42:27 INFO - "Change" 13:42:27 INFO - ], 13:42:27 INFO - [ 13:42:27 INFO - "pgo_build", 13:42:27 INFO - "False", 13:42:27 INFO - "Change" 13:42:27 INFO - ] 13:42:27 INFO - ], 13:42:27 INFO - "revision": "760f2be9b5490933e5c64dfab9e39b620b57c945" 13:42:27 INFO - } 13:42:27 INFO - ], 13:42:27 INFO - "revision": "760f2be9b5490933e5c64dfab9e39b620b57c945" 13:42:27 INFO - } 13:42:27 INFO - } 13:42:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:42:27 INFO - Running post-action listener: _resource_record_post_action 13:42:27 INFO - ##### 13:42:27 INFO - ##### Running download-and-extract step. 13:42:27 INFO - ##### 13:42:27 INFO - Running pre-action listener: _resource_record_pre_action 13:42:27 INFO - Running main action method: download_and_extract 13:42:27 INFO - mkdir: /builds/slave/test/build/tests 13:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:27 INFO - https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/test_packages.json 13:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/test_packages.json 13:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:42:28 INFO - Downloaded 1302 bytes. 13:42:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:42:28 INFO - Using the following test package requirements: 13:42:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:42:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:42:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:28 INFO - u'jsshell-linux-x86_64.zip'], 13:42:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:42:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:42:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:42:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:42:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:42:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:42:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:42:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:42:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:28 INFO - https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:42:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:42:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:42:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/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 13:42:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/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 13:42:29 INFO - Downloaded 21866925 bytes. 13:42:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:42:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:42:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:42:30 INFO - Return code: 0 13:42:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:30 INFO - https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:42:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:42:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:42:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/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 13:42:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/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 13:42:31 INFO - Downloaded 21866925 bytes. 13:42:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 13:42:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:42:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 13:42:32 INFO - Return code: 0 13:42:32 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')]} 13:42:32 INFO - https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:42:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:42:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:42:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/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 13:42:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/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 13:42:33 INFO - Downloaded 11132038 bytes. 13:42:33 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 13:42:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:42:33 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 13:42:34 INFO - Return code: 0 13:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:34 INFO - https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:42:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:42:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:42:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/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 13:42:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/kuxiNaszRQiZynJfIlr3eQ/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 13:42:35 INFO - Downloaded 57730351 bytes. 13:42:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:42:35 INFO - mkdir: /builds/slave/test/properties 13:42:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:42:35 INFO - Writing to file /builds/slave/test/properties/build_url 13:42:35 INFO - Contents: 13:42:35 INFO - build_url:https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:42:35 INFO - Running post-action listener: _resource_record_post_action 13:42:35 INFO - Running post-action listener: set_extra_try_arguments 13:42:35 INFO - ##### 13:42:35 INFO - ##### Running populate-webroot step. 13:42:35 INFO - ##### 13:42:35 INFO - Running pre-action listener: _resource_record_pre_action 13:42:35 INFO - Running main action method: populate_webroot 13:42:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:42:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:42:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:42:35 INFO - '--tppagecycles', 13:42:35 INFO - '7'], 13:42:35 INFO - 'tests': ['tsvgm']}}, 13:42:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:42:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:42:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:42:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:42:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:42:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:42:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:42:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:35 INFO - 'talos_options': ['--e10s'], 13:42:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:42:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:35 INFO - 'tests': ['damp', 'tps']}, 13:42:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:35 INFO - 'talos_options': ['--e10s'], 13:42:35 INFO - 'tests': ['damp', 'tps']}, 13:42:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:42:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:42:35 INFO - 'other': {'tests': ['a11yr', 13:42:35 INFO - 'ts_paint', 13:42:35 INFO - 'tpaint', 13:42:35 INFO - 'sessionrestore', 13:42:35 INFO - 'sessionrestore_no_auto_restore']}, 13:42:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:42:35 INFO - 'tests': ['a11yr', 13:42:35 INFO - 'ts_paint', 13:42:35 INFO - 'tpaint', 13:42:35 INFO - 'sessionrestore', 13:42:35 INFO - 'sessionrestore_no_auto_restore']}, 13:42:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:42:35 INFO - 'tests': ['a11yr', 13:42:35 INFO - 'ts_paint', 13:42:35 INFO - 'tpaint', 13:42:35 INFO - 'sessionrestore', 13:42:35 INFO - 'sessionrestore_no_auto_restore']}, 13:42:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:42:35 INFO - 'tests': ['a11yr', 13:42:35 INFO - 'ts_paint', 13:42:35 INFO - 'tpaint', 13:42:35 INFO - 'sessionrestore', 13:42:35 INFO - 'sessionrestore_no_auto_restore']}, 13:42:35 INFO - 'other_l64': {'tests': ['a11yr', 13:42:35 INFO - 'ts_paint', 13:42:35 INFO - 'tpaint', 13:42:35 INFO - 'sessionrestore', 13:42:35 INFO - 'sessionrestore_no_auto_restore']}, 13:42:35 INFO - 'other_nol64': {'tests': ['a11yr', 13:42:35 INFO - 'ts_paint', 13:42:35 INFO - 'tpaint', 13:42:35 INFO - 'sessionrestore', 13:42:35 INFO - 'sessionrestore_no_auto_restore']}, 13:42:35 INFO - 'svgr': {'tests': ['tsvgx', 13:42:35 INFO - 'tsvgr_opacity', 13:42:35 INFO - 'tart', 13:42:35 INFO - 'tscrollx', 13:42:35 INFO - 'cart']}, 13:42:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:42:35 INFO - 'tests': ['tsvgx', 13:42:35 INFO - 'tsvgr_opacity', 13:42:35 INFO - 'tart', 13:42:35 INFO - 'tscrollx', 13:42:35 INFO - 'cart']}, 13:42:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:35 INFO - 'tests': ['tp5o']}, 13:42:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:35 INFO - 'talos_options': ['--e10s'], 13:42:35 INFO - 'tests': ['tp5o']}, 13:42:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:35 INFO - 'talos_options': ['--xperf_path', 13:42:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:42:35 INFO - 'tests': ['tp5n']}, 13:42:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:42:35 INFO - 'talos_options': ['--e10s', 13:42:35 INFO - '--xperf_path', 13:42:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:42:35 INFO - 'tests': ['tp5n']}}, 13:42:35 INFO - 'talos.zip': {'path': '', 13:42:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:42:35 INFO - Running post-action listener: _resource_record_post_action 13:42:35 INFO - ##### 13:42:35 INFO - ##### Running create-virtualenv step. 13:42:35 INFO - ##### 13:42:35 INFO - Running pre-action listener: _resource_record_pre_action 13:42:35 INFO - Running main action method: create_virtualenv 13:42:35 INFO - Creating virtualenv /builds/slave/test/build/venv 13:42:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:42:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:42:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:42:35 INFO - Using real prefix '/usr' 13:42:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:42:36 INFO - Installing distribute.............................................................................................................................................................................................done. 13:42:38 INFO - Installing pip.................done. 13:42:38 INFO - Return code: 0 13:42:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca6314cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b240b0>, '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 0x1b24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25440>, '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': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', '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 13:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:42:38 INFO - Using env: {'DISPLAY': ':0', 13:42:38 INFO - 'HOME': '/home/cltbld', 13:42:38 INFO - 'LANG': 'en_US.UTF-8', 13:42:38 INFO - 'LANGUAGE': 'en_US:en', 13:42:38 INFO - 'LOGNAME': 'cltbld', 13:42:38 INFO - 'MAIL': '/var/mail/cltbld', 13:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:38 INFO - 'MOZ_NO_REMOTE': '1', 13:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:38 INFO - 'NO_EM_RESTART': '1', 13:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:38 INFO - 'PWD': '/builds/slave/test', 13:42:38 INFO - 'SHELL': '/bin/bash', 13:42:38 INFO - 'SHLVL': '1', 13:42:38 INFO - 'TERM': 'linux', 13:42:38 INFO - 'TMOUT': '86400', 13:42:38 INFO - 'USER': 'cltbld', 13:42:38 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', 13:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:38 INFO - '_': '/tools/buildbot/bin/python'} 13:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:42:38 INFO - Cleaning up... 13:42:38 INFO - Return code: 0 13:42:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca6314cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b240b0>, '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 0x1b24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25440>, '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': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', '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 13:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:42:38 INFO - Using env: {'DISPLAY': ':0', 13:42:38 INFO - 'HOME': '/home/cltbld', 13:42:38 INFO - 'LANG': 'en_US.UTF-8', 13:42:38 INFO - 'LANGUAGE': 'en_US:en', 13:42:38 INFO - 'LOGNAME': 'cltbld', 13:42:38 INFO - 'MAIL': '/var/mail/cltbld', 13:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:38 INFO - 'MOZ_NO_REMOTE': '1', 13:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:38 INFO - 'NO_EM_RESTART': '1', 13:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:38 INFO - 'PWD': '/builds/slave/test', 13:42:38 INFO - 'SHELL': '/bin/bash', 13:42:38 INFO - 'SHLVL': '1', 13:42:38 INFO - 'TERM': 'linux', 13:42:38 INFO - 'TMOUT': '86400', 13:42:38 INFO - 'USER': 'cltbld', 13:42:38 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', 13:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:38 INFO - '_': '/tools/buildbot/bin/python'} 13:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:38 INFO - Downloading/unpacking psutil>=0.7.1 13:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:40 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:42:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:42:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:42:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:42:40 INFO - Installing collected packages: psutil 13:42:40 INFO - Running setup.py install for psutil 13:42:40 INFO - building 'psutil._psutil_linux' extension 13:42:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:42:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:42:40 INFO - building 'psutil._psutil_posix' extension 13:42:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:42:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:42:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:42:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:42:40 INFO - Successfully installed psutil 13:42:40 INFO - Cleaning up... 13:42:40 INFO - Return code: 0 13:42:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:40 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 0x7fca6314cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b240b0>, '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 0x1b24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25440>, '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': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', '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 13:42:40 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 13:42:40 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 13:42:40 INFO - Using env: {'DISPLAY': ':0', 13:42:40 INFO - 'HOME': '/home/cltbld', 13:42:40 INFO - 'LANG': 'en_US.UTF-8', 13:42:40 INFO - 'LANGUAGE': 'en_US:en', 13:42:40 INFO - 'LOGNAME': 'cltbld', 13:42:40 INFO - 'MAIL': '/var/mail/cltbld', 13:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:40 INFO - 'MOZ_NO_REMOTE': '1', 13:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:40 INFO - 'NO_EM_RESTART': '1', 13:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:40 INFO - 'PWD': '/builds/slave/test', 13:42:40 INFO - 'SHELL': '/bin/bash', 13:42:40 INFO - 'SHLVL': '1', 13:42:40 INFO - 'TERM': 'linux', 13:42:40 INFO - 'TMOUT': '86400', 13:42:40 INFO - 'USER': 'cltbld', 13:42:40 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', 13:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:40 INFO - '_': '/tools/buildbot/bin/python'} 13:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:42:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:42:42 INFO - Installing collected packages: mozsystemmonitor 13:42:42 INFO - Running setup.py install for mozsystemmonitor 13:42:42 INFO - Successfully installed mozsystemmonitor 13:42:42 INFO - Cleaning up... 13:42:42 INFO - Return code: 0 13:42:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:42 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 0x7fca6314cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b240b0>, '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 0x1b24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25440>, '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': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', '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 13:42:42 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 13:42:42 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 13:42:42 INFO - Using env: {'DISPLAY': ':0', 13:42:42 INFO - 'HOME': '/home/cltbld', 13:42:42 INFO - 'LANG': 'en_US.UTF-8', 13:42:42 INFO - 'LANGUAGE': 'en_US:en', 13:42:42 INFO - 'LOGNAME': 'cltbld', 13:42:42 INFO - 'MAIL': '/var/mail/cltbld', 13:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:42 INFO - 'MOZ_NO_REMOTE': '1', 13:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:42 INFO - 'NO_EM_RESTART': '1', 13:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:42 INFO - 'PWD': '/builds/slave/test', 13:42:42 INFO - 'SHELL': '/bin/bash', 13:42:42 INFO - 'SHLVL': '1', 13:42:42 INFO - 'TERM': 'linux', 13:42:42 INFO - 'TMOUT': '86400', 13:42:42 INFO - 'USER': 'cltbld', 13:42:42 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', 13:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:42 INFO - '_': '/tools/buildbot/bin/python'} 13:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:43 INFO - Downloading/unpacking blobuploader==1.2.4 13:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:44 INFO - Downloading blobuploader-1.2.4.tar.gz 13:42:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:42:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:42:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:42:44 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 13:42:44 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 13:42:44 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 13:42:44 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 13:42:44 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 13:42:44 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 13:42:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:42:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:45 INFO - Downloading docopt-0.6.1.tar.gz 13:42:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:42:45 INFO - Installing collected packages: blobuploader, requests, docopt 13:42:45 INFO - Running setup.py install for blobuploader 13:42:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:42:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:42:45 INFO - Running setup.py install for requests 13:42:46 INFO - Running setup.py install for docopt 13:42:46 INFO - Successfully installed blobuploader requests docopt 13:42:46 INFO - Cleaning up... 13:42:46 INFO - Return code: 0 13:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca6314cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b240b0>, '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 0x1b24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25440>, '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': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', '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 13:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:42:46 INFO - Using env: {'DISPLAY': ':0', 13:42:46 INFO - 'HOME': '/home/cltbld', 13:42:46 INFO - 'LANG': 'en_US.UTF-8', 13:42:46 INFO - 'LANGUAGE': 'en_US:en', 13:42:46 INFO - 'LOGNAME': 'cltbld', 13:42:46 INFO - 'MAIL': '/var/mail/cltbld', 13:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:46 INFO - 'MOZ_NO_REMOTE': '1', 13:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:46 INFO - 'NO_EM_RESTART': '1', 13:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:46 INFO - 'PWD': '/builds/slave/test', 13:42:46 INFO - 'SHELL': '/bin/bash', 13:42:46 INFO - 'SHLVL': '1', 13:42:46 INFO - 'TERM': 'linux', 13:42:46 INFO - 'TMOUT': '86400', 13:42:46 INFO - 'USER': 'cltbld', 13:42:46 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', 13:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:46 INFO - '_': '/tools/buildbot/bin/python'} 13:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:42:46 INFO - Running setup.py (path:/tmp/pip-FZE8ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:42:46 INFO - Running setup.py (path:/tmp/pip-vsxWvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:42:46 INFO - Running setup.py (path:/tmp/pip-lLrVg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:42:46 INFO - Running setup.py (path:/tmp/pip-Xygdhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:42:46 INFO - Running setup.py (path:/tmp/pip-6kGUaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:42:46 INFO - Running setup.py (path:/tmp/pip-iedOSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:42:46 INFO - Running setup.py (path:/tmp/pip-05QDA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:42:46 INFO - Running setup.py (path:/tmp/pip-AMSiKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:42:46 INFO - Running setup.py (path:/tmp/pip-yYdzEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:42:47 INFO - Running setup.py (path:/tmp/pip-RayMWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:42:47 INFO - Running setup.py (path:/tmp/pip-W5q_I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:42:47 INFO - Running setup.py (path:/tmp/pip-ImQbun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:42:47 INFO - Running setup.py (path:/tmp/pip-hgBqHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:42:47 INFO - Running setup.py (path:/tmp/pip-VPuWQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:47 INFO - Running setup.py (path:/tmp/pip-bQ4yjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:42:47 INFO - Running setup.py (path:/tmp/pip-461dAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:42:47 INFO - Running setup.py (path:/tmp/pip-oIPDZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:42:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:42:47 INFO - Running setup.py install for manifestparser 13:42:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:42:47 INFO - Running setup.py install for mozcrash 13:42:47 INFO - Running setup.py install for mozdebug 13:42:47 INFO - Running setup.py install for mozdevice 13:42:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Running setup.py install for mozfile 13:42:48 INFO - Running setup.py install for mozhttpd 13:42:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Running setup.py install for mozinfo 13:42:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Running setup.py install for mozInstall 13:42:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Running setup.py install for mozleak 13:42:48 INFO - Running setup.py install for mozlog 13:42:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Running setup.py install for moznetwork 13:42:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Running setup.py install for mozprocess 13:42:48 INFO - Running setup.py install for mozprofile 13:42:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:42:48 INFO - Running setup.py install for mozrunner 13:42:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:42:49 INFO - Running setup.py install for mozscreenshot 13:42:49 INFO - Running setup.py install for moztest 13:42:49 INFO - Running setup.py install for mozversion 13:42:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:42:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:42:49 INFO - Cleaning up... 13:42:49 INFO - Return code: 0 13:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca6314cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b240b0>, '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 0x1b24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25440>, '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': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', '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 13:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:42:49 INFO - Using env: {'DISPLAY': ':0', 13:42:49 INFO - 'HOME': '/home/cltbld', 13:42:49 INFO - 'LANG': 'en_US.UTF-8', 13:42:49 INFO - 'LANGUAGE': 'en_US:en', 13:42:49 INFO - 'LOGNAME': 'cltbld', 13:42:49 INFO - 'MAIL': '/var/mail/cltbld', 13:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:49 INFO - 'MOZ_NO_REMOTE': '1', 13:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:49 INFO - 'NO_EM_RESTART': '1', 13:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:49 INFO - 'PWD': '/builds/slave/test', 13:42:49 INFO - 'SHELL': '/bin/bash', 13:42:49 INFO - 'SHLVL': '1', 13:42:49 INFO - 'TERM': 'linux', 13:42:49 INFO - 'TMOUT': '86400', 13:42:49 INFO - 'USER': 'cltbld', 13:42:49 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', 13:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:49 INFO - '_': '/tools/buildbot/bin/python'} 13:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:42:49 INFO - Running setup.py (path:/tmp/pip-Dkc2kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:42:49 INFO - Running setup.py (path:/tmp/pip-O6VjHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:42:49 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)) 13:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:42:49 INFO - Running setup.py (path:/tmp/pip-qs8Cxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:42:49 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)) 13:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:42:49 INFO - Running setup.py (path:/tmp/pip-KVC1RV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:42:49 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)) 13:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:42:49 INFO - Running setup.py (path:/tmp/pip-7uzJK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:42:49 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)) 13:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:42:49 INFO - Running setup.py (path:/tmp/pip-ZO1Drt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:42:50 INFO - Running setup.py (path:/tmp/pip-UuaUxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:42:50 INFO - Running setup.py (path:/tmp/pip-Erdyrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:42:50 INFO - Running setup.py (path:/tmp/pip-1UXM60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:42:50 INFO - Running setup.py (path:/tmp/pip-C0VEkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:42:50 INFO - Running setup.py (path:/tmp/pip-F5HN__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:42:50 INFO - Running setup.py (path:/tmp/pip-V1grtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:42:50 INFO - Running setup.py (path:/tmp/pip-lyqnG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:42:50 INFO - Running setup.py (path:/tmp/pip-wqdtch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:50 INFO - Running setup.py (path:/tmp/pip-qJXC3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:42:50 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)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:42:50 INFO - Running setup.py (path:/tmp/pip-VJtL3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:42:50 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)) 13:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:42:50 INFO - Running setup.py (path:/tmp/pip-p28kws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:42:50 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)) 13:42:50 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)) 13:42:50 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)) 13:42:50 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)) 13:42:50 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)) 13:42:50 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)) 13:42:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:52 INFO - Downloading blessings-1.5.1.tar.gz 13:42:52 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 13:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:42:52 INFO - Installing collected packages: blessings 13:42:52 INFO - Running setup.py install for blessings 13:42:52 INFO - Successfully installed blessings 13:42:52 INFO - Cleaning up... 13:42:52 INFO - Return code: 0 13:42:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:42:52 INFO - Reading from file tmpfile_stdout 13:42:52 INFO - Current package versions: 13:42:52 INFO - argparse == 1.2.1 13:42:52 INFO - blessings == 1.5.1 13:42:52 INFO - blobuploader == 1.2.4 13:42:52 INFO - docopt == 0.6.1 13:42:52 INFO - manifestparser == 1.1 13:42:52 INFO - mozInstall == 1.12 13:42:52 INFO - mozcrash == 0.16 13:42:52 INFO - mozdebug == 0.1 13:42:52 INFO - mozdevice == 0.47 13:42:52 INFO - mozfile == 1.2 13:42:52 INFO - mozhttpd == 0.7 13:42:52 INFO - mozinfo == 0.9 13:42:52 INFO - mozleak == 0.1 13:42:52 INFO - mozlog == 3.1 13:42:52 INFO - moznetwork == 0.27 13:42:52 INFO - mozprocess == 0.22 13:42:52 INFO - mozprofile == 0.27 13:42:52 INFO - mozrunner == 6.11 13:42:52 INFO - mozscreenshot == 0.1 13:42:52 INFO - mozsystemmonitor == 0.0 13:42:52 INFO - moztest == 0.7 13:42:52 INFO - mozversion == 1.4 13:42:52 INFO - psutil == 3.1.1 13:42:52 INFO - requests == 1.2.3 13:42:52 INFO - wsgiref == 0.1.2 13:42:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:42:52 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')]} 13:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:52 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')]} 13:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:52 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 0x7fca6314cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b240b0>, '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 0x1b24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25440>, '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': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', '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 13:42:52 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 13:42:52 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 13:42:52 INFO - Using env: {'DISPLAY': ':0', 13:42:52 INFO - 'HOME': '/home/cltbld', 13:42:52 INFO - 'LANG': 'en_US.UTF-8', 13:42:52 INFO - 'LANGUAGE': 'en_US:en', 13:42:52 INFO - 'LOGNAME': 'cltbld', 13:42:52 INFO - 'MAIL': '/var/mail/cltbld', 13:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:52 INFO - 'MOZ_NO_REMOTE': '1', 13:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:52 INFO - 'NO_EM_RESTART': '1', 13:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:52 INFO - 'PWD': '/builds/slave/test', 13:42:52 INFO - 'SHELL': '/bin/bash', 13:42:52 INFO - 'SHLVL': '1', 13:42:52 INFO - 'TERM': 'linux', 13:42:52 INFO - 'TMOUT': '86400', 13:42:52 INFO - 'USER': 'cltbld', 13:42:52 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', 13:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:52 INFO - '_': '/tools/buildbot/bin/python'} 13:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:42:53 INFO - Cleaning up... 13:42:53 INFO - Return code: 0 13:42:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca6314cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b240b0>, '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 0x1b24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25440>, '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': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', '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 13:42:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:42:53 INFO - Using env: {'DISPLAY': ':0', 13:42:53 INFO - 'HOME': '/home/cltbld', 13:42:53 INFO - 'LANG': 'en_US.UTF-8', 13:42:53 INFO - 'LANGUAGE': 'en_US:en', 13:42:53 INFO - 'LOGNAME': 'cltbld', 13:42:53 INFO - 'MAIL': '/var/mail/cltbld', 13:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:53 INFO - 'MOZ_NO_REMOTE': '1', 13:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:53 INFO - 'NO_EM_RESTART': '1', 13:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:53 INFO - 'PWD': '/builds/slave/test', 13:42:53 INFO - 'SHELL': '/bin/bash', 13:42:53 INFO - 'SHLVL': '1', 13:42:53 INFO - 'TERM': 'linux', 13:42:53 INFO - 'TMOUT': '86400', 13:42:53 INFO - 'USER': 'cltbld', 13:42:53 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', 13:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:53 INFO - '_': '/tools/buildbot/bin/python'} 13:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:53 INFO - Downloading/unpacking jsonschema 13:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:42:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 13:42:55 INFO - Downloading/unpacking functools32 (from jsonschema) 13:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:55 INFO - Downloading functools32-3.2.3-2.tar.gz 13:42:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:42:55 INFO - warning: no files found matching '*.txt' 13:42:55 INFO - no previously-included directories found matching 'build' 13:42:55 INFO - no previously-included directories found matching 'dist' 13:42:55 INFO - no previously-included directories found matching '.git*' 13:42:55 INFO - Installing collected packages: jsonschema, functools32 13:42:55 INFO - Running setup.py install for functools32 13:42:55 INFO - warning: no files found matching '*.txt' 13:42:55 INFO - no previously-included directories found matching 'build' 13:42:55 INFO - no previously-included directories found matching 'dist' 13:42:55 INFO - no previously-included directories found matching '.git*' 13:42:55 INFO - Successfully installed jsonschema functools32 13:42:55 INFO - Cleaning up... 13:42:55 INFO - Return code: 0 13:42:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:42:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca6314cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a95240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b240b0>, '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 0x1b24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25440>, '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': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', '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 13:42:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:42:55 INFO - Using env: {'DISPLAY': ':0', 13:42:55 INFO - 'HOME': '/home/cltbld', 13:42:55 INFO - 'LANG': 'en_US.UTF-8', 13:42:55 INFO - 'LANGUAGE': 'en_US:en', 13:42:55 INFO - 'LOGNAME': 'cltbld', 13:42:55 INFO - 'MAIL': '/var/mail/cltbld', 13:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:42:55 INFO - 'MOZ_NO_REMOTE': '1', 13:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:42:55 INFO - 'NO_EM_RESTART': '1', 13:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:42:55 INFO - 'PWD': '/builds/slave/test', 13:42:55 INFO - 'SHELL': '/bin/bash', 13:42:55 INFO - 'SHLVL': '1', 13:42:55 INFO - 'TERM': 'linux', 13:42:55 INFO - 'TMOUT': '86400', 13:42:55 INFO - 'USER': 'cltbld', 13:42:55 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', 13:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:42:55 INFO - '_': '/tools/buildbot/bin/python'} 13:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:42:55 INFO - Downloading/unpacking flake8 13:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:42:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 13:42:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:42:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 13:42:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:57 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 13:42:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:42:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:42:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:42:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:42:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:42:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:42:58 INFO - no previously-included directories found matching 'docs/_build' 13:42:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:42:58 INFO - Running setup.py install for pep8 13:42:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:42:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:42:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:42:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:42:58 INFO - no previously-included directories found matching 'docs/_build' 13:42:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:42:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:42:58 INFO - Cleaning up... 13:42:58 INFO - Return code: 0 13:42:58 INFO - Running post-action listener: _resource_record_post_action 13:42:58 INFO - Running post-action listener: _start_resource_monitoring 13:42:58 INFO - Starting resource monitoring. 13:42:58 INFO - ##### 13:42:58 INFO - ##### Running install step. 13:42:58 INFO - ##### 13:42:58 INFO - Running pre-action listener: _resource_record_pre_action 13:42:58 INFO - Running main action method: install 13:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:42:58 INFO - Reading from file tmpfile_stdout 13:42:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:42:58 INFO - Reading from file tmpfile_stdout 13:42:58 INFO - Output received: 13:42:58 INFO - Usage: mozinstall [options] installer 13:42:58 INFO - Options: 13:42:58 INFO - -h, --help show this help message and exit 13:42:58 INFO - -d DEST, --destination=DEST 13:42:58 INFO - Directory to install application into. [default: 13:42:58 INFO - "/builds/slave/test"] 13:42:58 INFO - --app=APP Application being installed. [default: firefox] 13:42:58 INFO - mkdir: /builds/slave/test/build/application 13:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:43:13 INFO - Reading from file tmpfile_stdout 13:43:13 INFO - Output received: 13:43:13 INFO - /builds/slave/test/build/application/firefox/firefox 13:43:13 INFO - Running post-action listener: _resource_record_post_action 13:43:13 INFO - ##### 13:43:13 INFO - ##### Running run-tests step. 13:43:13 INFO - ##### 13:43:13 INFO - Running pre-action listener: _resource_record_pre_action 13:43:13 INFO - Running main action method: run_tests 13:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:43:13 INFO - Python 2.7.3 13:43:13 INFO - Return code: 0 13:43:13 INFO - grabbing minidump binary from tooltool 13:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:43:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b240b0>, '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 0x1b24fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b25440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:43:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:43:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:43:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:43:13 INFO - Return code: 0 13:43:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:43:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:43:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:43:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:43:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:43:14 INFO - Return code: 0 13:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test/build 13:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost 13:43:14 INFO - Using env: {'DISPLAY': ':0', 13:43:14 INFO - 'HOME': '/home/cltbld', 13:43:14 INFO - 'LANG': 'en_US.UTF-8', 13:43:14 INFO - 'LANGUAGE': 'en_US:en', 13:43:14 INFO - 'LOGNAME': 'cltbld', 13:43:14 INFO - 'MAIL': '/var/mail/cltbld', 13:43:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:43:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:14 INFO - 'MOZ_NO_REMOTE': '1', 13:43:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:14 INFO - 'NO_EM_RESTART': '1', 13:43:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:14 INFO - 'PWD': '/builds/slave/test', 13:43:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:43:14 INFO - 'SHELL': '/bin/bash', 13:43:14 INFO - 'SHLVL': '1', 13:43:14 INFO - 'TERM': 'linux', 13:43:14 INFO - 'TMOUT': '86400', 13:43:14 INFO - 'USER': 'cltbld', 13:43:14 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154', 13:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:14 INFO - '_': '/tools/buildbot/bin/python'} 13:43:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 13:43:14 INFO - mozversion INFO | application_buildid: 20151210130140 13:43:14 INFO - mozversion INFO | application_changeset: 760f2be9b5490933e5c64dfab9e39b620b57c945 13:43:14 INFO - mozversion INFO | application_display_name: Nightly 13:43:14 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:43:14 INFO - mozversion INFO | application_name: Firefox 13:43:14 INFO - mozversion INFO | application_remotingname: firefox 13:43:14 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:43:14 INFO - mozversion INFO | application_vendor: Mozilla 13:43:14 INFO - mozversion INFO | application_version: 45.0a1 13:43:14 INFO - mozversion INFO | platform_buildid: 20151210130140 13:43:14 INFO - mozversion INFO | platform_changeset: 760f2be9b5490933e5c64dfab9e39b620b57c945 13:43:14 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:43:14 INFO - mozversion INFO | platform_version: 45.0a1 13:43:14 INFO - 2015-12-10 13:43:14,415 DEBUG : using testdate: 1449783794 13:43:14 INFO - 2015-12-10 13:43:14,415 DEBUG : actual date: 1449783794 13:43:14 INFO - 2015-12-10 13:43:14,423 INFO : starting webserver on 'localhost:52821' 13:43:14 INFO - 2015-12-10 13:43:14,424 INFO : Starting test suite talos-linux64-ix-028 13:43:14 INFO - 2015-12-10 13:43:14,424 INFO : Starting test dromaeo_css 13:43:14 INFO - 2015-12-10 13:43:14,424 DEBUG : operating with platform_type : linux_ 13:43:14 INFO - 2015-12-10 13:43:14,424 INFO : Initialising browser for dromaeo_css test... 13:43:14 INFO - 2015-12-10 13:43:14,435 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphcFiqH/profile http://localhost:52821/getInfo.html 13:43:18 INFO - 2015-12-10 13:43:18,795 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:43:18 INFO - 2015-12-10 13:43:18,795 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:43:18 INFO - 2015-12-10 13:43:18,795 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:43:18 INFO - 2015-12-10 13:43:18,795 DEBUG : BROWSER_OUTPUT: __metrics 13:43:18 INFO - 2015-12-10 13:43:18,872 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] 13:43:18 INFO - 2015-12-10 13:43:18,948 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:43:19 INFO - 2015-12-10 13:43:19,754 INFO : Browser initialized. 13:43:19 INFO - 2015-12-10 13:43:19,754 INFO : Running cycle 1/1 for dromaeo_css test... 13:43:19 INFO - 2015-12-10 13:43:19,755 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphcFiqH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:43:31 INFO - 2015-12-10 13:43:31,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 142348288 13:43:31 INFO - 2015-12-10 13:43:31,836 DEBUG : BROWSER_OUTPUT: 13:44:23 INFO - 2015-12-10 13:44:23,071 DEBUG : BROWSER_OUTPUT: 1449783863066 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] 13:46:33 INFO - 2015-12-10 13:46:33,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52821/tests/dromaeo/cssquery-ext.html) 13:46:34 INFO - 2015-12-10 13:46:34,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 251600896 13:46:34 INFO - 2015-12-10 13:46:34,965 DEBUG : BROWSER_OUTPUT: 13:49:37 INFO - 2015-12-10 13:49:37,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/dromaeo/cssquery-ext.html (next: http://localhost:52821/tests/dromaeo/cssquery-jquery.html) 13:49:38 INFO - 2015-12-10 13:49:38,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 221356032 13:49:38 INFO - 2015-12-10 13:49:38,008 DEBUG : BROWSER_OUTPUT: 13:52:40 INFO - 2015-12-10 13:52:40,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52821/tests/dromaeo/cssquery-mootools.html) 13:52:40 INFO - 2015-12-10 13:52:40,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 220352512 13:52:40 INFO - 2015-12-10 13:52:40,628 DEBUG : BROWSER_OUTPUT: 13:55:42 INFO - 2015-12-10 13:55:42,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52821/tests/dromaeo/cssquery-prototype.html) 13:55:43 INFO - 2015-12-10 13:55:43,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 209747968 13:55:43 INFO - 2015-12-10 13:55:43,167 DEBUG : BROWSER_OUTPUT: 13:58:45 INFO - 2015-12-10 13:58:45,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52821/tests/dromaeo/cssquery-yui.html) 13:58:46 INFO - 2015-12-10 13:58:46,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 209907712 13:58:46 INFO - 2015-12-10 13:58:46,512 DEBUG : BROWSER_OUTPUT: 14:01:48 INFO - 2015-12-10 14:01:48,987 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/dromaeo/cssquery-yui.html (next: http://localhost:52821/tests/dromaeo/cssquery-dojo.html) 14:01:49 INFO - 2015-12-10 14:01:49,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 253149184 14:01:49 INFO - 2015-12-10 14:01:49,236 DEBUG : BROWSER_OUTPUT: 14:01:49 INFO - 2015-12-10 14:01:49,238 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:01:49 INFO - 2015-12-10 14:01:49,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:01:49 INFO - 2015-12-10 14:01:49,238 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:01:49 INFO - 2015-12-10 14:01:49,238 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:01:49 INFO - 2015-12-10 14:01:49,239 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2588.779953703935;2653;2668.6130511075894;2685.8119931604783;2705.053231369021;4427.446569178853;4521.660875434343;4581.129585378776;4591.357209990604;4599.563041511055;4591.24244499658;4620.306953956908;4622.884427889305;4659.510751371108;4771.045790841837;4271.78641067947;4282.635975942048;4315.676324275676;4323.502797178317;4336.522982471925;27.06996283953498;4112.3420252759415;4298.26929421999;4369.300911854104;4398.186335527937;4233.428487154226;4262.360645903108;4307.633851122659;4418.602325790662;4440.2895536714295;4341.175176716414;4349.173657005191;4352.129574085196;4369.3009118541195;4393.1872603568445;4310.4611923509565;4320.1575692739925;4339.414179085815;4346.73919564824;4363.890902727426;4389.2977123660385;4497.145542346976;4497.617702495292;4507.5267096955;4585.220512512881;4936.234883593049;4953.653244272902;4963.156263435225;4967.7019378837385;4995.500449955011;4991.051700176955;4992.101421744084;4992.151334273182;4998.925016124761;5000.799968001275;4463.4866990296205;4571.817127314936;4576.153411618861;4577.176108300505;4686.343911852344;5112.667676601009;5113.335266415343;5117.2068329409;5122.590192784568;5163.251328557338;4906.877328066756;4915.631327650441;4917.262410638433;4917.459079501252;4964;4872.098661747588;4967.528084831935;4987.62592805541;4989.850304490871;4998.450170481244;4781.474037855833;4870.366852309177;4871.902561948741;4877.12211801879;4912.975435122873;4928.975355123202;4999.800007999712;5000.399952005782;5001.89996200074;5002.424721157041;4054.2296963576828;4165.45849039629;4169.228692691801;4177.248095342868;4199.580041995776;3554.20030493137;3612.422012477991;3619.511365965561;3622.040159357772;3647.0335361129323;4286.37847512109;4368.628666563378;4369.519352871182;4404.4494438195225;4405.867823965286;4794.880127996758;4904.117258893362;4909.533594308535;5059.215821547666;5069.062223488592;4236.766977816188;4260.616544511009;4310.181065597527;4326.805293761789;4329.631981281564;4444.2222611042935;4445.377647129404;4449.577290157495;4455.955440445554;4482.775861206992;4599.1721490132095;4722.811087556459;4761.690490118062;4761.7142971421135;4762.523747625279;4868.2210846264425;4946.62900282473;4946.653734238569;4956.10790057793;4968.602511798975;4724.102420540086;4733.668643194943;4745.667803253739;4746.240601503743;4791.9281210782565;4916.680415772963;4916.950830491649;4918.188498897642;4922.556969872729;4975.7512124392915;4830.2513110467935;4894.412670479565;4946.925796112989;4954.3311652926395;4991.3511243538105;4703.129920964632;4798;4799.736014519235;4805.927911081407;4846.781894814671;4845.345878306383;4851.32081508582;4857.732824694534;4861.95138048615;4870.95129048705;4558.498565157764;4656.743879086547;4774.236122220428;4779.3070004848405;4801.231802911518;4790.329353890388;4854.563089321837;4915.5330243626795;4926.359573255454;4943.159662857251;4755.38180036593;4773.3794606702295;4777.378940737682;4798.928016079832;4828.5412885775795 14:01:49 INFO - 2015-12-10 14:01:49,243 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.7420586530199;585.4730742331902;593.2465768474038;596.34997852341;598.7365559153973;26881;27329.45341093177;32376.838115809416;32844.17889552762;32865.67134328656;38808;39322.21355572894;39431.605683943155;39504.80247598765;39514.80242598783;7800.882986755203;7967.402444816662;7968.482048666818;7975.202479752007;7975.883376327319;7228.891566626478;7427.294407031323;9811.558479868387;10065.245106616996;10067.942865999075;9871.358361706467;9945.60217591299;9954.90045099547;9965.75085622858;9967.651132210374;7216.422686185093;7397.445191610597;9873.407595544255;9952.402855828637;9986.600535978625;7093.184283807325;9807.411555306704;10092.697219083439;10100.989901009914;10113.595456181743;36032.279354413025;36455;36458.27083458316;36540.45189322162;36546;2880.510313246732;2893.537034074559;3010.277533391992;3229.450993331139;3304.7025767680784;28166.155015349574;28173.29566760827;28270.293242668893;29646.703532964824;30793.692063079307;3428.794272343667;3469.3755124077657;3480.5475288212624;3551.200979779555;3553.2538166984964;212365;213842;213855;214182;214811;54942;55020.724896375265;55366.72316638391;55482;55562;50336;51655.48344516582;59242;59549.70225148847;65303;13427.328633568477;13558.932205339108;13614.115082519604;13646.044776865525;13657.317134143253;9319.114684105;9336.439813611205;9340.53297335144;9341.486218258062;9383.718488445358;18851.43445696631;18918.810811891704;18944.431667050012;19008.619827603372;19019.524511887037;7343.339099480965;7663.2983851229155;7728.729494467667;7740.690372385154;7824.295813376823;797.7168105322527;812.2567850416802;895.9910400895908;963.0706368354431;994.3188915592842;30021.39957200844;31280.84359578233;31349;31507.36985260282;31917.20206994844;916.913457552802;926.305271046715;943.7734943613483;944.5749412764284;1030.99484502577;14069.788953165711;14355.282235888373;14627;14932.104073755609;14933;292901;297895;298123;298300;299183;47220.52779472162;47771;47912.7604361976;47932;47933;1173.7828501727208;1201.2612243470203;1221.8289439478303;1224.8897599215936;1226.343906010298;23812.285631431085;28290.85854570714;29702.405951881272;30956.69043309538;30969.8451507741;36274.455883161245;37053.221008423934;41750.37374439446;41938;42686.14627707366;240989;244093;244403;245024;245559;37816.62183378241;37956.24087518289;38447.80776096213;38465.80767096147;38488.422673660476;40524.79737601293;40726.59273407228;41422.58577414187;41512.584874150874;41532.58467415287;34183;34331.828340858134;34946.126346840516;39820.2035959285;41967.58032419759;35688.64311356957;35968.28063438769;36363.81818090893;36761.26477470489;36831.81584092062;34778.13054673552;35292.823535882155;35847.82076089603;36095.81952090223;36146;34423.655763442046;35358.646413535535;35708;35804.462933056544;36090.63909360978;25328.366790830376;25882.741172588034;25889.352766180997;26295.60556591691;26316.21051368462 14:01:49 INFO - 2015-12-10 14:01:49,243 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.41108881634773;341.09609534732954;342.01329165357936;343.5619585029089;346.0604458894102;13251.204927704344;13850;15910.363585456582;16068.67862642748;16792.160391980397;9805.460699661517;13382.93308533456;16592.751108733377;16596.50210493684;16615.006199256077;4450.933236001462;4561.338605902142;4570.063137056912;4572.519885412034;4576.06190730901;3545.4327307630783;3671.192337685718;4289.871303860889;4321.762303073329;5155.072087024334;5232.215167724853;5280.867978300554;5310.15037593985;5325.920111198335;5329.147336426173;5093.465186155456;5204.375474942994;5220.686758794484;5243;5248.527632513092;5044.848654540369;5047.9747601262125;5060.898782024376;5063.594912406998;5067.0879241736475;11212.607558735404;12200.328981905992;12234.204776689487;12271.69320766979;12290.078244131637;1775.0947017021283;1775.1035726957803;1807.1325763633529;1834.257125864014;1842.8709990300683;9039;10190.133838623726;10327.483625818679;12612.81080783789;13088.541901033514;1694.8220436854199;1711.922963466647;1729.2477772169148;1747.5106970048407;1784.1971112999202;50118;51233;53209.46790532084;54235;55870.720646396505;9356.906430935604;9694.75763105914;10048.397096174253;10054.54754536033;10067.144292735053;12665.873341266653;12684.23894566329;12706.301153436465;12733.36333183337;12743.107982441326;6934;6948.27043160471;7028.789136325919;7055.858882822315;7061.152661680631;6631.673665266966;6640.701168447432;6646.235682896432;6647.202335719648;6699.229588597276;4243.702940794176;4270.829166833354;4295.656347492193;4310.6335961443;4314.482262128565;1594.537584100621;1650.8101568319557;1682.3943380383052;1684.1410880450812;1732.6003485172873;807.9838403231903;814.2956342763467;825.5748289630845;879.4926840850301;910.1990248581207;15369.538913832603;15508.759299256033;15790.842091578937;15907.840921590867;16015.919920400323;738.2469880721634;750.9324160825552;771.6758961236294;775.4378075894931;817.3257062923112;8500.319974402157;8589.226969572768;8593.570321483901;8708.303335733126;8747.825043499095;440475;449417;456467;458131;459090;68541.31458685349;69603.65198174078;69613.65193174103;70601;71026.28973710196;999.5551979369111;1009.8283291840405;1013.108464551205;1015.5328548867456;1028.043919155178;13555.93222033923;13746.243956582484;14295.213763242706;14320.212388318743;14492.34784434682;29980.700192997792;31076.844615776776;31823.840880795447;31951;35045.82477087598;40073;41020.1795964085;42211.577884221995;42533.36199957065;44185;8397.580120994047;8644;8811.691590794291;9070;9075.319351048829;10921.781564368826;10940.945295273472;10952.780944381228;15065.774013390028;17027.91486042562;13879.16724996463;13960.58118256454;13995.930020349833;14205.431782728576;14468;12961.935190323988;13352.399142038437;14003.859961400256;14082.225477598831;14137.363818628392;13356.465741370625;13509.527166549124;13607.387667555182;14410.351534180778;14619.488317908823;8909.599068042084;8993.7751556209;9040.095990400907;9120.087991200828;9133.497657628894;10259.384436933808;13989.510367137102;14098.083624564371;14186.929065354607;14190.432382704576 14:01:49 INFO - 2015-12-10 14:01:49,247 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1375.77299745542;1406.4093080906018;1413.4840783114166;1589.3801417447198;1684.4441334359658;5858.619189752663;6813.863722725542;6971.930280697192;6985;6988.266232045638;6889.207741109773;7071.328223818729;7071.717131314754;7079.575225486475;7083.681234344454;1767.982320176801;1798.6762382771096;1802.6394721055776;2032.4715573950732;2071.6892466130125;2036.389083275019;2083;2085.447356450542;2086.6452703040445;2089.352300786761;2067.266120527214;2069.1516478243925;2083.8228750556223;2114;2116.47088227943;2057.4856285928518;2085.7914208579095;2108.5888251790907;2111.6621340585584;2113.0596884386377;2107.4520624637703;2134.3916983659738;2136.6688163334707;2138.379869837745;2141.271967531047;6923.6884340204815;6982.406495447843;6983.615901125436;6986.266442023565;6993.0908981832035;4173.91652166958;4238.173556156551;4263.18999390118;4270.12462445198;4276.486821581399;2563.9102631408;2669.5194864924306;2674.17100698784;2675.0770984010487;2682.5439675255056;805.8549461097;818.467995802727;829.867221244604;843.9113893041265;870.1516021878617;9653.17947974423;9656.90343096567;9666.468344241064;9692.176165025981;9698.806023879482;3869.671077958405;3941.1329507508303;3944.4674968878835;3950.3876899080688;4016.357382818793;8179.100298967109;8196.59017049157;8197.303229225463;8199.95900020496;8221.136780637948;4234;4237.87286381409;4242;4249.128928569698;4260.659147268211;3832.5400951885395;3850.2876967761053;3862.594427585063;3873.1285460771664;3876.9418458723144;3015.2461884528866;3113.0193988893425;3136.6706495818066;3415.1291420687567;3490.110021944388;1089.624079692505;1115.2639258089785;1117.5082963496036;1123.2474242257706;1135.1146106037304;933.2906990687127;933.477252738455;973.8880028796779;988.6885631026204;1179.55177032727;6550.541462097703;6609.3060228675295;6613.4709223262025;6618.569792963442;6621.271660117383;1015.9136473399844;1019.8674172357546;1033.395463653771;1033.7715265525121;1042.0413219837767;4996.7001979881325;5023.623228257895;5040.218766091261;5042.470540593258;5054.82308119214;7865.646045927947;8053.516788992679;8119.634616442274;8131.227533384319;8255.215754503313;8144.30773384269;8249.29880960113;8250.46371985819;8257.504549727035;8262.586870656443;6548.443382312462;6553.082568440422;6658.733650654017;6771.72913083481;6776.08522849409;6659.467242620675;6720.764773232913;6726.428253598499;6730.764423245163;6736.461083113437;7428.591427471541;7648.923510764821;7650.4644674872225;7734.729284475016;7741.690332386642;7754.922450775645;7768.53388796674;7911.960440197762;8031;8040.3969702273735;5943.435373639497;6096.75612975476;6127.601705889103;6160;6175.660338681416;5862.677552734641;6008.03871380577;6020.578559500968;6748.763793267212;6830.112085428863;5700.800471983461;5759.395263497272;6080.695965201634;6207.596506227081;6320.241571011508;6079.088136779518;6128.816135515942;6160.630362178104;6173.938260617337;6221.751129954932;6242.406971337716;6280.403361680633;6284.24589049317;6287.654179020198;6288.088227207121;5784.681842498703;5799.246098007232;5863.677497737665;5868.119782032729;5869.383714709894;5981.9401805983125;6005.36943620931;6013.699315034143;6021.397860213943;6042.0332746760305 14:01:49 INFO - 2015-12-10 14:01:49,247 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.42728815251024;312.1540624906504;313.9183812208825;314.8853060167009;315.7947334232747;5121.8463446096675;5255.553277971372;5303.7082960437165;5334.786608535659;5352.866178345538;5107.897842043166;5205.0370681423865;5277;5283.471652834714;5303.098473259545;4155.812988415529;4158.8336466541305;4159.209750147477;4174.08170202555;4174.519930208035;3952.8814135575835;4041.797910104483;4044.2315959967514;4170.582941705836;4176.352665336878;4115.814788334517;4134.6692264618905;4135.627793498585;4137.855175068873;4152.792360381969;4122.979385103085;4127.504699436087;4128.298189307825;4130.256553820311;4142.171565686875;3647.0517665407187;3654.3604869148057;3656;3672.9081772955624;3673.2837096766143;5012.649114561982;5053.722045287508;5111.05445492585;5119.744012799345;5119.820806271762;4728;4777.856664300077;4784.736839473828;4784.976075119637;4793.161196790547;5574.052411090124;5586.385497595261;5586.581006424534;5590.832275031756;5600.439956004408;3779.79211143387;3861.4980052593264;3885.7668539887695;3989.98005009976;3994.560598334181;5835.679037652927;5837.211976383176;5872.236609240771;5872.383399743051;5884.264466941632;4115.42384066231;4119.8352065917625;4121.340585506365;4121.52602450722;4122.40225167349;4177.498700156001;4181.247375472383;4183.5398106208295;4186.497620285585;4192.182524407711;4652.209124448852;4730.935539503585;4741.0754902794315;4749.430068391815;4763.976180119077;5603.943960560424;5606;5613.803516876889;5616.831495055073;5623.493885550321;1455.3960106555874;1483.3769816677022;1486.6060493969107;1487.5462983790048;1488.2261224163374;1001.5643195209962;1015.1219195395929;1019.9953046249439;1027.9331843430152;1031.4739482863642;4900.2894580286375;4914.066327397783;4916.262560615936;4919.508049195052;4920.803167873245;5789.94210057894;5793.24687790593;5795;5796.710164491758;5801.042827933344;4884.4871288514905;4888.95111048885;4898;4898.265260210926;4898.755062246873;3042.4067306874945;3082.1061892051052;3096.7212950834532;3114.9377012460077;3121.5161649944293;5466.043442397565;5473.616846820764;5476.945230547723;5478.205660179252;5482.890342193214;5927.199828023248;5935.376785437553;5935.436133567304;5936.851578710481;5947.583669143119;5460.918086228709;5465.863353416196;5474.09677403224;5475.0418676731415;5476.72616369172;5634.267545219095;5775.393583673654;5778;5837.153612726216;5838.854028649318;5409.594280428905;5604;5612.410696876769;5645.435456454486;5653.462921022497;5378.650387724785;5424.267723857229;5426;5502.9174562382395;5529.474699903502;4134.91730165401;4143.109231515239;4149.6265336119895;4150.91698166041;4152.937705934474;5698.8290351289525;5785.537157027512;5811.680357580373;5819.592628515963;5823.417658234142;5523.088690366205;5617.382087970238;5622.915656265078;5627.43725627434;5629.324481062299;5598.86002849932;5613.915791263216;5619.915701264403;5623.746931388016;5623.803166889139;5485.917711234255;5506.5870059746485;5509.090999984957;5512.5589952804485;5513.476219759116;5537.36320323168;5658.066419040812;5664.5751568631695;5664.85837854057;5670;5518.392976772471;5528.834134975958;5532.391436942014;5533.087040638411;5537.390887002507 14:01:49 INFO - 2015-12-10 14:01:49,247 DEBUG : BROWSER_OUTPUT: |5;yui.html;745.2510227221642;766.5017738469994;787.9409044321674;805.9274665280124;825.2119226139038;13439.328033598318;13626.114302570326;13670.521531746392;13672.248026358546;13813.240271785047;13522;13525.323733813319;13645.45418183274;13649.727005459885;13655.931720341408;634.4226753654176;644.7195469970578;798.4211446701154;813.8901248331458;814.5845618734429;813.5037627047526;820.0937963550251;824.6495239523178;828.6229765456703;828.6768160417442;853.2278288149234;857.3826844671827;857.4041041476146;859.8882145321099;860.1742327365737;669.3072669786771;678.565717940516;679.8062552172607;834.8079941613403;853.4964371021097;626.6929204689669;629.128656810321;629.5561629051508;629.710333246707;629.9559030867841;12146.45340959659;12231.633051008484;12381.257124572554;12391.194572352859;12394.132410731252;10153.898461015444;11230;11246.268992515543;11251.83122253167;11729.88270117305;8950.955245223797;9048.41185322952;9057.81884362309;9122.635094596208;9273.72178834636;3205.5512228288057;3248.3178532507964;3254.1213872254357;3258.038878530839;3267.0852161394846;38692.61307386918;38734.320239577195;38917.22165556673;38919.805400972815;39297.60702392968;8916.910830891738;8946.776330591658;9215.90784092164;9241.3531052827;9357.532123393803;16004;16009.199540022952;16012.919935400249;16041.037537747772;16052.678946421007;5868.589198756132;6003.549733769897;6121.510279177655;6145.661988590581;6184.845378865564;3326.3846188455213;3386.119608901654;3390.1016230698883;3470.7917524948584;3485.4597537381746;2753.1465245773875;2757.1039412191117;2766.4743698697184;2775.0287399410045;2775.2368098772595;455.0126226089394;464.05101567294963;464.57723471640645;466.11438267292414;475.9619230461555;415.66331271670043;416.8353500367338;460.09591153383764;472.9358942379646;493.767929073335;7081.327273908971;7181.640917954186;7244.13070431541;7281.781546553612;7432.108147022392;445.5633479190412;459.99080018400116;473.3986742848072;482.08644618447846;546.2952790899695;3387.2886693794085;3392.6268110508317;3420.8289585520624;3428.6057103432927;3536.204354020325;45948.770256148506;46236.075278494245;46829.76585117052;47203.763981180564;47459;42569;42752;42812.143757124686;42982;43269.78365108154;40686.575969841506;41008.58991410048;41143.7942810284;41188.176236475105;41513.792431037655;7223.602701851449;7394.852102957803;7523.548587084792;7713.267239612453;7792.649330780015;29509.26226844346;29749.25626859259;30205;30534;30631.693683062884;36983.63016369802;37312.253754924204;38573.614263857;39091.413628795024;39218;9796.65711700087;9858.440356933137;9868.605255789687;9963.701088967342;10011.399316041061;10760.838587421038;10980.505877235384;10983.725406864893;11242.437878106226;11494.655160345203;10523.94738026305;10821.891781082404;10859.782804344028;10879.347239165676;10983.670489885317;10077.546510406903;10146.594136234764;10153.441560714231;10343.689689309333;10601.575936962743;9647.758806029906;9788.510574471391;9858.556364963737;9944.204463642747;9973.551190196604;8790.780230494289;8929.330300227379;8994.280457563249;9196.08039196075;9220.354575179674;7278.818029549304;7311.232320606472;7360.595167265852;7383.114026316876;7490.176080631018 14:01:49 INFO - 2015-12-10 14:01:49,247 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:01:49 INFO - 2015-12-10 14:01:49,247 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:01:49 INFO - 2015-12-10 14:01:49,247 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,901 14:01:49 INFO - 2015-12-10 14:01:49,247 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:01:49 INFO - 2015-12-10 14:01:49,247 DEBUG : BROWSER_OUTPUT: __startTimestamp1449784909237__endTimestamp 14:01:49 INFO - 2015-12-10 14:01:49,248 DEBUG : BROWSER_OUTPUT: 14:01:49 INFO - 2015-12-10 14:01:49,248 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:01:49 INFO - 2015-12-10 14:01:49,248 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:01:49 INFO - 2015-12-10 14:01:49,248 DEBUG : BROWSER_OUTPUT: 14:01:49 INFO - 2015-12-10 14:01:49,248 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4565.08 Median:4746.24 stddev:590.85 (12.4%) stddev-sans-first:571.96 14:01:49 INFO - 2015-12-10 14:01:49,249 DEBUG : BROWSER_OUTPUT: Values: 2588.8 2653.0 2668.6 2685.8 2705.1 4427.4 4521.7 4581.1 4591.4 4599.6 4591.2 4620.3 4622.9 4659.5 4771.0 4271.8 4282.6 4315.7 4323.5 4336.5 27.1 4112.3 4298.3 4369.3 4398.2 4233.4 4262.4 4307.6 4418.6 4440.3 4341.2 4349.2 4352.1 4369.3 4393.2 4310.5 4320.2 4339.4 4346.7 4363.9 4389.3 4497.1 4497.6 4507.5 4585.2 4936.2 4953.7 4963.2 4967.7 4995.5 4991.1 4992.1 4992.2 4998.9 5000.8 4463.5 4571.8 4576.2 4577.2 4686.3 5112.7 5113.3 5117.2 5122.6 5163.3 4906.9 4915.6 4917.3 4917.5 4964.0 4872.1 4967.5 4987.6 4989.9 4998.5 4781.5 4870.4 4871.9 4877.1 4913.0 4929.0 4999.8 5000.4 5001.9 5002.4 4054.2 4165.5 4169.2 4177.2 4199.6 3554.2 3612.4 3619.5 3622.0 3647.0 4286.4 4368.6 4369.5 4404.4 4405.9 4794.9 4904.1 4909.5 5059.2 5069.1 4236.8 4260.6 4310.2 4326.8 4329.6 4444.2 4445.4 4449.6 4456.0 4482.8 4599.2 4722.8 4761.7 4761.7 4762.5 4868.2 4946.6 4946.7 4956.1 4968.6 4724.1 4733.7 4745.7 4746.2 4791.9 4916.7 4917.0 4918.2 4922.6 4975.8 4830.3 4894.4 4946.9 4954.3 4991.4 4703.1 4798.0 4799.7 4805.9 4846.8 4845.3 4851.3 4857.7 4862.0 4871.0 4558.5 4656.7 4774.2 4779.3 4801.2 4790.3 4854.6 4915.5 4926.4 4943.2 4755.4 4773.4 4777.4 4798.9 4828.5 14:01:49 INFO - 2015-12-10 14:01:49,249 DEBUG : BROWSER_OUTPUT: 14:01:49 INFO - 2015-12-10 14:01:49,249 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42213.69 Median:36120.91 stddev:66136.71 (183.1%) stddev-sans-first:66248.29 14:01:49 INFO - 2015-12-10 14:01:49,249 DEBUG : BROWSER_OUTPUT: Values: 560.7 585.5 593.2 596.3 598.7 26881.0 27329.5 32376.8 32844.2 32865.7 38808.0 39322.2 39431.6 39504.8 39514.8 7800.9 7967.4 7968.5 7975.2 7975.9 7228.9 7427.3 9811.6 10065.2 10067.9 9871.4 9945.6 9954.9 9965.8 9967.7 7216.4 7397.4 9873.4 9952.4 9986.6 7093.2 9807.4 10092.7 10101.0 10113.6 36032.3 36455.0 36458.3 36540.5 36546.0 2880.5 2893.5 3010.3 3229.5 3304.7 28166.2 28173.3 28270.3 29646.7 30793.7 3428.8 3469.4 3480.5 3551.2 3553.3 212365.0 213842.0 213855.0 214182.0 214811.0 54942.0 55020.7 55366.7 55482.0 55562.0 50336.0 51655.5 59242.0 59549.7 65303.0 13427.3 13558.9 13614.1 13646.0 13657.3 9319.1 9336.4 9340.5 9341.5 9383.7 18851.4 18918.8 18944.4 19008.6 19019.5 7343.3 7663.3 7728.7 7740.7 7824.3 797.7 812.3 896.0 963.1 994.3 30021.4 31280.8 31349.0 31507.4 31917.2 916.9 926.3 943.8 944.6 1031.0 14069.8 14355.3 14627.0 14932.1 14933.0 292901.0 297895.0 298123.0 298300.0 299183.0 47220.5 47771.0 47912.8 47932.0 47933.0 1173.8 1201.3 1221.8 1224.9 1226.3 23812.3 28290.9 29702.4 30956.7 30969.8 36274.5 37053.2 41750.4 41938.0 42686.1 240989.0 244093.0 244403.0 245024.0 245559.0 37816.6 37956.2 38447.8 38465.8 38488.4 40524.8 40726.6 41422.6 41512.6 41532.6 34183.0 34331.8 34946.1 39820.2 41967.6 35688.6 35968.3 36363.8 36761.3 36831.8 34778.1 35292.8 35847.8 36095.8 36146.0 34423.7 35358.6 35708.0 35804.5 36090.6 25328.4 25882.7 25889.4 26295.6 26316.2 14:01:49 INFO - 2015-12-10 14:01:49,249 DEBUG : BROWSER_OUTPUT: 14:01:49 INFO - 2015-12-10 14:01:49,249 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24990.41 Median:3608.31 stddev:73961.71 (2049.8%) stddev-sans-first:74146.04 14:01:49 INFO - 2015-12-10 14:01:49,250 DEBUG : BROWSER_OUTPUT: Values: 340.4 341.1 342.0 343.6 346.1 13251.2 13850.0 15910.4 16068.7 16792.2 9805.5 13382.9 16592.8 16596.5 16615.0 4450.9 4561.3 4570.1 4572.5 4576.1 3545.4 3671.2 4289.9 4321.8 5155.1 5232.2 5280.9 5310.2 5325.9 5329.1 5093.5 5204.4 5220.7 5243.0 5248.5 5044.8 5048.0 5060.9 5063.6 5067.1 11212.6 12200.3 12234.2 12271.7 12290.1 1775.1 1775.1 1807.1 1834.3 1842.9 9039.0 10190.1 10327.5 12612.8 13088.5 1694.8 1711.9 1729.2 1747.5 1784.2 50118.0 51233.0 53209.5 54235.0 55870.7 9356.9 9694.8 10048.4 10054.5 10067.1 12665.9 12684.2 12706.3 12733.4 12743.1 6934.0 6948.3 7028.8 7055.9 7061.2 6631.7 6640.7 6646.2 6647.2 6699.2 4243.7 4270.8 4295.7 4310.6 4314.5 1594.5 1650.8 1682.4 1684.1 1732.6 808.0 814.3 825.6 879.5 910.2 15369.5 15508.8 15790.8 15907.8 16015.9 738.2 750.9 771.7 775.4 817.3 8500.3 8589.2 8593.6 8708.3 8747.8 440475.0 449417.0 456467.0 458131.0 459090.0 68541.3 69603.7 69613.7 70601.0 71026.3 999.6 1009.8 1013.1 1015.5 1028.0 13555.9 13746.2 14295.2 14320.2 14492.3 29980.7 31076.8 31823.8 31951.0 35045.8 40073.0 41020.2 42211.6 42533.4 44185.0 8397.6 8644.0 8811.7 9070.0 9075.3 10921.8 10940.9 10952.8 15065.8 17027.9 13879.2 13960.6 13995.9 14205.4 14468.0 12961.9 13352.4 14003.9 14082.2 14137.4 13356.5 13509.5 13607.4 14410.4 14619.5 8909.6 8993.8 9040.1 9120.1 9133.5 10259.4 13989.5 14098.1 14186.9 14190.4 14:01:49 INFO - 2015-12-10 14:01:49,250 DEBUG : BROWSER_OUTPUT: 14:01:49 INFO - 2015-12-10 14:01:49,250 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4891.93 Median:6020.99 stddev:2520.77 (41.9%) stddev-sans-first:2513.99 14:01:49 INFO - 2015-12-10 14:01:49,251 DEBUG : BROWSER_OUTPUT: Values: 1375.8 1406.4 1413.5 1589.4 1684.4 5858.6 6813.9 6971.9 6985.0 6988.3 6889.2 7071.3 7071.7 7079.6 7083.7 1768.0 1798.7 1802.6 2032.5 2071.7 2036.4 2083.0 2085.4 2086.6 2089.4 2067.3 2069.2 2083.8 2114.0 2116.5 2057.5 2085.8 2108.6 2111.7 2113.1 2107.5 2134.4 2136.7 2138.4 2141.3 6923.7 6982.4 6983.6 6986.3 6993.1 4173.9 4238.2 4263.2 4270.1 4276.5 2563.9 2669.5 2674.2 2675.1 2682.5 805.9 818.5 829.9 843.9 870.2 9653.2 9656.9 9666.5 9692.2 9698.8 3869.7 3941.1 3944.5 3950.4 4016.4 8179.1 8196.6 8197.3 8200.0 8221.1 4234.0 4237.9 4242.0 4249.1 4260.7 3832.5 3850.3 3862.6 3873.1 3876.9 3015.2 3113.0 3136.7 3415.1 3490.1 1089.6 1115.3 1117.5 1123.2 1135.1 933.3 933.5 973.9 988.7 1179.6 6550.5 6609.3 6613.5 6618.6 6621.3 1015.9 1019.9 1033.4 1033.8 1042.0 4996.7 5023.6 5040.2 5042.5 5054.8 7865.6 8053.5 8119.6 8131.2 8255.2 8144.3 8249.3 8250.5 8257.5 8262.6 6548.4 6553.1 6658.7 6771.7 6776.1 6659.5 6720.8 6726.4 6730.8 6736.5 7428.6 7648.9 7650.5 7734.7 7741.7 7754.9 7768.5 7912.0 8031.0 8040.4 5943.4 6096.8 6127.6 6160.0 6175.7 5862.7 6008.0 6020.6 6748.8 6830.1 5700.8 5759.4 6080.7 6207.6 6320.2 6079.1 6128.8 6160.6 6173.9 6221.8 6242.4 6280.4 6284.2 6287.7 6288.1 5784.7 5799.2 5863.7 5868.1 5869.4 5981.9 6005.4 6013.7 6021.4 6042.0 14:01:49 INFO - 2015-12-10 14:01:49,251 DEBUG : BROWSER_OUTPUT: 14:01:49 INFO - 2015-12-10 14:01:49,251 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4654.34 Median:5120.83 stddev:1347.32 (26.3%) stddev-sans-first:1310.88 14:01:49 INFO - 2015-12-10 14:01:49,251 DEBUG : BROWSER_OUTPUT: Values: 301.4 312.2 313.9 314.9 315.8 5121.8 5255.6 5303.7 5334.8 5352.9 5107.9 5205.0 5277.0 5283.5 5303.1 4155.8 4158.8 4159.2 4174.1 4174.5 3952.9 4041.8 4044.2 4170.6 4176.4 4115.8 4134.7 4135.6 4137.9 4152.8 4123.0 4127.5 4128.3 4130.3 4142.2 3647.1 3654.4 3656.0 3672.9 3673.3 5012.6 5053.7 5111.1 5119.7 5119.8 4728.0 4777.9 4784.7 4785.0 4793.2 5574.1 5586.4 5586.6 5590.8 5600.4 3779.8 3861.5 3885.8 3990.0 3994.6 5835.7 5837.2 5872.2 5872.4 5884.3 4115.4 4119.8 4121.3 4121.5 4122.4 4177.5 4181.2 4183.5 4186.5 4192.2 4652.2 4730.9 4741.1 4749.4 4764.0 5603.9 5606.0 5613.8 5616.8 5623.5 1455.4 1483.4 1486.6 1487.5 1488.2 1001.6 1015.1 1020.0 1027.9 1031.5 4900.3 4914.1 4916.3 4919.5 4920.8 5789.9 5793.2 5795.0 5796.7 5801.0 4884.5 4889.0 4898.0 4898.3 4898.8 3042.4 3082.1 3096.7 3114.9 3121.5 5466.0 5473.6 5476.9 5478.2 5482.9 5927.2 5935.4 5935.4 5936.9 5947.6 5460.9 5465.9 5474.1 5475.0 5476.7 5634.3 5775.4 5778.0 5837.2 5838.9 5409.6 5604.0 5612.4 5645.4 5653.5 5378.7 5424.3 5426.0 5502.9 5529.5 4134.9 4143.1 4149.6 4150.9 4152.9 5698.8 5785.5 5811.7 5819.6 5823.4 5523.1 5617.4 5622.9 5627.4 5629.3 5598.9 5613.9 5619.9 5623.7 5623.8 5485.9 5506.6 5509.1 5512.6 5513.5 5537.4 5658.1 5664.6 5664.9 5670.0 5518.4 5528.8 5532.4 5533.1 5537.4 14:01:49 INFO - 2015-12-10 14:01:49,251 DEBUG : BROWSER_OUTPUT: 14:01:49 INFO - 2015-12-10 14:01:49,251 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11969.40 Median:23204.38 stddev:13347.18 (57.5%) stddev-sans-first:13358.00 14:01:49 INFO - 2015-12-10 14:01:49,252 DEBUG : BROWSER_OUTPUT: Values: 745.3 766.5 787.9 805.9 825.2 13439.3 13626.1 13670.5 13672.2 13813.2 13522.0 13525.3 13645.5 13649.7 13655.9 634.4 644.7 798.4 813.9 814.6 813.5 820.1 824.6 828.6 828.7 853.2 857.4 857.4 859.9 860.2 669.3 678.6 679.8 834.8 853.5 626.7 629.1 629.6 629.7 630.0 12146.5 12231.6 12381.3 12391.2 12394.1 10153.9 11230.0 11246.3 11251.8 11729.9 8951.0 9048.4 9057.8 9122.6 9273.7 3205.6 3248.3 3254.1 3258.0 3267.1 38692.6 38734.3 38917.2 38919.8 39297.6 8916.9 8946.8 9215.9 9241.4 9357.5 16004.0 16009.2 16012.9 16041.0 16052.7 5868.6 6003.5 6121.5 6145.7 6184.8 3326.4 3386.1 3390.1 3470.8 3485.5 2753.1 2757.1 2766.5 2775.0 2775.2 455.0 464.1 464.6 466.1 476.0 415.7 416.8 460.1 472.9 493.8 7081.3 7181.6 7244.1 7281.8 7432.1 445.6 460.0 473.4 482.1 546.3 3387.3 3392.6 3420.8 3428.6 3536.2 45948.8 46236.1 46829.8 47203.8 47459.0 42569.0 42752.0 42812.1 42982.0 43269.8 40686.6 41008.6 41143.8 41188.2 41513.8 7223.6 7394.9 7523.5 7713.3 7792.6 29509.3 29749.3 30205.0 30534.0 30631.7 36983.6 37312.3 38573.6 39091.4 39218.0 9796.7 9858.4 9868.6 9963.7 10011.4 10760.8 10980.5 10983.7 11242.4 11494.7 10523.9 10821.9 10859.8 10879.3 10983.7 10077.5 10146.6 10153.4 10343.7 10601.6 9647.8 9788.5 9858.6 9944.2 9973.6 8790.8 8929.3 8994.3 9196.1 9220.4 7278.8 7311.2 7360.6 7383.1 7490.2 14:01:49 INFO - 2015-12-10 14:01:49,252 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:01:49 INFO - 2015-12-10 14:01:49,252 DEBUG : BROWSER_OUTPUT: 14:01:50 INFO - 2015-12-10 14:01:50,021 INFO : Browser exited with error code: 0 14:01:50 INFO - 2015-12-10 14:01:50,042 INFO : Completed test dromaeo_css (00:18:35) 14:01:50 INFO - 2015-12-10 14:01:50,043 INFO : Starting test kraken 14:01:50 INFO - 2015-12-10 14:01:50,043 DEBUG : operating with platform_type : linux_ 14:01:50 INFO - 2015-12-10 14:01:50,043 INFO : Initialising browser for kraken test... 14:01:50 INFO - 2015-12-10 14:01:50,049 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeF6Vzh/profile http://localhost:52821/getInfo.html 14:01:53 INFO - 2015-12-10 14:01:53,902 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:01:53 INFO - 2015-12-10 14:01:53,902 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:01:53 INFO - 2015-12-10 14:01:53,902 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:01:53 INFO - 2015-12-10 14:01:53,902 DEBUG : BROWSER_OUTPUT: __metrics 14:01:53 INFO - 2015-12-10 14:01:53,978 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] 14:01:54 INFO - 2015-12-10 14:01:54,055 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:01:55 INFO - 2015-12-10 14:01:55,167 INFO : Browser initialized. 14:01:55 INFO - 2015-12-10 14:01:55,167 INFO : Running cycle 1/1 for kraken test... 14:01:55 INFO - 2015-12-10 14:01:55,168 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeF6Vzh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:02:07 INFO - 2015-12-10 14:02:07,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 142450688 14:02:07 INFO - 2015-12-10 14:02:07,222 DEBUG : BROWSER_OUTPUT: 14:02:09 INFO - 2015-12-10 14:02:09,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52821/tests/kraken/driver.html?testName=audio-beat-detection) 14:02:10 INFO - 2015-12-10 14:02:10,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 178274304 14:02:10 INFO - 2015-12-10 14:02:10,439 DEBUG : BROWSER_OUTPUT: 14:02:13 INFO - 2015-12-10 14:02:13,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52821/tests/kraken/driver.html?testName=audio-dft) 14:02:13 INFO - 2015-12-10 14:02:13,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 166547456 14:02:13 INFO - 2015-12-10 14:02:13,784 DEBUG : BROWSER_OUTPUT: 14:02:16 INFO - 2015-12-10 14:02:16,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52821/tests/kraken/driver.html?testName=audio-fft) 14:02:17 INFO - 2015-12-10 14:02:17,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 154411008 14:02:17 INFO - 2015-12-10 14:02:17,342 DEBUG : BROWSER_OUTPUT: 14:02:19 INFO - 2015-12-10 14:02:19,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52821/tests/kraken/driver.html?testName=audio-oscillator) 14:02:19 INFO - 2015-12-10 14:02:19,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 155889664 14:02:19 INFO - 2015-12-10 14:02:19,958 DEBUG : BROWSER_OUTPUT: 14:02:22 INFO - 2015-12-10 14:02:22,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52821/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:02:22 INFO - 2015-12-10 14:02:22,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 157163520 14:02:22 INFO - 2015-12-10 14:02:22,810 DEBUG : BROWSER_OUTPUT: 14:02:25 INFO - 2015-12-10 14:02:25,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52821/tests/kraken/driver.html?testName=imaging-darkroom) 14:02:26 INFO - 2015-12-10 14:02:26,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 157605888 14:02:26 INFO - 2015-12-10 14:02:26,347 DEBUG : BROWSER_OUTPUT: 14:02:29 INFO - 2015-12-10 14:02:29,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52821/tests/kraken/driver.html?testName=imaging-desaturate) 14:02:30 INFO - 2015-12-10 14:02:30,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 157724672 14:02:30 INFO - 2015-12-10 14:02:30,395 DEBUG : BROWSER_OUTPUT: 14:02:33 INFO - 2015-12-10 14:02:33,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52821/tests/kraken/driver.html?testName=json-parse-financial) 14:02:33 INFO - 2015-12-10 14:02:33,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 159338496 14:02:33 INFO - 2015-12-10 14:02:33,820 DEBUG : BROWSER_OUTPUT: 14:02:35 INFO - 2015-12-10 14:02:35,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52821/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:02:36 INFO - 2015-12-10 14:02:36,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 167477248 14:02:36 INFO - 2015-12-10 14:02:36,147 DEBUG : BROWSER_OUTPUT: 14:02:38 INFO - 2015-12-10 14:02:38,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52821/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:02:38 INFO - 2015-12-10 14:02:38,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 167723008 14:02:38 INFO - 2015-12-10 14:02:38,596 DEBUG : BROWSER_OUTPUT: 14:02:40 INFO - 2015-12-10 14:02:40,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52821/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:02:41 INFO - 2015-12-10 14:02:41,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 178614272 14:02:41 INFO - 2015-12-10 14:02:41,316 DEBUG : BROWSER_OUTPUT: 14:02:43 INFO - 2015-12-10 14:02:43,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:02:44 INFO - 2015-12-10 14:02:44,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 184750080 14:02:44 INFO - 2015-12-10 14:02:44,472 DEBUG : BROWSER_OUTPUT: 14:02:47 INFO - 2015-12-10 14:02:47,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:02:47 INFO - 2015-12-10 14:02:47,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 182009856 14:02:47 INFO - 2015-12-10 14:02:47,642 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52821/tests/kraken/driver.html?testName=ai-astar) 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: RSS: Main: 239808512 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;106;112;112;112;100;111;111;115 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;130;164;176;137;165;158;132;170;130 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;161;162;163;161;162;162;162 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;86;90;72;71;72;99;90;73 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;139;94;95;94;131;95;95;126 14:02:49 INFO - 2015-12-10 14:02:49,678 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;110;110;109;109;109 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;148;151;148;150;149;149;148;150;147 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;96;95;95;96;96;96 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;72;71;71;71;73;80;68;69 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;68;68;69;69;69 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;84;83;84;85;83;85;88;85 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;120;128;122;124;119;136;128;122;131 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;144;145;146;145;149;147;146;146;134 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;68;68;69;68;68;70;68;70;68 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: __startTimestamp1449784969673__endTimestamp 14:02:49 INFO - 2015-12-10 14:02:49,679 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,680 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:02:49 INFO - 2015-12-10 14:02:49,680 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:02:49 INFO - 2015-12-10 14:02:49,680 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,680 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:4.22 (3.8%) stddev-sans-first:4.46 14:02:49 INFO - 2015-12-10 14:02:49,681 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 106.0 112.0 112.0 112.0 100.0 111.0 111.0 115.0 14:02:49 INFO - 2015-12-10 14:02:49,681 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,681 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.00 Median:161.00 stddev:17.88 (11.1%) stddev-sans-first:18.83 14:02:49 INFO - 2015-12-10 14:02:49,681 DEBUG : BROWSER_OUTPUT: Values: 158.0 130.0 164.0 176.0 137.0 165.0 158.0 132.0 170.0 130.0 14:02:49 INFO - 2015-12-10 14:02:49,681 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,681 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 14:02:49 INFO - 2015-12-10 14:02:49,681 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 161.0 162.0 163.0 161.0 162.0 162.0 162.0 14:02:49 INFO - 2015-12-10 14:02:49,681 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:79.50 stddev:10.37 (13.0%) stddev-sans-first:10.61 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 86.0 90.0 72.0 71.0 72.0 99.0 90.0 73.0 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.50 stddev:18.35 (19.4%) stddev-sans-first:18.96 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 139.0 94.0 95.0 94.0 131.0 95.0 95.0 126.0 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 151.0 148.0 150.0 149.0 149.0 148.0 150.0 147.0 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,682 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.80 Median:71.50 stddev:3.22 (4.5%) stddev-sans-first:3.41 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 71.0 71.0 71.0 73.0 80.0 68.0 69.0 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 69.0 69.0 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:1.51 (1.8%) stddev-sans-first:1.51 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 84.0 83.0 84.0 85.0 83.0 85.0 88.0 85.0 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:127.50 stddev:5.31 (4.2%) stddev-sans-first:5.61 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: Values: 127.0 120.0 128.0 122.0 124.0 119.0 136.0 128.0 122.0 131.0 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:146.00 stddev:4.68 (3.2%) stddev-sans-first:4.24 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: Values: 137.0 144.0 145.0 146.0 145.0 149.0 147.0 146.0 146.0 134.0 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 14:02:49 INFO - 2015-12-10 14:02:49,683 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 68.0 69.0 68.0 68.0 70.0 68.0 70.0 68.0 14:02:49 INFO - 2015-12-10 14:02:49,684 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:02:49 INFO - 2015-12-10 14:02:49,684 DEBUG : BROWSER_OUTPUT: 14:02:50 INFO - 2015-12-10 14:02:50,578 INFO : Browser exited with error code: 0 14:02:50 INFO - 2015-12-10 14:02:50,629 INFO : Completed test kraken (00:01:00) 14:02:50 INFO - 2015-12-10 14:02:50,629 INFO : Starting test v8_7 14:02:50 INFO - 2015-12-10 14:02:50,629 DEBUG : operating with platform_type : linux_ 14:02:50 INFO - 2015-12-10 14:02:50,629 INFO : Initialising browser for v8_7 test... 14:02:50 INFO - 2015-12-10 14:02:50,635 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg2JGWd/profile http://localhost:52821/getInfo.html 14:02:54 INFO - 2015-12-10 14:02:54,716 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:02:54 INFO - 2015-12-10 14:02:54,717 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:02:54 INFO - 2015-12-10 14:02:54,717 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:02:54 INFO - 2015-12-10 14:02:54,717 DEBUG : BROWSER_OUTPUT: __metrics 14:02:54 INFO - 2015-12-10 14:02:54,818 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] 14:02:54 INFO - 2015-12-10 14:02:54,894 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:02:54 ERROR - 2015-12-10 14:02:54,897 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 14:02:55 INFO - 2015-12-10 14:02:55,754 INFO : Browser initialized. 14:02:55 INFO - 2015-12-10 14:02:55,754 INFO : Running cycle 1/1 for v8_7 test... 14:02:55 INFO - 2015-12-10 14:02:55,754 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg2JGWd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:03:07 INFO - 2015-12-10 14:03:07,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 142778368 14:03:07 INFO - 2015-12-10 14:03:07,735 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52821/tests/v8_7/run.html (next: http://localhost:52821/tests/v8_7/run.html) 14:03:29 INFO - 2015-12-10 14:03:29,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 448589824 14:03:29 INFO - 2015-12-10 14:03:29,420 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,420 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:03:29 INFO - 2015-12-10 14:03:29,420 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:03:29 INFO - 2015-12-10 14:03:29,421 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:03:29 INFO - 2015-12-10 14:03:29,421 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:03:29 INFO - 2015-12-10 14:03:29,421 DEBUG : BROWSER_OUTPUT: |0;Richards;166.05778811026238 14:03:29 INFO - 2015-12-10 14:03:29,421 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.02075930428276 14:03:29 INFO - 2015-12-10 14:03:29,421 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 14:03:29 INFO - 2015-12-10 14:03:29,421 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 14:03:29 INFO - 2015-12-10 14:03:29,421 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1964.6365422396857 14:03:29 INFO - 2015-12-10 14:03:29,422 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 14:03:29 INFO - 2015-12-10 14:03:29,422 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 14:03:29 INFO - 2015-12-10 14:03:29,422 DEBUG : BROWSER_OUTPUT: |7;RegExp;27108.108108108107 14:03:29 INFO - 2015-12-10 14:03:29,422 DEBUG : BROWSER_OUTPUT: |8;Splay;619.5786864931846 14:03:29 INFO - 2015-12-10 14:03:29,422 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:03:29 INFO - 2015-12-10 14:03:29,422 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:03:29 INFO - 2015-12-10 14:03:29,422 DEBUG : BROWSER_OUTPUT: __startTimestamp1449785009417__endTimestamp 14:03:29 INFO - 2015-12-10 14:03:29,422 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,423 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:03:29 INFO - 2015-12-10 14:03:29,423 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:03:29 INFO - 2015-12-10 14:03:29,423 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,423 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.06 Median:166.06 stddev:0.00 (0.0%) 14:03:29 INFO - 2015-12-10 14:03:29,423 DEBUG : BROWSER_OUTPUT: Values: 166.1 14:03:29 INFO - 2015-12-10 14:03:29,423 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,423 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.02 Median:187.02 stddev:0.00 (0.0%) 14:03:29 INFO - 2015-12-10 14:03:29,423 DEBUG : BROWSER_OUTPUT: Values: 187.0 14:03:29 INFO - 2015-12-10 14:03:29,424 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,424 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 14:03:29 INFO - 2015-12-10 14:03:29,424 DEBUG : BROWSER_OUTPUT: Values: 279.2 14:03:29 INFO - 2015-12-10 14:03:29,424 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,424 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 14:03:29 INFO - 2015-12-10 14:03:29,424 DEBUG : BROWSER_OUTPUT: Values: 5202.1 14:03:29 INFO - 2015-12-10 14:03:29,424 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,424 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1964.64 Median:1964.64 stddev:0.00 (0.0%) 14:03:29 INFO - 2015-12-10 14:03:29,425 DEBUG : BROWSER_OUTPUT: Values: 1964.6 14:03:29 INFO - 2015-12-10 14:03:29,425 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,425 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 14:03:29 INFO - 2015-12-10 14:03:29,425 DEBUG : BROWSER_OUTPUT: Values: 791.8 14:03:29 INFO - 2015-12-10 14:03:29,425 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,425 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 14:03:29 INFO - 2015-12-10 14:03:29,425 DEBUG : BROWSER_OUTPUT: Values: 12292.7 14:03:29 INFO - 2015-12-10 14:03:29,426 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,426 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27108.11 Median:27108.11 stddev:0.00 (0.0%) 14:03:29 INFO - 2015-12-10 14:03:29,426 DEBUG : BROWSER_OUTPUT: Values: 27108.1 14:03:29 INFO - 2015-12-10 14:03:29,426 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,426 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.58 Median:619.58 stddev:0.00 (0.0%) 14:03:29 INFO - 2015-12-10 14:03:29,426 DEBUG : BROWSER_OUTPUT: Values: 619.6 14:03:29 INFO - 2015-12-10 14:03:29,426 DEBUG : BROWSER_OUTPUT: 14:03:29 INFO - 2015-12-10 14:03:29,426 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:03:29 INFO - 2015-12-10 14:03:29,426 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:03:29 INFO - 2015-12-10 14:03:29,426 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:03:29 INFO - 2015-12-10 14:03:29,427 DEBUG : BROWSER_OUTPUT: 14:03:30 INFO - 2015-12-10 14:03:30,361 INFO : Browser exited with error code: 0 14:03:30 INFO - 2015-12-10 14:03:30,380 INFO : Completed test v8_7 (00:00:39) 14:03:30 INFO - 2015-12-10 14:03:30,413 INFO : Completed test suite (00:20:15) 14:03:30 INFO - 2015-12-10 14:03:30,413 DEBUG : Working with test: dromaeo_css 14:03:30 INFO - 2015-12-10 14:03:30,413 DEBUG : Generating results file: dromaeo_css 14:03:30 INFO - 2015-12-10 14:03:30,414 DEBUG : Working with test: kraken 14:03:30 INFO - 2015-12-10 14:03:30,414 DEBUG : Generating results file: kraken 14:03:30 INFO - 2015-12-10 14:03:30,414 INFO : javascript benchmark 14:03:30 INFO - 2015-12-10 14:03:30,414 DEBUG : Working with test: v8_7 14:03:30 INFO - 2015-12-10 14:03:30,415 DEBUG : Generating results file: v8_7 14:03:30 INFO - 2015-12-10 14:03:30,415 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:03:30 INFO - 2015-12-10 14:03:30,462 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 14:03:30 INFO - 2015-12-10 14:03:30,463 DEBUG : process_Request line: dromaeo_css 6271.20 graph.html#tests=[[72,132,35]] 14:03:30 INFO - 2015-12-10 14:03:30,463 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:03:30 INFO - 2015-12-10 14:03:30,489 DEBUG : process_Request line: kraken 1525.70 graph.html#tests=[[232,132,35]] 14:03:30 INFO - 2015-12-10 14:03:30,489 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:03:30 INFO - 2015-12-10 14:03:30,516 DEBUG : process_Request line: v8_7 19720.23 graph.html#tests=[[230,132,35]] 14:03:30 INFO - 2015-12-10 14:03:30,518 INFO : javascript benchmark 14:03:30 INFO - 2015-12-10 14:03:30,521 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2588.779953703935, 2653.0, 2668.6130511075894, 2685.8119931604783, 2705.053231369021, 4427.446569178853, 4521.660875434343, 4581.129585378776, 4591.357209990604, 4599.563041511055, 4591.24244499658, 4620.306953956908, 4622.884427889305, 4659.510751371108, 4771.045790841837, 4271.78641067947, 4282.635975942048, 4315.676324275676, 4323.502797178317, 4336.522982471925, 27.06996283953498, 4112.3420252759415, 4298.26929421999, 4369.300911854104, 4398.186335527937, 4233.428487154226, 4262.360645903108, 4307.633851122659, 4418.602325790662, 4440.2895536714295, 4341.175176716414, 4349.173657005191, 4352.129574085196, 4369.3009118541195, 4393.1872603568445, 4310.4611923509565, 4320.1575692739925, 4339.414179085815, 4346.73919564824, 4363.890902727426, 4389.2977123660385, 4497.145542346976, 4497.617702495292, 4507.5267096955, 4585.220512512881, 4936.234883593049, 4953.653244272902, 4963.156263435225, 4967.7019378837385, 4995.500449955011, 4991.051700176955, 4992.101421744084, 4992.151334273182, 4998.925016124761, 5000.799968001275, 4463.4866990296205, 4571.817127314936, 4576.153411618861, 4577.176108300505, 4686.343911852344, 5112.667676601009, 5113.335266415343, 5117.2068329409, 5122.590192784568, 5163.251328557338, 4906.877328066756, 4915.631327650441, 4917.262410638433, 4917.459079501252, 4964.0, 4872.098661747588, 4967.528084831935, 4987.62592805541, 4989.850304490871, 4998.450170481244, 4781.474037855833, 4870.366852309177, 4871.902561948741, 4877.12211801879, 4912.975435122873, 4928.975355123202, 4999.800007999712, 5000.399952005782, 5001.89996200074, 5002.424721157041, 4054.2296963576828, 4165.45849039629, 4169.228692691801, 4177.248095342868, 4199.580041995776, 3554.20030493137, 3612.422012477991, 3619.511365965561, 3622.040159357772, 3647.0335361129323, 4286.37847512109, 4368.628666563378, 4369.519352871182, 4404.4494438195225, 4405.867823965286, 4794.880127996758, 4904.117258893362, 4909.533594308535, 5059.215821547666, 5069.062223488592, 4236.766977816188, 4260.616544511009, 4310.181065597527, 4326.805293761789, 4329.631981281564, 4444.2222611042935, 4445.377647129404, 4449.577290157495, 4455.955440445554, 4482.775861206992, 4599.1721490132095, 4722.811087556459, 4761.690490118062, 4761.7142971421135, 4762.523747625279, 4868.2210846264425, 4946.62900282473, 4946.653734238569, 4956.10790057793, 4968.602511798975, 4724.102420540086, 4733.668643194943, 4745.667803253739, 4746.240601503743, 4791.9281210782565, 4916.680415772963, 4916.950830491649, 4918.188498897642, 4922.556969872729, 4975.7512124392915, 4830.2513110467935, 4894.412670479565, 4946.925796112989, 4954.3311652926395, 4991.3511243538105, 4703.129920964632, 4798.0, 4799.736014519235, 4805.927911081407, 4846.781894814671, 4845.345878306383, 4851.32081508582, 4857.732824694534, 4861.95138048615, 4870.95129048705, 4558.498565157764, 4656.743879086547, 4774.236122220428, 4779.3070004848405, 4801.231802911518, 4790.329353890388, 4854.563089321837, 4915.5330243626795, 4926.359573255454, 4943.159662857251, 4755.38180036593, 4773.3794606702295, 4777.378940737682, 4798.928016079832, 4828.5412885775795], "unit": "ms", "name": "dojo.html", "value": 4531.180324176147}, {"lowerIsBetter": false, "replicates": [560.7420586530199, 585.4730742331902, 593.2465768474038, 596.34997852341, 598.7365559153973, 26881.0, 27329.45341093177, 32376.838115809416, 32844.17889552762, 32865.67134328656, 38808.0, 39322.21355572894, 39431.605683943155, 39504.80247598765, 39514.80242598783, 7800.882986755203, 7967.402444816662, 7968.482048666818, 7975.202479752007, 7975.883376327319, 7228.891566626478, 7427.294407031323, 9811.558479868387, 10065.245106616996, 10067.942865999075, 9871.358361706467, 9945.60217591299, 9954.90045099547, 9965.75085622858, 9967.651132210374, 7216.422686185093, 7397.445191610597, 9873.407595544255, 9952.402855828637, 9986.600535978625, 7093.184283807325, 9807.411555306704, 10092.697219083439, 10100.989901009914, 10113.595456181743, 36032.279354413025, 36455.0, 36458.27083458316, 36540.45189322162, 36546.0, 2880.510313246732, 2893.537034074559, 3010.277533391992, 3229.450993331139, 3304.7025767680784, 28166.155015349574, 28173.29566760827, 28270.293242668893, 29646.703532964824, 30793.692063079307, 3428.794272343667, 3469.3755124077657, 3480.5475288212624, 3551.200979779555, 3553.2538166984964, 212365.0, 213842.0, 213855.0, 214182.0, 214811.0, 54942.0, 55020.724896375265, 55366.72316638391, 55482.0, 55562.0, 50336.0, 51655.48344516582, 59242.0, 59549.70225148847, 65303.0, 13427.328633568477, 13558.932205339108, 13614.115082519604, 13646.044776865525, 13657.317134143253, 9319.114684105, 9336.439813611205, 9340.53297335144, 9341.486218258062, 9383.718488445358, 18851.43445696631, 18918.810811891704, 18944.431667050012, 19008.619827603372, 19019.524511887037, 7343.339099480965, 7663.2983851229155, 7728.729494467667, 7740.690372385154, 7824.295813376823, 797.7168105322527, 812.2567850416802, 895.9910400895908, 963.0706368354431, 994.3188915592842, 30021.39957200844, 31280.84359578233, 31349.0, 31507.36985260282, 31917.20206994844, 916.913457552802, 926.305271046715, 943.7734943613483, 944.5749412764284, 1030.99484502577, 14069.788953165711, 14355.282235888373, 14627.0, 14932.104073755609, 14933.0, 292901.0, 297895.0, 298123.0, 298300.0, 299183.0, 47220.52779472162, 47771.0, 47912.7604361976, 47932.0, 47933.0, 1173.7828501727208, 1201.2612243470203, 1221.8289439478303, 1224.8897599215936, 1226.343906010298, 23812.285631431085, 28290.85854570714, 29702.405951881272, 30956.69043309538, 30969.8451507741, 36274.455883161245, 37053.221008423934, 41750.37374439446, 41938.0, 42686.14627707366, 240989.0, 244093.0, 244403.0, 245024.0, 245559.0, 37816.62183378241, 37956.24087518289, 38447.80776096213, 38465.80767096147, 38488.422673660476, 40524.79737601293, 40726.59273407228, 41422.58577414187, 41512.584874150874, 41532.58467415287, 34183.0, 34331.828340858134, 34946.126346840516, 39820.2035959285, 41967.58032419759, 35688.64311356957, 35968.28063438769, 36363.81818090893, 36761.26477470489, 36831.81584092062, 34778.13054673552, 35292.823535882155, 35847.82076089603, 36095.81952090223, 36146.0, 34423.655763442046, 35358.646413535535, 35708.0, 35804.462933056544, 36090.63909360978, 25328.366790830376, 25882.741172588034, 25889.352766180997, 26295.60556591691, 26316.21051368462], "unit": "ms", "name": "ext.html", "value": 17647.582040787653}, {"lowerIsBetter": false, "replicates": [340.41108881634773, 341.09609534732954, 342.01329165357936, 343.5619585029089, 346.0604458894102, 13251.204927704344, 13850.0, 15910.363585456582, 16068.67862642748, 16792.160391980397, 9805.460699661517, 13382.93308533456, 16592.751108733377, 16596.50210493684, 16615.006199256077, 4450.933236001462, 4561.338605902142, 4570.063137056912, 4572.519885412034, 4576.06190730901, 3545.4327307630783, 3671.192337685718, 4289.871303860889, 4321.762303073329, 5155.072087024334, 5232.215167724853, 5280.867978300554, 5310.15037593985, 5325.920111198335, 5329.147336426173, 5093.465186155456, 5204.375474942994, 5220.686758794484, 5243.0, 5248.527632513092, 5044.848654540369, 5047.9747601262125, 5060.898782024376, 5063.594912406998, 5067.0879241736475, 11212.607558735404, 12200.328981905992, 12234.204776689487, 12271.69320766979, 12290.078244131637, 1775.0947017021283, 1775.1035726957803, 1807.1325763633529, 1834.257125864014, 1842.8709990300683, 9039.0, 10190.133838623726, 10327.483625818679, 12612.81080783789, 13088.541901033514, 1694.8220436854199, 1711.922963466647, 1729.2477772169148, 1747.5106970048407, 1784.1971112999202, 50118.0, 51233.0, 53209.46790532084, 54235.0, 55870.720646396505, 9356.906430935604, 9694.75763105914, 10048.397096174253, 10054.54754536033, 10067.144292735053, 12665.873341266653, 12684.23894566329, 12706.301153436465, 12733.36333183337, 12743.107982441326, 6934.0, 6948.27043160471, 7028.789136325919, 7055.858882822315, 7061.152661680631, 6631.673665266966, 6640.701168447432, 6646.235682896432, 6647.202335719648, 6699.229588597276, 4243.702940794176, 4270.829166833354, 4295.656347492193, 4310.6335961443, 4314.482262128565, 1594.537584100621, 1650.8101568319557, 1682.3943380383052, 1684.1410880450812, 1732.6003485172873, 807.9838403231903, 814.2956342763467, 825.5748289630845, 879.4926840850301, 910.1990248581207, 15369.538913832603, 15508.759299256033, 15790.842091578937, 15907.840921590867, 16015.919920400323, 738.2469880721634, 750.9324160825552, 771.6758961236294, 775.4378075894931, 817.3257062923112, 8500.319974402157, 8589.226969572768, 8593.570321483901, 8708.303335733126, 8747.825043499095, 440475.0, 449417.0, 456467.0, 458131.0, 459090.0, 68541.31458685349, 69603.65198174078, 69613.65193174103, 70601.0, 71026.28973710196, 999.5551979369111, 1009.8283291840405, 1013.108464551205, 1015.5328548867456, 1028.043919155178, 13555.93222033923, 13746.243956582484, 14295.213763242706, 14320.212388318743, 14492.34784434682, 29980.700192997792, 31076.844615776776, 31823.840880795447, 31951.0, 35045.82477087598, 40073.0, 41020.1795964085, 42211.577884221995, 42533.36199957065, 44185.0, 8397.580120994047, 8644.0, 8811.691590794291, 9070.0, 9075.319351048829, 10921.781564368826, 10940.945295273472, 10952.780944381228, 15065.774013390028, 17027.91486042562, 13879.16724996463, 13960.58118256454, 13995.930020349833, 14205.431782728576, 14468.0, 12961.935190323988, 13352.399142038437, 14003.859961400256, 14082.225477598831, 14137.363818628392, 13356.465741370625, 13509.527166549124, 13607.387667555182, 14410.351534180778, 14619.488317908823, 8909.599068042084, 8993.7751556209, 9040.095990400907, 9120.087991200828, 9133.497657628894, 10259.384436933808, 13989.510367137102, 14098.083624564371, 14186.929065354607, 14190.432382704576], "unit": "ms", "name": "jquery.html", "value": 8030.201633278657}, {"lowerIsBetter": false, "replicates": [1375.77299745542, 1406.4093080906018, 1413.4840783114166, 1589.3801417447198, 1684.4441334359658, 5858.619189752663, 6813.863722725542, 6971.930280697192, 6985.0, 6988.266232045638, 6889.207741109773, 7071.328223818729, 7071.717131314754, 7079.575225486475, 7083.681234344454, 1767.982320176801, 1798.6762382771096, 1802.6394721055776, 2032.4715573950732, 2071.6892466130125, 2036.389083275019, 2083.0, 2085.447356450542, 2086.6452703040445, 2089.352300786761, 2067.266120527214, 2069.1516478243925, 2083.8228750556223, 2114.0, 2116.47088227943, 2057.4856285928518, 2085.7914208579095, 2108.5888251790907, 2111.6621340585584, 2113.0596884386377, 2107.4520624637703, 2134.3916983659738, 2136.6688163334707, 2138.379869837745, 2141.271967531047, 6923.6884340204815, 6982.406495447843, 6983.615901125436, 6986.266442023565, 6993.0908981832035, 4173.91652166958, 4238.173556156551, 4263.18999390118, 4270.12462445198, 4276.486821581399, 2563.9102631408, 2669.5194864924306, 2674.17100698784, 2675.0770984010487, 2682.5439675255056, 805.8549461097, 818.467995802727, 829.867221244604, 843.9113893041265, 870.1516021878617, 9653.17947974423, 9656.90343096567, 9666.468344241064, 9692.176165025981, 9698.806023879482, 3869.671077958405, 3941.1329507508303, 3944.4674968878835, 3950.3876899080688, 4016.357382818793, 8179.100298967109, 8196.59017049157, 8197.303229225463, 8199.95900020496, 8221.136780637948, 4234.0, 4237.87286381409, 4242.0, 4249.128928569698, 4260.659147268211, 3832.5400951885395, 3850.2876967761053, 3862.594427585063, 3873.1285460771664, 3876.9418458723144, 3015.2461884528866, 3113.0193988893425, 3136.6706495818066, 3415.1291420687567, 3490.110021944388, 1089.624079692505, 1115.2639258089785, 1117.5082963496036, 1123.2474242257706, 1135.1146106037304, 933.2906990687127, 933.477252738455, 973.8880028796779, 988.6885631026204, 1179.55177032727, 6550.541462097703, 6609.3060228675295, 6613.4709223262025, 6618.569792963442, 6621.271660117383, 1015.9136473399844, 1019.8674172357546, 1033.395463653771, 1033.7715265525121, 1042.0413219837767, 4996.7001979881325, 5023.623228257895, 5040.218766091261, 5042.470540593258, 5054.82308119214, 7865.646045927947, 8053.516788992679, 8119.634616442274, 8131.227533384319, 8255.215754503313, 8144.30773384269, 8249.29880960113, 8250.46371985819, 8257.504549727035, 8262.586870656443, 6548.443382312462, 6553.082568440422, 6658.733650654017, 6771.72913083481, 6776.08522849409, 6659.467242620675, 6720.764773232913, 6726.428253598499, 6730.764423245163, 6736.461083113437, 7428.591427471541, 7648.923510764821, 7650.4644674872225, 7734.729284475016, 7741.690332386642, 7754.922450775645, 7768.53388796674, 7911.960440197762, 8031.0, 8040.3969702273735, 5943.435373639497, 6096.75612975476, 6127.601705889103, 6160.0, 6175.660338681416, 5862.677552734641, 6008.03871380577, 6020.578559500968, 6748.763793267212, 6830.112085428863, 5700.800471983461, 5759.395263497272, 6080.695965201634, 6207.596506227081, 6320.241571011508, 6079.088136779518, 6128.816135515942, 6160.630362178104, 6173.938260617337, 6221.751129954932, 6242.406971337716, 6280.403361680633, 6284.24589049317, 6287.654179020198, 6288.088227207121, 5784.681842498703, 5799.246098007232, 5863.677497737665, 5868.119782032729, 5869.383714709894, 5981.9401805983125, 6005.36943620931, 6013.699315034143, 6021.397860213943, 6042.0332746760305], "unit": "ms", "name": "mootools.html", "value": 4028.0902382423797}, {"lowerIsBetter": false, "replicates": [301.42728815251024, 312.1540624906504, 313.9183812208825, 314.8853060167009, 315.7947334232747, 5121.8463446096675, 5255.553277971372, 5303.7082960437165, 5334.786608535659, 5352.866178345538, 5107.897842043166, 5205.0370681423865, 5277.0, 5283.471652834714, 5303.098473259545, 4155.812988415529, 4158.8336466541305, 4159.209750147477, 4174.08170202555, 4174.519930208035, 3952.8814135575835, 4041.797910104483, 4044.2315959967514, 4170.582941705836, 4176.352665336878, 4115.814788334517, 4134.6692264618905, 4135.627793498585, 4137.855175068873, 4152.792360381969, 4122.979385103085, 4127.504699436087, 4128.298189307825, 4130.256553820311, 4142.171565686875, 3647.0517665407187, 3654.3604869148057, 3656.0, 3672.9081772955624, 3673.2837096766143, 5012.649114561982, 5053.722045287508, 5111.05445492585, 5119.744012799345, 5119.820806271762, 4728.0, 4777.856664300077, 4784.736839473828, 4784.976075119637, 4793.161196790547, 5574.052411090124, 5586.385497595261, 5586.581006424534, 5590.832275031756, 5600.439956004408, 3779.79211143387, 3861.4980052593264, 3885.7668539887695, 3989.98005009976, 3994.560598334181, 5835.679037652927, 5837.211976383176, 5872.236609240771, 5872.383399743051, 5884.264466941632, 4115.42384066231, 4119.8352065917625, 4121.340585506365, 4121.52602450722, 4122.40225167349, 4177.498700156001, 4181.247375472383, 4183.5398106208295, 4186.497620285585, 4192.182524407711, 4652.209124448852, 4730.935539503585, 4741.0754902794315, 4749.430068391815, 4763.976180119077, 5603.943960560424, 5606.0, 5613.803516876889, 5616.831495055073, 5623.493885550321, 1455.3960106555874, 1483.3769816677022, 1486.6060493969107, 1487.5462983790048, 1488.2261224163374, 1001.5643195209962, 1015.1219195395929, 1019.9953046249439, 1027.9331843430152, 1031.4739482863642, 4900.2894580286375, 4914.066327397783, 4916.262560615936, 4919.508049195052, 4920.803167873245, 5789.94210057894, 5793.24687790593, 5795.0, 5796.710164491758, 5801.042827933344, 4884.4871288514905, 4888.95111048885, 4898.0, 4898.265260210926, 4898.755062246873, 3042.4067306874945, 3082.1061892051052, 3096.7212950834532, 3114.9377012460077, 3121.5161649944293, 5466.043442397565, 5473.616846820764, 5476.945230547723, 5478.205660179252, 5482.890342193214, 5927.199828023248, 5935.376785437553, 5935.436133567304, 5936.851578710481, 5947.583669143119, 5460.918086228709, 5465.863353416196, 5474.09677403224, 5475.0418676731415, 5476.72616369172, 5634.267545219095, 5775.393583673654, 5778.0, 5837.153612726216, 5838.854028649318, 5409.594280428905, 5604.0, 5612.410696876769, 5645.435456454486, 5653.462921022497, 5378.650387724785, 5424.267723857229, 5426.0, 5502.9174562382395, 5529.474699903502, 4134.91730165401, 4143.109231515239, 4149.6265336119895, 4150.91698166041, 4152.937705934474, 5698.8290351289525, 5785.537157027512, 5811.680357580373, 5819.592628515963, 5823.417658234142, 5523.088690366205, 5617.382087970238, 5622.915656265078, 5627.43725627434, 5629.324481062299, 5598.86002849932, 5613.915791263216, 5619.915701264403, 5623.746931388016, 5623.803166889139, 5485.917711234255, 5506.5870059746485, 5509.090999984957, 5512.5589952804485, 5513.476219759116, 5537.36320323168, 5658.066419040812, 5664.5751568631695, 5664.85837854057, 5670.0, 5518.392976772471, 5528.834134975958, 5532.391436942014, 5533.087040638411, 5537.390887002507], "unit": "ms", "name": "prototype.html", "value": 4226.305979779862}, {"lowerIsBetter": false, "replicates": [745.2510227221642, 766.5017738469994, 787.9409044321674, 805.9274665280124, 825.2119226139038, 13439.328033598318, 13626.114302570326, 13670.521531746392, 13672.248026358546, 13813.240271785047, 13522.0, 13525.323733813319, 13645.45418183274, 13649.727005459885, 13655.931720341408, 634.4226753654176, 644.7195469970578, 798.4211446701154, 813.8901248331458, 814.5845618734429, 813.5037627047526, 820.0937963550251, 824.6495239523178, 828.6229765456703, 828.6768160417442, 853.2278288149234, 857.3826844671827, 857.4041041476146, 859.8882145321099, 860.1742327365737, 669.3072669786771, 678.565717940516, 679.8062552172607, 834.8079941613403, 853.4964371021097, 626.6929204689669, 629.128656810321, 629.5561629051508, 629.710333246707, 629.9559030867841, 12146.45340959659, 12231.633051008484, 12381.257124572554, 12391.194572352859, 12394.132410731252, 10153.898461015444, 11230.0, 11246.268992515543, 11251.83122253167, 11729.88270117305, 8950.955245223797, 9048.41185322952, 9057.81884362309, 9122.635094596208, 9273.72178834636, 3205.5512228288057, 3248.3178532507964, 3254.1213872254357, 3258.038878530839, 3267.0852161394846, 38692.61307386918, 38734.320239577195, 38917.22165556673, 38919.805400972815, 39297.60702392968, 8916.910830891738, 8946.776330591658, 9215.90784092164, 9241.3531052827, 9357.532123393803, 16004.0, 16009.199540022952, 16012.919935400249, 16041.037537747772, 16052.678946421007, 5868.589198756132, 6003.549733769897, 6121.510279177655, 6145.661988590581, 6184.845378865564, 3326.3846188455213, 3386.119608901654, 3390.1016230698883, 3470.7917524948584, 3485.4597537381746, 2753.1465245773875, 2757.1039412191117, 2766.4743698697184, 2775.0287399410045, 2775.2368098772595, 455.0126226089394, 464.05101567294963, 464.57723471640645, 466.11438267292414, 475.9619230461555, 415.66331271670043, 416.8353500367338, 460.09591153383764, 472.9358942379646, 493.767929073335, 7081.327273908971, 7181.640917954186, 7244.13070431541, 7281.781546553612, 7432.108147022392, 445.5633479190412, 459.99080018400116, 473.3986742848072, 482.08644618447846, 546.2952790899695, 3387.2886693794085, 3392.6268110508317, 3420.8289585520624, 3428.6057103432927, 3536.204354020325, 45948.770256148506, 46236.075278494245, 46829.76585117052, 47203.763981180564, 47459.0, 42569.0, 42752.0, 42812.143757124686, 42982.0, 43269.78365108154, 40686.575969841506, 41008.58991410048, 41143.7942810284, 41188.176236475105, 41513.792431037655, 7223.602701851449, 7394.852102957803, 7523.548587084792, 7713.267239612453, 7792.649330780015, 29509.26226844346, 29749.25626859259, 30205.0, 30534.0, 30631.693683062884, 36983.63016369802, 37312.253754924204, 38573.614263857, 39091.413628795024, 39218.0, 9796.65711700087, 9858.440356933137, 9868.605255789687, 9963.701088967342, 10011.399316041061, 10760.838587421038, 10980.505877235384, 10983.725406864893, 11242.437878106226, 11494.655160345203, 10523.94738026305, 10821.891781082404, 10859.782804344028, 10879.347239165676, 10983.670489885317, 10077.546510406903, 10146.594136234764, 10153.441560714231, 10343.689689309333, 10601.575936962743, 9647.758806029906, 9788.510574471391, 9858.556364963737, 9944.204463642747, 9973.551190196604, 8790.780230494289, 8929.330300227379, 8994.280457563249, 9196.08039196075, 9220.354575179674, 7278.818029549304, 7311.232320606472, 7360.595167265852, 7383.114026316876, 7490.176080631018], "unit": "ms", "name": "yui.html", "value": 5563.811305749246}], "name": "dromaeo_css", "value": 6271.198220680816}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 106.0, 112.0, 112.0, 112.0, 100.0, 111.0, 111.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [158.0, 130.0, 164.0, 176.0, 137.0, 165.0, 158.0, 132.0, 170.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 152.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 163.0, 161.0, 162.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 86.0, 90.0, 72.0, 71.0, 72.0, 99.0, 90.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 139.0, 94.0, 95.0, 94.0, 131.0, 95.0, 95.0, 126.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 151.0, 148.0, 150.0, 149.0, 149.0, 148.0, 150.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 71.0, 71.0, 71.0, 73.0, 80.0, 68.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 83.0, 84.0, 85.0, 83.0, 85.0, 88.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [127.0, 120.0, 128.0, 122.0, 124.0, 119.0, 136.0, 128.0, 122.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [137.0, 144.0, 145.0, 146.0, 145.0, 149.0, 147.0, 146.0, 146.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 68.0, 69.0, 68.0, 68.0, 70.0, 68.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1525.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.05778811026238], "unit": "score", "name": "Richards", "value": 212.58864400000002}, {"lowerIsBetter": false, "replicates": [187.02075930428276], "unit": "score", "name": "DeltaBlue", "value": 353.5329460000002}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1964.6365422396857], "unit": "score", "name": "RayTrace", "value": 376.654401}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [27108.108108108107], "unit": "score", "name": "RegExp", "value": 33.60562811565303}, {"lowerIsBetter": false, "replicates": [619.5786864931846], "unit": "score", "name": "Splay", "value": 131.52647400000006}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19720.23419253388}]} 14:03:30 INFO - RETURN: dromaeo_css: 6271.20 14:03:30 INFO - RETURN: kraken: 1525.70 14:03:30 INFO - RETURN: v8_7: 19720.23 14:03:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19720.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1525.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6271.20"}}} 14:03:30 INFO - Return code: 0 14:03:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:03:30 ERROR - # TBPL SUCCESS # 14:03:30 INFO - Running post-action listener: _resource_record_post_action 14:03:30 INFO - Running post-run listener: _resource_record_post_run 14:03:31 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 512569344; Read time: 20; Write time: 390256 14:03:31 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 235466752; Read time: 0; Write time: 248764 14:03:31 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276238336; Read time: 20; Write time: 141456 14:03:31 INFO - Running post-run listener: _upload_blobber_files 14:03:31 INFO - Blob upload gear active. 14:03:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:03:31 INFO - Copying logs to upload dir... 14:03:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1264.405994 ========= master_lag: 0.66 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-10 14:03:31.020535) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 14:03:31.023885) ========= 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=b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008674 build_url: 'https://queue.taskcluster.net/v1/task/kuxiNaszRQiZynJfIlr3eQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.29 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-10 14:03:31.325038) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:03:31.325425) ========= 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=b00de3c228505fac2445e70d000001bb-1449783744.743734-664724154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004637 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-10 14:03:31.342510) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 14:03:31.343200) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-10 14:03:31.343905) ========= ========= Total master_lag: 1.09 =========