builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1448387086.28 results: success (0) buildid: 20151124083121 builduid: 57ec50228a394e12a2ddb244727a7fda revision: d516d82f29a2636c5834c7f3c932025b8e85a8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.280013) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.280534) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.280918) ========= 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=20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.003771 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.297205) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.297705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.307879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.308228) ========= 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=20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004064 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.355933) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.359275) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.359656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.359943) ========= 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=20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 09:44:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-11-24 09:44:49 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171827 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.543805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.544141) ========= 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=20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014481 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.596784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:46.597638) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d516d82f29a2636c5834c7f3c932025b8e85a8ad --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 d516d82f29a2636c5834c7f3c932025b8e85a8ad --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=20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 09:44:49,445 truncating revision to first 12 chars 2015-11-24 09:44:49,445 Setting DEBUG logging. 2015-11-24 09:44:49,445 attempt 1/10 2015-11-24 09:44:49,445 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d516d82f29a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 09:44:49,694 unpacking tar archive at: fx-team-d516d82f29a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:47.170643) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:47.171193) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:47.180158) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:47.180509) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 09:44:47.180931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-24 09:44:47.181235) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:44:50 INFO - MultiFileLogger online at 20151124 09:44:50 in /builds/slave/test 09:44:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:44:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:44:50 INFO - {'append_to_log': False, 09:44:50 INFO - 'base_work_dir': '/builds/slave/test', 09:44:50 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:44:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:44:50 INFO - 'branch': 'Fx-Team-Non-PGO', 09:44:50 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:50 INFO - 'config_files': ('talos/linux_config.py',), 09:44:50 INFO - 'default_actions': ('clobber', 09:44:50 INFO - 'read-buildbot-config', 09:44:50 INFO - 'download-and-extract', 09:44:50 INFO - 'populate-webroot', 09:44:50 INFO - 'create-virtualenv', 09:44:50 INFO - 'install', 09:44:50 INFO - 'run-tests'), 09:44:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:50 INFO - 'download_minidump_stackwalk': True, 09:44:50 INFO - 'download_symbols': 'ondemand', 09:44:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:50 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:50 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:50 INFO - 'installer_path': 'installer.exe', 09:44:50 INFO - 'log_level': 'info', 09:44:50 INFO - 'log_name': 'talos', 09:44:50 INFO - 'log_to_console': True, 09:44:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:44:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:44:50 INFO - 'opt_config_files': (), 09:44:50 INFO - 'pip_index': False, 09:44:50 INFO - 'sps_profile': False, 09:44:50 INFO - 'sps_profile_interval': 0, 09:44:50 INFO - 'suite': 'dromaeojs-e10s', 09:44:50 INFO - 'system_bits': '64', 09:44:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:50 INFO - 'title': 'talos-linux64-ix-065', 09:44:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:50 INFO - 'use_talos_json': True, 09:44:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:44:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:50 INFO - 'work_dir': 'build'} 09:44:50 INFO - ##### 09:44:50 INFO - ##### Running clobber step. 09:44:50 INFO - ##### 09:44:50 INFO - Running pre-action listener: _resource_record_pre_action 09:44:50 INFO - Running main action method: clobber 09:44:50 INFO - rmtree: /builds/slave/test/build 09:44:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:44:50 INFO - Running post-action listener: _resource_record_post_action 09:44:50 INFO - ##### 09:44:50 INFO - ##### Running read-buildbot-config step. 09:44:50 INFO - ##### 09:44:50 INFO - Running pre-action listener: _resource_record_pre_action 09:44:50 INFO - Running main action method: read_buildbot_config 09:44:50 INFO - Using buildbot properties: 09:44:50 INFO - { 09:44:50 INFO - "properties": { 09:44:50 INFO - "buildnumber": 509, 09:44:50 INFO - "product": "firefox", 09:44:50 INFO - "script_repo_revision": "production", 09:44:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:44:50 INFO - "repository": "", 09:44:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:44:50 INFO - "buildid": "20151124083121", 09:44:50 INFO - "slavename": "talos-linux64-ix-065", 09:44:50 INFO - "pgo_build": "False", 09:44:50 INFO - "basedir": "/builds/slave/test", 09:44:50 INFO - "project": "", 09:44:50 INFO - "platform": "ubuntu64_hw", 09:44:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:44:50 INFO - "slavebuilddir": "test", 09:44:50 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:44:50 INFO - "branch": "fx-team", 09:44:50 INFO - "repo_path": "integration/fx-team", 09:44:50 INFO - "stage_platform": "linux64", 09:44:50 INFO - "builduid": "57ec50228a394e12a2ddb244727a7fda", 09:44:50 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:44:50 INFO - }, 09:44:50 INFO - "sourcestamp": { 09:44:50 INFO - "repository": "", 09:44:50 INFO - "hasPatch": false, 09:44:50 INFO - "project": "", 09:44:50 INFO - "branch": "fx-team-linux64-talos", 09:44:50 INFO - "changes": [ 09:44:50 INFO - { 09:44:50 INFO - "category": null, 09:44:50 INFO - "files": [ 09:44:50 INFO - { 09:44:50 INFO - "url": null, 09:44:50 INFO - "name": "https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:44:50 INFO - } 09:44:50 INFO - ], 09:44:50 INFO - "repository": "", 09:44:50 INFO - "rev": "d516d82f29a2636c5834c7f3c932025b8e85a8ad", 09:44:50 INFO - "who": "jwein@mozilla.com", 09:44:50 INFO - "when": 1448385257, 09:44:50 INFO - "number": 6700840, 09:44:50 INFO - "comments": "Bug 1213421 - Add a test that verifies the text of a notification is present. r=MattN", 09:44:50 INFO - "project": "", 09:44:50 INFO - "at": "Tue 24 Nov 2015 09:14:17", 09:44:50 INFO - "branch": "fx-team-linux64-talos", 09:44:50 INFO - "revlink": "", 09:44:50 INFO - "properties": [ 09:44:50 INFO - [ 09:44:50 INFO - "buildid", 09:44:50 INFO - "20151124083121", 09:44:50 INFO - "Change" 09:44:50 INFO - ], 09:44:50 INFO - [ 09:44:50 INFO - "builduid", 09:44:50 INFO - "57ec50228a394e12a2ddb244727a7fda", 09:44:50 INFO - "Change" 09:44:50 INFO - ], 09:44:50 INFO - [ 09:44:50 INFO - "pgo_build", 09:44:50 INFO - "False", 09:44:50 INFO - "Change" 09:44:50 INFO - ] 09:44:50 INFO - ], 09:44:50 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:44:50 INFO - } 09:44:50 INFO - ], 09:44:50 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:44:50 INFO - } 09:44:50 INFO - } 09:44:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:44:50 INFO - Running post-action listener: _resource_record_post_action 09:44:50 INFO - ##### 09:44:50 INFO - ##### Running download-and-extract step. 09:44:50 INFO - ##### 09:44:50 INFO - Running pre-action listener: _resource_record_pre_action 09:44:50 INFO - Running main action method: download_and_extract 09:44:50 INFO - mkdir: /builds/slave/test/build/tests 09:44:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:50 INFO - https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:44:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/test_packages.json 09:44:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/test_packages.json 09:44:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:44:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:44:51 INFO - Downloaded 1302 bytes. 09:44:51 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:44:51 INFO - Using the following test package requirements: 09:44:51 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:44:51 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:44:51 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:51 INFO - u'jsshell-linux-x86_64.zip'], 09:44:51 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:44:51 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:44:51 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:44:51 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:44:51 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:44:51 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:44:51 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:51 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:44:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:51 INFO - https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:44:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:44:52 INFO - Downloaded 21341306 bytes. 09:44:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:44:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:44:53 INFO - Return code: 0 09:44:53 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:53 INFO - https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:44:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:44:54 INFO - Downloaded 21341306 bytes. 09:44:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 09:44:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:44:55 INFO - Return code: 0 09:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:55 INFO - https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:44:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:44:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:44:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:44:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:44:56 INFO - Downloaded 11130997 bytes. 09:44:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 09:44:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:44:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:44:56 INFO - Return code: 0 09:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:56 INFO - https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:44:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:44:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:44:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:44:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:44:57 INFO - Downloaded 56072224 bytes. 09:44:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:44:57 INFO - mkdir: /builds/slave/test/properties 09:44:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:44:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:44:57 INFO - Contents: 09:44:57 INFO - build_url:https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:44:57 INFO - Running post-action listener: _resource_record_post_action 09:44:57 INFO - Running post-action listener: set_extra_try_arguments 09:44:57 INFO - ##### 09:44:57 INFO - ##### Running populate-webroot step. 09:44:57 INFO - ##### 09:44:57 INFO - Running pre-action listener: _resource_record_pre_action 09:44:57 INFO - Running main action method: populate_webroot 09:44:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:44:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:44:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:44:57 INFO - '../fennec_ids.txt'], 09:44:57 INFO - 'tests': ['tcheck2']}, 09:44:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:44:57 INFO - '--tppagecycles', 09:44:57 INFO - '7'], 09:44:57 INFO - 'tests': ['tsvgm']}}, 09:44:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:44:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:44:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:44:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:44:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:44:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:44:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:44:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:57 INFO - 'talos_options': ['--e10s'], 09:44:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:44:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:57 INFO - 'tests': ['damp', 'tps']}, 09:44:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:57 INFO - 'talos_options': ['--e10s'], 09:44:57 INFO - 'tests': ['damp', 'tps']}, 09:44:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:44:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:44:57 INFO - 'other': {'tests': ['a11yr', 09:44:57 INFO - 'ts_paint', 09:44:57 INFO - 'tpaint', 09:44:57 INFO - 'sessionrestore', 09:44:57 INFO - 'sessionrestore_no_auto_restore']}, 09:44:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:44:57 INFO - 'tests': ['a11yr', 09:44:57 INFO - 'ts_paint', 09:44:57 INFO - 'tpaint', 09:44:57 INFO - 'sessionrestore', 09:44:57 INFO - 'sessionrestore_no_auto_restore']}, 09:44:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:44:57 INFO - 'tests': ['a11yr', 09:44:57 INFO - 'ts_paint', 09:44:57 INFO - 'tpaint', 09:44:57 INFO - 'sessionrestore', 09:44:57 INFO - 'sessionrestore_no_auto_restore']}, 09:44:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:44:57 INFO - 'tests': ['a11yr', 09:44:57 INFO - 'ts_paint', 09:44:57 INFO - 'tpaint', 09:44:57 INFO - 'sessionrestore', 09:44:57 INFO - 'sessionrestore_no_auto_restore']}, 09:44:57 INFO - 'other_l64': {'tests': ['a11yr', 09:44:57 INFO - 'ts_paint', 09:44:57 INFO - 'tpaint', 09:44:57 INFO - 'sessionrestore', 09:44:57 INFO - 'sessionrestore_no_auto_restore']}, 09:44:57 INFO - 'other_nol64': {'tests': ['a11yr', 09:44:57 INFO - 'ts_paint', 09:44:57 INFO - 'tpaint', 09:44:57 INFO - 'sessionrestore', 09:44:57 INFO - 'sessionrestore_no_auto_restore']}, 09:44:57 INFO - 'svgr': {'tests': ['tsvgx', 09:44:57 INFO - 'tsvgr_opacity', 09:44:57 INFO - 'tart', 09:44:57 INFO - 'tscrollx', 09:44:57 INFO - 'cart']}, 09:44:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:44:57 INFO - 'tests': ['tsvgx', 09:44:57 INFO - 'tsvgr_opacity', 09:44:57 INFO - 'tart', 09:44:57 INFO - 'tscrollx', 09:44:57 INFO - 'cart']}, 09:44:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:57 INFO - 'tests': ['tp5o']}, 09:44:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:57 INFO - 'talos_options': ['--e10s'], 09:44:57 INFO - 'tests': ['tp5o']}, 09:44:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:57 INFO - 'talos_options': ['--xperf_path', 09:44:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:44:57 INFO - 'tests': ['tp5n']}, 09:44:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:44:57 INFO - 'talos_options': ['--e10s', 09:44:57 INFO - '--xperf_path', 09:44:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:44:57 INFO - 'tests': ['tp5n']}}, 09:44:57 INFO - 'talos.zip': {'path': '', 09:44:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:44:57 INFO - Running post-action listener: _resource_record_post_action 09:44:57 INFO - ##### 09:44:57 INFO - ##### Running create-virtualenv step. 09:44:57 INFO - ##### 09:44:57 INFO - Running pre-action listener: _resource_record_pre_action 09:44:57 INFO - Running main action method: create_virtualenv 09:44:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:44:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:44:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:44:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:44:58 INFO - Using real prefix '/usr' 09:44:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:44:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:00 INFO - Installing pip.................done. 09:45:00 INFO - Return code: 0 09:45:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c886b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cecb70>, '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 0x1d3ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e250>, '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': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:00 INFO - Using env: {'DISPLAY': ':0', 09:45:00 INFO - 'HOME': '/home/cltbld', 09:45:00 INFO - 'LANG': 'en_US.UTF-8', 09:45:00 INFO - 'LANGUAGE': 'en_US:en', 09:45:00 INFO - 'LOGNAME': 'cltbld', 09:45:00 INFO - 'MAIL': '/var/mail/cltbld', 09:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:00 INFO - 'MOZ_NO_REMOTE': '1', 09:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:00 INFO - 'NO_EM_RESTART': '1', 09:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:00 INFO - 'PWD': '/builds/slave/test', 09:45:00 INFO - 'SHELL': '/bin/bash', 09:45:00 INFO - 'SHLVL': '1', 09:45:00 INFO - 'TERM': 'linux', 09:45:00 INFO - 'TMOUT': '86400', 09:45:00 INFO - 'USER': 'cltbld', 09:45:00 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 09:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:00 INFO - '_': '/tools/buildbot/bin/python'} 09:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:45:00 INFO - Cleaning up... 09:45:00 INFO - Return code: 0 09:45:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c886b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cecb70>, '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 0x1d3ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e250>, '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': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:45:00 INFO - Using env: {'DISPLAY': ':0', 09:45:00 INFO - 'HOME': '/home/cltbld', 09:45:00 INFO - 'LANG': 'en_US.UTF-8', 09:45:00 INFO - 'LANGUAGE': 'en_US:en', 09:45:00 INFO - 'LOGNAME': 'cltbld', 09:45:00 INFO - 'MAIL': '/var/mail/cltbld', 09:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:00 INFO - 'MOZ_NO_REMOTE': '1', 09:45:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:00 INFO - 'NO_EM_RESTART': '1', 09:45:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:00 INFO - 'PWD': '/builds/slave/test', 09:45:00 INFO - 'SHELL': '/bin/bash', 09:45:00 INFO - 'SHLVL': '1', 09:45:00 INFO - 'TERM': 'linux', 09:45:00 INFO - 'TMOUT': '86400', 09:45:00 INFO - 'USER': 'cltbld', 09:45:00 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 09:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:00 INFO - '_': '/tools/buildbot/bin/python'} 09:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:00 INFO - Downloading/unpacking psutil>=0.7.1 09:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:45:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:02 INFO - Installing collected packages: psutil 09:45:02 INFO - Running setup.py install for psutil 09:45:02 INFO - building 'psutil._psutil_linux' extension 09:45:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:45:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:45:03 INFO - building 'psutil._psutil_posix' extension 09:45:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:45:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:45:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:03 INFO - Successfully installed psutil 09:45:03 INFO - Cleaning up... 09:45:03 INFO - Return code: 0 09:45:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1c886b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cecb70>, '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 0x1d3ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e250>, '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': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:45:03 INFO - Using env: {'DISPLAY': ':0', 09:45:03 INFO - 'HOME': '/home/cltbld', 09:45:03 INFO - 'LANG': 'en_US.UTF-8', 09:45:03 INFO - 'LANGUAGE': 'en_US:en', 09:45:03 INFO - 'LOGNAME': 'cltbld', 09:45:03 INFO - 'MAIL': '/var/mail/cltbld', 09:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:03 INFO - 'MOZ_NO_REMOTE': '1', 09:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:03 INFO - 'NO_EM_RESTART': '1', 09:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:03 INFO - 'PWD': '/builds/slave/test', 09:45:03 INFO - 'SHELL': '/bin/bash', 09:45:03 INFO - 'SHLVL': '1', 09:45:03 INFO - 'TERM': 'linux', 09:45:03 INFO - 'TMOUT': '86400', 09:45:03 INFO - 'USER': 'cltbld', 09:45:03 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 09:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:03 INFO - '_': '/tools/buildbot/bin/python'} 09:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:45:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:45:05 INFO - Installing collected packages: mozsystemmonitor 09:45:05 INFO - Running setup.py install for mozsystemmonitor 09:45:05 INFO - Successfully installed mozsystemmonitor 09:45:05 INFO - Cleaning up... 09:45:05 INFO - Return code: 0 09:45:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1c886b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cecb70>, '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 0x1d3ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e250>, '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': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:45:05 INFO - Using env: {'DISPLAY': ':0', 09:45:05 INFO - 'HOME': '/home/cltbld', 09:45:05 INFO - 'LANG': 'en_US.UTF-8', 09:45:05 INFO - 'LANGUAGE': 'en_US:en', 09:45:05 INFO - 'LOGNAME': 'cltbld', 09:45:05 INFO - 'MAIL': '/var/mail/cltbld', 09:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:05 INFO - 'MOZ_NO_REMOTE': '1', 09:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:05 INFO - 'NO_EM_RESTART': '1', 09:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:05 INFO - 'PWD': '/builds/slave/test', 09:45:05 INFO - 'SHELL': '/bin/bash', 09:45:05 INFO - 'SHLVL': '1', 09:45:05 INFO - 'TERM': 'linux', 09:45:05 INFO - 'TMOUT': '86400', 09:45:05 INFO - 'USER': 'cltbld', 09:45:05 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 09:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:05 INFO - '_': '/tools/buildbot/bin/python'} 09:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:07 INFO - Downloading docopt-0.6.1.tar.gz 09:45:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:08 INFO - Running setup.py install for blobuploader 09:45:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:08 INFO - Running setup.py install for requests 09:45:08 INFO - Running setup.py install for docopt 09:45:08 INFO - Successfully installed blobuploader requests docopt 09:45:08 INFO - Cleaning up... 09:45:08 INFO - Return code: 0 09:45:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:08 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 0x7f1c886b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cecb70>, '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 0x1d3ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e250>, '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': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:08 INFO - Using env: {'DISPLAY': ':0', 09:45:08 INFO - 'HOME': '/home/cltbld', 09:45:08 INFO - 'LANG': 'en_US.UTF-8', 09:45:08 INFO - 'LANGUAGE': 'en_US:en', 09:45:08 INFO - 'LOGNAME': 'cltbld', 09:45:08 INFO - 'MAIL': '/var/mail/cltbld', 09:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:08 INFO - 'MOZ_NO_REMOTE': '1', 09:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:08 INFO - 'NO_EM_RESTART': '1', 09:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:08 INFO - 'PWD': '/builds/slave/test', 09:45:08 INFO - 'SHELL': '/bin/bash', 09:45:08 INFO - 'SHLVL': '1', 09:45:08 INFO - 'TERM': 'linux', 09:45:08 INFO - 'TMOUT': '86400', 09:45:08 INFO - 'USER': 'cltbld', 09:45:08 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 09:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:08 INFO - '_': '/tools/buildbot/bin/python'} 09:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:08 INFO - Running setup.py (path:/tmp/pip-TS9R7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:08 INFO - Running setup.py (path:/tmp/pip-2la55o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:08 INFO - Running setup.py (path:/tmp/pip-HDDC5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:09 INFO - Running setup.py (path:/tmp/pip-ZukGPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:09 INFO - Running setup.py (path:/tmp/pip-qVlJr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:09 INFO - Running setup.py (path:/tmp/pip-Krqnpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:09 INFO - Running setup.py (path:/tmp/pip-YsnGeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:09 INFO - Running setup.py (path:/tmp/pip-Jfr29L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:09 INFO - Running setup.py (path:/tmp/pip-F77orn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:09 INFO - Running setup.py (path:/tmp/pip-XfNmlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:09 INFO - Running setup.py (path:/tmp/pip-_kydRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:09 INFO - Running setup.py (path:/tmp/pip-XkvVcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:09 INFO - Running setup.py (path:/tmp/pip-mQgIwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:09 INFO - Running setup.py (path:/tmp/pip-3iGnrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:09 INFO - Running setup.py (path:/tmp/pip-gDHDsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:09 INFO - Running setup.py (path:/tmp/pip-HZ64PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:09 INFO - Running setup.py (path:/tmp/pip-1CSETj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:10 INFO - Running setup.py install for manifestparser 09:45:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:10 INFO - Running setup.py install for mozcrash 09:45:10 INFO - Running setup.py install for mozdebug 09:45:10 INFO - Running setup.py install for mozdevice 09:45:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:10 INFO - Running setup.py install for mozfile 09:45:10 INFO - Running setup.py install for mozhttpd 09:45:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:10 INFO - Running setup.py install for mozinfo 09:45:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:10 INFO - Running setup.py install for mozInstall 09:45:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:10 INFO - Running setup.py install for mozleak 09:45:10 INFO - Running setup.py install for mozlog 09:45:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:11 INFO - Running setup.py install for moznetwork 09:45:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:11 INFO - Running setup.py install for mozprocess 09:45:11 INFO - Running setup.py install for mozprofile 09:45:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:11 INFO - Running setup.py install for mozrunner 09:45:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:11 INFO - Running setup.py install for mozscreenshot 09:45:11 INFO - Running setup.py install for moztest 09:45:11 INFO - Running setup.py install for mozversion 09:45:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:11 INFO - Cleaning up... 09:45:11 INFO - Return code: 0 09:45:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f1c886b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cecb70>, '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 0x1d3ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e250>, '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': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:11 INFO - Using env: {'DISPLAY': ':0', 09:45:11 INFO - 'HOME': '/home/cltbld', 09:45:11 INFO - 'LANG': 'en_US.UTF-8', 09:45:11 INFO - 'LANGUAGE': 'en_US:en', 09:45:11 INFO - 'LOGNAME': 'cltbld', 09:45:11 INFO - 'MAIL': '/var/mail/cltbld', 09:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:11 INFO - 'MOZ_NO_REMOTE': '1', 09:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:11 INFO - 'NO_EM_RESTART': '1', 09:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:11 INFO - 'PWD': '/builds/slave/test', 09:45:11 INFO - 'SHELL': '/bin/bash', 09:45:11 INFO - 'SHLVL': '1', 09:45:11 INFO - 'TERM': 'linux', 09:45:11 INFO - 'TMOUT': '86400', 09:45:11 INFO - 'USER': 'cltbld', 09:45:11 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 09:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:11 INFO - '_': '/tools/buildbot/bin/python'} 09:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:12 INFO - Running setup.py (path:/tmp/pip-rrBN1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:12 INFO - Running setup.py (path:/tmp/pip-VU5Rbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:12 INFO - Running setup.py (path:/tmp/pip-ZP_d_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:12 INFO - Running setup.py (path:/tmp/pip-euinqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:12 INFO - Running setup.py (path:/tmp/pip-xzYPHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:12 INFO - Running setup.py (path:/tmp/pip-60A2AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:12 INFO - Running setup.py (path:/tmp/pip-qFWILD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:12 INFO - Running setup.py (path:/tmp/pip-wFwV3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:12 INFO - Running setup.py (path:/tmp/pip-ZQ5m4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:12 INFO - Running setup.py (path:/tmp/pip-iso6Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:12 INFO - Running setup.py (path:/tmp/pip-ilYMqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:12 INFO - Running setup.py (path:/tmp/pip-y_thfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:12 INFO - Running setup.py (path:/tmp/pip-zMElxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:45:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:13 INFO - Running setup.py (path:/tmp/pip-YVFenY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:13 INFO - Running setup.py (path:/tmp/pip-NQFI2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:13 INFO - Running setup.py (path:/tmp/pip-jEP1Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:13 INFO - Running setup.py (path:/tmp/pip-ocPiut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:45:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:14 INFO - Downloading blessings-1.5.1.tar.gz 09:45:14 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:15 INFO - Installing collected packages: blessings 09:45:15 INFO - Running setup.py install for blessings 09:45:15 INFO - Successfully installed blessings 09:45:15 INFO - Cleaning up... 09:45:15 INFO - Return code: 0 09:45:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:15 INFO - Reading from file tmpfile_stdout 09:45:15 INFO - Current package versions: 09:45:15 INFO - argparse == 1.2.1 09:45:15 INFO - blessings == 1.5.1 09:45:15 INFO - blobuploader == 1.2.4 09:45:15 INFO - docopt == 0.6.1 09:45:15 INFO - manifestparser == 1.1 09:45:15 INFO - mozInstall == 1.12 09:45:15 INFO - mozcrash == 0.16 09:45:15 INFO - mozdebug == 0.1 09:45:15 INFO - mozdevice == 0.47 09:45:15 INFO - mozfile == 1.2 09:45:15 INFO - mozhttpd == 0.7 09:45:15 INFO - mozinfo == 0.9 09:45:15 INFO - mozleak == 0.1 09:45:15 INFO - mozlog == 3.1 09:45:15 INFO - moznetwork == 0.27 09:45:15 INFO - mozprocess == 0.22 09:45:15 INFO - mozprofile == 0.27 09:45:15 INFO - mozrunner == 6.11 09:45:15 INFO - mozscreenshot == 0.1 09:45:15 INFO - mozsystemmonitor == 0.0 09:45:15 INFO - moztest == 0.7 09:45:15 INFO - mozversion == 1.4 09:45:15 INFO - psutil == 3.1.1 09:45:15 INFO - requests == 1.2.3 09:45:15 INFO - wsgiref == 0.1.2 09:45:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:15 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 0x7f1c886b3c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca6900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cecb70>, '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 0x1d3ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e250>, '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': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:45:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:45:15 INFO - Using env: {'DISPLAY': ':0', 09:45:15 INFO - 'HOME': '/home/cltbld', 09:45:15 INFO - 'LANG': 'en_US.UTF-8', 09:45:15 INFO - 'LANGUAGE': 'en_US:en', 09:45:15 INFO - 'LOGNAME': 'cltbld', 09:45:15 INFO - 'MAIL': '/var/mail/cltbld', 09:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:15 INFO - 'MOZ_NO_REMOTE': '1', 09:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:15 INFO - 'NO_EM_RESTART': '1', 09:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:15 INFO - 'PWD': '/builds/slave/test', 09:45:15 INFO - 'SHELL': '/bin/bash', 09:45:15 INFO - 'SHLVL': '1', 09:45:15 INFO - 'TERM': 'linux', 09:45:15 INFO - 'TMOUT': '86400', 09:45:15 INFO - 'USER': 'cltbld', 09:45:15 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 09:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:15 INFO - '_': '/tools/buildbot/bin/python'} 09:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:45:15 INFO - Cleaning up... 09:45:15 INFO - Return code: 0 09:45:15 INFO - Running post-action listener: _resource_record_post_action 09:45:15 INFO - Running post-action listener: _start_resource_monitoring 09:45:15 INFO - Starting resource monitoring. 09:45:15 INFO - ##### 09:45:15 INFO - ##### Running install step. 09:45:15 INFO - ##### 09:45:15 INFO - Running pre-action listener: _resource_record_pre_action 09:45:15 INFO - Running main action method: install 09:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:15 INFO - Reading from file tmpfile_stdout 09:45:15 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:15 INFO - Reading from file tmpfile_stdout 09:45:15 INFO - Output received: 09:45:15 INFO - Usage: mozinstall [options] installer 09:45:15 INFO - Options: 09:45:15 INFO - -h, --help show this help message and exit 09:45:15 INFO - -d DEST, --destination=DEST 09:45:15 INFO - Directory to install application into. [default: 09:45:15 INFO - "/builds/slave/test"] 09:45:15 INFO - --app=APP Application being installed. [default: firefox] 09:45:15 INFO - mkdir: /builds/slave/test/build/application 09:45:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:45:30 INFO - Reading from file tmpfile_stdout 09:45:30 INFO - Output received: 09:45:30 INFO - /builds/slave/test/build/application/firefox/firefox 09:45:30 INFO - Running post-action listener: _resource_record_post_action 09:45:30 INFO - ##### 09:45:30 INFO - ##### Running run-tests step. 09:45:30 INFO - ##### 09:45:30 INFO - Running pre-action listener: _resource_record_pre_action 09:45:30 INFO - Running main action method: run_tests 09:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:45:30 INFO - Python 2.7.3 09:45:30 INFO - Return code: 0 09:45:30 INFO - grabbing minidump binary from tooltool 09:45: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')]} 09:45:30 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 0x1cecb70>, '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 0x1d3ddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d3e250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:45:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:45:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:45:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:45:30 INFO - Return code: 0 09:45:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:45:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:45:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:45:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:45:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:45:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] in /builds/slave/test/build 09:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost 09:45:30 INFO - Using env: {'DISPLAY': ':0', 09:45:30 INFO - 'HOME': '/home/cltbld', 09:45:30 INFO - 'LANG': 'en_US.UTF-8', 09:45:30 INFO - 'LANGUAGE': 'en_US:en', 09:45:30 INFO - 'LOGNAME': 'cltbld', 09:45:30 INFO - 'MAIL': '/var/mail/cltbld', 09:45:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:45:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:30 INFO - 'MOZ_NO_REMOTE': '1', 09:45:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:30 INFO - 'NO_EM_RESTART': '1', 09:45:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:30 INFO - 'PWD': '/builds/slave/test', 09:45:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:45:30 INFO - 'SHELL': '/bin/bash', 09:45:30 INFO - 'SHLVL': '1', 09:45:30 INFO - 'TERM': 'linux', 09:45:30 INFO - 'TMOUT': '86400', 09:45:30 INFO - 'USER': 'cltbld', 09:45:30 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061', 09:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:30 INFO - '_': '/tools/buildbot/bin/python'} 09:45:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] with output_timeout 3600 09:45:30 INFO - mozversion INFO | application_buildid: 20151124083121 09:45:30 INFO - mozversion INFO | application_changeset: d516d82f29a2636c5834c7f3c932025b8e85a8ad 09:45:30 INFO - mozversion INFO | application_display_name: Nightly 09:45:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:45:30 INFO - mozversion INFO | application_name: Firefox 09:45:30 INFO - mozversion INFO | application_remotingname: firefox 09:45:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:45:30 INFO - mozversion INFO | application_vendor: Mozilla 09:45:30 INFO - mozversion INFO | application_version: 45.0a1 09:45:30 INFO - mozversion INFO | platform_buildid: 20151124083121 09:45:30 INFO - mozversion INFO | platform_changeset: d516d82f29a2636c5834c7f3c932025b8e85a8ad 09:45:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:45:30 INFO - mozversion INFO | platform_version: 45.0a1 09:45:30 INFO - 2015-11-24 09:45:30,348 DEBUG : using testdate: 1448387130 09:45:30 INFO - 2015-11-24 09:45:30,348 DEBUG : actual date: 1448387130 09:45:30 INFO - 2015-11-24 09:45:30,357 INFO : starting webserver on 'localhost:45489' 09:45:30 INFO - 2015-11-24 09:45:30,358 INFO : Starting test suite talos-linux64-ix-065.e 09:45:30 INFO - 2015-11-24 09:45:30,358 INFO : Starting test dromaeo_css 09:45:30 INFO - 2015-11-24 09:45:30,358 DEBUG : operating with platform_type : linux_ 09:45:30 INFO - 2015-11-24 09:45:30,359 INFO : Initialising browser for dromaeo_css test... 09:45:30 INFO - 2015-11-24 09:45:30,375 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNhd15P/profile http://localhost:45489/getInfo.html 09:45:35 INFO - 2015-11-24 09:45:35,958 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:45:35 INFO - 2015-11-24 09:45:35,958 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:45:35 INFO - 2015-11-24 09:45:35,958 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:45:35 INFO - 2015-11-24 09:45:35,958 DEBUG : BROWSER_OUTPUT: __metrics 09:45:37 INFO - 2015-11-24 09:45:37,009 INFO : Browser initialized. 09:45:37 INFO - 2015-11-24 09:45:37,009 INFO : Running cycle 1/1 for dromaeo_css test... 09:45:37 INFO - 2015-11-24 09:45:37,010 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNhd15P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:45:48 INFO - 2015-11-24 09:45:48,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 141824000 09:45:48 INFO - 2015-11-24 09:45:48,954 DEBUG : BROWSER_OUTPUT: 09:46:38 INFO - 2015-11-24 09:46:38,622 DEBUG : BROWSER_OUTPUT: 1448387198616 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:48:50 INFO - 2015-11-24 09:48:50,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45489/tests/dromaeo/cssquery-ext.html) 09:48:51 INFO - 2015-11-24 09:48:51,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 144187392 09:48:51 INFO - 2015-11-24 09:48:51,165 DEBUG : BROWSER_OUTPUT: 09:51:53 INFO - 2015-11-24 09:51:53,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/dromaeo/cssquery-ext.html (next: http://localhost:45489/tests/dromaeo/cssquery-jquery.html) 09:51:53 INFO - 2015-11-24 09:51:53,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 142917632 09:51:53 INFO - 2015-11-24 09:51:53,731 DEBUG : BROWSER_OUTPUT: 09:54:55 INFO - 2015-11-24 09:54:55,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45489/tests/dromaeo/cssquery-mootools.html) 09:54:56 INFO - 2015-11-24 09:54:56,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 142028800 09:54:56 INFO - 2015-11-24 09:54:56,175 DEBUG : BROWSER_OUTPUT: 09:57:57 INFO - 2015-11-24 09:57:57,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45489/tests/dromaeo/cssquery-prototype.html) 09:57:58 INFO - 2015-11-24 09:57:58,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 141033472 09:57:58 INFO - 2015-11-24 09:57:58,561 DEBUG : BROWSER_OUTPUT: 10:01:01 INFO - 2015-11-24 10:01:01,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45489/tests/dromaeo/cssquery-yui.html) 10:01:01 INFO - 2015-11-24 10:01:01,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 142147584 10:01:01 INFO - 2015-11-24 10:01:01,818 DEBUG : BROWSER_OUTPUT: 10:04:04 INFO - 2015-11-24 10:04:04,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/dromaeo/cssquery-yui.html (next: http://localhost:45489/tests/dromaeo/cssquery-dojo.html) 10:04:04 INFO - 2015-11-24 10:04:04,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 144846848 10:04:04 INFO - 2015-11-24 10:04:04,431 DEBUG : BROWSER_OUTPUT: 10:04:04 INFO - 2015-11-24 10:04:04,431 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:04:04 INFO - 2015-11-24 10:04:04,431 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:04:04 INFO - 2015-11-24 10:04:04,432 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:04:04 INFO - 2015-11-24 10:04:04,432 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:04:04 INFO - 2015-11-24 10:04:04,432 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2634.4072583668676;2677.9062732804355;2699.4736026474843;2716.959245611316;2720.7279272072797;4520.525344838794;4739.8815029624275;4744.739039352834;4765.857024289273;4776.259679749635;4643.582077613014;4665.113628410608;4709.246520556711;4748.5726284634375;4761.381020467335;4316.287812510932;4357.891052723676;4438.489573699034;4465.799039043251;4483.551644835523;4346.6739994500385;4404.647628189737;4427.225235583776;4514.27771556551;4548.067646132551;4180.937285940713;4229.471316085489;4312.482502099768;4443.822247110112;4474.955250447519;4343.869683909487;4359.193549193409;4372.431583894106;4389.802458889326;4403.471583409979;4318.028443600197;4323.956760432387;4325.935110973338;4338.783060846977;4373.978130109361;4497.302918047708;4548.704334218265;4583.3125031245245;4649.093426781779;4685.0395668887795;5013.799448022075;5027.622928280393;5040.16837221858;5047.87380315495;5070.974645126787;5044.873878153039;5046.116929537353;5050.494950504957;5070.391553013662;5084.51697088776;4488.775561221959;4595.586397224266;4627.722336659777;4669.089527542164;4719.622430205575;5088.720120393414;5089.440161582223;5096;5138.049460849755;5147.047796157723;4736.407949006374;4887.706737595756;4890.388701412324;4920.237363208708;4927.039227350632;4799.976000120047;4923.655344125877;4928.48250933654;4934.432540257844;4978.4025916890205;4933.062718083553;5011.5489605935645;5012.649114562018;5019.0463811875625;5049.772760225798;4763.3807605011125;4885;4975.626827987915;4998.550130488201;5056.82301119459;4056.8782936511952;4099.385092236188;4125.525564560054;4130.256553820281;4156.376543518496;3640.7087433005295;3659.652333028358;3666.046827824785;3697.574778900461;3701.6668499835146;4185.393117997874;4232.132412855357;4315.935260971088;4366.847160349373;4378.8029538670835;5088.465711100355;5118.10433174193;5121.2574176744165;5126.718030508283;5140.074786538459;4402.185595664812;4426.822927082945;4428.31361139024;4436.977815110969;4479.7984090715345;4254.255505286563;4414.381986521889;4416.558344165622;4417.624501917308;4522.683412161183;4640.9535904640525;4682.4381074271305;4710.858674239778;4727.669063165546;4781.378420805273;5051.393832740095;5059.266406371129;5059.721715305694;5085.567726743268;5086.186210206497;4610.953890461053;4709.505501922249;4736.644751643709;4739.218029025173;4824.131656301759;4944;4986.501349864984;5011.799528018839;5014.648974571891;5024.673396229234;5089.720065396439;5092.261622064854;5097.949020509747;5100.20946753239;5136.049830781318;4748.501407352316;4809.975950120227;4888.60891128716;4916.237983112624;4930.580900623487;4842.709437433765;4854.80580776765;4879.829205977774;4882.292067650242;4946.35697359341;4769.73766442849;4780.617550596014;4794.736289504111;4801.975990120167;4852.539008794159;4751.40607424072;4806.279058141306;4898.632602554751;4915.361003069578;4934.679245849008;4715.292706094114;4732.077244937204;4750.548697873696;4776.283557466269;4789.042191561772 10:04:04 INFO - 2015-11-24 10:04:04,432 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.3320299039657;567.7047935073763;574.7384939852368;576.0523938121789;582.3739480058938;36032.639673603255;36662.816685916536;36874.8156259219;36877.63122368776;37090.62909370905;39417.40873886894;40296.59703402965;40599.79700101495;40606.7969660152;40660;7809.726659566916;7925.722599709012;7954.443188976774;7963;7965.6813727450835;7858.685652573919;7950;7966.044074711014;7969.840603187962;7973.920260797376;7834.255745704149;7870.173631768667;7884.526928384286;7908.604569771517;7917.208279172094;7809.492382995087;7885.96057019717;7891.960540197262;7941.841163176733;7953.244441778051;7806.57063861493;7900.723474678416;7900.881486777703;7904.249096335839;7916.960415197945;36929.630703693154;37161;37251.81374093139;37354.43968340477;37378.81310593457;2567.8459292442512;2748.670159580843;2884.4952133376573;3282.2450836307544;3293.818839963801;27764.861175694194;27980.160595181973;28011.859940700167;28149;28303.15090547287;3297.1097803593134;3476.5132881396626;3478.7912725236315;3510;3540.4689296605457;221387;222110;223561.88219058962;224214;225459;50092;51373.22940155901;56433;60241.09638355428;61745;56848.431515685144;57180.42819571834;57334.7133264331;57553.42446575564;57561.42438575561;13974.930125349309;14019;14185;14213.573592792232;14245.501407450689;10707.785844283071;10804.459777011118;10825.566977320976;10854.34873907568;10979;18765.530861728294;18856.245750170114;18942.337018204573;19027.14377853;19122.71315930262;7576.924230757621;7842.5686587237105;7907.9604601976625;7970.202979701983;8025.157358477392;791.2443616346376;823.1357075071152;826.2604968553111;887.7425546591545;913.8446464100986;25909.74090259111;26170.476590468083;26233.213003609922;26325.73674263233;26350.47299054008;934.8223837470858;957.7653474898694;984.606157536991;1020.8672872526524;1103.9724006899892;13123.820742944394;13240.667907958517;13372.866271337356;13440.260785656883;13476.258805765581;333017;339644;340163;340371;343350;45567.58243131779;45596.54403455923;45799.542004579525;45874.54125458703;45897.77051114723;1149.8850114988434;1213.3447938113497;1214.4352875912743;1217.908656850722;1217.945192466341;24850.502989939738;25269.494610107326;25606.487870242865;25620.23139305824;25764.871175644003;37648.623513765604;38131.80934095312;38144.80927595344;38145.2370952585;38483.230335393695;236527;239259;239263;239986;240026;28461.715382845905;40585.391219132325;41189;41643.37534937039;41977;38416.42375364316;38700.6129938697;38825.80587097159;39688.206235875696;39841.2031759369;33190.66809331876;33341.16647083842;33932.49101263434;34102;34130.82934585311;34225.14437139092;34326.656733433345;34462.655373445945;34652.30695386128;34799.47800783041;33826.3234735299;33960.320793583494;34326.14184645404;34626.48060279148;34691.47962780611;30027.699723003363;30481;31003.68996310008;31016.379672406878;31073.8446307767;23886.044558217476;24159.75840241575;24451.26646200617;24584.754152458245;24785.62821557714 10:04:04 INFO - 2015-11-24 10:04:04,433 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.9017939707785;332.9550510681057;333.1920093772601;336.00079526815455;336.4247137395054;14700.852991470083;15285.388584456623;15571;15672.764908526382;16385.09881956492;14375.784363234534;14416.20710860905;14529.636759081002;14535.418583256656;14693.55919322422;4449.243628583149;6223.066540018988;6471.741130354781;6483.7082331295205;6485.221773387177;5391.083515802323;5768.3654797972185;6485.2541957675;6490.578112422701;6493.448056915168;5890.823275301748;6046.667433291167;6091.543134264925;6640.56836305641;6666.966665166668;6005.4895333896675;6075.392460753934;6085.300190478108;6119.694015299239;6254.937450625481;6060.212172417601;6070.514358851281;6074.240719910012;6076.5442591805795;6081.96606576883;19046;20752;20862.26982055621;20873.165073397045;21892.12431502738;1856.1276200186026;1862.757841480599;1884.1521315408122;1925.1625542888887;1958.8922609256485;12628.68428289291;13004.284764337957;13040.54358097462;13192.86807131926;13403.195808251536;1739.2173521915063;1761.3042848075067;1794.9192286347015;1797.6224992751538;1811.3207547169811;60145.6992715038;64645;64728.67635661839;65329;65359;15542.84457155414;15599.376024959101;15601.843981560267;15606.3757449703;15833.841661583467;22597.2090976815;22599;22847.885760571422;22854.31437056891;22895.198668046538;8630.697925572575;8654.22112009922;8681.696140635047;8688.218060374596;8767.736967890845;7231.674574644154;7251.456140789356;7295.817604559928;7309.853802923912;7335.889961650473;7527.397808175333;7552.962235188898;7620.80947976305;7629.20713632296;7633.732819351407;1658.286936617266;1722.3627257914652;2860.127661063354;2990.2673844908136;3002.4237275430137;773.7601343583507;817.7464985854285;911.4166933162782;915.4049867586123;966.6858271061933;15072.171030593423;15445.536633901002;15567.688646227012;15685.137317447421;15749.842501574838;782.5031105248208;785.8742601183783;805.8025783682918;815.4740192575874;841.7222316635496;8258.926339575817;8317.41778075529;8389.286910612544;8451.619677114422;8532.232099110986;462022;468819;486272;488617;492780;72309.27690723131;72655.2734472659;73576.26423735802;73712.26287737161;74095.62952185313;1023.7798873242289;1071.2019545438543;1076.381080878498;1133.4049623947494;1152.6484422251294;13361;13677.452901884211;13721.382537785625;14023.527529609652;14265.358058887168;31760.570774315674;32641.510377344835;32843.671563284064;33153;33617.495737564444;40637.79681101694;43018.05292391415;44356.33465497955;46194.76902615465;46281.53718462772;8789.472631642122;8796.780080498038;8946.37375383717;8978.057303982987;9098;10179.389236645826;10228.64199753005;10307.742306442398;10317;11753.118516111155;10577.682669519927;12612.936935315633;12630.431630576462;12660.240385576526;12667.113302068767;8411.327093832357;8644.740657780276;12451.688707782378;12640.810387844374;12736.363181840685;9225.630974760934;9227.86158207614;9708.368956017835;9710.70867873965;9724.95137524308;13738.65653358674;14123.223222722849;14411.351489182802;14504.274786260856;14507.896355028673;14102.36539355711;14226.430942762174;14573;15113.697726045637;15159 10:04:04 INFO - 2015-11-24 10:04:04,434 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1499.9250037498123;1523.8704710099644;1600.7278762610356;1620.9594760130994;1631.1518010634463;6586.308437614053;6790.728370865159;6871.244163142051;6891.310868913106;6934.895976560343;6919.550229235108;6986.126734158231;6994.860102797941;7001.019857219981;7059;1989.9005049747527;2012.2856385982984;2014.8488863335235;2020.464576887126;2028.0468179955396;2035.8065983731522;2061.309461330456;2070.534129820793;2088.6240476714183;2090.8745475271458;2006.9698954515693;2033.2070492507933;2036.6028624418245;2052.7434070741156;2072.9792702073014;1993.531520092777;2020.2424090965887;2023.4132101690493;2025.3923822853085;2025.7872923343132;1926.922923083075;1973.4770285874256;1975.8320542753884;1977.5550501137272;1985.2158397433077;6766.15423072116;6825.965870170667;6828.52200345976;6835.93164068358;6852.177738671341;4118.629323360882;4172.749635021908;4178.456800615931;4182.226288136704;4185.811638476276;2693.7440943110373;2708.674959004912;2789.6791868934924;2797.2587264374956;2806.845623490707;872.5375550958003;906.1074841281398;920.2178148573659;922.7831459606987;947.2280091725222;8877.778055548599;8961.551922403854;8977.192052715287;9002.414843035247;9055.320850936207;3564.590072141685;3639.9818000909827;3655.1593133579427;3694.5935947045805;3709.5919448860604;7496.212897645669;7499.62501874915;7509.474336796481;7514.0607424071995;7515.098188217449;3922.1763429679518;3936.075022369741;3957.703172262092;3975.3838155085427;3987.1626958339075;3654.3056819204267;3670.596234414212;3696.353138200804;3699.075231192202;3708.2027364116843;3009.5184770436626;3023.183740390082;3026.137550798012;3030.530267808493;3051.3287076843058;897.3225214962791;898.869663898731;899.3299991506369;904.4754042655244;912.2382810353429;837.1335667584021;842.7303262955918;842.8187939593017;903.1375036839802;1050.658535975811;6358.554901156967;6388.680565971683;6402.807915762534;6406.935930640634;6411.903821442682;1017.9847302290472;1029.5984566019258;1032.808930347888;1043.6034306963456;1044.2011860926398;5151.021305951857;5190.92213616796;5211.895762084737;5215.035218484592;5219.712915789668;7999.800004999922;8019.719309824245;8097.514149151069;8167.060788009455;8302.460340077996;8139.348852091818;8148.592570371457;8186.8538404623405;8204.548749818698;8215.383846211438;6359.982402815527;6372.426481616677;6426.35736426363;6448.290688024314;6449.193850768654;6157.722902469489;6283.120363149072;6308.053791931247;6309.085182648399;6314.684265786784;7066.646667666699;7262.3826974707745;7268.818279543054;7405.62971851416;7447.292507211806;7040.647967601497;7115.964420177866;7411.962940185264;7459.477836551389;7482.3639990601405;5784.623999440023;5797.188393624981;5820.068788993741;5823.417658234142;5842.298924129132;6211.627302361872;6263.937360626518;6283.968580157253;6324.905126423199;6337.714802833976;5897.882042359214;6004.909926351195;6017.879642407215;6103.633781973096;6113.205283313141;5583.832485025456;5680.147977803363;5728.942710573007;5733.913991290051;5917.970410147922;6104.38956104386;6158.538109641705;6172.814815555541;6183.628982261079;6214.658193799384;5746.42535746422;5773.913391299218;5786.045302525036;5796.797112101056;5801.94198058014;5206.6095042871175;5565.332160140809;5573.080441727069;5815.5929084963645;5821.301443826768 10:04:04 INFO - 2015-11-24 10:04:04,435 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.24052350171576;315.8831232443996;315.9921001974949;316.09438957387096;316.20632213145007;5538.75075621597;5598;5695.487406133452;5706.457886500786;5716.1711551824965;5456;5564.8052318168775;5567.137093750465;5575.470330318623;5581.079121944874;4298.828046878121;4380.956190438087;4384.693071484998;4408.3167109097985;4413.139437809628;4394.07724377881;4394.165108629366;4395.86812395627;4409;4417;4357.150355680644;4363.083752411997;4363.890902727441;4365.956340436603;4366.672499562545;4357.433533640622;4359.433273674418;4361.672874534423;4366.08312254427;4380;3728.5898551159353;3823.5794062653085;3860.073582340246;3862.671672907806;3864.130570621616;5320.441353657849;5381.165919282517;5399.7030163341;5405.972865155608;5453.072977593819;4991.900161996739;4994.175960966436;5005.674631148963;5007.4491805901325;5009.899802003976;5876.471117599436;5900.940990590082;5909.615874968156;5914.260717410324;5935.614185077956;4060.3097473429293;4181.247375472413;4182.979085104555;4184.351425529047;4194.601512856274;6089.056196289582;6175.042868355367;6183.319834818167;6183.845403864894;6206.324292441106;4307.56924307573;4309.073549186877;4315.503717072577;4315.633171180422;4320.65434765218;4364.410804541346;4365.694401391936;4383.101464199832;4391.143726973273;4391.3193455014525;4782;4881.780319885614;4945.357103576512;4963.925541116886;4965.453800081988;5863.091220860773;5870.002099642986;5872.588918775645;5875.353711091777;5894.970525147432;1535.485612319863;1549.6435819761518;1551.5190291009824;1556.2841093097077;1562.3906676396214;1060.1571750458404;1065.0574241796066;1071.0467683761458;1087.2117714656968;1089.8855620159768;5139.12634852076;5146.511081447256;5159.17453207485;5162.457941916045;5166.509181627739;6141.785037523755;6143.96928015366;6144.07838824171;6146.78486252979;6147.66187859672;5087.974560127176;5134.5378915897;5152.3044389007755;5165.690058596496;5177.145770947826;3212.5984251968503;3264;3326.5176549400203;3343.6154842192973;3359.227377703142;5701.515371193412;5763.567732420085;5766.192733017381;5812.564057695689;5816.040353341651;6298.464630506367;6326.240851097806;6354.841128971812;6360.809175724736;6375.521835862329;5744.540436765133;5758.049921762862;5758.856028599319;5770.422957704196;5829.8251052468495;5906.497947674496;6160.9383906160365;6162.876742465215;6172.074188871705;6177;5987.491063259672;6006.759729610942;6016;6017.428344307284;6019.518438524995;5774;5777.94222057774;5793.15999180125;5806.593538452268;5811.883762324815;4097.44684467605;4124.7731374773475;4130.504339479282;4131;4132.628063474302;6034.849128771641;6114.633122012693;6137.754489820536;6156.876862462816;6180.042093475518;5909.6158749681135;5920.111983202554;5923.644581325134;5929.822105336847;5954.612950158225;5945.524358051432;5949.583529152917;5950.256217972754;5951.732172052181;5959.791407300723;5664.291963504562;5755.8561035974435;5808.651480911159;5820.039693450533;5820.70896455184;5970.492508136684;5976.940230597638;5979.4917432018765;5986.3238293277955;6002.849928751816;5818.33089194748;5821.126830975388;5825.446582574648;5830;5841.18223448726 10:04:04 INFO - 2015-11-24 10:04:04,435 DEBUG : BROWSER_OUTPUT: |5;yui.html;655.0109334904295;770.3067239484467;775.9146493885671;781.5076501803866;784.3881772217669;11030.338179709213;11055.778884422316;11202.887971120286;11240.718982025453;11283.323000619957;11234.32594044358;11343.43282835857;12754.362281885891;12984.610461686141;13000.28498432586;743.6690672650673;746.0860445953704;751.6054071612419;756.1115689065326;759.981624623005;755.4070055006821;755.9697612095509;757.7007082202526;760.5018712743162;763.9923600763976;785.9842803143933;787.0633945604741;788.597815114293;792.4413288631501;796.0208943000114;785.9371250299962;786.4219798448136;787.4330482052912;788.3614272439343;790.6876783670447;580.1240127407602;583.0991118721543;586.7418335932219;586.7564960541371;588.4086493074433;11650.766984660258;11863;11864.584739534075;11864.644060678107;11896.286222826659;11158.330500170016;11404.201705880592;11453.713657158554;11581;11687.357195354252;9005.369624126313;9006.729798106002;9049.140331668481;9074.818503629891;9123.726288211297;3183.1405520509334;3192.6328472225528;3199.5520627112223;3244.1403028197547;3265.134739294065;43879;44039.33940990888;44339;44391.77804110991;44406;9290.860637090449;9465.66870159541;9644.276679248944;9667.419954802594;9803.019698030283;16369.590760231089;16426.589335266715;16559.586010349838;16569.42007029772;16585.336586536403;6065.363136870653;6263.812085637438;6295.464885484785;6365.904511432333;6477.870442591122;3252.1381833814057;3394.575678040245;3402.996116145743;3412.129906873781;3471.7222622190166;2573.5496288149498;2576.4074262919635;2599.337169021925;2606.6741657292837;2608.3479130217447;468.2110643565603;468.6133939499926;476.0954187044643;478.0963978081429;482.68384208343593;465.7135861445187;470.9152352576569;536.924830523727;551.4320250142359;579.6493121661418;6962.1645402551;7140.250273721184;7152.570845749272;7189.1013623297085;7327.340539351484;414;492.33288893548723;500.6470438340961;556.1268807971527;595.6694034810635;3170.7621928355466;3338.2488939988793;3339.6660333966893;3351.949720754191;3436.278381539905;47083.76458117756;47721;47779.76110119427;51598.48401516012;51620;43598;44387.334189987174;44421.55578444239;44617.330740038924;45641.77179114083;42301.78849105735;42586;42812.35781463281;42897.14205715868;42903.78548107302;6995.901229631192;7403.962980185064;7572.507786993828;7754.612269386621;7791.571463569559;29700.257493562833;30061.549076764302;30542.541861871647;31194.532082019243;32273.677263228008;39378.40932385959;39431.211375772895;39603.405948910215;39683.2063358737;40464.79767601143;9497.335186536877;9696.175825054666;9738.659146930107;9819.312648114563;9822.65620703272;9797.363171393836;10355.43045132525;10551;10580.15358771281;11398.658040258806;9190.862137068083;9307.906920930704;9440;9449.574769135543;9458.858117128111;9849.852252216078;9870.506474676382;10000;10085;10158.695239142837;8397.202265784741;9102.817943641223;9218.354715169873;9385.765355866159;9554.140127388291;7967.880481792894;8107.3114680387735;8232.711855085043;8263.917360826315;8330;8061.717839875576;8092.947916770782;8200.630971606173;8319.584020798815;8345.332373410234 10:04:04 INFO - 2015-11-24 10:04:04,435 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:04:04 INFO - 2015-11-24 10:04:04,435 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:04:04 INFO - 2015-11-24 10:04:04,435 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,328 10:04:04 INFO - 2015-11-24 10:04:04,436 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:04:04 INFO - 2015-11-24 10:04:04,436 DEBUG : BROWSER_OUTPUT: __startTimestamp1448388244424__endTimestamp 10:04:04 INFO - 2015-11-24 10:04:04,436 DEBUG : BROWSER_OUTPUT: 10:04:04 INFO - 2015-11-24 10:04:04,436 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:04:04 INFO - 2015-11-24 10:04:04,436 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:04:04 INFO - 2015-11-24 10:04:04,436 DEBUG : BROWSER_OUTPUT: 10:04:04 INFO - 2015-11-24 10:04:04,436 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4634.86 Median:4748.50 stddev:480.17 (10.1%) stddev-sans-first:455.28 10:04:04 INFO - 2015-11-24 10:04:04,436 DEBUG : BROWSER_OUTPUT: Values: 2634.4 2677.9 2699.5 2717.0 2720.7 4520.5 4739.9 4744.7 4765.9 4776.3 4643.6 4665.1 4709.2 4748.6 4761.4 4316.3 4357.9 4438.5 4465.8 4483.6 4346.7 4404.6 4427.2 4514.3 4548.1 4180.9 4229.5 4312.5 4443.8 4475.0 4343.9 4359.2 4372.4 4389.8 4403.5 4318.0 4324.0 4325.9 4338.8 4374.0 4497.3 4548.7 4583.3 4649.1 4685.0 5013.8 5027.6 5040.2 5047.9 5071.0 5044.9 5046.1 5050.5 5070.4 5084.5 4488.8 4595.6 4627.7 4669.1 4719.6 5088.7 5089.4 5096.0 5138.0 5147.0 4736.4 4887.7 4890.4 4920.2 4927.0 4800.0 4923.7 4928.5 4934.4 4978.4 4933.1 5011.5 5012.6 5019.0 5049.8 4763.4 4885.0 4975.6 4998.6 5056.8 4056.9 4099.4 4125.5 4130.3 4156.4 3640.7 3659.7 3666.0 3697.6 3701.7 4185.4 4232.1 4315.9 4366.8 4378.8 5088.5 5118.1 5121.3 5126.7 5140.1 4402.2 4426.8 4428.3 4437.0 4479.8 4254.3 4414.4 4416.6 4417.6 4522.7 4641.0 4682.4 4710.9 4727.7 4781.4 5051.4 5059.3 5059.7 5085.6 5086.2 4611.0 4709.5 4736.6 4739.2 4824.1 4944.0 4986.5 5011.8 5014.6 5024.7 5089.7 5092.3 5097.9 5100.2 5136.0 4748.5 4810.0 4888.6 4916.2 4930.6 4842.7 4854.8 4879.8 4882.3 4946.4 4769.7 4780.6 4794.7 4802.0 4852.5 4751.4 4806.3 4898.6 4915.4 4934.7 4715.3 4732.1 4750.5 4776.3 4789.0 10:04:04 INFO - 2015-11-24 10:04:04,436 DEBUG : BROWSER_OUTPUT: 10:04:04 INFO - 2015-11-24 10:04:04,436 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42856.92 Median:19154.74 stddev:71271.01 (372.1%) stddev-sans-first:71400.17 10:04:04 INFO - 2015-11-24 10:04:04,438 DEBUG : BROWSER_OUTPUT: Values: 554.3 567.7 574.7 576.1 582.4 36032.6 36662.8 36874.8 36877.6 37090.6 39417.4 40296.6 40599.8 40606.8 40660.0 7809.7 7925.7 7954.4 7963.0 7965.7 7858.7 7950.0 7966.0 7969.8 7973.9 7834.3 7870.2 7884.5 7908.6 7917.2 7809.5 7886.0 7892.0 7941.8 7953.2 7806.6 7900.7 7900.9 7904.2 7917.0 36929.6 37161.0 37251.8 37354.4 37378.8 2567.8 2748.7 2884.5 3282.2 3293.8 27764.9 27980.2 28011.9 28149.0 28303.2 3297.1 3476.5 3478.8 3510.0 3540.5 221387.0 222110.0 223561.9 224214.0 225459.0 50092.0 51373.2 56433.0 60241.1 61745.0 56848.4 57180.4 57334.7 57553.4 57561.4 13974.9 14019.0 14185.0 14213.6 14245.5 10707.8 10804.5 10825.6 10854.3 10979.0 18765.5 18856.2 18942.3 19027.1 19122.7 7576.9 7842.6 7908.0 7970.2 8025.2 791.2 823.1 826.3 887.7 913.8 25909.7 26170.5 26233.2 26325.7 26350.5 934.8 957.8 984.6 1020.9 1104.0 13123.8 13240.7 13372.9 13440.3 13476.3 333017.0 339644.0 340163.0 340371.0 343350.0 45567.6 45596.5 45799.5 45874.5 45897.8 1149.9 1213.3 1214.4 1217.9 1217.9 24850.5 25269.5 25606.5 25620.2 25764.9 37648.6 38131.8 38144.8 38145.2 38483.2 236527.0 239259.0 239263.0 239986.0 240026.0 28461.7 40585.4 41189.0 41643.4 41977.0 38416.4 38700.6 38825.8 39688.2 39841.2 33190.7 33341.2 33932.5 34102.0 34130.8 34225.1 34326.7 34462.7 34652.3 34799.5 33826.3 33960.3 34326.1 34626.5 34691.5 30027.7 30481.0 31003.7 31016.4 31073.8 23886.0 24159.8 24451.3 24584.8 24785.6 10:04:04 INFO - 2015-11-24 10:04:04,438 DEBUG : BROWSER_OUTPUT: 10:04:04 INFO - 2015-11-24 10:04:04,438 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27174.32 Median:336.21 stddev:78365.74 (23308.4%) stddev-sans-first:78559.66 10:04:04 INFO - 2015-11-24 10:04:04,438 DEBUG : BROWSER_OUTPUT: Values: 332.9 333.0 333.2 336.0 336.4 14700.9 15285.4 15571.0 15672.8 16385.1 14375.8 14416.2 14529.6 14535.4 14693.6 4449.2 6223.1 6471.7 6483.7 6485.2 5391.1 5768.4 6485.3 6490.6 6493.4 5890.8 6046.7 6091.5 6640.6 6667.0 6005.5 6075.4 6085.3 6119.7 6254.9 6060.2 6070.5 6074.2 6076.5 6082.0 19046.0 20752.0 20862.3 20873.2 21892.1 1856.1 1862.8 1884.2 1925.2 1958.9 12628.7 13004.3 13040.5 13192.9 13403.2 1739.2 1761.3 1794.9 1797.6 1811.3 60145.7 64645.0 64728.7 65329.0 65359.0 15542.8 15599.4 15601.8 15606.4 15833.8 22597.2 22599.0 22847.9 22854.3 22895.2 8630.7 8654.2 8681.7 8688.2 8767.7 7231.7 7251.5 7295.8 7309.9 7335.9 7527.4 7553.0 7620.8 7629.2 7633.7 1658.3 1722.4 2860.1 2990.3 3002.4 773.8 817.7 911.4 915.4 966.7 15072.2 15445.5 15567.7 15685.1 15749.8 782.5 785.9 805.8 815.5 841.7 8258.9 8317.4 8389.3 8451.6 8532.2 462022.0 468819.0 486272.0 488617.0 492780.0 72309.3 72655.3 73576.3 73712.3 74095.6 1023.8 1071.2 1076.4 1133.4 1152.6 13361.0 13677.5 13721.4 14023.5 14265.4 31760.6 32641.5 32843.7 33153.0 33617.5 40637.8 43018.1 44356.3 46194.8 46281.5 8789.5 8796.8 8946.4 8978.1 9098.0 10179.4 10228.6 10307.7 10317.0 11753.1 10577.7 12612.9 12630.4 12660.2 12667.1 8411.3 8644.7 12451.7 12640.8 12736.4 9225.6 9227.9 9708.4 9710.7 9725.0 13738.7 14123.2 14411.4 14504.3 14507.9 14102.4 14226.4 14573.0 15113.7 15159.0 10:04:04 INFO - 2015-11-24 10:04:04,439 DEBUG : BROWSER_OUTPUT: 10:04:04 INFO - 2015-11-24 10:04:04,439 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4732.03 Median:5907.93 stddev:2415.29 (40.9%) stddev-sans-first:2409.85 10:04:04 INFO - 2015-11-24 10:04:04,440 DEBUG : BROWSER_OUTPUT: Values: 1499.9 1523.9 1600.7 1621.0 1631.2 6586.3 6790.7 6871.2 6891.3 6934.9 6919.6 6986.1 6994.9 7001.0 7059.0 1989.9 2012.3 2014.8 2020.5 2028.0 2035.8 2061.3 2070.5 2088.6 2090.9 2007.0 2033.2 2036.6 2052.7 2073.0 1993.5 2020.2 2023.4 2025.4 2025.8 1926.9 1973.5 1975.8 1977.6 1985.2 6766.2 6826.0 6828.5 6835.9 6852.2 4118.6 4172.7 4178.5 4182.2 4185.8 2693.7 2708.7 2789.7 2797.3 2806.8 872.5 906.1 920.2 922.8 947.2 8877.8 8961.6 8977.2 9002.4 9055.3 3564.6 3640.0 3655.2 3694.6 3709.6 7496.2 7499.6 7509.5 7514.1 7515.1 3922.2 3936.1 3957.7 3975.4 3987.2 3654.3 3670.6 3696.4 3699.1 3708.2 3009.5 3023.2 3026.1 3030.5 3051.3 897.3 898.9 899.3 904.5 912.2 837.1 842.7 842.8 903.1 1050.7 6358.6 6388.7 6402.8 6406.9 6411.9 1018.0 1029.6 1032.8 1043.6 1044.2 5151.0 5190.9 5211.9 5215.0 5219.7 7999.8 8019.7 8097.5 8167.1 8302.5 8139.3 8148.6 8186.9 8204.5 8215.4 6360.0 6372.4 6426.4 6448.3 6449.2 6157.7 6283.1 6308.1 6309.1 6314.7 7066.6 7262.4 7268.8 7405.6 7447.3 7040.6 7116.0 7412.0 7459.5 7482.4 5784.6 5797.2 5820.1 5823.4 5842.3 6211.6 6263.9 6284.0 6324.9 6337.7 5897.9 6004.9 6017.9 6103.6 6113.2 5583.8 5680.1 5728.9 5733.9 5918.0 6104.4 6158.5 6172.8 6183.6 6214.7 5746.4 5773.9 5786.0 5796.8 5801.9 5206.6 5565.3 5573.1 5815.6 5821.3 10:04:04 INFO - 2015-11-24 10:04:04,440 DEBUG : BROWSER_OUTPUT: 10:04:04 INFO - 2015-11-24 10:04:04,440 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4912.26 Median:5497.38 stddev:1433.26 (26.1%) stddev-sans-first:1394.96 10:04:04 INFO - 2015-11-24 10:04:04,441 DEBUG : BROWSER_OUTPUT: Values: 306.2 315.9 316.0 316.1 316.2 5538.8 5598.0 5695.5 5706.5 5716.2 5456.0 5564.8 5567.1 5575.5 5581.1 4298.8 4381.0 4384.7 4408.3 4413.1 4394.1 4394.2 4395.9 4409.0 4417.0 4357.2 4363.1 4363.9 4366.0 4366.7 4357.4 4359.4 4361.7 4366.1 4380.0 3728.6 3823.6 3860.1 3862.7 3864.1 5320.4 5381.2 5399.7 5406.0 5453.1 4991.9 4994.2 5005.7 5007.4 5009.9 5876.5 5900.9 5909.6 5914.3 5935.6 4060.3 4181.2 4183.0 4184.4 4194.6 6089.1 6175.0 6183.3 6183.8 6206.3 4307.6 4309.1 4315.5 4315.6 4320.7 4364.4 4365.7 4383.1 4391.1 4391.3 4782.0 4881.8 4945.4 4963.9 4965.5 5863.1 5870.0 5872.6 5875.4 5895.0 1535.5 1549.6 1551.5 1556.3 1562.4 1060.2 1065.1 1071.0 1087.2 1089.9 5139.1 5146.5 5159.2 5162.5 5166.5 6141.8 6144.0 6144.1 6146.8 6147.7 5088.0 5134.5 5152.3 5165.7 5177.1 3212.6 3264.0 3326.5 3343.6 3359.2 5701.5 5763.6 5766.2 5812.6 5816.0 6298.5 6326.2 6354.8 6360.8 6375.5 5744.5 5758.0 5758.9 5770.4 5829.8 5906.5 6160.9 6162.9 6172.1 6177.0 5987.5 6006.8 6016.0 6017.4 6019.5 5774.0 5777.9 5793.2 5806.6 5811.9 4097.4 4124.8 4130.5 4131.0 4132.6 6034.8 6114.6 6137.8 6156.9 6180.0 5909.6 5920.1 5923.6 5929.8 5954.6 5945.5 5949.6 5950.3 5951.7 5959.8 5664.3 5755.9 5808.7 5820.0 5820.7 5970.5 5976.9 5979.5 5986.3 6002.8 5818.3 5821.1 5825.4 5830.0 5841.2 10:04:04 INFO - 2015-11-24 10:04:04,441 DEBUG : BROWSER_OUTPUT: 10:04:04 INFO - 2015-11-24 10:04:04,441 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12151.39 Median:51609.24 stddev:14167.39 (27.5%) stddev-sans-first:14180.83 10:04:04 INFO - 2015-11-24 10:04:04,442 DEBUG : BROWSER_OUTPUT: Values: 655.0 770.3 775.9 781.5 784.4 11030.3 11055.8 11202.9 11240.7 11283.3 11234.3 11343.4 12754.4 12984.6 13000.3 743.7 746.1 751.6 756.1 760.0 755.4 756.0 757.7 760.5 764.0 786.0 787.1 788.6 792.4 796.0 785.9 786.4 787.4 788.4 790.7 580.1 583.1 586.7 586.8 588.4 11650.8 11863.0 11864.6 11864.6 11896.3 11158.3 11404.2 11453.7 11581.0 11687.4 9005.4 9006.7 9049.1 9074.8 9123.7 3183.1 3192.6 3199.6 3244.1 3265.1 43879.0 44039.3 44339.0 44391.8 44406.0 9290.9 9465.7 9644.3 9667.4 9803.0 16369.6 16426.6 16559.6 16569.4 16585.3 6065.4 6263.8 6295.5 6365.9 6477.9 3252.1 3394.6 3403.0 3412.1 3471.7 2573.5 2576.4 2599.3 2606.7 2608.3 468.2 468.6 476.1 478.1 482.7 465.7 470.9 536.9 551.4 579.6 6962.2 7140.3 7152.6 7189.1 7327.3 414.0 492.3 500.6 556.1 595.7 3170.8 3338.2 3339.7 3351.9 3436.3 47083.8 47721.0 47779.8 51598.5 51620.0 43598.0 44387.3 44421.6 44617.3 45641.8 42301.8 42586.0 42812.4 42897.1 42903.8 6995.9 7404.0 7572.5 7754.6 7791.6 29700.3 30061.5 30542.5 31194.5 32273.7 39378.4 39431.2 39603.4 39683.2 40464.8 9497.3 9696.2 9738.7 9819.3 9822.7 9797.4 10355.4 10551.0 10580.2 11398.7 9190.9 9307.9 9440.0 9449.6 9458.9 9849.9 9870.5 10000.0 10085.0 10158.7 8397.2 9102.8 9218.4 9385.8 9554.1 7967.9 8107.3 8232.7 8263.9 8330.0 8061.7 8092.9 8200.6 8319.6 8345.3 10:04:04 INFO - 2015-11-24 10:04:04,442 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:04:04 INFO - 2015-11-24 10:04:04,442 DEBUG : BROWSER_OUTPUT: 10:04:05 INFO - 2015-11-24 10:04:05,185 INFO : Browser exited with error code: 0 10:04:05 INFO - 2015-11-24 10:04:05,201 INFO : Completed test dromaeo_css (00:18:34) 10:04:05 INFO - 2015-11-24 10:04:05,202 INFO : Starting test kraken 10:04:05 INFO - 2015-11-24 10:04:05,202 DEBUG : operating with platform_type : linux_ 10:04:05 INFO - 2015-11-24 10:04:05,202 INFO : Initialising browser for kraken test... 10:04:05 INFO - 2015-11-24 10:04:05,208 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp08PK6k/profile http://localhost:45489/getInfo.html 10:04:10 INFO - 2015-11-24 10:04:10,171 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:04:10 INFO - 2015-11-24 10:04:10,172 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:04:10 INFO - 2015-11-24 10:04:10,172 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:04:10 INFO - 2015-11-24 10:04:10,172 DEBUG : BROWSER_OUTPUT: __metrics 10:04:11 INFO - 2015-11-24 10:04:11,237 INFO : Browser initialized. 10:04:11 INFO - 2015-11-24 10:04:11,237 INFO : Running cycle 1/1 for kraken test... 10:04:11 INFO - 2015-11-24 10:04:11,238 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp08PK6k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:04:23 INFO - 2015-11-24 10:04:23,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 140288000 10:04:23 INFO - 2015-11-24 10:04:23,230 DEBUG : BROWSER_OUTPUT: 10:04:25 INFO - 2015-11-24 10:04:25,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45489/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:26 INFO - 2015-11-24 10:04:26,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 141299712 10:04:26 INFO - 2015-11-24 10:04:26,461 DEBUG : BROWSER_OUTPUT: 10:04:29 INFO - 2015-11-24 10:04:29,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45489/tests/kraken/driver.html?testName=audio-dft) 10:04:29 INFO - 2015-11-24 10:04:29,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 141410304 10:04:29 INFO - 2015-11-24 10:04:29,792 DEBUG : BROWSER_OUTPUT: 10:04:32 INFO - 2015-11-24 10:04:32,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45489/tests/kraken/driver.html?testName=audio-fft) 10:04:33 INFO - 2015-11-24 10:04:33,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 136761344 10:04:33 INFO - 2015-11-24 10:04:33,322 DEBUG : BROWSER_OUTPUT: 10:04:35 INFO - 2015-11-24 10:04:35,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45489/tests/kraken/driver.html?testName=audio-oscillator) 10:04:36 INFO - 2015-11-24 10:04:36,045 DEBUG : BROWSER_OUTPUT: RSS: Main: 137531392 10:04:36 INFO - 2015-11-24 10:04:36,046 DEBUG : BROWSER_OUTPUT: 10:04:38 INFO - 2015-11-24 10:04:38,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:04:38 INFO - 2015-11-24 10:04:38,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 138858496 10:04:38 INFO - 2015-11-24 10:04:38,888 DEBUG : BROWSER_OUTPUT: 10:04:42 INFO - 2015-11-24 10:04:42,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45489/tests/kraken/driver.html?testName=imaging-darkroom) 10:04:42 INFO - 2015-11-24 10:04:42,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 139010048 10:04:42 INFO - 2015-11-24 10:04:42,623 DEBUG : BROWSER_OUTPUT: 10:04:46 INFO - 2015-11-24 10:04:46,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45489/tests/kraken/driver.html?testName=imaging-desaturate) 10:04:46 INFO - 2015-11-24 10:04:46,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 137306112 10:04:46 INFO - 2015-11-24 10:04:46,736 DEBUG : BROWSER_OUTPUT: 10:04:49 INFO - 2015-11-24 10:04:49,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45489/tests/kraken/driver.html?testName=json-parse-financial) 10:04:50 INFO - 2015-11-24 10:04:50,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 137326592 10:04:50 INFO - 2015-11-24 10:04:50,213 DEBUG : BROWSER_OUTPUT: 10:04:51 INFO - 2015-11-24 10:04:51,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:04:52 INFO - 2015-11-24 10:04:52,576 DEBUG : BROWSER_OUTPUT: RSS: Main: 139464704 10:04:52 INFO - 2015-11-24 10:04:52,576 DEBUG : BROWSER_OUTPUT: 10:04:54 INFO - 2015-11-24 10:04:54,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45489/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:04:55 INFO - 2015-11-24 10:04:55,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 138956800 10:04:55 INFO - 2015-11-24 10:04:55,101 DEBUG : BROWSER_OUTPUT: 10:04:57 INFO - 2015-11-24 10:04:57,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:04:57 INFO - 2015-11-24 10:04:57,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 139378688 10:04:57 INFO - 2015-11-24 10:04:57,828 DEBUG : BROWSER_OUTPUT: 10:05:00 INFO - 2015-11-24 10:05:00,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:00 INFO - 2015-11-24 10:05:00,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 139358208 10:05:00 INFO - 2015-11-24 10:05:00,985 DEBUG : BROWSER_OUTPUT: 10:05:03 INFO - 2015-11-24 10:05:03,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:04 INFO - 2015-11-24 10:05:04,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 139100160 10:05:04 INFO - 2015-11-24 10:05:04,211 DEBUG : BROWSER_OUTPUT: 10:05:05 INFO - 2015-11-24 10:05:05,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45489/tests/kraken/driver.html?testName=ai-astar) 10:05:06 INFO - 2015-11-24 10:05:06,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 138907648 10:05:06 INFO - 2015-11-24 10:05:06,239 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,239 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:06 INFO - 2015-11-24 10:05:06,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:06 INFO - 2015-11-24 10:05:06,239 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:06 INFO - 2015-11-24 10:05:06,239 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:06 INFO - 2015-11-24 10:05:06,239 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;110;117;113;115;126;114;113;115;115 10:05:06 INFO - 2015-11-24 10:05:06,239 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;168;133;153;167;130;154;158;135;166;132 10:05:06 INFO - 2015-11-24 10:05:06,239 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;165;163;163;167;170;166;165;166;163 10:05:06 INFO - 2015-11-24 10:05:06,240 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;72;72;73;76;139;72;72;72 10:05:06 INFO - 2015-11-24 10:05:06,240 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;128;94;95;95;128;94;95;128 10:05:06 INFO - 2015-11-24 10:05:06,240 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;112;110;111;110;110;110;112;111 10:05:06 INFO - 2015-11-24 10:05:06,240 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;150;149;150;147;149;149;148;147;169 10:05:06 INFO - 2015-11-24 10:05:06,240 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;95;96;97;97;96;97;96;96 10:05:06 INFO - 2015-11-24 10:05:06,240 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;74;74;74;74;74;75;74;77;82 10:05:06 INFO - 2015-11-24 10:05:06,240 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;69;69;69;70;68;70 10:05:06 INFO - 2015-11-24 10:05:06,240 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;81;85;83;82;85;85;83;84;82 10:05:06 INFO - 2015-11-24 10:05:06,240 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;126;123;117;128;126;125;129;118;121 10:05:06 INFO - 2015-11-24 10:05:06,241 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;139;151;154;165;137;148;149;150;159 10:05:06 INFO - 2015-11-24 10:05:06,241 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;70;69;69;70;69;69;70;69;70 10:05:06 INFO - 2015-11-24 10:05:06,241 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:06 INFO - 2015-11-24 10:05:06,241 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:05:06 INFO - 2015-11-24 10:05:06,241 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,788 10:05:06 INFO - 2015-11-24 10:05:06,241 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:05:06 INFO - 2015-11-24 10:05:06,242 DEBUG : BROWSER_OUTPUT: __startTimestamp1448388306233__endTimestamp 10:05:06 INFO - 2015-11-24 10:05:06,242 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,242 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:06 INFO - 2015-11-24 10:05:06,242 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:05:06 INFO - 2015-11-24 10:05:06,242 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,243 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:4.21 (3.7%) stddev-sans-first:4.44 10:05:06 INFO - 2015-11-24 10:05:06,243 DEBUG : BROWSER_OUTPUT: Values: 114.0 110.0 117.0 113.0 115.0 126.0 114.0 113.0 115.0 115.0 10:05:06 INFO - 2015-11-24 10:05:06,243 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,243 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.00 stddev:15.61 (10.0%) stddev-sans-first:15.08 10:05:06 INFO - 2015-11-24 10:05:06,243 DEBUG : BROWSER_OUTPUT: Values: 168.0 133.0 153.0 167.0 130.0 154.0 158.0 135.0 166.0 132.0 10:05:06 INFO - 2015-11-24 10:05:06,243 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,244 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.10 Median:165.50 stddev:2.28 (1.4%) stddev-sans-first:2.29 10:05:06 INFO - 2015-11-24 10:05:06,244 DEBUG : BROWSER_OUTPUT: Values: 163.0 165.0 163.0 163.0 167.0 170.0 166.0 165.0 166.0 163.0 10:05:06 INFO - 2015-11-24 10:05:06,244 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,244 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:72.00 stddev:20.98 (29.1%) stddev-sans-first:22.08 10:05:06 INFO - 2015-11-24 10:05:06,244 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 72.0 72.0 73.0 76.0 139.0 72.0 72.0 72.0 10:05:06 INFO - 2015-11-24 10:05:06,245 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.70 Median:95.00 stddev:16.08 (16.9%) stddev-sans-first:16.67 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 128.0 94.0 95.0 95.0 128.0 94.0 95.0 128.0 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.70 Median:111.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 112.0 110.0 111.0 110.0 110.0 110.0 112.0 111.0 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:150.70 Median:149.00 stddev:6.52 (4.4%) stddev-sans-first:6.88 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: Values: 149.0 150.0 149.0 150.0 147.0 149.0 149.0 148.0 147.0 169.0 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 95.0 96.0 97.0 97.0 96.0 97.0 96.0 96.0 10:05:06 INFO - 2015-11-24 10:05:06,246 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.10 Median:74.00 stddev:2.64 (3.6%) stddev-sans-first:2.69 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 74.0 74.0 74.0 74.0 75.0 74.0 77.0 82.0 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.78 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 69.0 69.0 69.0 70.0 68.0 70.0 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:1.42 (1.7%) stddev-sans-first:1.50 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: Values: 83.0 81.0 85.0 83.0 82.0 85.0 85.0 83.0 84.0 82.0 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:126.00 stddev:4.14 (3.3%) stddev-sans-first:4.24 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: Values: 127.0 126.0 123.0 117.0 128.0 126.0 125.0 129.0 118.0 121.0 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:150.50 stddev:9.28 (6.2%) stddev-sans-first:8.79 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: Values: 137.0 139.0 151.0 154.0 165.0 137.0 148.0 149.0 150.0 159.0 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-11-24 10:05:06,247 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:0.95 (1.4%) stddev-sans-first:0.53 10:05:06 INFO - 2015-11-24 10:05:06,248 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 69.0 69.0 70.0 69.0 69.0 70.0 69.0 70.0 10:05:06 INFO - 2015-11-24 10:05:06,248 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:06 INFO - 2015-11-24 10:05:06,248 DEBUG : BROWSER_OUTPUT: 10:05:07 INFO - 2015-11-24 10:05:07,197 INFO : Browser exited with error code: 0 10:05:07 INFO - 2015-11-24 10:05:07,250 INFO : Completed test kraken (00:01:02) 10:05:07 INFO - 2015-11-24 10:05:07,250 INFO : Starting test v8_7 10:05:07 INFO - 2015-11-24 10:05:07,250 DEBUG : operating with platform_type : linux_ 10:05:07 INFO - 2015-11-24 10:05:07,250 INFO : Initialising browser for v8_7 test... 10:05:07 INFO - 2015-11-24 10:05:07,256 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmfWKNY/profile http://localhost:45489/getInfo.html 10:05:12 INFO - 2015-11-24 10:05:12,161 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:05:12 INFO - 2015-11-24 10:05:12,161 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:05:12 INFO - 2015-11-24 10:05:12,161 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:05:12 INFO - 2015-11-24 10:05:12,161 DEBUG : BROWSER_OUTPUT: __metrics 10:05:13 INFO - 2015-11-24 10:05:13,329 INFO : Browser initialized. 10:05:13 INFO - 2015-11-24 10:05:13,329 INFO : Running cycle 1/1 for v8_7 test... 10:05:13 INFO - 2015-11-24 10:05:13,329 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmfWKNY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:25 INFO - 2015-11-24 10:05:25,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 141742080 10:05:25 INFO - 2015-11-24 10:05:25,377 DEBUG : BROWSER_OUTPUT: 10:05:46 INFO - 2015-11-24 10:05:46,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45489/tests/v8_7/run.html (next: http://localhost:45489/tests/v8_7/run.html) 10:05:47 INFO - 2015-11-24 10:05:47,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 138674176 10:05:47 INFO - 2015-11-24 10:05:47,153 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,153 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:47 INFO - 2015-11-24 10:05:47,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:47 INFO - 2015-11-24 10:05:47,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:47 INFO - 2015-11-24 10:05:47,155 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:47 INFO - 2015-11-24 10:05:47,155 DEBUG : BROWSER_OUTPUT: |0;Richards;186.74136321195144 10:05:47 INFO - 2015-11-24 10:05:47,155 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.86403085824494 10:05:47 INFO - 2015-11-24 10:05:47,156 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 10:05:47 INFO - 2015-11-24 10:05:47,156 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5117.34693877551 10:05:47 INFO - 2015-11-24 10:05:47,156 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1042.752867570386 10:05:47 INFO - 2015-11-24 10:05:47,156 DEBUG : BROWSER_OUTPUT: |5;Earley;706.2146892655368 10:05:47 INFO - 2015-11-24 10:05:47,157 DEBUG : BROWSER_OUTPUT: |6;Boyer;12207.317073170732 10:05:47 INFO - 2015-11-24 10:05:47,157 DEBUG : BROWSER_OUTPUT: |7;RegExp;27916.666666666668 10:05:47 INFO - 2015-11-24 10:05:47,157 DEBUG : BROWSER_OUTPUT: |8;Splay;594.1943127962086 10:05:47 INFO - 2015-11-24 10:05:47,157 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4859.223300970873 10:05:47 INFO - 2015-11-24 10:05:47,158 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:47 INFO - 2015-11-24 10:05:47,158 DEBUG : BROWSER_OUTPUT: __startTimestamp1448388347153__endTimestamp 10:05:47 INFO - 2015-11-24 10:05:47,158 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,158 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:47 INFO - 2015-11-24 10:05:47,158 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:05:47 INFO - 2015-11-24 10:05:47,159 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,159 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.74 Median:186.74 stddev:0.00 (0.0%) 10:05:47 INFO - 2015-11-24 10:05:47,159 DEBUG : BROWSER_OUTPUT: Values: 186.7 10:05:47 INFO - 2015-11-24 10:05:47,159 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,161 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.86 Median:192.86 stddev:0.00 (0.0%) 10:05:47 INFO - 2015-11-24 10:05:47,161 DEBUG : BROWSER_OUTPUT: Values: 192.9 10:05:47 INFO - 2015-11-24 10:05:47,161 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,161 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 10:05:47 INFO - 2015-11-24 10:05:47,162 DEBUG : BROWSER_OUTPUT: Values: 279.7 10:05:47 INFO - 2015-11-24 10:05:47,162 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,162 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5117.35 Median:5117.35 stddev:0.00 (0.0%) 10:05:47 INFO - 2015-11-24 10:05:47,162 DEBUG : BROWSER_OUTPUT: Values: 5117.3 10:05:47 INFO - 2015-11-24 10:05:47,162 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,162 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1042.75 Median:1042.75 stddev:0.00 (0.0%) 10:05:47 INFO - 2015-11-24 10:05:47,163 DEBUG : BROWSER_OUTPUT: Values: 1042.8 10:05:47 INFO - 2015-11-24 10:05:47,163 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,163 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:706.21 Median:706.21 stddev:0.00 (0.0%) 10:05:47 INFO - 2015-11-24 10:05:47,163 DEBUG : BROWSER_OUTPUT: Values: 706.2 10:05:47 INFO - 2015-11-24 10:05:47,163 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,163 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 10:05:47 INFO - 2015-11-24 10:05:47,163 DEBUG : BROWSER_OUTPUT: Values: 12207.3 10:05:47 INFO - 2015-11-24 10:05:47,164 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,164 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27916.67 Median:27916.67 stddev:0.00 (0.0%) 10:05:47 INFO - 2015-11-24 10:05:47,164 DEBUG : BROWSER_OUTPUT: Values: 27916.7 10:05:47 INFO - 2015-11-24 10:05:47,164 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,164 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.19 Median:594.19 stddev:0.00 (0.0%) 10:05:47 INFO - 2015-11-24 10:05:47,164 DEBUG : BROWSER_OUTPUT: Values: 594.2 10:05:47 INFO - 2015-11-24 10:05:47,164 DEBUG : BROWSER_OUTPUT: 10:05:47 INFO - 2015-11-24 10:05:47,164 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 10:05:47 INFO - 2015-11-24 10:05:47,165 DEBUG : BROWSER_OUTPUT: Values: 4859.2 10:05:47 INFO - 2015-11-24 10:05:47,165 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:47 INFO - 2015-11-24 10:05:47,165 DEBUG : BROWSER_OUTPUT: 10:05:48 INFO - 2015-11-24 10:05:48,065 INFO : Browser exited with error code: 0 10:05:48 INFO - 2015-11-24 10:05:48,080 INFO : Completed test v8_7 (00:00:40) 10:05:48 INFO - 2015-11-24 10:05:48,142 INFO : Completed test suite (00:20:17) 10:05:48 INFO - 2015-11-24 10:05:48,142 DEBUG : Working with test: dromaeo_css 10:05:48 INFO - 2015-11-24 10:05:48,142 DEBUG : Generating results file: dromaeo_css 10:05:48 INFO - 2015-11-24 10:05:48,143 DEBUG : Working with test: kraken 10:05:48 INFO - 2015-11-24 10:05:48,143 DEBUG : Generating results file: kraken 10:05:48 INFO - 2015-11-24 10:05:48,144 INFO : javascript benchmark 10:05:48 INFO - 2015-11-24 10:05:48,144 DEBUG : Working with test: v8_7 10:05:48 INFO - 2015-11-24 10:05:48,144 DEBUG : Generating results file: v8_7 10:05:48 INFO - 2015-11-24 10:05:48,144 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:48 INFO - 2015-11-24 10:05:48,302 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 10:05:48 INFO - 2015-11-24 10:05:48,302 DEBUG : process_Request line: dromaeo_css 6397.16 graph.html#tests=[[72,132,43]] 10:05:48 INFO - 2015-11-24 10:05:48,302 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:48 INFO - 2015-11-24 10:05:48,337 DEBUG : process_Request line: kraken 1541.60 graph.html#tests=[[232,132,43]] 10:05:48 INFO - 2015-11-24 10:05:48,337 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:05:48 INFO - 2015-11-24 10:05:48,371 DEBUG : process_Request line: v8_7 21005.07 graph.html#tests=[[230,132,43]] 10:05:48 INFO - 2015-11-24 10:05:48,373 INFO : javascript benchmark 10:05:48 INFO - 2015-11-24 10:05:48,376 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.4072583668676, 2677.9062732804355, 2699.4736026474843, 2716.959245611316, 2720.7279272072797, 4520.525344838794, 4739.8815029624275, 4744.739039352834, 4765.857024289273, 4776.259679749635, 4643.582077613014, 4665.113628410608, 4709.246520556711, 4748.5726284634375, 4761.381020467335, 4316.287812510932, 4357.891052723676, 4438.489573699034, 4465.799039043251, 4483.551644835523, 4346.6739994500385, 4404.647628189737, 4427.225235583776, 4514.27771556551, 4548.067646132551, 4180.937285940713, 4229.471316085489, 4312.482502099768, 4443.822247110112, 4474.955250447519, 4343.869683909487, 4359.193549193409, 4372.431583894106, 4389.802458889326, 4403.471583409979, 4318.028443600197, 4323.956760432387, 4325.935110973338, 4338.783060846977, 4373.978130109361, 4497.302918047708, 4548.704334218265, 4583.3125031245245, 4649.093426781779, 4685.0395668887795, 5013.799448022075, 5027.622928280393, 5040.16837221858, 5047.87380315495, 5070.974645126787, 5044.873878153039, 5046.116929537353, 5050.494950504957, 5070.391553013662, 5084.51697088776, 4488.775561221959, 4595.586397224266, 4627.722336659777, 4669.089527542164, 4719.622430205575, 5088.720120393414, 5089.440161582223, 5096.0, 5138.049460849755, 5147.047796157723, 4736.407949006374, 4887.706737595756, 4890.388701412324, 4920.237363208708, 4927.039227350632, 4799.976000120047, 4923.655344125877, 4928.48250933654, 4934.432540257844, 4978.4025916890205, 4933.062718083553, 5011.5489605935645, 5012.649114562018, 5019.0463811875625, 5049.772760225798, 4763.3807605011125, 4885.0, 4975.626827987915, 4998.550130488201, 5056.82301119459, 4056.8782936511952, 4099.385092236188, 4125.525564560054, 4130.256553820281, 4156.376543518496, 3640.7087433005295, 3659.652333028358, 3666.046827824785, 3697.574778900461, 3701.6668499835146, 4185.393117997874, 4232.132412855357, 4315.935260971088, 4366.847160349373, 4378.8029538670835, 5088.465711100355, 5118.10433174193, 5121.2574176744165, 5126.718030508283, 5140.074786538459, 4402.185595664812, 4426.822927082945, 4428.31361139024, 4436.977815110969, 4479.7984090715345, 4254.255505286563, 4414.381986521889, 4416.558344165622, 4417.624501917308, 4522.683412161183, 4640.9535904640525, 4682.4381074271305, 4710.858674239778, 4727.669063165546, 4781.378420805273, 5051.393832740095, 5059.266406371129, 5059.721715305694, 5085.567726743268, 5086.186210206497, 4610.953890461053, 4709.505501922249, 4736.644751643709, 4739.218029025173, 4824.131656301759, 4944.0, 4986.501349864984, 5011.799528018839, 5014.648974571891, 5024.673396229234, 5089.720065396439, 5092.261622064854, 5097.949020509747, 5100.20946753239, 5136.049830781318, 4748.501407352316, 4809.975950120227, 4888.60891128716, 4916.237983112624, 4930.580900623487, 4842.709437433765, 4854.80580776765, 4879.829205977774, 4882.292067650242, 4946.35697359341, 4769.73766442849, 4780.617550596014, 4794.736289504111, 4801.975990120167, 4852.539008794159, 4751.40607424072, 4806.279058141306, 4898.632602554751, 4915.361003069578, 4934.679245849008, 4715.292706094114, 4732.077244937204, 4750.548697873696, 4776.283557466269, 4789.042191561772], "unit": "ms", "name": "dojo.html", "value": 4605.155960321038}, {"lowerIsBetter": false, "replicates": [554.3320299039657, 567.7047935073763, 574.7384939852368, 576.0523938121789, 582.3739480058938, 36032.639673603255, 36662.816685916536, 36874.8156259219, 36877.63122368776, 37090.62909370905, 39417.40873886894, 40296.59703402965, 40599.79700101495, 40606.7969660152, 40660.0, 7809.726659566916, 7925.722599709012, 7954.443188976774, 7963.0, 7965.6813727450835, 7858.685652573919, 7950.0, 7966.044074711014, 7969.840603187962, 7973.920260797376, 7834.255745704149, 7870.173631768667, 7884.526928384286, 7908.604569771517, 7917.208279172094, 7809.492382995087, 7885.96057019717, 7891.960540197262, 7941.841163176733, 7953.244441778051, 7806.57063861493, 7900.723474678416, 7900.881486777703, 7904.249096335839, 7916.960415197945, 36929.630703693154, 37161.0, 37251.81374093139, 37354.43968340477, 37378.81310593457, 2567.8459292442512, 2748.670159580843, 2884.4952133376573, 3282.2450836307544, 3293.818839963801, 27764.861175694194, 27980.160595181973, 28011.859940700167, 28149.0, 28303.15090547287, 3297.1097803593134, 3476.5132881396626, 3478.7912725236315, 3510.0, 3540.4689296605457, 221387.0, 222110.0, 223561.88219058962, 224214.0, 225459.0, 50092.0, 51373.22940155901, 56433.0, 60241.09638355428, 61745.0, 56848.431515685144, 57180.42819571834, 57334.7133264331, 57553.42446575564, 57561.42438575561, 13974.930125349309, 14019.0, 14185.0, 14213.573592792232, 14245.501407450689, 10707.785844283071, 10804.459777011118, 10825.566977320976, 10854.34873907568, 10979.0, 18765.530861728294, 18856.245750170114, 18942.337018204573, 19027.14377853, 19122.71315930262, 7576.924230757621, 7842.5686587237105, 7907.9604601976625, 7970.202979701983, 8025.157358477392, 791.2443616346376, 823.1357075071152, 826.2604968553111, 887.7425546591545, 913.8446464100986, 25909.74090259111, 26170.476590468083, 26233.213003609922, 26325.73674263233, 26350.47299054008, 934.8223837470858, 957.7653474898694, 984.606157536991, 1020.8672872526524, 1103.9724006899892, 13123.820742944394, 13240.667907958517, 13372.866271337356, 13440.260785656883, 13476.258805765581, 333017.0, 339644.0, 340163.0, 340371.0, 343350.0, 45567.58243131779, 45596.54403455923, 45799.542004579525, 45874.54125458703, 45897.77051114723, 1149.8850114988434, 1213.3447938113497, 1214.4352875912743, 1217.908656850722, 1217.945192466341, 24850.502989939738, 25269.494610107326, 25606.487870242865, 25620.23139305824, 25764.871175644003, 37648.623513765604, 38131.80934095312, 38144.80927595344, 38145.2370952585, 38483.230335393695, 236527.0, 239259.0, 239263.0, 239986.0, 240026.0, 28461.715382845905, 40585.391219132325, 41189.0, 41643.37534937039, 41977.0, 38416.42375364316, 38700.6129938697, 38825.80587097159, 39688.206235875696, 39841.2031759369, 33190.66809331876, 33341.16647083842, 33932.49101263434, 34102.0, 34130.82934585311, 34225.14437139092, 34326.656733433345, 34462.655373445945, 34652.30695386128, 34799.47800783041, 33826.3234735299, 33960.320793583494, 34326.14184645404, 34626.48060279148, 34691.47962780611, 30027.699723003363, 30481.0, 31003.68996310008, 31016.379672406878, 31073.8446307767, 23886.044558217476, 24159.75840241575, 24451.26646200617, 24584.754152458245, 24785.62821557714], "unit": "ms", "name": "ext.html", "value": 17139.574477086935}, {"lowerIsBetter": false, "replicates": [332.9017939707785, 332.9550510681057, 333.1920093772601, 336.00079526815455, 336.4247137395054, 14700.852991470083, 15285.388584456623, 15571.0, 15672.764908526382, 16385.09881956492, 14375.784363234534, 14416.20710860905, 14529.636759081002, 14535.418583256656, 14693.55919322422, 4449.243628583149, 6223.066540018988, 6471.741130354781, 6483.7082331295205, 6485.221773387177, 5391.083515802323, 5768.3654797972185, 6485.2541957675, 6490.578112422701, 6493.448056915168, 5890.823275301748, 6046.667433291167, 6091.543134264925, 6640.56836305641, 6666.966665166668, 6005.4895333896675, 6075.392460753934, 6085.300190478108, 6119.694015299239, 6254.937450625481, 6060.212172417601, 6070.514358851281, 6074.240719910012, 6076.5442591805795, 6081.96606576883, 19046.0, 20752.0, 20862.26982055621, 20873.165073397045, 21892.12431502738, 1856.1276200186026, 1862.757841480599, 1884.1521315408122, 1925.1625542888887, 1958.8922609256485, 12628.68428289291, 13004.284764337957, 13040.54358097462, 13192.86807131926, 13403.195808251536, 1739.2173521915063, 1761.3042848075067, 1794.9192286347015, 1797.6224992751538, 1811.3207547169811, 60145.6992715038, 64645.0, 64728.67635661839, 65329.0, 65359.0, 15542.84457155414, 15599.376024959101, 15601.843981560267, 15606.3757449703, 15833.841661583467, 22597.2090976815, 22599.0, 22847.885760571422, 22854.31437056891, 22895.198668046538, 8630.697925572575, 8654.22112009922, 8681.696140635047, 8688.218060374596, 8767.736967890845, 7231.674574644154, 7251.456140789356, 7295.817604559928, 7309.853802923912, 7335.889961650473, 7527.397808175333, 7552.962235188898, 7620.80947976305, 7629.20713632296, 7633.732819351407, 1658.286936617266, 1722.3627257914652, 2860.127661063354, 2990.2673844908136, 3002.4237275430137, 773.7601343583507, 817.7464985854285, 911.4166933162782, 915.4049867586123, 966.6858271061933, 15072.171030593423, 15445.536633901002, 15567.688646227012, 15685.137317447421, 15749.842501574838, 782.5031105248208, 785.8742601183783, 805.8025783682918, 815.4740192575874, 841.7222316635496, 8258.926339575817, 8317.41778075529, 8389.286910612544, 8451.619677114422, 8532.232099110986, 462022.0, 468819.0, 486272.0, 488617.0, 492780.0, 72309.27690723131, 72655.2734472659, 73576.26423735802, 73712.26287737161, 74095.62952185313, 1023.7798873242289, 1071.2019545438543, 1076.381080878498, 1133.4049623947494, 1152.6484422251294, 13361.0, 13677.452901884211, 13721.382537785625, 14023.527529609652, 14265.358058887168, 31760.570774315674, 32641.510377344835, 32843.671563284064, 33153.0, 33617.495737564444, 40637.79681101694, 43018.05292391415, 44356.33465497955, 46194.76902615465, 46281.53718462772, 8789.472631642122, 8796.780080498038, 8946.37375383717, 8978.057303982987, 9098.0, 10179.389236645826, 10228.64199753005, 10307.742306442398, 10317.0, 11753.118516111155, 10577.682669519927, 12612.936935315633, 12630.431630576462, 12660.240385576526, 12667.113302068767, 8411.327093832357, 8644.740657780276, 12451.688707782378, 12640.810387844374, 12736.363181840685, 9225.630974760934, 9227.86158207614, 9708.368956017835, 9710.70867873965, 9724.95137524308, 13738.65653358674, 14123.223222722849, 14411.351489182802, 14504.274786260856, 14507.896355028673, 14102.36539355711, 14226.430942762174, 14573.0, 15113.697726045637, 15159.0], "unit": "ms", "name": "jquery.html", "value": 9055.589131293968}, {"lowerIsBetter": false, "replicates": [1499.9250037498123, 1523.8704710099644, 1600.7278762610356, 1620.9594760130994, 1631.1518010634463, 6586.308437614053, 6790.728370865159, 6871.244163142051, 6891.310868913106, 6934.895976560343, 6919.550229235108, 6986.126734158231, 6994.860102797941, 7001.019857219981, 7059.0, 1989.9005049747527, 2012.2856385982984, 2014.8488863335235, 2020.464576887126, 2028.0468179955396, 2035.8065983731522, 2061.309461330456, 2070.534129820793, 2088.6240476714183, 2090.8745475271458, 2006.9698954515693, 2033.2070492507933, 2036.6028624418245, 2052.7434070741156, 2072.9792702073014, 1993.531520092777, 2020.2424090965887, 2023.4132101690493, 2025.3923822853085, 2025.7872923343132, 1926.922923083075, 1973.4770285874256, 1975.8320542753884, 1977.5550501137272, 1985.2158397433077, 6766.15423072116, 6825.965870170667, 6828.52200345976, 6835.93164068358, 6852.177738671341, 4118.629323360882, 4172.749635021908, 4178.456800615931, 4182.226288136704, 4185.811638476276, 2693.7440943110373, 2708.674959004912, 2789.6791868934924, 2797.2587264374956, 2806.845623490707, 872.5375550958003, 906.1074841281398, 920.2178148573659, 922.7831459606987, 947.2280091725222, 8877.778055548599, 8961.551922403854, 8977.192052715287, 9002.414843035247, 9055.320850936207, 3564.590072141685, 3639.9818000909827, 3655.1593133579427, 3694.5935947045805, 3709.5919448860604, 7496.212897645669, 7499.62501874915, 7509.474336796481, 7514.0607424071995, 7515.098188217449, 3922.1763429679518, 3936.075022369741, 3957.703172262092, 3975.3838155085427, 3987.1626958339075, 3654.3056819204267, 3670.596234414212, 3696.353138200804, 3699.075231192202, 3708.2027364116843, 3009.5184770436626, 3023.183740390082, 3026.137550798012, 3030.530267808493, 3051.3287076843058, 897.3225214962791, 898.869663898731, 899.3299991506369, 904.4754042655244, 912.2382810353429, 837.1335667584021, 842.7303262955918, 842.8187939593017, 903.1375036839802, 1050.658535975811, 6358.554901156967, 6388.680565971683, 6402.807915762534, 6406.935930640634, 6411.903821442682, 1017.9847302290472, 1029.5984566019258, 1032.808930347888, 1043.6034306963456, 1044.2011860926398, 5151.021305951857, 5190.92213616796, 5211.895762084737, 5215.035218484592, 5219.712915789668, 7999.800004999922, 8019.719309824245, 8097.514149151069, 8167.060788009455, 8302.460340077996, 8139.348852091818, 8148.592570371457, 8186.8538404623405, 8204.548749818698, 8215.383846211438, 6359.982402815527, 6372.426481616677, 6426.35736426363, 6448.290688024314, 6449.193850768654, 6157.722902469489, 6283.120363149072, 6308.053791931247, 6309.085182648399, 6314.684265786784, 7066.646667666699, 7262.3826974707745, 7268.818279543054, 7405.62971851416, 7447.292507211806, 7040.647967601497, 7115.964420177866, 7411.962940185264, 7459.477836551389, 7482.3639990601405, 5784.623999440023, 5797.188393624981, 5820.068788993741, 5823.417658234142, 5842.298924129132, 6211.627302361872, 6263.937360626518, 6283.968580157253, 6324.905126423199, 6337.714802833976, 5897.882042359214, 6004.909926351195, 6017.879642407215, 6103.633781973096, 6113.205283313141, 5583.832485025456, 5680.147977803363, 5728.942710573007, 5733.913991290051, 5917.970410147922, 6104.38956104386, 6158.538109641705, 6172.814815555541, 6183.628982261079, 6214.658193799384, 5746.42535746422, 5773.913391299218, 5786.045302525036, 5796.797112101056, 5801.94198058014, 5206.6095042871175, 5565.332160140809, 5573.080441727069, 5815.5929084963645, 5821.301443826768], "unit": "ms", "name": "mootools.html", "value": 3903.782491783427}, {"lowerIsBetter": false, "replicates": [306.24052350171576, 315.8831232443996, 315.9921001974949, 316.09438957387096, 316.20632213145007, 5538.75075621597, 5598.0, 5695.487406133452, 5706.457886500786, 5716.1711551824965, 5456.0, 5564.8052318168775, 5567.137093750465, 5575.470330318623, 5581.079121944874, 4298.828046878121, 4380.956190438087, 4384.693071484998, 4408.3167109097985, 4413.139437809628, 4394.07724377881, 4394.165108629366, 4395.86812395627, 4409.0, 4417.0, 4357.150355680644, 4363.083752411997, 4363.890902727441, 4365.956340436603, 4366.672499562545, 4357.433533640622, 4359.433273674418, 4361.672874534423, 4366.08312254427, 4380.0, 3728.5898551159353, 3823.5794062653085, 3860.073582340246, 3862.671672907806, 3864.130570621616, 5320.441353657849, 5381.165919282517, 5399.7030163341, 5405.972865155608, 5453.072977593819, 4991.900161996739, 4994.175960966436, 5005.674631148963, 5007.4491805901325, 5009.899802003976, 5876.471117599436, 5900.940990590082, 5909.615874968156, 5914.260717410324, 5935.614185077956, 4060.3097473429293, 4181.247375472413, 4182.979085104555, 4184.351425529047, 4194.601512856274, 6089.056196289582, 6175.042868355367, 6183.319834818167, 6183.845403864894, 6206.324292441106, 4307.56924307573, 4309.073549186877, 4315.503717072577, 4315.633171180422, 4320.65434765218, 4364.410804541346, 4365.694401391936, 4383.101464199832, 4391.143726973273, 4391.3193455014525, 4782.0, 4881.780319885614, 4945.357103576512, 4963.925541116886, 4965.453800081988, 5863.091220860773, 5870.002099642986, 5872.588918775645, 5875.353711091777, 5894.970525147432, 1535.485612319863, 1549.6435819761518, 1551.5190291009824, 1556.2841093097077, 1562.3906676396214, 1060.1571750458404, 1065.0574241796066, 1071.0467683761458, 1087.2117714656968, 1089.8855620159768, 5139.12634852076, 5146.511081447256, 5159.17453207485, 5162.457941916045, 5166.509181627739, 6141.785037523755, 6143.96928015366, 6144.07838824171, 6146.78486252979, 6147.66187859672, 5087.974560127176, 5134.5378915897, 5152.3044389007755, 5165.690058596496, 5177.145770947826, 3212.5984251968503, 3264.0, 3326.5176549400203, 3343.6154842192973, 3359.227377703142, 5701.515371193412, 5763.567732420085, 5766.192733017381, 5812.564057695689, 5816.040353341651, 6298.464630506367, 6326.240851097806, 6354.841128971812, 6360.809175724736, 6375.521835862329, 5744.540436765133, 5758.049921762862, 5758.856028599319, 5770.422957704196, 5829.8251052468495, 5906.497947674496, 6160.9383906160365, 6162.876742465215, 6172.074188871705, 6177.0, 5987.491063259672, 6006.759729610942, 6016.0, 6017.428344307284, 6019.518438524995, 5774.0, 5777.94222057774, 5793.15999180125, 5806.593538452268, 5811.883762324815, 4097.44684467605, 4124.7731374773475, 4130.504339479282, 4131.0, 4132.628063474302, 6034.849128771641, 6114.633122012693, 6137.754489820536, 6156.876862462816, 6180.042093475518, 5909.6158749681135, 5920.111983202554, 5923.644581325134, 5929.822105336847, 5954.612950158225, 5945.524358051432, 5949.583529152917, 5950.256217972754, 5951.732172052181, 5959.791407300723, 5664.291963504562, 5755.8561035974435, 5808.651480911159, 5820.039693450533, 5820.70896455184, 5970.492508136684, 5976.940230597638, 5979.4917432018765, 5986.3238293277955, 6002.849928751816, 5818.33089194748, 5821.126830975388, 5825.446582574648, 5830.0, 5841.18223448726], "unit": "ms", "name": "prototype.html", "value": 4452.4093320381435}, {"lowerIsBetter": false, "replicates": [655.0109334904295, 770.3067239484467, 775.9146493885671, 781.5076501803866, 784.3881772217669, 11030.338179709213, 11055.778884422316, 11202.887971120286, 11240.718982025453, 11283.323000619957, 11234.32594044358, 11343.43282835857, 12754.362281885891, 12984.610461686141, 13000.28498432586, 743.6690672650673, 746.0860445953704, 751.6054071612419, 756.1115689065326, 759.981624623005, 755.4070055006821, 755.9697612095509, 757.7007082202526, 760.5018712743162, 763.9923600763976, 785.9842803143933, 787.0633945604741, 788.597815114293, 792.4413288631501, 796.0208943000114, 785.9371250299962, 786.4219798448136, 787.4330482052912, 788.3614272439343, 790.6876783670447, 580.1240127407602, 583.0991118721543, 586.7418335932219, 586.7564960541371, 588.4086493074433, 11650.766984660258, 11863.0, 11864.584739534075, 11864.644060678107, 11896.286222826659, 11158.330500170016, 11404.201705880592, 11453.713657158554, 11581.0, 11687.357195354252, 9005.369624126313, 9006.729798106002, 9049.140331668481, 9074.818503629891, 9123.726288211297, 3183.1405520509334, 3192.6328472225528, 3199.5520627112223, 3244.1403028197547, 3265.134739294065, 43879.0, 44039.33940990888, 44339.0, 44391.77804110991, 44406.0, 9290.860637090449, 9465.66870159541, 9644.276679248944, 9667.419954802594, 9803.019698030283, 16369.590760231089, 16426.589335266715, 16559.586010349838, 16569.42007029772, 16585.336586536403, 6065.363136870653, 6263.812085637438, 6295.464885484785, 6365.904511432333, 6477.870442591122, 3252.1381833814057, 3394.575678040245, 3402.996116145743, 3412.129906873781, 3471.7222622190166, 2573.5496288149498, 2576.4074262919635, 2599.337169021925, 2606.6741657292837, 2608.3479130217447, 468.2110643565603, 468.6133939499926, 476.0954187044643, 478.0963978081429, 482.68384208343593, 465.7135861445187, 470.9152352576569, 536.924830523727, 551.4320250142359, 579.6493121661418, 6962.1645402551, 7140.250273721184, 7152.570845749272, 7189.1013623297085, 7327.340539351484, 414.0, 492.33288893548723, 500.6470438340961, 556.1268807971527, 595.6694034810635, 3170.7621928355466, 3338.2488939988793, 3339.6660333966893, 3351.949720754191, 3436.278381539905, 47083.76458117756, 47721.0, 47779.76110119427, 51598.48401516012, 51620.0, 43598.0, 44387.334189987174, 44421.55578444239, 44617.330740038924, 45641.77179114083, 42301.78849105735, 42586.0, 42812.35781463281, 42897.14205715868, 42903.78548107302, 6995.901229631192, 7403.962980185064, 7572.507786993828, 7754.612269386621, 7791.571463569559, 29700.257493562833, 30061.549076764302, 30542.541861871647, 31194.532082019243, 32273.677263228008, 39378.40932385959, 39431.211375772895, 39603.405948910215, 39683.2063358737, 40464.79767601143, 9497.335186536877, 9696.175825054666, 9738.659146930107, 9819.312648114563, 9822.65620703272, 9797.363171393836, 10355.43045132525, 10551.0, 10580.15358771281, 11398.658040258806, 9190.862137068083, 9307.906920930704, 9440.0, 9449.574769135543, 9458.858117128111, 9849.852252216078, 9870.506474676382, 10000.0, 10085.0, 10158.695239142837, 8397.202265784741, 9102.817943641223, 9218.354715169873, 9385.765355866159, 9554.140127388291, 7967.880481792894, 8107.3114680387735, 8232.711855085043, 8263.917360826315, 8330.0, 8061.717839875576, 8092.947916770782, 8200.630971606173, 8319.584020798815, 8345.332373410234], "unit": "ms", "name": "yui.html", "value": 5516.133557590162}], "name": "dromaeo_css", "value": 6397.162600754069}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 117.0, 113.0, 115.0, 126.0, 114.0, 113.0, 115.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 115.2}, {"lowerIsBetter": true, "replicates": [168.0, 133.0, 153.0, 167.0, 130.0, 154.0, 158.0, 135.0, 166.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 163.0, 163.0, 167.0, 170.0, 166.0, 165.0, 166.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 165.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 72.0, 72.0, 73.0, 76.0, 139.0, 72.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 128.0, 94.0, 95.0, 95.0, 128.0, 94.0, 95.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 104.7}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 112.0, 110.0, 111.0, 110.0, 110.0, 110.0, 112.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.7}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 149.0, 150.0, 147.0, 149.0, 149.0, 148.0, 147.0, 169.0], "unit": "ms", "name": "imaging-darkroom", "value": 150.7}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 95.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 74.0, 74.0, 74.0, 74.0, 75.0, 74.0, 77.0, 82.0], "unit": "ms", "name": "json-parse-financial", "value": 75.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 70.0, 68.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 85.0, 83.0, 82.0, 85.0, 85.0, 83.0, 84.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [127.0, 126.0, 123.0, 117.0, 128.0, 126.0, 125.0, 129.0, 118.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [137.0, 139.0, 151.0, 154.0, 165.0, 137.0, 148.0, 149.0, 150.0, 159.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 69.0, 69.0, 70.0, 69.0, 69.0, 70.0, 69.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1541.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [186.74136321195144], "unit": "score", "name": "Richards", "value": 189.04221}, {"lowerIsBetter": false, "replicates": [192.86403085824494], "unit": "score", "name": "DeltaBlue", "value": 342.82183000000015}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5117.34693877551], "unit": "score", "name": "Decrypt", "value": 52.01542971086741}, {"lowerIsBetter": false, "replicates": [1042.752867570386], "unit": "score", "name": "RayTrace", "value": 709.6494509999998}, {"lowerIsBetter": false, "replicates": [706.2146892655368], "unit": "score", "name": "Earley", "value": 943.711608}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [27916.666666666668], "unit": "score", "name": "RegExp", "value": 32.63229850746267}, {"lowerIsBetter": false, "replicates": [594.1943127962086], "unit": "score", "name": "Splay", "value": 137.14537188434699}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 21005.070261160596}]} 10:05:48 INFO - RETURN: dromaeo_css: 6397.16 10:05:48 INFO - RETURN: kraken: 1541.60 10:05:48 INFO - RETURN: v8_7: 21005.07 10:05:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21005.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1541.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6397.16"}}} 10:05:48 INFO - Return code: 0 10:05:48 INFO - # TBPL SUCCESS # 10:05:48 INFO - Running post-action listener: _resource_record_post_action 10:05:48 INFO - Running post-run listener: _resource_record_post_run 10:05:49 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 511459328; Read time: 0; Write time: 454416 10:05:49 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 170074112; Read time: 0; Write time: 188000 10:05:49 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 341385216; Read time: 0; Write time: 266416 10:05:49 INFO - Running post-run listener: _upload_blobber_files 10:05:49 INFO - Blob upload gear active. 10:05:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:05:49 INFO - Copying logs to upload dir... 10:05:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1259.599917 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-11-24 10:05:46.783958) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 10:05:46.787761) ========= 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=20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009991 build_url: 'https://queue.taskcluster.net/v1/task/PqZbAb2kS8acQGP6HuJvaQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 10:05:46.839448) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:05:46.839786) ========= 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=20aa3857bbc5a756c598c738000001bb-1448387088.425355-301394061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:05:46.889410) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 10:05:46.889756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 10:05:46.890080) ========= ========= Total master_lag: 0.21 =========