builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1448451143.99 results: success (0) buildid: 20151125025232 builduid: f5e1198a22804eb38cc309b5a2b8f662 revision: 9680aa9b2aeb4d0ecb4d1c8b4aaa72f3fe527c15 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:23.993220) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:23.993757) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:23.994080) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007863 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.026083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.026383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.050133) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.050403) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.106056) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.106353) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.106709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.106975) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 03:32:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 73.6M=0s 2015-11-25 03:32:25 (73.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.323280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.323560) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015427 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.382046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:24.382414) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9680aa9b2aeb4d0ecb4d1c8b4aaa72f3fe527c15 --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 9680aa9b2aeb4d0ecb4d1c8b4aaa72f3fe527c15 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 03:32:25,582 truncating revision to first 12 chars 2015-11-25 03:32:25,582 Setting DEBUG logging. 2015-11-25 03:32:25,582 attempt 1/10 2015-11-25 03:32:25,582 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9680aa9b2aeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 03:32:25,938 unpacking tar archive at: fx-team-9680aa9b2aeb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627655 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:25.026356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:25.026878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:25.036851) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:25.037205) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 03:32:25.037614) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-25 03:32:25.037898) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:26 INFO - MultiFileLogger online at 20151125 03:32:26 in /builds/slave/test 03:32:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:32:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:26 INFO - {'append_to_log': False, 03:32:26 INFO - 'base_work_dir': '/builds/slave/test', 03:32:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:32:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:26 INFO - 'branch': 'Fx-Team-Non-PGO', 03:32:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:26 INFO - 'config_files': ('talos/linux_config.py',), 03:32:26 INFO - 'default_actions': ('clobber', 03:32:26 INFO - 'read-buildbot-config', 03:32:26 INFO - 'download-and-extract', 03:32:26 INFO - 'populate-webroot', 03:32:26 INFO - 'create-virtualenv', 03:32:26 INFO - 'install', 03:32:26 INFO - 'run-tests'), 03:32:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:26 INFO - 'download_minidump_stackwalk': True, 03:32:26 INFO - 'download_symbols': 'ondemand', 03:32:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:26 INFO - 'installer_path': 'installer.exe', 03:32:26 INFO - 'log_level': 'info', 03:32:26 INFO - 'log_name': 'talos', 03:32:26 INFO - 'log_to_console': True, 03:32:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:26 INFO - 'opt_config_files': (), 03:32:26 INFO - 'pip_index': False, 03:32:26 INFO - 'sps_profile': False, 03:32:26 INFO - 'sps_profile_interval': 0, 03:32:26 INFO - 'suite': 'dromaeojs', 03:32:26 INFO - 'system_bits': '64', 03:32:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:26 INFO - 'title': 'talos-linux64-ix-061', 03:32:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:26 INFO - 'use_talos_json': True, 03:32:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:26 INFO - 'work_dir': 'build'} 03:32:26 INFO - ##### 03:32:26 INFO - ##### Running clobber step. 03:32:26 INFO - ##### 03:32:26 INFO - Running pre-action listener: _resource_record_pre_action 03:32:26 INFO - Running main action method: clobber 03:32:26 INFO - rmtree: /builds/slave/test/build 03:32:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:27 INFO - Running post-action listener: _resource_record_post_action 03:32:27 INFO - ##### 03:32:27 INFO - ##### Running read-buildbot-config step. 03:32:27 INFO - ##### 03:32:27 INFO - Running pre-action listener: _resource_record_pre_action 03:32:27 INFO - Running main action method: read_buildbot_config 03:32:27 INFO - Using buildbot properties: 03:32:27 INFO - { 03:32:27 INFO - "properties": { 03:32:27 INFO - "buildnumber": 1132, 03:32:27 INFO - "product": "firefox", 03:32:27 INFO - "script_repo_revision": "production", 03:32:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:32:27 INFO - "repository": "", 03:32:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:32:27 INFO - "buildid": "20151125025232", 03:32:27 INFO - "slavename": "talos-linux64-ix-061", 03:32:27 INFO - "pgo_build": "False", 03:32:27 INFO - "basedir": "/builds/slave/test", 03:32:27 INFO - "project": "", 03:32:27 INFO - "platform": "ubuntu64_hw", 03:32:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:32:27 INFO - "slavebuilddir": "test", 03:32:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:32:27 INFO - "branch": "fx-team", 03:32:27 INFO - "repo_path": "integration/fx-team", 03:32:27 INFO - "stage_platform": "linux64", 03:32:27 INFO - "builduid": "f5e1198a22804eb38cc309b5a2b8f662", 03:32:27 INFO - "revision": "9680aa9b2aeb4d0ecb4d1c8b4aaa72f3fe527c15" 03:32:27 INFO - }, 03:32:27 INFO - "sourcestamp": { 03:32:27 INFO - "repository": "", 03:32:27 INFO - "hasPatch": false, 03:32:27 INFO - "project": "", 03:32:27 INFO - "branch": "fx-team-linux64-talos", 03:32:27 INFO - "changes": [ 03:32:27 INFO - { 03:32:27 INFO - "category": null, 03:32:27 INFO - "files": [ 03:32:27 INFO - { 03:32:27 INFO - "url": null, 03:32:27 INFO - "name": "https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:32:27 INFO - } 03:32:27 INFO - ], 03:32:27 INFO - "repository": "", 03:32:27 INFO - "rev": "9680aa9b2aeb4d0ecb4d1c8b4aaa72f3fe527c15", 03:32:27 INFO - "who": "georg.fritzsche@googlemail.com", 03:32:27 INFO - "when": 1448451034, 03:32:27 INFO - "number": 6705132, 03:32:27 INFO - "comments": "Bug 1227579 - Change the main about:healthreport URL to the v4 content. r=dexter", 03:32:27 INFO - "project": "", 03:32:27 INFO - "at": "Wed 25 Nov 2015 03:30:34", 03:32:27 INFO - "branch": "fx-team-linux64-talos", 03:32:27 INFO - "revlink": "", 03:32:27 INFO - "properties": [ 03:32:27 INFO - [ 03:32:27 INFO - "buildid", 03:32:27 INFO - "20151125025232", 03:32:27 INFO - "Change" 03:32:27 INFO - ], 03:32:27 INFO - [ 03:32:27 INFO - "builduid", 03:32:27 INFO - "f5e1198a22804eb38cc309b5a2b8f662", 03:32:27 INFO - "Change" 03:32:27 INFO - ], 03:32:27 INFO - [ 03:32:27 INFO - "pgo_build", 03:32:27 INFO - "False", 03:32:27 INFO - "Change" 03:32:27 INFO - ] 03:32:27 INFO - ], 03:32:27 INFO - "revision": "9680aa9b2aeb4d0ecb4d1c8b4aaa72f3fe527c15" 03:32:27 INFO - } 03:32:27 INFO - ], 03:32:27 INFO - "revision": "9680aa9b2aeb4d0ecb4d1c8b4aaa72f3fe527c15" 03:32:27 INFO - } 03:32:27 INFO - } 03:32:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:32:27 INFO - Running post-action listener: _resource_record_post_action 03:32:27 INFO - ##### 03:32:27 INFO - ##### Running download-and-extract step. 03:32:27 INFO - ##### 03:32:27 INFO - Running pre-action listener: _resource_record_pre_action 03:32:27 INFO - Running main action method: download_and_extract 03:32:27 INFO - mkdir: /builds/slave/test/build/tests 03:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:27 INFO - https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/test_packages.json 03:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/test_packages.json 03:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:32:33 INFO - Downloaded 1302 bytes. 03:32:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:32:33 INFO - Using the following test package requirements: 03:32:33 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:32:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:32:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:33 INFO - u'jsshell-linux-x86_64.zip'], 03:32:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:32:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:32:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:32:33 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:32:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:32:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:32:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:32:33 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:32:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:33 INFO - https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:32:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:32:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/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 03:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/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 03:32:48 INFO - Downloaded 21346027 bytes. 03:32:48 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 03:32:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:32:48 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 03:32:49 INFO - Return code: 0 03:32:49 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 03:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:49 INFO - https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:32:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:32:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:32:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/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 03:32:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/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 03:32:50 INFO - Downloaded 21346027 bytes. 03:32:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:32:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:32:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:32:51 INFO - Return code: 0 03:32: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')]} 03:32:51 INFO - https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:32:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:32:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:32:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/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 03:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/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 03:32:52 INFO - Downloaded 11131717 bytes. 03:32:52 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 03:32:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:32:52 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 03:32:52 INFO - Return code: 0 03:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:52 INFO - https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/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 03:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/40tRM-9ZST2aEC324tWtxQ/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 03:32:53 INFO - Downloaded 56848953 bytes. 03:32:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:32:53 INFO - mkdir: /builds/slave/test/properties 03:32:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:53 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:53 INFO - Contents: 03:32:53 INFO - build_url:https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:32:53 INFO - Running post-action listener: _resource_record_post_action 03:32:53 INFO - Running post-action listener: set_extra_try_arguments 03:32:53 INFO - ##### 03:32:53 INFO - ##### Running populate-webroot step. 03:32:53 INFO - ##### 03:32:53 INFO - Running pre-action listener: _resource_record_pre_action 03:32:53 INFO - Running main action method: populate_webroot 03:32:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:32:53 INFO - '../fennec_ids.txt'], 03:32:53 INFO - 'tests': ['tcheck2']}, 03:32:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:53 INFO - '--tppagecycles', 03:32:53 INFO - '7'], 03:32:53 INFO - 'tests': ['tsvgm']}}, 03:32:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:32:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:32:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:32:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:32:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:32:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:53 INFO - 'talos_options': ['--e10s'], 03:32:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:53 INFO - 'tests': ['damp', 'tps']}, 03:32:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:53 INFO - 'talos_options': ['--e10s'], 03:32:53 INFO - 'tests': ['damp', 'tps']}, 03:32:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:32:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:53 INFO - 'other': {'tests': ['a11yr', 03:32:53 INFO - 'ts_paint', 03:32:53 INFO - 'tpaint', 03:32:53 INFO - 'sessionrestore', 03:32:53 INFO - 'sessionrestore_no_auto_restore']}, 03:32:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:32:53 INFO - 'tests': ['a11yr', 03:32:53 INFO - 'ts_paint', 03:32:53 INFO - 'tpaint', 03:32:53 INFO - 'sessionrestore', 03:32:53 INFO - 'sessionrestore_no_auto_restore']}, 03:32:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:32:53 INFO - 'tests': ['a11yr', 03:32:53 INFO - 'ts_paint', 03:32:53 INFO - 'tpaint', 03:32:53 INFO - 'sessionrestore', 03:32:53 INFO - 'sessionrestore_no_auto_restore']}, 03:32:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:32:53 INFO - 'tests': ['a11yr', 03:32:53 INFO - 'ts_paint', 03:32:53 INFO - 'tpaint', 03:32:53 INFO - 'sessionrestore', 03:32:53 INFO - 'sessionrestore_no_auto_restore']}, 03:32:53 INFO - 'other_l64': {'tests': ['a11yr', 03:32:53 INFO - 'ts_paint', 03:32:53 INFO - 'tpaint', 03:32:53 INFO - 'sessionrestore', 03:32:53 INFO - 'sessionrestore_no_auto_restore']}, 03:32:53 INFO - 'other_nol64': {'tests': ['a11yr', 03:32:53 INFO - 'ts_paint', 03:32:53 INFO - 'tpaint', 03:32:53 INFO - 'sessionrestore', 03:32:53 INFO - 'sessionrestore_no_auto_restore']}, 03:32:53 INFO - 'svgr': {'tests': ['tsvgx', 03:32:53 INFO - 'tsvgr_opacity', 03:32:53 INFO - 'tart', 03:32:53 INFO - 'tscrollx', 03:32:53 INFO - 'cart']}, 03:32:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:32:53 INFO - 'tests': ['tsvgx', 03:32:53 INFO - 'tsvgr_opacity', 03:32:53 INFO - 'tart', 03:32:53 INFO - 'tscrollx', 03:32:53 INFO - 'cart']}, 03:32:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:53 INFO - 'tests': ['tp5o']}, 03:32:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:53 INFO - 'talos_options': ['--e10s'], 03:32:53 INFO - 'tests': ['tp5o']}, 03:32:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:53 INFO - 'talos_options': ['--xperf_path', 03:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:53 INFO - 'tests': ['tp5n']}, 03:32:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:53 INFO - 'talos_options': ['--e10s', 03:32:53 INFO - '--xperf_path', 03:32:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:53 INFO - 'tests': ['tp5n']}}, 03:32:53 INFO - 'talos.zip': {'path': '', 03:32:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:53 INFO - Running post-action listener: _resource_record_post_action 03:32:53 INFO - ##### 03:32:53 INFO - ##### Running create-virtualenv step. 03:32:53 INFO - ##### 03:32:53 INFO - Running pre-action listener: _resource_record_pre_action 03:32:53 INFO - Running main action method: create_virtualenv 03:32:53 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:53 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 03:32:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:53 INFO - Using real prefix '/usr' 03:32:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:56 INFO - Installing pip.................done. 03:32:56 INFO - Return code: 0 03:32:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:56 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 0x18ef030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb2220>, '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 0x1b1e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', '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 03:32:56 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 03:32:56 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 03:32:56 INFO - Using env: {'DISPLAY': ':0', 03:32:56 INFO - 'HOME': '/home/cltbld', 03:32:56 INFO - 'LANG': 'en_US.UTF-8', 03:32:56 INFO - 'LANGUAGE': 'en_US:en', 03:32:56 INFO - 'LOGNAME': 'cltbld', 03:32:56 INFO - 'MAIL': '/var/mail/cltbld', 03:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:56 INFO - 'MOZ_NO_REMOTE': '1', 03:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:56 INFO - 'NO_EM_RESTART': '1', 03:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:56 INFO - 'PWD': '/builds/slave/test', 03:32:56 INFO - 'SHELL': '/bin/bash', 03:32:56 INFO - 'SHLVL': '1', 03:32:56 INFO - 'TERM': 'linux', 03:32:56 INFO - 'TMOUT': '86400', 03:32:56 INFO - 'USER': 'cltbld', 03:32:56 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', 03:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:56 INFO - '_': '/tools/buildbot/bin/python'} 03:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:56 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 03:32:56 INFO - Cleaning up... 03:32:56 INFO - Return code: 0 03:32:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:56 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 0x18ef030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb2220>, '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 0x1b1e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', '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 03:32:56 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 03:32:56 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 03:32:56 INFO - Using env: {'DISPLAY': ':0', 03:32:56 INFO - 'HOME': '/home/cltbld', 03:32:56 INFO - 'LANG': 'en_US.UTF-8', 03:32:56 INFO - 'LANGUAGE': 'en_US:en', 03:32:56 INFO - 'LOGNAME': 'cltbld', 03:32:56 INFO - 'MAIL': '/var/mail/cltbld', 03:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:56 INFO - 'MOZ_NO_REMOTE': '1', 03:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:56 INFO - 'NO_EM_RESTART': '1', 03:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:56 INFO - 'PWD': '/builds/slave/test', 03:32:56 INFO - 'SHELL': '/bin/bash', 03:32:56 INFO - 'SHLVL': '1', 03:32:56 INFO - 'TERM': 'linux', 03:32:56 INFO - 'TMOUT': '86400', 03:32:56 INFO - 'USER': 'cltbld', 03:32:56 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', 03:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:56 INFO - '_': '/tools/buildbot/bin/python'} 03:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:56 INFO - Downloading/unpacking psutil>=0.7.1 03:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:32:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:58 INFO - Installing collected packages: psutil 03:32:58 INFO - Running setup.py install for psutil 03:32:58 INFO - building 'psutil._psutil_linux' extension 03:32:58 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 03:32:58 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 03:32:58 INFO - building 'psutil._psutil_posix' extension 03:32:58 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 03:32:58 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 03:32:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:58 INFO - Successfully installed psutil 03:32:58 INFO - Cleaning up... 03:32:58 INFO - Return code: 0 03:32:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:32:58 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')]} 03:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:58 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')]} 03:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:58 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 0x18ef030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb2220>, '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 0x1b1e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', '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 03:32:58 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 03:32:58 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 03:32:58 INFO - Using env: {'DISPLAY': ':0', 03:32:58 INFO - 'HOME': '/home/cltbld', 03:32:58 INFO - 'LANG': 'en_US.UTF-8', 03:32:58 INFO - 'LANGUAGE': 'en_US:en', 03:32:58 INFO - 'LOGNAME': 'cltbld', 03:32:58 INFO - 'MAIL': '/var/mail/cltbld', 03:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:58 INFO - 'MOZ_NO_REMOTE': '1', 03:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:58 INFO - 'NO_EM_RESTART': '1', 03:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:58 INFO - 'PWD': '/builds/slave/test', 03:32:58 INFO - 'SHELL': '/bin/bash', 03:32:58 INFO - 'SHLVL': '1', 03:32:58 INFO - 'TERM': 'linux', 03:32:58 INFO - 'TMOUT': '86400', 03:32:58 INFO - 'USER': 'cltbld', 03:32:58 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', 03:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:58 INFO - '_': '/tools/buildbot/bin/python'} 03:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:32:59 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 03:32:59 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 03:32:59 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 03:32:59 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 03:32:59 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 03:32:59 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 03:33:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:33:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:33:00 INFO - Installing collected packages: mozsystemmonitor 03:33:00 INFO - Running setup.py install for mozsystemmonitor 03:33:01 INFO - Successfully installed mozsystemmonitor 03:33:01 INFO - Cleaning up... 03:33:01 INFO - Return code: 0 03:33:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:01 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')]} 03:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:01 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')]} 03:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:01 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 0x18ef030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb2220>, '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 0x1b1e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', '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 03:33:01 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 03:33:01 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 03:33:01 INFO - Using env: {'DISPLAY': ':0', 03:33:01 INFO - 'HOME': '/home/cltbld', 03:33:01 INFO - 'LANG': 'en_US.UTF-8', 03:33:01 INFO - 'LANGUAGE': 'en_US:en', 03:33:01 INFO - 'LOGNAME': 'cltbld', 03:33:01 INFO - 'MAIL': '/var/mail/cltbld', 03:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:01 INFO - 'MOZ_NO_REMOTE': '1', 03:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:01 INFO - 'NO_EM_RESTART': '1', 03:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:01 INFO - 'PWD': '/builds/slave/test', 03:33:01 INFO - 'SHELL': '/bin/bash', 03:33:01 INFO - 'SHLVL': '1', 03:33:01 INFO - 'TERM': 'linux', 03:33:01 INFO - 'TMOUT': '86400', 03:33:01 INFO - 'USER': 'cltbld', 03:33:01 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', 03:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:01 INFO - '_': '/tools/buildbot/bin/python'} 03:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:01 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 03:33: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 03:33:01 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 03:33:01 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 03:33:01 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 03:33: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 03:33:02 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:03 INFO - Downloading docopt-0.6.1.tar.gz 03:33:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:03 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:03 INFO - Running setup.py install for blobuploader 03:33:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:03 INFO - Running setup.py install for requests 03:33:04 INFO - Running setup.py install for docopt 03:33:04 INFO - Successfully installed blobuploader requests docopt 03:33:04 INFO - Cleaning up... 03:33:04 INFO - Return code: 0 03:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:04 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 0x18ef030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb2220>, '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 0x1b1e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', '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 03:33:04 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 03:33:04 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 03:33:04 INFO - Using env: {'DISPLAY': ':0', 03:33:04 INFO - 'HOME': '/home/cltbld', 03:33:04 INFO - 'LANG': 'en_US.UTF-8', 03:33:04 INFO - 'LANGUAGE': 'en_US:en', 03:33:04 INFO - 'LOGNAME': 'cltbld', 03:33:04 INFO - 'MAIL': '/var/mail/cltbld', 03:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:04 INFO - 'MOZ_NO_REMOTE': '1', 03:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:04 INFO - 'NO_EM_RESTART': '1', 03:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:04 INFO - 'PWD': '/builds/slave/test', 03:33:04 INFO - 'SHELL': '/bin/bash', 03:33:04 INFO - 'SHLVL': '1', 03:33:04 INFO - 'TERM': 'linux', 03:33:04 INFO - 'TMOUT': '86400', 03:33:04 INFO - 'USER': 'cltbld', 03:33:04 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', 03:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:04 INFO - '_': '/tools/buildbot/bin/python'} 03:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:04 INFO - Running setup.py (path:/tmp/pip-GDO7uZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:04 INFO - Running setup.py (path:/tmp/pip-iI9U9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:04 INFO - Running setup.py (path:/tmp/pip-Y3x9ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:04 INFO - Running setup.py (path:/tmp/pip-OTKSnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:04 INFO - Running setup.py (path:/tmp/pip-RuxB7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:04 INFO - Running setup.py (path:/tmp/pip-pMSbPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:04 INFO - Running setup.py (path:/tmp/pip-C1tiBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:04 INFO - Running setup.py (path:/tmp/pip-aQUTOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:05 INFO - Running setup.py (path:/tmp/pip-5vcfM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:05 INFO - Running setup.py (path:/tmp/pip-9bdM41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:05 INFO - Running setup.py (path:/tmp/pip-hC2RVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:05 INFO - Running setup.py (path:/tmp/pip-JJeP3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:05 INFO - Running setup.py (path:/tmp/pip-Oirs8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:05 INFO - Running setup.py (path:/tmp/pip-db6tFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:05 INFO - Running setup.py (path:/tmp/pip-tPf8ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:05 INFO - Running setup.py (path:/tmp/pip-c6JAsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:05 INFO - Running setup.py (path:/tmp/pip-JUzl6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:05 INFO - Running setup.py install for manifestparser 03:33:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:05 INFO - Running setup.py install for mozcrash 03:33:05 INFO - Running setup.py install for mozdebug 03:33:05 INFO - Running setup.py install for mozdevice 03:33:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Running setup.py install for mozfile 03:33:06 INFO - Running setup.py install for mozhttpd 03:33:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Running setup.py install for mozinfo 03:33:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Running setup.py install for mozInstall 03:33:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Running setup.py install for mozleak 03:33:06 INFO - Running setup.py install for mozlog 03:33:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Running setup.py install for moznetwork 03:33:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:06 INFO - Running setup.py install for mozprocess 03:33:06 INFO - Running setup.py install for mozprofile 03:33:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:07 INFO - Running setup.py install for mozrunner 03:33:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:07 INFO - Running setup.py install for mozscreenshot 03:33:07 INFO - Running setup.py install for moztest 03:33:07 INFO - Running setup.py install for mozversion 03:33:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:07 INFO - Cleaning up... 03:33:07 INFO - Return code: 0 03:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:07 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')]} 03:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:07 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')]} 03:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:07 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 0x18ef030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb2220>, '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 0x1b1e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', '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 03:33:07 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 03:33:07 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 03:33:07 INFO - Using env: {'DISPLAY': ':0', 03:33:07 INFO - 'HOME': '/home/cltbld', 03:33:07 INFO - 'LANG': 'en_US.UTF-8', 03:33:07 INFO - 'LANGUAGE': 'en_US:en', 03:33:07 INFO - 'LOGNAME': 'cltbld', 03:33:07 INFO - 'MAIL': '/var/mail/cltbld', 03:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:07 INFO - 'MOZ_NO_REMOTE': '1', 03:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:07 INFO - 'NO_EM_RESTART': '1', 03:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:07 INFO - 'PWD': '/builds/slave/test', 03:33:07 INFO - 'SHELL': '/bin/bash', 03:33:07 INFO - 'SHLVL': '1', 03:33:07 INFO - 'TERM': 'linux', 03:33:07 INFO - 'TMOUT': '86400', 03:33:07 INFO - 'USER': 'cltbld', 03:33:07 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', 03:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:07 INFO - '_': '/tools/buildbot/bin/python'} 03:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:07 INFO - Running setup.py (path:/tmp/pip-niwz0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:07 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)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:07 INFO - Running setup.py (path:/tmp/pip-qH4leC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:07 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)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:07 INFO - Running setup.py (path:/tmp/pip-pexg6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:07 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)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:07 INFO - Running setup.py (path:/tmp/pip-UZgzuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:07 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)) 03:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:07 INFO - Running setup.py (path:/tmp/pip-SXSbx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:08 INFO - Running setup.py (path:/tmp/pip-NZ_ujJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:08 INFO - Running setup.py (path:/tmp/pip-l3d_X8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:08 INFO - Running setup.py (path:/tmp/pip-LtySXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:08 INFO - Running setup.py (path:/tmp/pip-oWcIJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:08 INFO - Running setup.py (path:/tmp/pip-zi_Poo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:08 INFO - Running setup.py (path:/tmp/pip-z6H3Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:08 INFO - Running setup.py (path:/tmp/pip-dcArHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:08 INFO - Running setup.py (path:/tmp/pip-YOa1n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:08 INFO - Running setup.py (path:/tmp/pip-iO4CaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:08 INFO - Running setup.py (path:/tmp/pip-xal20d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:08 INFO - Running setup.py (path:/tmp/pip-ma8smN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:08 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)) 03:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:08 INFO - Running setup.py (path:/tmp/pip-ZGyL5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:08 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)) 03:33:08 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)) 03:33:08 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)) 03:33:08 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)) 03:33:08 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)) 03:33:08 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)) 03:33:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:10 INFO - Downloading blessings-1.5.1.tar.gz 03:33:10 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 03:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:10 INFO - Installing collected packages: blessings 03:33:10 INFO - Running setup.py install for blessings 03:33:10 INFO - Successfully installed blessings 03:33:10 INFO - Cleaning up... 03:33:10 INFO - Return code: 0 03:33:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:11 INFO - Reading from file tmpfile_stdout 03:33:11 INFO - Current package versions: 03:33:11 INFO - argparse == 1.2.1 03:33:11 INFO - blessings == 1.5.1 03:33:11 INFO - blobuploader == 1.2.4 03:33:11 INFO - docopt == 0.6.1 03:33:11 INFO - manifestparser == 1.1 03:33:11 INFO - mozInstall == 1.12 03:33:11 INFO - mozcrash == 0.16 03:33:11 INFO - mozdebug == 0.1 03:33:11 INFO - mozdevice == 0.47 03:33:11 INFO - mozfile == 1.2 03:33:11 INFO - mozhttpd == 0.7 03:33:11 INFO - mozinfo == 0.9 03:33:11 INFO - mozleak == 0.1 03:33:11 INFO - mozlog == 3.1 03:33:11 INFO - moznetwork == 0.27 03:33:11 INFO - mozprocess == 0.22 03:33:11 INFO - mozprofile == 0.27 03:33:11 INFO - mozrunner == 6.11 03:33:11 INFO - mozscreenshot == 0.1 03:33:11 INFO - mozsystemmonitor == 0.0 03:33:11 INFO - moztest == 0.7 03:33:11 INFO - mozversion == 1.4 03:33:11 INFO - psutil == 3.1.1 03:33:11 INFO - requests == 1.2.3 03:33:11 INFO - wsgiref == 0.1.2 03:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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/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 0x18ef030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb2220>, '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 0x1b1e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', '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 03:33: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/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 03:33: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/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 03:33:11 INFO - Using env: {'DISPLAY': ':0', 03:33:11 INFO - 'HOME': '/home/cltbld', 03:33:11 INFO - 'LANG': 'en_US.UTF-8', 03:33:11 INFO - 'LANGUAGE': 'en_US:en', 03:33:11 INFO - 'LOGNAME': 'cltbld', 03:33:11 INFO - 'MAIL': '/var/mail/cltbld', 03:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:11 INFO - 'MOZ_NO_REMOTE': '1', 03:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:11 INFO - 'NO_EM_RESTART': '1', 03:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:11 INFO - 'PWD': '/builds/slave/test', 03:33:11 INFO - 'SHELL': '/bin/bash', 03:33:11 INFO - 'SHLVL': '1', 03:33:11 INFO - 'TERM': 'linux', 03:33:11 INFO - 'TMOUT': '86400', 03:33:11 INFO - 'USER': 'cltbld', 03:33:11 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', 03:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:11 INFO - '_': '/tools/buildbot/bin/python'} 03:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:11 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)) 03:33:11 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)) 03:33:11 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)) 03:33:11 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)) 03:33:11 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)) 03:33:11 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)) 03:33:11 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)) 03:33:11 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)) 03:33:11 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)) 03:33:11 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)) 03:33:11 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)) 03:33:11 INFO - Cleaning up... 03:33:11 INFO - Return code: 0 03:33:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33: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')]} 03:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ef030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b20210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb2220>, '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 0x1b1e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', '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 03:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:33:11 INFO - Using env: {'DISPLAY': ':0', 03:33:11 INFO - 'HOME': '/home/cltbld', 03:33:11 INFO - 'LANG': 'en_US.UTF-8', 03:33:11 INFO - 'LANGUAGE': 'en_US:en', 03:33:11 INFO - 'LOGNAME': 'cltbld', 03:33:11 INFO - 'MAIL': '/var/mail/cltbld', 03:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:11 INFO - 'MOZ_NO_REMOTE': '1', 03:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:11 INFO - 'NO_EM_RESTART': '1', 03:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:11 INFO - 'PWD': '/builds/slave/test', 03:33:11 INFO - 'SHELL': '/bin/bash', 03:33:11 INFO - 'SHLVL': '1', 03:33:11 INFO - 'TERM': 'linux', 03:33:11 INFO - 'TMOUT': '86400', 03:33:11 INFO - 'USER': 'cltbld', 03:33:11 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', 03:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:11 INFO - '_': '/tools/buildbot/bin/python'} 03:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:11 INFO - Downloading/unpacking jsonschema 03:33:11 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 03:33:11 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 03:33:11 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 03:33:11 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 03:33:11 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 03:33:11 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 03:33:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:33:13 INFO - Downloading/unpacking functools32 (from jsonschema) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:13 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:13 INFO - warning: no files found matching '*.txt' 03:33:13 INFO - no previously-included directories found matching 'build' 03:33:13 INFO - no previously-included directories found matching 'dist' 03:33:13 INFO - no previously-included directories found matching '.git*' 03:33:13 INFO - Installing collected packages: jsonschema, functools32 03:33:13 INFO - Running setup.py install for functools32 03:33:13 INFO - warning: no files found matching '*.txt' 03:33:13 INFO - no previously-included directories found matching 'build' 03:33:13 INFO - no previously-included directories found matching 'dist' 03:33:13 INFO - no previously-included directories found matching '.git*' 03:33:13 INFO - Successfully installed jsonschema functools32 03:33:13 INFO - Cleaning up... 03:33:13 INFO - Return code: 0 03:33:13 INFO - Running post-action listener: _resource_record_post_action 03:33:13 INFO - Running post-action listener: _start_resource_monitoring 03:33:13 INFO - Starting resource monitoring. 03:33:13 INFO - ##### 03:33:13 INFO - ##### Running install step. 03:33:13 INFO - ##### 03:33:13 INFO - Running pre-action listener: _resource_record_pre_action 03:33:13 INFO - Running main action method: install 03:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:13 INFO - Reading from file tmpfile_stdout 03:33:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:13 INFO - Reading from file tmpfile_stdout 03:33:13 INFO - Output received: 03:33:13 INFO - Usage: mozinstall [options] installer 03:33:13 INFO - Options: 03:33:13 INFO - -h, --help show this help message and exit 03:33:13 INFO - -d DEST, --destination=DEST 03:33:13 INFO - Directory to install application into. [default: 03:33:13 INFO - "/builds/slave/test"] 03:33:13 INFO - --app=APP Application being installed. [default: firefox] 03:33:13 INFO - mkdir: /builds/slave/test/build/application 03:33:13 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'] 03:33:13 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 03:33:28 INFO - Reading from file tmpfile_stdout 03:33:28 INFO - Output received: 03:33:28 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:28 INFO - Running post-action listener: _resource_record_post_action 03:33:28 INFO - ##### 03:33:28 INFO - ##### Running run-tests step. 03:33:28 INFO - ##### 03:33:28 INFO - Running pre-action listener: _resource_record_pre_action 03:33:28 INFO - Running main action method: run_tests 03:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:28 INFO - Python 2.7.3 03:33:28 INFO - Return code: 0 03:33:28 INFO - grabbing minidump binary from tooltool 03:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:28 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 0x1bb2220>, '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 0x1b1e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:28 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 03:33:28 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 03:33:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:28 INFO - Return code: 0 03:33:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test/build 03:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 03:33:28 INFO - Using env: {'DISPLAY': ':0', 03:33:28 INFO - 'HOME': '/home/cltbld', 03:33:28 INFO - 'LANG': 'en_US.UTF-8', 03:33:28 INFO - 'LANGUAGE': 'en_US:en', 03:33:28 INFO - 'LOGNAME': 'cltbld', 03:33:28 INFO - 'MAIL': '/var/mail/cltbld', 03:33:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:28 INFO - 'MOZ_NO_REMOTE': '1', 03:33:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:28 INFO - 'NO_EM_RESTART': '1', 03:33:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:28 INFO - 'PWD': '/builds/slave/test', 03:33:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:28 INFO - 'SHELL': '/bin/bash', 03:33:28 INFO - 'SHLVL': '1', 03:33:28 INFO - 'TERM': 'linux', 03:33:28 INFO - 'TMOUT': '86400', 03:33:28 INFO - 'USER': 'cltbld', 03:33:28 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717', 03:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:28 INFO - '_': '/tools/buildbot/bin/python'} 03:33:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 03:33:28 INFO - mozversion INFO | application_buildid: 20151125025232 03:33:28 INFO - mozversion INFO | application_changeset: 9680aa9b2aeb4d0ecb4d1c8b4aaa72f3fe527c15 03:33:28 INFO - mozversion INFO | application_display_name: Nightly 03:33:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:28 INFO - mozversion INFO | application_name: Firefox 03:33:28 INFO - mozversion INFO | application_remotingname: firefox 03:33:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:33:28 INFO - mozversion INFO | application_vendor: Mozilla 03:33:28 INFO - mozversion INFO | application_version: 45.0a1 03:33:28 INFO - mozversion INFO | platform_buildid: 20151125025232 03:33:28 INFO - mozversion INFO | platform_changeset: 9680aa9b2aeb4d0ecb4d1c8b4aaa72f3fe527c15 03:33:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:33:28 INFO - mozversion INFO | platform_version: 45.0a1 03:33:28 INFO - 2015-11-25 03:33:28,583 DEBUG : using testdate: 1448451208 03:33:28 INFO - 2015-11-25 03:33:28,583 DEBUG : actual date: 1448451208 03:33:28 INFO - 2015-11-25 03:33:28,630 INFO : starting webserver on 'localhost:57288' 03:33:28 INFO - 2015-11-25 03:33:28,631 INFO : Starting test suite talos-linux64-ix-061 03:33:28 INFO - 2015-11-25 03:33:28,631 INFO : Starting test dromaeo_css 03:33:28 INFO - 2015-11-25 03:33:28,631 DEBUG : operating with platform_type : linux_ 03:33:28 INFO - 2015-11-25 03:33:28,632 INFO : Initialising browser for dromaeo_css test... 03:33:28 INFO - 2015-11-25 03:33:28,644 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpupyzYW/profile http://localhost:57288/getInfo.html 03:33:32 INFO - 2015-11-25 03:33:32,619 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:33:32 INFO - 2015-11-25 03:33:32,619 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:33:32 INFO - 2015-11-25 03:33:32,619 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:33:32 INFO - 2015-11-25 03:33:32,619 DEBUG : BROWSER_OUTPUT: __metrics 03:33:32 INFO - 2015-11-25 03:33:32,736 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:33:34 INFO - 2015-11-25 03:33:34,013 INFO : Browser initialized. 03:33:34 INFO - 2015-11-25 03:33:34,014 INFO : Running cycle 1/1 for dromaeo_css test... 03:33:34 INFO - 2015-11-25 03:33:34,014 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpupyzYW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:33:45 INFO - 2015-11-25 03:33:45,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 03:33:45 INFO - 2015-11-25 03:33:45,869 DEBUG : BROWSER_OUTPUT: 03:34:37 INFO - 2015-11-25 03:34:37,047 DEBUG : BROWSER_OUTPUT: 1448451277043 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] 03:36:48 INFO - 2015-11-25 03:36:48,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57288/tests/dromaeo/cssquery-ext.html) 03:36:49 INFO - 2015-11-25 03:36:49,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 244310016 03:36:49 INFO - 2015-11-25 03:36:49,863 DEBUG : BROWSER_OUTPUT: 03:39:52 INFO - 2015-11-25 03:39:52,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-ext.html (next: http://localhost:57288/tests/dromaeo/cssquery-jquery.html) 03:39:53 INFO - 2015-11-25 03:39:53,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 225894400 03:39:53 INFO - 2015-11-25 03:39:53,034 DEBUG : BROWSER_OUTPUT: 03:42:55 INFO - 2015-11-25 03:42:55,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57288/tests/dromaeo/cssquery-mootools.html) 03:42:55 INFO - 2015-11-25 03:42:55,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 214650880 03:42:55 INFO - 2015-11-25 03:42:55,646 DEBUG : BROWSER_OUTPUT: 03:45:57 INFO - 2015-11-25 03:45:57,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57288/tests/dromaeo/cssquery-prototype.html) 03:45:58 INFO - 2015-11-25 03:45:58,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 201281536 03:45:58 INFO - 2015-11-25 03:45:58,224 DEBUG : BROWSER_OUTPUT: 03:49:01 INFO - 2015-11-25 03:49:01,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57288/tests/dromaeo/cssquery-yui.html) 03:49:01 INFO - 2015-11-25 03:49:01,751 DEBUG : BROWSER_OUTPUT: RSS: Main: 208379904 03:49:01 INFO - 2015-11-25 03:49:01,751 DEBUG : BROWSER_OUTPUT: 03:52:04 INFO - 2015-11-25 03:52:04,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/dromaeo/cssquery-yui.html (next: http://localhost:57288/tests/dromaeo/cssquery-dojo.html) 03:52:04 INFO - 2015-11-25 03:52:04,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 253976576 03:52:04 INFO - 2015-11-25 03:52:04,656 DEBUG : BROWSER_OUTPUT: 03:52:04 INFO - 2015-11-25 03:52:04,656 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:52:04 INFO - 2015-11-25 03:52:04,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:52:04 INFO - 2015-11-25 03:52:04,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:52:04 INFO - 2015-11-25 03:52:04,657 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:52:04 INFO - 2015-11-25 03:52:04,657 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2593.6628238329017;2710.579860121682;2719.673639163301;2725.1007167634684;2739.6027576001475;4385.934210986838;4497.1455423469515;4574.954250457495;4591.747453890035;4621.029583787405;4498.460184777823;4504.481984571776;4561.977190114053;4569.109023740372;4615.28463088221;4192.769397683126;4213.831446742142;4225.154969006211;4231.4710661167355;4255.2978758504805;4041.1715598302276;4305.763183024932;4327.891802704926;4342.5874541918465;4351.521332653406;4166.791660416967;4167.312393455091;4219.43037689911;4236.110416812473;4270.871873843789;4187.413762073312;4228.154369126156;4270.316749320125;4275.508316543606;4310.719803212813;4007.73949693269;4110.157417729359;4228.386883901817;4249.596288352602;4276.550962148961;4406.272964960777;4433.623142032931;4494.640428765691;4527.796249168795;4537.636989040869;4901.852944411673;4924.655274130812;4925.704457732548;4926.1379258629595;4966.1309270877455;4728.763561821896;4945.876353091166;4953.182724850431;4964.354633897607;5005.849824505271;4513.390692256569;4519.909601807945;4566.13243483737;4628.768561571908;4682.882927926829;5067.543921047123;5075.111855425286;5080.54275115234;5081.339425874613;5085.084684756779;4623.214053610895;4828.082664293773;4853.369062021915;4860.8784780380065;4883.902321953541;4750.8337208197545;4789.616830653539;4802.51974802517;4816.373871396766;4826.95173048272;4834.492378300228;4836.395450568679;4840.7337596432535;4844.15227335215;4882.389701287339;4820.71075735457;4827.831025914076;4828.203346447796;4843.903121937541;4869.780859861315;3955.0507878109047;4032.3951407288555;4048.1296521248073;4053.5541090480024;4088.325426304686;3541.787492750443;3550.2366991097037;3551.3074950384425;3577.695895848882;3578.946315805265;4280.379344994958;4282.678799090018;4285.742855428684;4288.399624052635;4329.372241025097;4625.283081122431;4691.906161876812;4737.573618374363;4740.597049250783;4944.604431645532;4137.81379837908;4150.335946248586;4206.179794939957;4287.614114729689;4304.913901721948;4363.47638283408;4417.0724147929295;4419.535948725337;4419.867403977886;4455.532169122261;4416.359627854007;4540.954590454186;4541.659375546913;4696.365990591295;4791.808327666854;4801.68789028712;4858.392700912386;4875.366202393666;4879.243717223836;4909.582685471775;4732.337472753748;4735.17134501454;4735.502772208868;4738.4787673356595;4742.549457801503;4597.494275629611;4696.976515117402;4697.248440249544;4878.414590249193;4928;4821.46963833985;4867.9269810952155;4893.853184404474;4894.19245824435;4933.876653083558;4686.992296656235;4748.358971538936;4748.905021899612;4755.38180036593;4777.95222047775;4499.820007199675;4594.1730488512385;4631.467381251065;4747.976260118678;4788.23388257891;4572.5198854119835;4619.122366750306;4633.745144017112;4664.160451118832;4679.859604211879;4838.250071238964;4841.878953026203;4845.781939812788;4847.733374664427;4851.320815085962;4549.112922979987;4660.510646382081;4665.32352808834;4712.175369310426;4772.117158325721 03:52:04 INFO - 2015-11-25 03:52:04,661 DEBUG : BROWSER_OUTPUT: |1;ext.html;569.0184431855049;574.7126436781609;576.8788554403575;578.1154833105351;594.9643021418715;26412.603810942826;26833.195004149882;26904.192874213757;26915.730842691566;36065.278694426095;39812.203755924864;40409;40409.797951010274;40460.190796184055;40539.18921621566;7936.722214722486;8111.229433203836;8113.634886430095;8115;8116.6347514362;7103.183133939586;7251.6374181290985;7265.854682906339;7275.199728029939;7857.174996625329;7084.220735719093;7171.89242161368;10125.3924764514;10369.688909332694;10387.22095842811;10033;10111.09000189979;10124.34191777532;10127.746806329864;10131.79736405275;7085.787426377217;7281.1990681025045;9684.225261979025;9778.90221097787;9803.901960980442;40578.39132413016;41511.7924410376;41549.584504154875;41579.792101039304;41736.58263417388;2778.221140417375;2792.3437992071845;2916.3875586126937;3275.7215636670912;3286.354613880687;27593.310167245778;27661.446771064668;27828.30429239285;27853.303667408276;28380.432391352264;3415.077928959167;3437.5187473753695;3454.29187016661;3495.353359628477;3544.769589976669;227819;229431.8528407364;230501;230984;231965;56290.71854640783;56332.43667563272;56376;56465;56738;59984.700076499335;60423.39576604265;60447.697761511794;60469;60488.395116048276;13462.259575723428;13925.373358198905;13926.164430134022;13933.094348867291;13939.512117075854;9803.705888823346;9815.509224538744;9817.509124543743;9820.312578119607;9825.508724563742;18911.653191943955;19218.711719324223;19346.613067738846;19419.834809911452;19463.318783842496;7468;7713.1515533291295;7747.573883436465;7824;7851;888.1739981816972;892.7857314244535;911.3028533172129;945.5177859291811;990.0742805476758;27094.322641934108;27432.588511172347;30111.548326775115;31032.53451198234;31763.36473270568;851.0553285852699;860.1484530314943;869.626060793852;937.6249500199838;964.5563041001218;13366.93316533411;15678.843211567966;16342.182890855409;16437.342506299854;16480.09359485216;339264.9110263348;344084;344531;344853;344983.10033799685;48487.27269090967;48889.75555122201;49025.50974490281;49505.50494495081;49550;1213.2720367779261;1225.6139316115396;1241.975160496785;1242.2670624331868;1243.8258643789877;27832.44335113246;28575.28561785972;28768;28771.85614072;28850.422991540472;40579.59420405876;41027.384589231784;41327;41329.793351033055;41366.58633413627;259766;261178;261697;261816;263325;24737;25216.117435889657;28747.856260718563;28793.56809647815;29308.56037159487;34047.65952340445;34596.654033459345;34628.134296642784;34700.47949280712;34994.82502587471;31177;32328.83835580807;32788.344233115684;32997.50503742398;33231.169220769676;25684.45046513202;31593.36813263676;32025.839870800497;32549.837250813594;32884.83557582197;32788;32862.671373285964;33017;33020;38551.42172867465;29023.854880725463;29920.700792992662;31251;31289;31348.529772053895;23902.88048559746;24446.877765611058;24542;24890.751092488845;25193.370165746004 03:52:04 INFO - 2015-11-25 03:52:04,661 DEBUG : BROWSER_OUTPUT: |2;jquery.html;338.6105978125157;340.27181830881915;341.8017549821104;342.04398705617797;342.46917278218757;11931.403429828517;12308.569200077998;15095.849041509582;15104.395824167033;15811.209439528006;11905.226160299575;14492.565223043299;14534.927325363386;14791.852081479208;14876;4787.976060119703;4792.544708252711;4874.46380898101;4930.235813448921;4969.676970996892;3242.302904875463;3338.031970728498;4955.08330958772;4998.075356059141;5066.138756411419;5102.642815002932;5175.094358487268;5180.352455943007;5195.506426889439;5213.661112027725;5027.798888044474;5149.330587023682;5161.896762064775;5162.612804039693;5163.922541161885;4981.153203955337;4998.275250088753;5000.2499625056535;5001.124803159432;5001.924971125436;11436.771264574661;15260.923695381563;18066.4580062597;18703.158357873792;18707.251709931723;1810.809864964173;1814.0566905209348;1820.599468117012;1853.379117995473;1935.283944940367;8860.424072435335;8866.290696744245;8953.104689530996;9053.637854485878;9134.269258459308;1720.8967461952323;1750.0549703160277;1759.3930094117509;1807.13257636334;1809.6833054215592;55538.44461555414;57005.71497142488;58135.70932145397;58642.706786466224;59182.11226831601;8946.821063578822;9177.449353038706;9456.8581471278;9495.287853411022;9576.95211523952;12229.816552751716;12300.81548776769;12306.07704422172;12308.138430309793;12335.50657973689;6925.480588955848;6932.61870597122;6954.09596752429;6981.371676549135;6988.19635741886;6689;6689.732410703517;6726.495512836557;6752.020956961213;6771.322867713189;3829.5404551454003;3877.108265099043;3899.922001559953;4027.838886444509;4099.528554216244;1538.1924489643027;1596.2976290432173;1596.944106956251;1679.5465224389347;1720.329071662053;787.6494959742975;829.8796674482167;831.1646794971016;856.1438561438562;905.316486053039;13958.930205349112;14607.269636518344;15051.397944082333;15299.617509562127;15624.140672262907;804.4650307545417;833.9374546909006;840.2311884625622;867.1285358214953;902.7652810269377;8401.621927013177;8577.656893724306;8700.956495217484;8711.085336039625;8802;334917;341996;496065;499985;500558;72625.63687181531;73385.6330718343;73562.63218683872;74253;74313.62843185749;1034.7878684869584;1054.5623566219933;1059.761553650438;1061.6655753437797;1062.3625824505234;13095.148815326973;13421.66445838862;13799.310034498436;14006.719865602834;14104;28315.71684283213;31227.84386078055;32654.51018234681;32776.34447311088;33160.834195828866;39580.208395832495;39731.205375892896;39788.80105599569;41644.16711665689;41773;8497.532635705096;8633.05036445978;8847.73456796297;8863.157999989991;8888.955555222183;15469.458568950033;15501.922490387477;15801.20993950321;15922.442714504938;15925.920370398075;13115.803262950873;13220.867791321964;13453.730925381242;13637.795433068313;13674.863251367358;12926.935365323114;13218.140820846615;13300.002499812746;13470.528531501743;13538.458461661423;10431.739206519898;11570.132240081859;13257.204567725967;13380;13578.777909988148;8446;8463.703770368254;8705.216530512283;8883.511406872683;8898.599563019809;13499.86500134986;13567.38946747379;13750.793738093736;13871.722565548835;13887.444502220202 03:52:04 INFO - 2015-11-25 03:52:04,664 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1412.4491448335145;1580.826109127996;1630.1604673593101;1637.05869125253;1661.2026227410836;5684.772609095637;6060.212172417585;6842.82892927677;7051.294870512959;7073.540219885704;6905.516613837033;6916.377526022669;6985.057017302663;6998.055262539556;6999.160100787913;1700.6598680263935;1732.9220185091638;2038.4699978005715;2076.730025096743;2079.2826474866147;2085.270155445597;2131.126238242321;2131.968020479694;2134.1676746069047;2134.3596920923737;2050.323393280214;2053.897305134745;2069.668852983523;2084.4893001214723;2084.874907505547;1713.4174380710617;1747.9213435395438;2009.2666176845346;2022.5348169920926;2033.857629965903;2068.9482762930897;2076.646970015101;2078.1791192479036;2078.7505499340177;2079.5944790765657;6695.631740254284;6864;6908;6917.688704008281;6920.273371296042;4113.609207125318;4121.5878412158845;4177.10192308652;4187.350960601112;4210.810513526899;2601.297649634588;2665.4136090060156;2666.6933302670054;2671.973280267192;2672.27848480911;847.4364547575855;851.4508142248216;856.3235044314983;875.1030194051085;892.6830975003845;9296.581653825595;9313.767155821091;9318.627254909796;9336.066393360677;9346.252299816066;3818.770873747584;3827.2919509890758;3859.517560304962;3877.5734669186368;3962.881113566598;8047.557384343917;8068.112507624157;8075.111737708848;8087.069986951576;8089.069756978023;4242.978785106116;4260.723053001607;4263.997960479347;4268.338407546835;4274;3842.212346468967;3865.2269546090893;3866.4007078902814;3869.980650096788;3875.8643447479203;3350.4136776064092;3397.4224381855142;3400.4219282721997;3417.060308415206;3428.245785927092;1081.983770243447;1087.1791797193068;1092.3609688332415;1100.1418893263267;1101.553870682375;815.6778072661266;825.2861274997084;826.7189155687096;828.9253967142986;944.3436811416;6456.451201647818;6490;6498.992656138306;6506.41442270198;6514.706838192293;416.17804835449743;443.5187821213954;443.64286749166587;445.02317413277547;459.27434653247786;4193.97903010483;5164.845054648366;5319.468053194727;5331.040412725669;5359.785608575613;7983.481073730189;8139.186081391932;8206.630701618442;8345.791355216168;8378.41351105429;8190.180981901762;8197.221263979913;8203.548804815793;8213.301869341054;8231.506109633441;6375.936240637627;6389.9361006389345;6410.711517981702;6429.517786166056;6457.644829534421;6389.9041514376395;6445.871082578416;6454.354564543508;6454.548181627241;6482.837929051811;6960.582365058112;7489.363404110493;7539.9246007541415;7544;7614.581198034161;7404.259574042552;7497.662605182671;7614.086309642878;7812.062552493737;7953.244441778022;6530.608163510205;6593.934060659332;6597.1423714916755;6609.041688955171;6612.305707900794;6523.18460192476;6600.9009864851105;6620.2386725527185;6661.733530658719;6672.499562532927;6215;6305.527085468517;6355.491560675227;6394.71223794921;6401.935980640134;6200.193974783249;6202.81391558254;6233.968830156002;6244.063390491463;6300.7479700811455;5912.73392697321;6166.784162554289;6194.0708893666315;6230.283517395557;6237.656928868956;5856.150858125633;5889;5905.852353691193;5910.615809972338;5913.083472061838;5699.430056994267;5732.541396688338;5768.596198266081;5787.392323806108;5792.536597072309 03:52:04 INFO - 2015-11-25 03:52:04,666 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.8627803766343;316.77667244592567;318.69405370843987;320.9662985386533;321.3155977767355;5077.593792496601;5222.9216561751555;5254.7635356408955;5272.340957380327;5342.385625653056;5046.949530504694;5187.221916712486;5187.351581052369;5191.480851914816;5209.843704688856;4128.566500517448;4130.566290539495;4134.13183231521;4148.8340466381305;4149.273877071516;3890.1247219375555;3982.8406863725418;4016.0562267867026;4115.1975364803875;4117.341225403936;4093.5497095319492;4118.917621647565;4124.938125928114;4130.834766609332;4139.130782535671;4106.7125301228925;4108.4864391951005;4109.2808758467145;4113.25961326961;4116.773577453238;3651.7443778935485;3656.323580137683;3657.122290650251;3670.137517683342;3677.4667673187505;4989.226669866177;5042.092423363793;5046.545810877039;5060.266261392115;5091.66904151229;4728.361671174382;4731.455882573479;4739.0758802033615;4744.667873248874;4746.145693775119;5496.945030549683;5503.587230957694;5505.3393592768725;5507.889842203133;5524.171374293848;3694.3165514379925;3802.752821066622;3842.1931394407206;3979.462772525701;3983.940240896389;5815.127730840365;5843.912341314884;5849.356570777169;5862.14998825168;5862.296524417055;4086.1419101988913;4103.199876024147;4106.260873042881;4107.014316564003;4108.712390132662;4170.624643782075;4170.979145104255;4174.269502837052;4175.144095460484;4182.2890108681595;4499.730016199039;4637.536246375403;4644.651651126112;4706.694064885772;4710.105080034851;5515.420880807537;5523.502884740393;5524.447555244444;5524.8342549723575;5533.446655334515;1411.3225651687042;1431.2271373458425;1431.355889849572;1433.5592729307189;1434.9354279057468;964.7154089543601;969.5927710361665;975.9658411955547;987.3088837813559;994.3586386780486;4821.132196204717;4827.179379505493;4848.757562121879;4852.393450818648;4887.560119589254;5673.943260567424;5679.148127780866;5687.573431992617;5702.48677619008;5707.0583353747;4851.248056551241;4865.464798872121;4870.318155458239;4876.804927802919;4882.365292512021;2743.43759529296;2898.130560831742;3032.7725420593542;3070.8311042892856;3072.2472994116583;5394.73026348681;5402.18967154922;5403.432639572867;5479.986202552541;5540.141278101901;5895.675737834375;5896.086106653475;5901;5904.940950590525;5908.084246941731;5511.641743286754;5518.475744804237;5522.337319521603;5527.2538207342295;5528.668279903219;5720.256366672306;5720.399358067343;5723.112917497794;5739.540836733135;5742.971285143548;5431.728413579384;5469.234307197075;5504.091824848855;5543.445655434424;5638.295213098363;5361.758720857492;5416.21464887597;5449.3188351456065;5449.6730196188355;5544.140658197985;4084.4894388201474;4110.116324990141;4116.320807066801;4116.9794151029055;4120.505539335299;5678.346990096192;5680.062789639664;5686.374498805046;5690.829275121753;5693.345265294544;5356.946430535801;5500.1749737539685;5501.972490137524;5505.284313039279;5506.256655351476;5477.835664930059;5495.120780675073;5504.697241651747;5510.228568000403;5519.337679478488;5388.946110538845;5391.622586418913;5400.83797486076;5404.675719456845;5407.972485227794;5398.811041613525;5421.349438067457;5503.614746967673;5523.834284971457;5525.806596769094;5370.946290537045;5374.731263436891;5387.515123638735;5390.460953904578;5397.622166448311 03:52:04 INFO - 2015-11-25 03:52:04,667 DEBUG : BROWSER_OUTPUT: |5;yui.html;731.1956847467783;735.1031741275646;737.8192342875994;741.8108382362503;748.4731148457149;11629.418529073544;11763.294202347844;11816;11817.586384476544;11829.7634047319;11160.66518004459;11172.832407513893;11194.38430886301;12792.119397074466;13111.6722081948;766.3907193780957;777.9805504862395;778.1401551285833;778.3267473635293;779.7465823607322;610.5207412181438;616.8797084568511;769.334525635327;784.3764207455058;785.2893131715778;807.2936180841764;808.9514629122242;809.5304723260524;814.5764202614637;814.9918500814975;624.687656171914;632.8417895526119;789.5144486141039;797.3182928596054;797.7088362747613;588.5526999480383;593.522214617233;594.5808205215313;594.7085927895344;595.1875689683551;11730.12024098196;11935.82096268548;11952.103592230531;11960.760784784343;11963;10486.370817750883;10579.31234469757;10719.196060295431;10992.505337259843;11542.596009139725;9462.29032822541;9679.467629280387;9786.168175705074;9858.211343092535;10045.648402305884;3151.5115157150676;3246.2371342734436;3265.967340326614;3300.5709257796334;3311.718503927169;42594.148117037796;42942.78528607337;43273;43274.78362608167;43574;8279.089300176976;8362.832743345221;8392.244697977088;8441.016361155123;8905.927161385001;15967.121808300422;15991.28039238237;16044;16088;16092.275847586887;6040.456358927718;6117.694115294217;6202.782902598387;6348.555601107878;6360.872782544323;3612.6026137124895;3643.2349206666895;3687.815609219582;3702.389105797567;3730.626937306248;2629.8948042078105;2657.694365148033;2669.479451506976;2669.639598654157;2670.626112344273;449.40229494771876;457.1268876445972;460.36009946174846;476.8307250925941;478.273025001995;422.57320106692464;429.7249760153504;432.66684652817156;468.8054457400141;492.36976669862634;6910.723571057101;7443.516171448839;7443.813904652318;7570.318671319607;7669.9616501917135;396.5657604922663;498.2451585847444;507.16824407970955;537.0815904802831;547.9232907392968;3485.6165821759587;3638.308721342936;3672.761270517461;3686.7050635949595;3743.9251214976093;52888.471115289125;52992;53369.1994620081;53573.73213133909;53578.464215357344;45555.405560805215;46189.30716039262;46224.7688761554;46259.53740462619;46341.30488042682;42098;42306.57693423027;42557.148857023305;42832.78583607062;43047.35428968568;6898.509157180811;6909.412699920563;6913.170419549686;6981.5112942093565;7082.4688148390105;31368.843155784987;31547.36905261836;31554.684453155176;32381;32481.675183247866;37890;38453.80773096228;38490.23019539537;38583.2283354337;39612.80193599014;9485.857712134186;9679.225661946886;9730.309835642063;9739;9759.072888075621;10507.842382364424;10662.573497060032;10733.677989660322;10775.676729698122;10941.945290273497;9961.252906031932;9965.900340996788;9973.351732137678;9976.2517811163;10409.9479502602;10027.398356098658;10313.587456501657;10529.262951593315;10570.41862697559;10686.145108391154;10290.485475726333;10295.07344339013;10339.948300258451;10349.379037257788;10354.637587684394;8662.480251184948;9127.817443651222;9141.63433462654;9176.26589872822;9427.575759090994;8345.624446899783;8527.74416767498;8741.650333986823;8914.687985920462;9074.183323500916 03:52:04 INFO - 2015-11-25 03:52:04,667 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:52:04 INFO - 2015-11-25 03:52:04,667 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:52:04 INFO - 2015-11-25 03:52:04,667 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,877 03:52:04 INFO - 2015-11-25 03:52:04,667 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:52:04 INFO - 2015-11-25 03:52:04,667 DEBUG : BROWSER_OUTPUT: __startTimestamp1448452324654__endTimestamp 03:52:04 INFO - 2015-11-25 03:52:04,667 DEBUG : BROWSER_OUTPUT: 03:52:04 INFO - 2015-11-25 03:52:04,667 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4510.87 Median:4623.21 stddev:456.58 (9.9%) stddev-sans-first:432.50 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: Values: 2593.7 2710.6 2719.7 2725.1 2739.6 4385.9 4497.1 4575.0 4591.7 4621.0 4498.5 4504.5 4562.0 4569.1 4615.3 4192.8 4213.8 4225.2 4231.5 4255.3 4041.2 4305.8 4327.9 4342.6 4351.5 4166.8 4167.3 4219.4 4236.1 4270.9 4187.4 4228.2 4270.3 4275.5 4310.7 4007.7 4110.2 4228.4 4249.6 4276.6 4406.3 4433.6 4494.6 4527.8 4537.6 4901.9 4924.7 4925.7 4926.1 4966.1 4728.8 4945.9 4953.2 4964.4 5005.8 4513.4 4519.9 4566.1 4628.8 4682.9 5067.5 5075.1 5080.5 5081.3 5085.1 4623.2 4828.1 4853.4 4860.9 4883.9 4750.8 4789.6 4802.5 4816.4 4827.0 4834.5 4836.4 4840.7 4844.2 4882.4 4820.7 4827.8 4828.2 4843.9 4869.8 3955.1 4032.4 4048.1 4053.6 4088.3 3541.8 3550.2 3551.3 3577.7 3578.9 4280.4 4282.7 4285.7 4288.4 4329.4 4625.3 4691.9 4737.6 4740.6 4944.6 4137.8 4150.3 4206.2 4287.6 4304.9 4363.5 4417.1 4419.5 4419.9 4455.5 4416.4 4541.0 4541.7 4696.4 4791.8 4801.7 4858.4 4875.4 4879.2 4909.6 4732.3 4735.2 4735.5 4738.5 4742.5 4597.5 4697.0 4697.2 4878.4 4928.0 4821.5 4867.9 4893.9 4894.2 4933.9 4687.0 4748.4 4748.9 4755.4 4778.0 4499.8 4594.2 4631.5 4748.0 4788.2 4572.5 4619.1 4633.7 4664.2 4679.9 4838.3 4841.9 4845.8 4847.7 4851.3 4549.1 4660.5 4665.3 4712.2 4772.1 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43690.01 Median:186248.04 stddev:74050.26 (39.8%) stddev-sans-first:74187.21 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: Values: 569.0 574.7 576.9 578.1 595.0 26412.6 26833.2 26904.2 26915.7 36065.3 39812.2 40409.0 40409.8 40460.2 40539.2 7936.7 8111.2 8113.6 8115.0 8116.6 7103.2 7251.6 7265.9 7275.2 7857.2 7084.2 7171.9 10125.4 10369.7 10387.2 10033.0 10111.1 10124.3 10127.7 10131.8 7085.8 7281.2 9684.2 9778.9 9803.9 40578.4 41511.8 41549.6 41579.8 41736.6 2778.2 2792.3 2916.4 3275.7 3286.4 27593.3 27661.4 27828.3 27853.3 28380.4 3415.1 3437.5 3454.3 3495.4 3544.8 227819.0 229431.9 230501.0 230984.0 231965.0 56290.7 56332.4 56376.0 56465.0 56738.0 59984.7 60423.4 60447.7 60469.0 60488.4 13462.3 13925.4 13926.2 13933.1 13939.5 9803.7 9815.5 9817.5 9820.3 9825.5 18911.7 19218.7 19346.6 19419.8 19463.3 7468.0 7713.2 7747.6 7824.0 7851.0 888.2 892.8 911.3 945.5 990.1 27094.3 27432.6 30111.5 31032.5 31763.4 851.1 860.1 869.6 937.6 964.6 13366.9 15678.8 16342.2 16437.3 16480.1 339264.9 344084.0 344531.0 344853.0 344983.1 48487.3 48889.8 49025.5 49505.5 49550.0 1213.3 1225.6 1242.0 1242.3 1243.8 27832.4 28575.3 28768.0 28771.9 28850.4 40579.6 41027.4 41327.0 41329.8 41366.6 259766.0 261178.0 261697.0 261816.0 263325.0 24737.0 25216.1 28747.9 28793.6 29308.6 34047.7 34596.7 34628.1 34700.5 34994.8 31177.0 32328.8 32788.3 32997.5 33231.2 25684.5 31593.4 32025.8 32549.8 32884.8 32788.0 32862.7 33017.0 33020.0 38551.4 29023.9 29920.7 31251.0 31289.0 31348.5 23902.9 24446.9 24542.0 24890.8 25193.4 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24640.96 Median:3888.52 stddev:72372.97 (1861.2%) stddev-sans-first:72552.99 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: Values: 338.6 340.3 341.8 342.0 342.5 11931.4 12308.6 15095.8 15104.4 15811.2 11905.2 14492.6 14534.9 14791.9 14876.0 4788.0 4792.5 4874.5 4930.2 4969.7 3242.3 3338.0 4955.1 4998.1 5066.1 5102.6 5175.1 5180.4 5195.5 5213.7 5027.8 5149.3 5161.9 5162.6 5163.9 4981.2 4998.3 5000.2 5001.1 5001.9 11436.8 15260.9 18066.5 18703.2 18707.3 1810.8 1814.1 1820.6 1853.4 1935.3 8860.4 8866.3 8953.1 9053.6 9134.3 1720.9 1750.1 1759.4 1807.1 1809.7 55538.4 57005.7 58135.7 58642.7 59182.1 8946.8 9177.4 9456.9 9495.3 9577.0 12229.8 12300.8 12306.1 12308.1 12335.5 6925.5 6932.6 6954.1 6981.4 6988.2 6689.0 6689.7 6726.5 6752.0 6771.3 3829.5 3877.1 3899.9 4027.8 4099.5 1538.2 1596.3 1596.9 1679.5 1720.3 787.6 829.9 831.2 856.1 905.3 13958.9 14607.3 15051.4 15299.6 15624.1 804.5 833.9 840.2 867.1 902.8 8401.6 8577.7 8701.0 8711.1 8802.0 334917.0 341996.0 496065.0 499985.0 500558.0 72625.6 73385.6 73562.6 74253.0 74313.6 1034.8 1054.6 1059.8 1061.7 1062.4 13095.1 13421.7 13799.3 14006.7 14104.0 28315.7 31227.8 32654.5 32776.3 33160.8 39580.2 39731.2 39788.8 41644.2 41773.0 8497.5 8633.1 8847.7 8863.2 8889.0 15469.5 15501.9 15801.2 15922.4 15925.9 13115.8 13220.9 13453.7 13637.8 13674.9 12926.9 13218.1 13300.0 13470.5 13538.5 10431.7 11570.1 13257.2 13380.0 13578.8 8446.0 8463.7 8705.2 8883.5 8898.6 13499.9 13567.4 13750.8 13871.7 13887.4 03:52:04 INFO - 2015-11-25 03:52:04,668 DEBUG : BROWSER_OUTPUT: 03:52:04 INFO - 2015-11-25 03:52:04,669 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4844.61 Median:6201.50 stddev:2518.48 (40.6%) stddev-sans-first:2512.33 03:52:04 INFO - 2015-11-25 03:52:04,670 DEBUG : BROWSER_OUTPUT: Values: 1412.4 1580.8 1630.2 1637.1 1661.2 5684.8 6060.2 6842.8 7051.3 7073.5 6905.5 6916.4 6985.1 6998.1 6999.2 1700.7 1732.9 2038.5 2076.7 2079.3 2085.3 2131.1 2132.0 2134.2 2134.4 2050.3 2053.9 2069.7 2084.5 2084.9 1713.4 1747.9 2009.3 2022.5 2033.9 2068.9 2076.6 2078.2 2078.8 2079.6 6695.6 6864.0 6908.0 6917.7 6920.3 4113.6 4121.6 4177.1 4187.4 4210.8 2601.3 2665.4 2666.7 2672.0 2672.3 847.4 851.5 856.3 875.1 892.7 9296.6 9313.8 9318.6 9336.1 9346.3 3818.8 3827.3 3859.5 3877.6 3962.9 8047.6 8068.1 8075.1 8087.1 8089.1 4243.0 4260.7 4264.0 4268.3 4274.0 3842.2 3865.2 3866.4 3870.0 3875.9 3350.4 3397.4 3400.4 3417.1 3428.2 1082.0 1087.2 1092.4 1100.1 1101.6 815.7 825.3 826.7 828.9 944.3 6456.5 6490.0 6499.0 6506.4 6514.7 416.2 443.5 443.6 445.0 459.3 4194.0 5164.8 5319.5 5331.0 5359.8 7983.5 8139.2 8206.6 8345.8 8378.4 8190.2 8197.2 8203.5 8213.3 8231.5 6375.9 6389.9 6410.7 6429.5 6457.6 6389.9 6445.9 6454.4 6454.5 6482.8 6960.6 7489.4 7539.9 7544.0 7614.6 7404.3 7497.7 7614.1 7812.1 7953.2 6530.6 6593.9 6597.1 6609.0 6612.3 6523.2 6600.9 6620.2 6661.7 6672.5 6215.0 6305.5 6355.5 6394.7 6401.9 6200.2 6202.8 6234.0 6244.1 6300.7 5912.7 6166.8 6194.1 6230.3 6237.7 5856.2 5889.0 5905.9 5910.6 5913.1 5699.4 5732.5 5768.6 5787.4 5792.5 03:52:04 INFO - 2015-11-25 03:52:04,670 DEBUG : BROWSER_OUTPUT: 03:52:04 INFO - 2015-11-25 03:52:04,670 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4599.37 Median:5216.38 stddev:1334.16 (25.6%) stddev-sans-first:1298.51 03:52:04 INFO - 2015-11-25 03:52:04,670 DEBUG : BROWSER_OUTPUT: Values: 311.9 316.8 318.7 321.0 321.3 5077.6 5222.9 5254.8 5272.3 5342.4 5046.9 5187.2 5187.4 5191.5 5209.8 4128.6 4130.6 4134.1 4148.8 4149.3 3890.1 3982.8 4016.1 4115.2 4117.3 4093.5 4118.9 4124.9 4130.8 4139.1 4106.7 4108.5 4109.3 4113.3 4116.8 3651.7 3656.3 3657.1 3670.1 3677.5 4989.2 5042.1 5046.5 5060.3 5091.7 4728.4 4731.5 4739.1 4744.7 4746.1 5496.9 5503.6 5505.3 5507.9 5524.2 3694.3 3802.8 3842.2 3979.5 3983.9 5815.1 5843.9 5849.4 5862.1 5862.3 4086.1 4103.2 4106.3 4107.0 4108.7 4170.6 4171.0 4174.3 4175.1 4182.3 4499.7 4637.5 4644.7 4706.7 4710.1 5515.4 5523.5 5524.4 5524.8 5533.4 1411.3 1431.2 1431.4 1433.6 1434.9 964.7 969.6 976.0 987.3 994.4 4821.1 4827.2 4848.8 4852.4 4887.6 5673.9 5679.1 5687.6 5702.5 5707.1 4851.2 4865.5 4870.3 4876.8 4882.4 2743.4 2898.1 3032.8 3070.8 3072.2 5394.7 5402.2 5403.4 5480.0 5540.1 5895.7 5896.1 5901.0 5904.9 5908.1 5511.6 5518.5 5522.3 5527.3 5528.7 5720.3 5720.4 5723.1 5739.5 5743.0 5431.7 5469.2 5504.1 5543.4 5638.3 5361.8 5416.2 5449.3 5449.7 5544.1 4084.5 4110.1 4116.3 4117.0 4120.5 5678.3 5680.1 5686.4 5690.8 5693.3 5356.9 5500.2 5502.0 5505.3 5506.3 5477.8 5495.1 5504.7 5510.2 5519.3 5388.9 5391.6 5400.8 5404.7 5408.0 5398.8 5421.3 5503.6 5523.8 5525.8 5370.9 5374.7 5387.5 5390.5 5397.6 03:52:04 INFO - 2015-11-25 03:52:04,670 DEBUG : BROWSER_OUTPUT: 03:52:04 INFO - 2015-11-25 03:52:04,670 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12358.39 Median:46207.04 stddev:14460.60 (31.3%) stddev-sans-first:14474.80 03:52:04 INFO - 2015-11-25 03:52:04,671 DEBUG : BROWSER_OUTPUT: Values: 731.2 735.1 737.8 741.8 748.5 11629.4 11763.3 11816.0 11817.6 11829.8 11160.7 11172.8 11194.4 12792.1 13111.7 766.4 778.0 778.1 778.3 779.7 610.5 616.9 769.3 784.4 785.3 807.3 809.0 809.5 814.6 815.0 624.7 632.8 789.5 797.3 797.7 588.6 593.5 594.6 594.7 595.2 11730.1 11935.8 11952.1 11960.8 11963.0 10486.4 10579.3 10719.2 10992.5 11542.6 9462.3 9679.5 9786.2 9858.2 10045.6 3151.5 3246.2 3266.0 3300.6 3311.7 42594.1 42942.8 43273.0 43274.8 43574.0 8279.1 8362.8 8392.2 8441.0 8905.9 15967.1 15991.3 16044.0 16088.0 16092.3 6040.5 6117.7 6202.8 6348.6 6360.9 3612.6 3643.2 3687.8 3702.4 3730.6 2629.9 2657.7 2669.5 2669.6 2670.6 449.4 457.1 460.4 476.8 478.3 422.6 429.7 432.7 468.8 492.4 6910.7 7443.5 7443.8 7570.3 7670.0 396.6 498.2 507.2 537.1 547.9 3485.6 3638.3 3672.8 3686.7 3743.9 52888.5 52992.0 53369.2 53573.7 53578.5 45555.4 46189.3 46224.8 46259.5 46341.3 42098.0 42306.6 42557.1 42832.8 43047.4 6898.5 6909.4 6913.2 6981.5 7082.5 31368.8 31547.4 31554.7 32381.0 32481.7 37890.0 38453.8 38490.2 38583.2 39612.8 9485.9 9679.2 9730.3 9739.0 9759.1 10507.8 10662.6 10733.7 10775.7 10941.9 9961.3 9965.9 9973.4 9976.3 10409.9 10027.4 10313.6 10529.3 10570.4 10686.1 10290.5 10295.1 10339.9 10349.4 10354.6 8662.5 9127.8 9141.6 9176.3 9427.6 8345.6 8527.7 8741.7 8914.7 9074.2 03:52:04 INFO - 2015-11-25 03:52:04,672 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:52:04 INFO - 2015-11-25 03:52:04,672 DEBUG : BROWSER_OUTPUT: 03:52:05 INFO - 2015-11-25 03:52:05,458 INFO : Browser exited with error code: 0 03:52:05 INFO - 2015-11-25 03:52:05,476 INFO : Completed test dromaeo_css (00:18:36) 03:52:05 INFO - 2015-11-25 03:52:05,476 INFO : Starting test kraken 03:52:05 INFO - 2015-11-25 03:52:05,476 DEBUG : operating with platform_type : linux_ 03:52:05 INFO - 2015-11-25 03:52:05,476 INFO : Initialising browser for kraken test... 03:52:05 INFO - 2015-11-25 03:52:05,483 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHATOAg/profile http://localhost:57288/getInfo.html 03:52:09 INFO - 2015-11-25 03:52:09,287 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:52:09 INFO - 2015-11-25 03:52:09,288 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:52:09 INFO - 2015-11-25 03:52:09,288 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:52:09 INFO - 2015-11-25 03:52:09,288 DEBUG : BROWSER_OUTPUT: __metrics 03:52:09 INFO - 2015-11-25 03:52:09,409 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:52:10 INFO - 2015-11-25 03:52:10,651 INFO : Browser initialized. 03:52:10 INFO - 2015-11-25 03:52:10,652 INFO : Running cycle 1/1 for kraken test... 03:52:10 INFO - 2015-11-25 03:52:10,652 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHATOAg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:52:22 INFO - 2015-11-25 03:52:22,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 139395072 03:52:22 INFO - 2015-11-25 03:52:22,468 DEBUG : BROWSER_OUTPUT: 03:52:25 INFO - 2015-11-25 03:52:25,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57288/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:25 INFO - 2015-11-25 03:52:25,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 176463872 03:52:25 INFO - 2015-11-25 03:52:25,658 DEBUG : BROWSER_OUTPUT: 03:52:28 INFO - 2015-11-25 03:52:28,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57288/tests/kraken/driver.html?testName=audio-dft) 03:52:28 INFO - 2015-11-25 03:52:28,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 166191104 03:52:28 INFO - 2015-11-25 03:52:28,989 DEBUG : BROWSER_OUTPUT: 03:52:31 INFO - 2015-11-25 03:52:31,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57288/tests/kraken/driver.html?testName=audio-fft) 03:52:32 INFO - 2015-11-25 03:52:32,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 150966272 03:52:32 INFO - 2015-11-25 03:52:32,558 DEBUG : BROWSER_OUTPUT: 03:52:34 INFO - 2015-11-25 03:52:34,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57288/tests/kraken/driver.html?testName=audio-oscillator) 03:52:35 INFO - 2015-11-25 03:52:35,156 DEBUG : BROWSER_OUTPUT: RSS: Main: 152104960 03:52:35 INFO - 2015-11-25 03:52:35,156 DEBUG : BROWSER_OUTPUT: 03:52:37 INFO - 2015-11-25 03:52:37,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:37 INFO - 2015-11-25 03:52:37,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 155336704 03:52:37 INFO - 2015-11-25 03:52:37,973 DEBUG : BROWSER_OUTPUT: 03:52:40 INFO - 2015-11-25 03:52:40,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57288/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:41 INFO - 2015-11-25 03:52:41,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 154005504 03:52:41 INFO - 2015-11-25 03:52:41,531 DEBUG : BROWSER_OUTPUT: 03:52:44 INFO - 2015-11-25 03:52:44,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57288/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:45 INFO - 2015-11-25 03:52:45,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 155799552 03:52:45 INFO - 2015-11-25 03:52:45,515 DEBUG : BROWSER_OUTPUT: 03:52:48 INFO - 2015-11-25 03:52:48,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57288/tests/kraken/driver.html?testName=json-parse-financial) 03:52:48 INFO - 2015-11-25 03:52:48,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 156299264 03:52:48 INFO - 2015-11-25 03:52:48,928 DEBUG : BROWSER_OUTPUT: 03:52:50 INFO - 2015-11-25 03:52:50,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:51 INFO - 2015-11-25 03:52:51,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 164659200 03:52:51 INFO - 2015-11-25 03:52:51,284 DEBUG : BROWSER_OUTPUT: 03:52:53 INFO - 2015-11-25 03:52:53,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:53 INFO - 2015-11-25 03:52:53,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 166002688 03:52:53 INFO - 2015-11-25 03:52:53,749 DEBUG : BROWSER_OUTPUT: 03:52:55 INFO - 2015-11-25 03:52:55,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:56 INFO - 2015-11-25 03:52:56,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 172367872 03:52:56 INFO - 2015-11-25 03:52:56,467 DEBUG : BROWSER_OUTPUT: 03:52:59 INFO - 2015-11-25 03:52:59,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:59 INFO - 2015-11-25 03:52:59,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 181014528 03:52:59 INFO - 2015-11-25 03:52:59,589 DEBUG : BROWSER_OUTPUT: 03:53:02 INFO - 2015-11-25 03:53:02,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:02 INFO - 2015-11-25 03:53:02,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 178311168 03:53:02 INFO - 2015-11-25 03:53:02,799 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57288/tests/kraken/driver.html?testName=ai-astar) 03:53:04 INFO - 2015-11-25 03:53:04,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 238215168 03:53:04 INFO - 2015-11-25 03:53:04,794 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,794 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:53:04 INFO - 2015-11-25 03:53:04,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:53:04 INFO - 2015-11-25 03:53:04,794 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:53:04 INFO - 2015-11-25 03:53:04,794 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:53:04 INFO - 2015-11-25 03:53:04,794 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;105;113;114;112;101;113;111;103 03:53:04 INFO - 2015-11-25 03:53:04,795 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;131;153;175;131;161;158;149;183;131 03:53:04 INFO - 2015-11-25 03:53:04,795 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;162;161;160;161;160;160;162;162 03:53:04 INFO - 2015-11-25 03:53:04,795 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;85;91;74;72;72;98;91;71 03:53:04 INFO - 2015-11-25 03:53:04,795 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;129;95;96;95;129;95;94;132 03:53:04 INFO - 2015-11-25 03:53:04,795 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;111;110;110;109;109 03:53:04 INFO - 2015-11-25 03:53:04,796 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;146;146;146;146;146;147 03:53:04 INFO - 2015-11-25 03:53:04,796 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;95;96;96;95;96;95 03:53:04 INFO - 2015-11-25 03:53:04,796 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;74;73;74;73;74;74;82;70;70 03:53:04 INFO - 2015-11-25 03:53:04,796 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;70;69;69;70;71 03:53:04 INFO - 2015-11-25 03:53:04,796 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;85;83;85;83;83;92;86;85;86 03:53:04 INFO - 2015-11-25 03:53:04,797 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;131;122;135;127;121;120;123;123;129 03:53:04 INFO - 2015-11-25 03:53:04,797 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;138;148;160;150;139;150;149;148;140 03:53:04 INFO - 2015-11-25 03:53:04,797 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;73;71;68;71;71;69;68;68;69 03:53:04 INFO - 2015-11-25 03:53:04,797 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:53:04 INFO - 2015-11-25 03:53:04,797 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:53:04 INFO - 2015-11-25 03:53:04,798 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,986 03:53:04 INFO - 2015-11-25 03:53:04,798 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:53:04 INFO - 2015-11-25 03:53:04,798 DEBUG : BROWSER_OUTPUT: __startTimestamp1448452384789__endTimestamp 03:53:04 INFO - 2015-11-25 03:53:04,798 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,798 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:53:04 INFO - 2015-11-25 03:53:04,798 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:53:04 INFO - 2015-11-25 03:53:04,798 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,798 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.70 Median:112.50 stddev:4.79 (4.3%) stddev-sans-first:5.00 03:53:04 INFO - 2015-11-25 03:53:04,798 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 105.0 113.0 114.0 112.0 101.0 113.0 111.0 103.0 03:53:04 INFO - 2015-11-25 03:53:04,799 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,799 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:153.00 Median:158.00 stddev:18.15 (11.5%) stddev-sans-first:19.16 03:53:04 INFO - 2015-11-25 03:53:04,799 DEBUG : BROWSER_OUTPUT: Values: 158.0 131.0 153.0 175.0 131.0 161.0 158.0 149.0 183.0 131.0 03:53:04 INFO - 2015-11-25 03:53:04,799 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,799 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:0.87 03:53:04 INFO - 2015-11-25 03:53:04,799 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 162.0 161.0 160.0 161.0 160.0 160.0 162.0 162.0 03:53:04 INFO - 2015-11-25 03:53:04,799 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,799 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.90 Median:79.50 stddev:10.27 (12.9%) stddev-sans-first:10.58 03:53:04 INFO - 2015-11-25 03:53:04,800 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 85.0 91.0 74.0 72.0 72.0 98.0 91.0 71.0 03:53:04 INFO - 2015-11-25 03:53:04,800 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,800 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.30 Median:94.50 stddev:17.08 (18.1%) stddev-sans-first:17.61 03:53:04 INFO - 2015-11-25 03:53:04,800 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 129.0 95.0 96.0 95.0 129.0 95.0 94.0 132.0 03:53:04 INFO - 2015-11-25 03:53:04,800 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,800 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 03:53:04 INFO - 2015-11-25 03:53:04,801 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 111.0 110.0 110.0 109.0 109.0 03:53:04 INFO - 2015-11-25 03:53:04,801 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,801 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 03:53:04 INFO - 2015-11-25 03:53:04,801 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 03:53:04 INFO - 2015-11-25 03:53:04,801 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,801 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:53:04 INFO - 2015-11-25 03:53:04,801 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 95.0 03:53:04 INFO - 2015-11-25 03:53:04,801 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,801 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.60 Median:74.00 stddev:3.34 (4.5%) stddev-sans-first:3.49 03:53:04 INFO - 2015-11-25 03:53:04,802 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 73.0 74.0 73.0 74.0 74.0 82.0 70.0 70.0 03:53:04 INFO - 2015-11-25 03:53:04,802 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,802 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 03:53:04 INFO - 2015-11-25 03:53:04,802 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 70.0 69.0 69.0 70.0 71.0 03:53:04 INFO - 2015-11-25 03:53:04,802 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,802 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.83 (3.3%) stddev-sans-first:2.78 03:53:04 INFO - 2015-11-25 03:53:04,802 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 83.0 85.0 83.0 83.0 92.0 86.0 85.0 86.0 03:53:04 INFO - 2015-11-25 03:53:04,802 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,802 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:127.00 stddev:4.85 (3.8%) stddev-sans-first:5.12 03:53:04 INFO - 2015-11-25 03:53:04,803 DEBUG : BROWSER_OUTPUT: Values: 127.0 131.0 122.0 135.0 127.0 121.0 120.0 123.0 123.0 129.0 03:53:04 INFO - 2015-11-25 03:53:04,803 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,803 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:149.50 stddev:6.68 (4.5%) stddev-sans-first:6.95 03:53:04 INFO - 2015-11-25 03:53:04,803 DEBUG : BROWSER_OUTPUT: Values: 151.0 138.0 148.0 160.0 150.0 139.0 150.0 149.0 148.0 140.0 03:53:04 INFO - 2015-11-25 03:53:04,803 DEBUG : BROWSER_OUTPUT: 03:53:04 INFO - 2015-11-25 03:53:04,803 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.70 (2.4%) stddev-sans-first:1.79 03:53:04 INFO - 2015-11-25 03:53:04,803 DEBUG : BROWSER_OUTPUT: Values: 69.0 73.0 71.0 68.0 71.0 71.0 69.0 68.0 68.0 69.0 03:53:04 INFO - 2015-11-25 03:53:04,803 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:53:04 INFO - 2015-11-25 03:53:04,803 DEBUG : BROWSER_OUTPUT: 03:53:05 INFO - 2015-11-25 03:53:05,669 INFO : Browser exited with error code: 0 03:53:05 INFO - 2015-11-25 03:53:05,723 INFO : Completed test kraken (00:01:00) 03:53:05 INFO - 2015-11-25 03:53:05,723 INFO : Starting test v8_7 03:53:05 INFO - 2015-11-25 03:53:05,723 DEBUG : operating with platform_type : linux_ 03:53:05 INFO - 2015-11-25 03:53:05,723 INFO : Initialising browser for v8_7 test... 03:53:05 INFO - 2015-11-25 03:53:05,729 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5lyNEi/profile http://localhost:57288/getInfo.html 03:53:09 INFO - 2015-11-25 03:53:09,738 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:53:09 INFO - 2015-11-25 03:53:09,738 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:53:09 INFO - 2015-11-25 03:53:09,738 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:53:09 INFO - 2015-11-25 03:53:09,738 DEBUG : BROWSER_OUTPUT: __metrics 03:53:09 INFO - 2015-11-25 03:53:09,900 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:53:11 INFO - 2015-11-25 03:53:11,099 INFO : Browser initialized. 03:53:11 INFO - 2015-11-25 03:53:11,099 INFO : Running cycle 1/1 for v8_7 test... 03:53:11 INFO - 2015-11-25 03:53:11,100 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5lyNEi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:53:23 INFO - 2015-11-25 03:53:23,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 138809344 03:53:23 INFO - 2015-11-25 03:53:23,026 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57288/tests/v8_7/run.html (next: http://localhost:57288/tests/v8_7/run.html) 03:53:44 INFO - 2015-11-25 03:53:44,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 445566976 03:53:44 INFO - 2015-11-25 03:53:44,723 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,723 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:53:44 INFO - 2015-11-25 03:53:44,723 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:53:44 INFO - 2015-11-25 03:53:44,723 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:53:44 INFO - 2015-11-25 03:53:44,723 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: |0;Richards;165.31658125309968 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.75250578257518 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.8622420524261 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5138.461538461538 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1998.0039920159682 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: |5;Earley;809.7165991902834 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: |6;Boyer;12432.098765432098 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: |7;RegExp;26736.842105263157 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: |8;Splay;616.5228113440197 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4868.9320388349515 03:53:44 INFO - 2015-11-25 03:53:44,724 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:53:44 INFO - 2015-11-25 03:53:44,725 DEBUG : BROWSER_OUTPUT: __startTimestamp1448452424722__endTimestamp 03:53:44 INFO - 2015-11-25 03:53:44,725 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,725 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:53:44 INFO - 2015-11-25 03:53:44,725 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:53:44 INFO - 2015-11-25 03:53:44,725 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,725 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.32 Median:165.32 stddev:0.00 (0.0%) 03:53:44 INFO - 2015-11-25 03:53:44,725 DEBUG : BROWSER_OUTPUT: Values: 165.3 03:53:44 INFO - 2015-11-25 03:53:44,726 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,726 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.75 Median:192.75 stddev:0.00 (0.0%) 03:53:44 INFO - 2015-11-25 03:53:44,726 DEBUG : BROWSER_OUTPUT: Values: 192.8 03:53:44 INFO - 2015-11-25 03:53:44,726 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,726 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 03:53:44 INFO - 2015-11-25 03:53:44,726 DEBUG : BROWSER_OUTPUT: Values: 278.9 03:53:44 INFO - 2015-11-25 03:53:44,727 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,727 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 03:53:44 INFO - 2015-11-25 03:53:44,727 DEBUG : BROWSER_OUTPUT: Values: 5138.5 03:53:44 INFO - 2015-11-25 03:53:44,727 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,727 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 03:53:44 INFO - 2015-11-25 03:53:44,727 DEBUG : BROWSER_OUTPUT: Values: 1998.0 03:53:44 INFO - 2015-11-25 03:53:44,728 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,729 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:809.72 Median:809.72 stddev:0.00 (0.0%) 03:53:44 INFO - 2015-11-25 03:53:44,729 DEBUG : BROWSER_OUTPUT: Values: 809.7 03:53:44 INFO - 2015-11-25 03:53:44,729 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,729 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12432.10 Median:12432.10 stddev:0.00 (0.0%) 03:53:44 INFO - 2015-11-25 03:53:44,729 DEBUG : BROWSER_OUTPUT: Values: 12432.1 03:53:44 INFO - 2015-11-25 03:53:44,729 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,730 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26736.84 Median:26736.84 stddev:0.00 (0.0%) 03:53:44 INFO - 2015-11-25 03:53:44,730 DEBUG : BROWSER_OUTPUT: Values: 26736.8 03:53:44 INFO - 2015-11-25 03:53:44,730 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,730 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.52 Median:616.52 stddev:0.00 (0.0%) 03:53:44 INFO - 2015-11-25 03:53:44,730 DEBUG : BROWSER_OUTPUT: Values: 616.5 03:53:44 INFO - 2015-11-25 03:53:44,730 DEBUG : BROWSER_OUTPUT: 03:53:44 INFO - 2015-11-25 03:53:44,730 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 03:53:44 INFO - 2015-11-25 03:53:44,731 DEBUG : BROWSER_OUTPUT: Values: 4868.9 03:53:44 INFO - 2015-11-25 03:53:44,731 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:53:44 INFO - 2015-11-25 03:53:44,731 DEBUG : BROWSER_OUTPUT: 03:53:45 INFO - 2015-11-25 03:53:45,617 INFO : Browser exited with error code: 0 03:53:45 INFO - 2015-11-25 03:53:45,636 INFO : Completed test v8_7 (00:00:39) 03:53:45 INFO - 2015-11-25 03:53:45,704 INFO : Completed test suite (00:20:17) 03:53:45 INFO - 2015-11-25 03:53:45,704 DEBUG : Working with test: dromaeo_css 03:53:45 INFO - 2015-11-25 03:53:45,704 DEBUG : Generating results file: dromaeo_css 03:53:45 INFO - 2015-11-25 03:53:45,705 DEBUG : Working with test: kraken 03:53:45 INFO - 2015-11-25 03:53:45,705 DEBUG : Generating results file: kraken 03:53:45 INFO - 2015-11-25 03:53:45,706 INFO : javascript benchmark 03:53:45 INFO - 2015-11-25 03:53:45,706 DEBUG : Working with test: v8_7 03:53:45 INFO - 2015-11-25 03:53:45,706 DEBUG : Generating results file: v8_7 03:53:45 INFO - 2015-11-25 03:53:45,706 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:53:45 INFO - 2015-11-25 03:53:45,753 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 03:53:45 INFO - 2015-11-25 03:53:45,754 DEBUG : process_Request line: dromaeo_css 6192.47 graph.html#tests=[[72,132,35]] 03:53:45 INFO - 2015-11-25 03:53:45,754 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:53:45 INFO - 2015-11-25 03:53:45,782 DEBUG : process_Request line: kraken 1531.70 graph.html#tests=[[232,132,35]] 03:53:45 INFO - 2015-11-25 03:53:45,782 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:53:45 INFO - 2015-11-25 03:53:45,808 DEBUG : process_Request line: v8_7 19618.94 graph.html#tests=[[230,132,35]] 03:53:45 INFO - 2015-11-25 03:53:45,813 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2593.6628238329017, 2710.579860121682, 2719.673639163301, 2725.1007167634684, 2739.6027576001475, 4385.934210986838, 4497.1455423469515, 4574.954250457495, 4591.747453890035, 4621.029583787405, 4498.460184777823, 4504.481984571776, 4561.977190114053, 4569.109023740372, 4615.28463088221, 4192.769397683126, 4213.831446742142, 4225.154969006211, 4231.4710661167355, 4255.2978758504805, 4041.1715598302276, 4305.763183024932, 4327.891802704926, 4342.5874541918465, 4351.521332653406, 4166.791660416967, 4167.312393455091, 4219.43037689911, 4236.110416812473, 4270.871873843789, 4187.413762073312, 4228.154369126156, 4270.316749320125, 4275.508316543606, 4310.719803212813, 4007.73949693269, 4110.157417729359, 4228.386883901817, 4249.596288352602, 4276.550962148961, 4406.272964960777, 4433.623142032931, 4494.640428765691, 4527.796249168795, 4537.636989040869, 4901.852944411673, 4924.655274130812, 4925.704457732548, 4926.1379258629595, 4966.1309270877455, 4728.763561821896, 4945.876353091166, 4953.182724850431, 4964.354633897607, 5005.849824505271, 4513.390692256569, 4519.909601807945, 4566.13243483737, 4628.768561571908, 4682.882927926829, 5067.543921047123, 5075.111855425286, 5080.54275115234, 5081.339425874613, 5085.084684756779, 4623.214053610895, 4828.082664293773, 4853.369062021915, 4860.8784780380065, 4883.902321953541, 4750.8337208197545, 4789.616830653539, 4802.51974802517, 4816.373871396766, 4826.95173048272, 4834.492378300228, 4836.395450568679, 4840.7337596432535, 4844.15227335215, 4882.389701287339, 4820.71075735457, 4827.831025914076, 4828.203346447796, 4843.903121937541, 4869.780859861315, 3955.0507878109047, 4032.3951407288555, 4048.1296521248073, 4053.5541090480024, 4088.325426304686, 3541.787492750443, 3550.2366991097037, 3551.3074950384425, 3577.695895848882, 3578.946315805265, 4280.379344994958, 4282.678799090018, 4285.742855428684, 4288.399624052635, 4329.372241025097, 4625.283081122431, 4691.906161876812, 4737.573618374363, 4740.597049250783, 4944.604431645532, 4137.81379837908, 4150.335946248586, 4206.179794939957, 4287.614114729689, 4304.913901721948, 4363.47638283408, 4417.0724147929295, 4419.535948725337, 4419.867403977886, 4455.532169122261, 4416.359627854007, 4540.954590454186, 4541.659375546913, 4696.365990591295, 4791.808327666854, 4801.68789028712, 4858.392700912386, 4875.366202393666, 4879.243717223836, 4909.582685471775, 4732.337472753748, 4735.17134501454, 4735.502772208868, 4738.4787673356595, 4742.549457801503, 4597.494275629611, 4696.976515117402, 4697.248440249544, 4878.414590249193, 4928.0, 4821.46963833985, 4867.9269810952155, 4893.853184404474, 4894.19245824435, 4933.876653083558, 4686.992296656235, 4748.358971538936, 4748.905021899612, 4755.38180036593, 4777.95222047775, 4499.820007199675, 4594.1730488512385, 4631.467381251065, 4747.976260118678, 4788.23388257891, 4572.5198854119835, 4619.122366750306, 4633.745144017112, 4664.160451118832, 4679.859604211879, 4838.250071238964, 4841.878953026203, 4845.781939812788, 4847.733374664427, 4851.320815085962, 4549.112922979987, 4660.510646382081, 4665.32352808834, 4712.175369310426, 4772.117158325721], "unit": "ms", "name": "dojo.html", "value": 4483.826469592805}, {"lowerIsBetter": false, "replicates": [569.0184431855049, 574.7126436781609, 576.8788554403575, 578.1154833105351, 594.9643021418715, 26412.603810942826, 26833.195004149882, 26904.192874213757, 26915.730842691566, 36065.278694426095, 39812.203755924864, 40409.0, 40409.797951010274, 40460.190796184055, 40539.18921621566, 7936.722214722486, 8111.229433203836, 8113.634886430095, 8115.0, 8116.6347514362, 7103.183133939586, 7251.6374181290985, 7265.854682906339, 7275.199728029939, 7857.174996625329, 7084.220735719093, 7171.89242161368, 10125.3924764514, 10369.688909332694, 10387.22095842811, 10033.0, 10111.09000189979, 10124.34191777532, 10127.746806329864, 10131.79736405275, 7085.787426377217, 7281.1990681025045, 9684.225261979025, 9778.90221097787, 9803.901960980442, 40578.39132413016, 41511.7924410376, 41549.584504154875, 41579.792101039304, 41736.58263417388, 2778.221140417375, 2792.3437992071845, 2916.3875586126937, 3275.7215636670912, 3286.354613880687, 27593.310167245778, 27661.446771064668, 27828.30429239285, 27853.303667408276, 28380.432391352264, 3415.077928959167, 3437.5187473753695, 3454.29187016661, 3495.353359628477, 3544.769589976669, 227819.0, 229431.8528407364, 230501.0, 230984.0, 231965.0, 56290.71854640783, 56332.43667563272, 56376.0, 56465.0, 56738.0, 59984.700076499335, 60423.39576604265, 60447.697761511794, 60469.0, 60488.395116048276, 13462.259575723428, 13925.373358198905, 13926.164430134022, 13933.094348867291, 13939.512117075854, 9803.705888823346, 9815.509224538744, 9817.509124543743, 9820.312578119607, 9825.508724563742, 18911.653191943955, 19218.711719324223, 19346.613067738846, 19419.834809911452, 19463.318783842496, 7468.0, 7713.1515533291295, 7747.573883436465, 7824.0, 7851.0, 888.1739981816972, 892.7857314244535, 911.3028533172129, 945.5177859291811, 990.0742805476758, 27094.322641934108, 27432.588511172347, 30111.548326775115, 31032.53451198234, 31763.36473270568, 851.0553285852699, 860.1484530314943, 869.626060793852, 937.6249500199838, 964.5563041001218, 13366.93316533411, 15678.843211567966, 16342.182890855409, 16437.342506299854, 16480.09359485216, 339264.9110263348, 344084.0, 344531.0, 344853.0, 344983.10033799685, 48487.27269090967, 48889.75555122201, 49025.50974490281, 49505.50494495081, 49550.0, 1213.2720367779261, 1225.6139316115396, 1241.975160496785, 1242.2670624331868, 1243.8258643789877, 27832.44335113246, 28575.28561785972, 28768.0, 28771.85614072, 28850.422991540472, 40579.59420405876, 41027.384589231784, 41327.0, 41329.793351033055, 41366.58633413627, 259766.0, 261178.0, 261697.0, 261816.0, 263325.0, 24737.0, 25216.117435889657, 28747.856260718563, 28793.56809647815, 29308.56037159487, 34047.65952340445, 34596.654033459345, 34628.134296642784, 34700.47949280712, 34994.82502587471, 31177.0, 32328.83835580807, 32788.344233115684, 32997.50503742398, 33231.169220769676, 25684.45046513202, 31593.36813263676, 32025.839870800497, 32549.837250813594, 32884.83557582197, 32788.0, 32862.671373285964, 33017.0, 33020.0, 38551.42172867465, 29023.854880725463, 29920.700792992662, 31251.0, 31289.0, 31348.529772053895, 23902.88048559746, 24446.877765611058, 24542.0, 24890.751092488845, 25193.370165746004], "unit": "ms", "name": "ext.html", "value": 17287.22290470176}, {"lowerIsBetter": false, "replicates": [338.6105978125157, 340.27181830881915, 341.8017549821104, 342.04398705617797, 342.46917278218757, 11931.403429828517, 12308.569200077998, 15095.849041509582, 15104.395824167033, 15811.209439528006, 11905.226160299575, 14492.565223043299, 14534.927325363386, 14791.852081479208, 14876.0, 4787.976060119703, 4792.544708252711, 4874.46380898101, 4930.235813448921, 4969.676970996892, 3242.302904875463, 3338.031970728498, 4955.08330958772, 4998.075356059141, 5066.138756411419, 5102.642815002932, 5175.094358487268, 5180.352455943007, 5195.506426889439, 5213.661112027725, 5027.798888044474, 5149.330587023682, 5161.896762064775, 5162.612804039693, 5163.922541161885, 4981.153203955337, 4998.275250088753, 5000.2499625056535, 5001.124803159432, 5001.924971125436, 11436.771264574661, 15260.923695381563, 18066.4580062597, 18703.158357873792, 18707.251709931723, 1810.809864964173, 1814.0566905209348, 1820.599468117012, 1853.379117995473, 1935.283944940367, 8860.424072435335, 8866.290696744245, 8953.104689530996, 9053.637854485878, 9134.269258459308, 1720.8967461952323, 1750.0549703160277, 1759.3930094117509, 1807.13257636334, 1809.6833054215592, 55538.44461555414, 57005.71497142488, 58135.70932145397, 58642.706786466224, 59182.11226831601, 8946.821063578822, 9177.449353038706, 9456.8581471278, 9495.287853411022, 9576.95211523952, 12229.816552751716, 12300.81548776769, 12306.07704422172, 12308.138430309793, 12335.50657973689, 6925.480588955848, 6932.61870597122, 6954.09596752429, 6981.371676549135, 6988.19635741886, 6689.0, 6689.732410703517, 6726.495512836557, 6752.020956961213, 6771.322867713189, 3829.5404551454003, 3877.108265099043, 3899.922001559953, 4027.838886444509, 4099.528554216244, 1538.1924489643027, 1596.2976290432173, 1596.944106956251, 1679.5465224389347, 1720.329071662053, 787.6494959742975, 829.8796674482167, 831.1646794971016, 856.1438561438562, 905.316486053039, 13958.930205349112, 14607.269636518344, 15051.397944082333, 15299.617509562127, 15624.140672262907, 804.4650307545417, 833.9374546909006, 840.2311884625622, 867.1285358214953, 902.7652810269377, 8401.621927013177, 8577.656893724306, 8700.956495217484, 8711.085336039625, 8802.0, 334917.0, 341996.0, 496065.0, 499985.0, 500558.0, 72625.63687181531, 73385.6330718343, 73562.63218683872, 74253.0, 74313.62843185749, 1034.7878684869584, 1054.5623566219933, 1059.761553650438, 1061.6655753437797, 1062.3625824505234, 13095.148815326973, 13421.66445838862, 13799.310034498436, 14006.719865602834, 14104.0, 28315.71684283213, 31227.84386078055, 32654.51018234681, 32776.34447311088, 33160.834195828866, 39580.208395832495, 39731.205375892896, 39788.80105599569, 41644.16711665689, 41773.0, 8497.532635705096, 8633.05036445978, 8847.73456796297, 8863.157999989991, 8888.955555222183, 15469.458568950033, 15501.922490387477, 15801.20993950321, 15922.442714504938, 15925.920370398075, 13115.803262950873, 13220.867791321964, 13453.730925381242, 13637.795433068313, 13674.863251367358, 12926.935365323114, 13218.140820846615, 13300.002499812746, 13470.528531501743, 13538.458461661423, 10431.739206519898, 11570.132240081859, 13257.204567725967, 13380.0, 13578.777909988148, 8446.0, 8463.703770368254, 8705.216530512283, 8883.511406872683, 8898.599563019809, 13499.86500134986, 13567.38946747379, 13750.793738093736, 13871.722565548835, 13887.444502220202], "unit": "ms", "name": "jquery.html", "value": 8023.676442808046}, {"lowerIsBetter": false, "replicates": [1412.4491448335145, 1580.826109127996, 1630.1604673593101, 1637.05869125253, 1661.2026227410836, 5684.772609095637, 6060.212172417585, 6842.82892927677, 7051.294870512959, 7073.540219885704, 6905.516613837033, 6916.377526022669, 6985.057017302663, 6998.055262539556, 6999.160100787913, 1700.6598680263935, 1732.9220185091638, 2038.4699978005715, 2076.730025096743, 2079.2826474866147, 2085.270155445597, 2131.126238242321, 2131.968020479694, 2134.1676746069047, 2134.3596920923737, 2050.323393280214, 2053.897305134745, 2069.668852983523, 2084.4893001214723, 2084.874907505547, 1713.4174380710617, 1747.9213435395438, 2009.2666176845346, 2022.5348169920926, 2033.857629965903, 2068.9482762930897, 2076.646970015101, 2078.1791192479036, 2078.7505499340177, 2079.5944790765657, 6695.631740254284, 6864.0, 6908.0, 6917.688704008281, 6920.273371296042, 4113.609207125318, 4121.5878412158845, 4177.10192308652, 4187.350960601112, 4210.810513526899, 2601.297649634588, 2665.4136090060156, 2666.6933302670054, 2671.973280267192, 2672.27848480911, 847.4364547575855, 851.4508142248216, 856.3235044314983, 875.1030194051085, 892.6830975003845, 9296.581653825595, 9313.767155821091, 9318.627254909796, 9336.066393360677, 9346.252299816066, 3818.770873747584, 3827.2919509890758, 3859.517560304962, 3877.5734669186368, 3962.881113566598, 8047.557384343917, 8068.112507624157, 8075.111737708848, 8087.069986951576, 8089.069756978023, 4242.978785106116, 4260.723053001607, 4263.997960479347, 4268.338407546835, 4274.0, 3842.212346468967, 3865.2269546090893, 3866.4007078902814, 3869.980650096788, 3875.8643447479203, 3350.4136776064092, 3397.4224381855142, 3400.4219282721997, 3417.060308415206, 3428.245785927092, 1081.983770243447, 1087.1791797193068, 1092.3609688332415, 1100.1418893263267, 1101.553870682375, 815.6778072661266, 825.2861274997084, 826.7189155687096, 828.9253967142986, 944.3436811416, 6456.451201647818, 6490.0, 6498.992656138306, 6506.41442270198, 6514.706838192293, 416.17804835449743, 443.5187821213954, 443.64286749166587, 445.02317413277547, 459.27434653247786, 4193.97903010483, 5164.845054648366, 5319.468053194727, 5331.040412725669, 5359.785608575613, 7983.481073730189, 8139.186081391932, 8206.630701618442, 8345.791355216168, 8378.41351105429, 8190.180981901762, 8197.221263979913, 8203.548804815793, 8213.301869341054, 8231.506109633441, 6375.936240637627, 6389.9361006389345, 6410.711517981702, 6429.517786166056, 6457.644829534421, 6389.9041514376395, 6445.871082578416, 6454.354564543508, 6454.548181627241, 6482.837929051811, 6960.582365058112, 7489.363404110493, 7539.9246007541415, 7544.0, 7614.581198034161, 7404.259574042552, 7497.662605182671, 7614.086309642878, 7812.062552493737, 7953.244441778022, 6530.608163510205, 6593.934060659332, 6597.1423714916755, 6609.041688955171, 6612.305707900794, 6523.18460192476, 6600.9009864851105, 6620.2386725527185, 6661.733530658719, 6672.499562532927, 6215.0, 6305.527085468517, 6355.491560675227, 6394.71223794921, 6401.935980640134, 6200.193974783249, 6202.81391558254, 6233.968830156002, 6244.063390491463, 6300.7479700811455, 5912.73392697321, 6166.784162554289, 6194.0708893666315, 6230.283517395557, 6237.656928868956, 5856.150858125633, 5889.0, 5905.852353691193, 5910.615809972338, 5913.083472061838, 5699.430056994267, 5732.541396688338, 5768.596198266081, 5787.392323806108, 5792.536597072309], "unit": "ms", "name": "mootools.html", "value": 3905.0098043645517}, {"lowerIsBetter": false, "replicates": [311.8627803766343, 316.77667244592567, 318.69405370843987, 320.9662985386533, 321.3155977767355, 5077.593792496601, 5222.9216561751555, 5254.7635356408955, 5272.340957380327, 5342.385625653056, 5046.949530504694, 5187.221916712486, 5187.351581052369, 5191.480851914816, 5209.843704688856, 4128.566500517448, 4130.566290539495, 4134.13183231521, 4148.8340466381305, 4149.273877071516, 3890.1247219375555, 3982.8406863725418, 4016.0562267867026, 4115.1975364803875, 4117.341225403936, 4093.5497095319492, 4118.917621647565, 4124.938125928114, 4130.834766609332, 4139.130782535671, 4106.7125301228925, 4108.4864391951005, 4109.2808758467145, 4113.25961326961, 4116.773577453238, 3651.7443778935485, 3656.323580137683, 3657.122290650251, 3670.137517683342, 3677.4667673187505, 4989.226669866177, 5042.092423363793, 5046.545810877039, 5060.266261392115, 5091.66904151229, 4728.361671174382, 4731.455882573479, 4739.0758802033615, 4744.667873248874, 4746.145693775119, 5496.945030549683, 5503.587230957694, 5505.3393592768725, 5507.889842203133, 5524.171374293848, 3694.3165514379925, 3802.752821066622, 3842.1931394407206, 3979.462772525701, 3983.940240896389, 5815.127730840365, 5843.912341314884, 5849.356570777169, 5862.14998825168, 5862.296524417055, 4086.1419101988913, 4103.199876024147, 4106.260873042881, 4107.014316564003, 4108.712390132662, 4170.624643782075, 4170.979145104255, 4174.269502837052, 4175.144095460484, 4182.2890108681595, 4499.730016199039, 4637.536246375403, 4644.651651126112, 4706.694064885772, 4710.105080034851, 5515.420880807537, 5523.502884740393, 5524.447555244444, 5524.8342549723575, 5533.446655334515, 1411.3225651687042, 1431.2271373458425, 1431.355889849572, 1433.5592729307189, 1434.9354279057468, 964.7154089543601, 969.5927710361665, 975.9658411955547, 987.3088837813559, 994.3586386780486, 4821.132196204717, 4827.179379505493, 4848.757562121879, 4852.393450818648, 4887.560119589254, 5673.943260567424, 5679.148127780866, 5687.573431992617, 5702.48677619008, 5707.0583353747, 4851.248056551241, 4865.464798872121, 4870.318155458239, 4876.804927802919, 4882.365292512021, 2743.43759529296, 2898.130560831742, 3032.7725420593542, 3070.8311042892856, 3072.2472994116583, 5394.73026348681, 5402.18967154922, 5403.432639572867, 5479.986202552541, 5540.141278101901, 5895.675737834375, 5896.086106653475, 5901.0, 5904.940950590525, 5908.084246941731, 5511.641743286754, 5518.475744804237, 5522.337319521603, 5527.2538207342295, 5528.668279903219, 5720.256366672306, 5720.399358067343, 5723.112917497794, 5739.540836733135, 5742.971285143548, 5431.728413579384, 5469.234307197075, 5504.091824848855, 5543.445655434424, 5638.295213098363, 5361.758720857492, 5416.21464887597, 5449.3188351456065, 5449.6730196188355, 5544.140658197985, 4084.4894388201474, 4110.116324990141, 4116.320807066801, 4116.9794151029055, 4120.505539335299, 5678.346990096192, 5680.062789639664, 5686.374498805046, 5690.829275121753, 5693.345265294544, 5356.946430535801, 5500.1749737539685, 5501.972490137524, 5505.284313039279, 5506.256655351476, 5477.835664930059, 5495.120780675073, 5504.697241651747, 5510.228568000403, 5519.337679478488, 5388.946110538845, 5391.622586418913, 5400.83797486076, 5404.675719456845, 5407.972485227794, 5398.811041613525, 5421.349438067457, 5503.614746967673, 5523.834284971457, 5525.806596769094, 5370.946290537045, 5374.731263436891, 5387.515123638735, 5390.460953904578, 5397.622166448311], "unit": "ms", "name": "prototype.html", "value": 4175.213939127514}, {"lowerIsBetter": false, "replicates": [731.1956847467783, 735.1031741275646, 737.8192342875994, 741.8108382362503, 748.4731148457149, 11629.418529073544, 11763.294202347844, 11816.0, 11817.586384476544, 11829.7634047319, 11160.66518004459, 11172.832407513893, 11194.38430886301, 12792.119397074466, 13111.6722081948, 766.3907193780957, 777.9805504862395, 778.1401551285833, 778.3267473635293, 779.7465823607322, 610.5207412181438, 616.8797084568511, 769.334525635327, 784.3764207455058, 785.2893131715778, 807.2936180841764, 808.9514629122242, 809.5304723260524, 814.5764202614637, 814.9918500814975, 624.687656171914, 632.8417895526119, 789.5144486141039, 797.3182928596054, 797.7088362747613, 588.5526999480383, 593.522214617233, 594.5808205215313, 594.7085927895344, 595.1875689683551, 11730.12024098196, 11935.82096268548, 11952.103592230531, 11960.760784784343, 11963.0, 10486.370817750883, 10579.31234469757, 10719.196060295431, 10992.505337259843, 11542.596009139725, 9462.29032822541, 9679.467629280387, 9786.168175705074, 9858.211343092535, 10045.648402305884, 3151.5115157150676, 3246.2371342734436, 3265.967340326614, 3300.5709257796334, 3311.718503927169, 42594.148117037796, 42942.78528607337, 43273.0, 43274.78362608167, 43574.0, 8279.089300176976, 8362.832743345221, 8392.244697977088, 8441.016361155123, 8905.927161385001, 15967.121808300422, 15991.28039238237, 16044.0, 16088.0, 16092.275847586887, 6040.456358927718, 6117.694115294217, 6202.782902598387, 6348.555601107878, 6360.872782544323, 3612.6026137124895, 3643.2349206666895, 3687.815609219582, 3702.389105797567, 3730.626937306248, 2629.8948042078105, 2657.694365148033, 2669.479451506976, 2669.639598654157, 2670.626112344273, 449.40229494771876, 457.1268876445972, 460.36009946174846, 476.8307250925941, 478.273025001995, 422.57320106692464, 429.7249760153504, 432.66684652817156, 468.8054457400141, 492.36976669862634, 6910.723571057101, 7443.516171448839, 7443.813904652318, 7570.318671319607, 7669.9616501917135, 396.5657604922663, 498.2451585847444, 507.16824407970955, 537.0815904802831, 547.9232907392968, 3485.6165821759587, 3638.308721342936, 3672.761270517461, 3686.7050635949595, 3743.9251214976093, 52888.471115289125, 52992.0, 53369.1994620081, 53573.73213133909, 53578.464215357344, 45555.405560805215, 46189.30716039262, 46224.7688761554, 46259.53740462619, 46341.30488042682, 42098.0, 42306.57693423027, 42557.148857023305, 42832.78583607062, 43047.35428968568, 6898.509157180811, 6909.412699920563, 6913.170419549686, 6981.5112942093565, 7082.4688148390105, 31368.843155784987, 31547.36905261836, 31554.684453155176, 32381.0, 32481.675183247866, 37890.0, 38453.80773096228, 38490.23019539537, 38583.2283354337, 39612.80193599014, 9485.857712134186, 9679.225661946886, 9730.309835642063, 9739.0, 9759.072888075621, 10507.842382364424, 10662.573497060032, 10733.677989660322, 10775.676729698122, 10941.945290273497, 9961.252906031932, 9965.900340996788, 9973.351732137678, 9976.2517811163, 10409.9479502602, 10027.398356098658, 10313.587456501657, 10529.262951593315, 10570.41862697559, 10686.145108391154, 10290.485475726333, 10295.07344339013, 10339.948300258451, 10349.379037257788, 10354.637587684394, 8662.480251184948, 9127.817443651222, 9141.63433462654, 9176.26589872822, 9427.575759090994, 8345.624446899783, 8527.74416767498, 8741.650333986823, 8914.687985920462, 9074.183323500916], "unit": "ms", "name": "yui.html", "value": 5560.127718337624}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 105.0, 113.0, 114.0, 112.0, 101.0, 113.0, 111.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [158.0, 131.0, 153.0, 175.0, 131.0, 161.0, 158.0, 149.0, 183.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 153.0}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 161.0, 160.0, 161.0, 160.0, 160.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 85.0, 91.0, 74.0, 72.0, 72.0, 98.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 129.0, 95.0, 96.0, 95.0, 129.0, 95.0, 94.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 73.0, 74.0, 73.0, 74.0, 74.0, 82.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 73.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 70.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 83.0, 85.0, 83.0, 83.0, 92.0, 86.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [127.0, 131.0, 122.0, 135.0, 127.0, 121.0, 120.0, 123.0, 123.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [151.0, 138.0, 148.0, 160.0, 150.0, 139.0, 150.0, 149.0, 148.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [69.0, 73.0, 71.0, 68.0, 71.0, 71.0, 69.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.31658125309968], "unit": "score", "name": "Richards", "value": 213.54179800000009}, {"lowerIsBetter": false, "replicates": [192.75250578257518], "unit": "score", "name": "DeltaBlue", "value": 343.0201839999999}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [809.7165991902834], "unit": "score", "name": "Earley", "value": 823.0818049999997}, {"lowerIsBetter": false, "replicates": [12432.098765432098], "unit": "score", "name": "Boyer", "value": 53.608245283018846}, {"lowerIsBetter": false, "replicates": [26736.842105263157], "unit": "score", "name": "RegExp", "value": 34.07227362204725}, {"lowerIsBetter": false, "replicates": [616.5228113440197], "unit": "score", "name": "Splay", "value": 132.17840199999998}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "NavierStokes", "value": 304.7896311066801}], "name": "v8_7"}]} 03:53:45 INFO - RETURN: dromaeo_css: 6192.47 03:53:45 INFO - RETURN: kraken: 1531.70 03:53:45 INFO - RETURN: v8_7: 19618.94 03:53:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19618.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1531.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6192.47"}}} 03:53:45 INFO - Return code: 0 03:53:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:53:45 INFO - # TBPL SUCCESS # 03:53:45 INFO - Running post-action listener: _resource_record_post_action 03:53:45 INFO - Running post-run listener: _resource_record_post_run 03:53:47 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 501952512; Read time: 12; Write time: 368460 03:53:47 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 224071680; Read time: 0; Write time: 236656 03:53:47 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277880832; Read time: 12; Write time: 131804 03:53:47 INFO - Running post-run listener: _upload_blobber_files 03:53:47 INFO - Blob upload gear active. 03:53:47 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:53:47 INFO - Copying logs to upload dir... 03:53:47 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.854328 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-11-25 03:53:45.901844) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 03:53:45.905560) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009906 build_url: 'https://queue.taskcluster.net/v1/task/40tRM-9ZST2aEC324tWtxQ/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-25 03:53:45.959390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:53:45.959748) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1448444975.935983-1002281717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:53:46.011111) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 03:53:46.011464) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 03:53:46.011808) ========= ========= Total master_lag: 0.26 =========