builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1448367457.61 results: success (0) buildid: 20151124025732 builduid: 7da7e0e5028949b7911e621520fb31fb revision: c6893ed724af1209d22833aa68c740b35d926b9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:37.612854) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:37.613349) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:37.613732) ========= 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=7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005355 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:37.642259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:37.642664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:37.711353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:37.711887) ========= 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=7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004661 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:37.938145) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:37.938483) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:37.943072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 04:17:37.943471) ========= 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=7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 04:17:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2015-11-24 04:17:38 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106564 ========= master_lag: 1.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 04:17:39.078610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:39.078966) ========= 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=7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014090 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:39.222317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:39.222718) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c6893ed724af1209d22833aa68c740b35d926b9b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c6893ed724af1209d22833aa68c740b35d926b9b --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=7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 04:17:39,401 truncating revision to first 12 chars 2015-11-24 04:17:39,402 Setting DEBUG logging. 2015-11-24 04:17:39,402 attempt 1/10 2015-11-24 04:17:39,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c6893ed724af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 04:17:39,726 unpacking tar archive at: mozilla-central-c6893ed724af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612559 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:39.863881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:39.867283) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:39.878215) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:39.878586) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 04:17:39.879108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-24 04:17:39.879442) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:17:40 INFO - MultiFileLogger online at 20151124 04:17:40 in /builds/slave/test 04:17:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:17:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:17:40 INFO - {'append_to_log': False, 04:17:40 INFO - 'base_work_dir': '/builds/slave/test', 04:17:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:17:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:17:40 INFO - 'branch': 'Firefox-Non-PGO', 04:17:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:17:40 INFO - 'config_files': ('talos/linux_config.py',), 04:17:40 INFO - 'default_actions': ('clobber', 04:17:40 INFO - 'read-buildbot-config', 04:17:40 INFO - 'download-and-extract', 04:17:40 INFO - 'populate-webroot', 04:17:40 INFO - 'create-virtualenv', 04:17:40 INFO - 'install', 04:17:40 INFO - 'run-tests'), 04:17:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:17:40 INFO - 'download_minidump_stackwalk': True, 04:17:40 INFO - 'download_symbols': 'ondemand', 04:17:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:17:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:17:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:17:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:17:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:17:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:17:40 INFO - 'installer_path': 'installer.exe', 04:17:40 INFO - 'log_level': 'info', 04:17:40 INFO - 'log_name': 'talos', 04:17:40 INFO - 'log_to_console': True, 04:17:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:17:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:17:40 INFO - 'opt_config_files': (), 04:17:40 INFO - 'pip_index': False, 04:17:40 INFO - 'sps_profile': False, 04:17:40 INFO - 'sps_profile_interval': 0, 04:17:40 INFO - 'suite': 'dromaeojs', 04:17:40 INFO - 'system_bits': '64', 04:17:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:17:40 INFO - 'title': 'talos-linux64-ix-008', 04:17:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:17:40 INFO - 'use_talos_json': True, 04:17:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:17:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:17:40 INFO - 'work_dir': 'build'} 04:17:40 INFO - ##### 04:17:40 INFO - ##### Running clobber step. 04:17:40 INFO - ##### 04:17:40 INFO - Running pre-action listener: _resource_record_pre_action 04:17:40 INFO - Running main action method: clobber 04:17:40 INFO - rmtree: /builds/slave/test/build 04:17:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:17:40 INFO - Running post-action listener: _resource_record_post_action 04:17:40 INFO - ##### 04:17:40 INFO - ##### Running read-buildbot-config step. 04:17:40 INFO - ##### 04:17:40 INFO - Running pre-action listener: _resource_record_pre_action 04:17:40 INFO - Running main action method: read_buildbot_config 04:17:40 INFO - Using buildbot properties: 04:17:40 INFO - { 04:17:40 INFO - "properties": { 04:17:40 INFO - "buildnumber": 372, 04:17:40 INFO - "product": "firefox", 04:17:40 INFO - "script_repo_revision": "production", 04:17:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:17:40 INFO - "repository": "", 04:17:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:17:40 INFO - "buildid": "20151124025732", 04:17:40 INFO - "slavename": "talos-linux64-ix-008", 04:17:40 INFO - "pgo_build": "False", 04:17:40 INFO - "basedir": "/builds/slave/test", 04:17:40 INFO - "project": "", 04:17:40 INFO - "platform": "ubuntu64_hw", 04:17:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:17:40 INFO - "slavebuilddir": "test", 04:17:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:17:40 INFO - "branch": "mozilla-central", 04:17:40 INFO - "repo_path": "mozilla-central", 04:17:40 INFO - "stage_platform": "linux64", 04:17:40 INFO - "builduid": "7da7e0e5028949b7911e621520fb31fb", 04:17:40 INFO - "revision": "c6893ed724af1209d22833aa68c740b35d926b9b" 04:17:40 INFO - }, 04:17:40 INFO - "sourcestamp": { 04:17:40 INFO - "repository": "", 04:17:40 INFO - "hasPatch": false, 04:17:40 INFO - "project": "", 04:17:40 INFO - "branch": "mozilla-central-linux64-talos", 04:17:40 INFO - "changes": [ 04:17:40 INFO - { 04:17:40 INFO - "category": null, 04:17:40 INFO - "files": [ 04:17:40 INFO - { 04:17:40 INFO - "url": null, 04:17:40 INFO - "name": "https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:17:40 INFO - } 04:17:40 INFO - ], 04:17:40 INFO - "repository": "", 04:17:40 INFO - "rev": "c6893ed724af1209d22833aa68c740b35d926b9b", 04:17:40 INFO - "who": "cbook@mozilla.com", 04:17:40 INFO - "when": 1448367446, 04:17:40 INFO - "number": 6699851, 04:17:40 INFO - "comments": "Bumping manifests a=b2g-bump", 04:17:40 INFO - "project": "", 04:17:40 INFO - "at": "Tue 24 Nov 2015 04:17:26", 04:17:40 INFO - "branch": "mozilla-central-linux64-talos", 04:17:40 INFO - "revlink": "", 04:17:40 INFO - "properties": [ 04:17:40 INFO - [ 04:17:40 INFO - "buildid", 04:17:40 INFO - "20151124025732", 04:17:40 INFO - "Change" 04:17:40 INFO - ], 04:17:40 INFO - [ 04:17:40 INFO - "builduid", 04:17:40 INFO - "7da7e0e5028949b7911e621520fb31fb", 04:17:40 INFO - "Change" 04:17:40 INFO - ], 04:17:40 INFO - [ 04:17:40 INFO - "pgo_build", 04:17:40 INFO - "False", 04:17:40 INFO - "Change" 04:17:40 INFO - ] 04:17:40 INFO - ], 04:17:40 INFO - "revision": "c6893ed724af1209d22833aa68c740b35d926b9b" 04:17:40 INFO - } 04:17:40 INFO - ], 04:17:40 INFO - "revision": "c6893ed724af1209d22833aa68c740b35d926b9b" 04:17:40 INFO - } 04:17:40 INFO - } 04:17:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:17:40 INFO - Running post-action listener: _resource_record_post_action 04:17:40 INFO - ##### 04:17:40 INFO - ##### Running download-and-extract step. 04:17:40 INFO - ##### 04:17:40 INFO - Running pre-action listener: _resource_record_pre_action 04:17:40 INFO - Running main action method: download_and_extract 04:17:40 INFO - mkdir: /builds/slave/test/build/tests 04:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:40 INFO - https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:17:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/test_packages.json 04:17:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/test_packages.json 04:17:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:17:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:17:43 INFO - Downloaded 1302 bytes. 04:17:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:17:43 INFO - Using the following test package requirements: 04:17:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:17:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:17:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:43 INFO - u'jsshell-linux-x86_64.zip'], 04:17:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:17:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:17:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:17:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:17:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:17:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:17:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:17:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:17:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:17:43 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')]} 04:17:43 INFO - https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:17:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:17:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:17:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/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 04:17:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/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 04:17:55 INFO - Downloaded 21341357 bytes. 04:17:55 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 04:17:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:17:55 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 04:17:56 INFO - Return code: 0 04:17:56 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 04:17: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')]} 04:17:56 INFO - https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:17:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:17:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:17:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/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 04:17:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/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 04:17:57 INFO - Downloaded 21341357 bytes. 04:17:57 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 04:17:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:17:57 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 04:17:58 INFO - Return code: 0 04:17: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')]} 04:17:58 INFO - https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:17:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/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 04:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/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 04:17:59 INFO - Downloaded 11130997 bytes. 04:17:59 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 04:17:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:17:59 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 04:18:00 INFO - Return code: 0 04:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:00 INFO - https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:18:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:18:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:18:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/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 04:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/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 04:18:01 INFO - Downloaded 56026830 bytes. 04:18:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:18:01 INFO - mkdir: /builds/slave/test/properties 04:18:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:18:01 INFO - Writing to file /builds/slave/test/properties/build_url 04:18:01 INFO - Contents: 04:18:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:18:01 INFO - Running post-action listener: _resource_record_post_action 04:18:01 INFO - Running post-action listener: set_extra_try_arguments 04:18:01 INFO - ##### 04:18:01 INFO - ##### Running populate-webroot step. 04:18:01 INFO - ##### 04:18:01 INFO - Running pre-action listener: _resource_record_pre_action 04:18:01 INFO - Running main action method: populate_webroot 04:18:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:18:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:18:01 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:18:01 INFO - '../fennec_ids.txt'], 04:18:01 INFO - 'tests': ['tcheck2']}, 04:18:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:18:01 INFO - '--tppagecycles', 04:18:01 INFO - '7'], 04:18:01 INFO - 'tests': ['tsvgm']}}, 04:18:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:18:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:18:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:18:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:18:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:18:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:18:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:01 INFO - 'talos_options': ['--e10s'], 04:18:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:01 INFO - 'tests': ['damp', 'tps']}, 04:18:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:01 INFO - 'talos_options': ['--e10s'], 04:18:01 INFO - 'tests': ['damp', 'tps']}, 04:18:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:18:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:18:01 INFO - 'other': {'tests': ['a11yr', 04:18:01 INFO - 'ts_paint', 04:18:01 INFO - 'tpaint', 04:18:01 INFO - 'sessionrestore', 04:18:01 INFO - 'sessionrestore_no_auto_restore']}, 04:18:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:18:01 INFO - 'tests': ['a11yr', 04:18:01 INFO - 'ts_paint', 04:18:01 INFO - 'tpaint', 04:18:01 INFO - 'sessionrestore', 04:18:01 INFO - 'sessionrestore_no_auto_restore']}, 04:18:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:18:01 INFO - 'tests': ['a11yr', 04:18:01 INFO - 'ts_paint', 04:18:01 INFO - 'tpaint', 04:18:01 INFO - 'sessionrestore', 04:18:01 INFO - 'sessionrestore_no_auto_restore']}, 04:18:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:18:01 INFO - 'tests': ['a11yr', 04:18:01 INFO - 'ts_paint', 04:18:01 INFO - 'tpaint', 04:18:01 INFO - 'sessionrestore', 04:18:01 INFO - 'sessionrestore_no_auto_restore']}, 04:18:01 INFO - 'other_l64': {'tests': ['a11yr', 04:18:01 INFO - 'ts_paint', 04:18:01 INFO - 'tpaint', 04:18:01 INFO - 'sessionrestore', 04:18:01 INFO - 'sessionrestore_no_auto_restore']}, 04:18:01 INFO - 'other_nol64': {'tests': ['a11yr', 04:18:01 INFO - 'ts_paint', 04:18:01 INFO - 'tpaint', 04:18:01 INFO - 'sessionrestore', 04:18:01 INFO - 'sessionrestore_no_auto_restore']}, 04:18:01 INFO - 'svgr': {'tests': ['tsvgx', 04:18:01 INFO - 'tsvgr_opacity', 04:18:01 INFO - 'tart', 04:18:01 INFO - 'tscrollx', 04:18:01 INFO - 'cart']}, 04:18:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:18:01 INFO - 'tests': ['tsvgx', 04:18:01 INFO - 'tsvgr_opacity', 04:18:01 INFO - 'tart', 04:18:01 INFO - 'tscrollx', 04:18:01 INFO - 'cart']}, 04:18:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:01 INFO - 'tests': ['tp5o']}, 04:18:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:01 INFO - 'talos_options': ['--e10s'], 04:18:01 INFO - 'tests': ['tp5o']}, 04:18:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:01 INFO - 'talos_options': ['--xperf_path', 04:18:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:01 INFO - 'tests': ['tp5n']}, 04:18:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:01 INFO - 'talos_options': ['--e10s', 04:18:01 INFO - '--xperf_path', 04:18:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:01 INFO - 'tests': ['tp5n']}}, 04:18:01 INFO - 'talos.zip': {'path': '', 04:18:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:18:01 INFO - Running post-action listener: _resource_record_post_action 04:18:01 INFO - ##### 04:18:01 INFO - ##### Running create-virtualenv step. 04:18:01 INFO - ##### 04:18:01 INFO - Running pre-action listener: _resource_record_pre_action 04:18:01 INFO - Running main action method: create_virtualenv 04:18:01 INFO - Creating virtualenv /builds/slave/test/build/venv 04:18:01 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 04:18:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:18:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:18:01 INFO - Using real prefix '/usr' 04:18:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:18:02 INFO - Installing distribute.............................................................................................................................................................................................done. 04:18:03 INFO - Installing pip.................done. 04:18:03 INFO - Return code: 0 04:18:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc602014c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c67b70>, '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 0x2cb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9250>, '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': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', '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 04:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:18:03 INFO - Using env: {'DISPLAY': ':0', 04:18:03 INFO - 'HOME': '/home/cltbld', 04:18:03 INFO - 'LANG': 'en_US.UTF-8', 04:18:03 INFO - 'LANGUAGE': 'en_US:en', 04:18:03 INFO - 'LOGNAME': 'cltbld', 04:18:03 INFO - 'MAIL': '/var/mail/cltbld', 04:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:03 INFO - 'MOZ_NO_REMOTE': '1', 04:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:03 INFO - 'NO_EM_RESTART': '1', 04:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:03 INFO - 'PWD': '/builds/slave/test', 04:18:03 INFO - 'SHELL': '/bin/bash', 04:18:03 INFO - 'SHLVL': '1', 04:18:03 INFO - 'TERM': 'linux', 04:18:03 INFO - 'TMOUT': '86400', 04:18:03 INFO - 'USER': 'cltbld', 04:18:03 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', 04:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:03 INFO - '_': '/tools/buildbot/bin/python'} 04:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:04 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 04:18:04 INFO - Cleaning up... 04:18:04 INFO - Return code: 0 04:18:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:18: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')]} 04:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18: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')]} 04:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc602014c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c67b70>, '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 0x2cb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9250>, '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': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', '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 04:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:18:04 INFO - Using env: {'DISPLAY': ':0', 04:18:04 INFO - 'HOME': '/home/cltbld', 04:18:04 INFO - 'LANG': 'en_US.UTF-8', 04:18:04 INFO - 'LANGUAGE': 'en_US:en', 04:18:04 INFO - 'LOGNAME': 'cltbld', 04:18:04 INFO - 'MAIL': '/var/mail/cltbld', 04:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:04 INFO - 'MOZ_NO_REMOTE': '1', 04:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:04 INFO - 'NO_EM_RESTART': '1', 04:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:04 INFO - 'PWD': '/builds/slave/test', 04:18:04 INFO - 'SHELL': '/bin/bash', 04:18:04 INFO - 'SHLVL': '1', 04:18:04 INFO - 'TERM': 'linux', 04:18:04 INFO - 'TMOUT': '86400', 04:18:04 INFO - 'USER': 'cltbld', 04:18:04 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', 04:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:04 INFO - '_': '/tools/buildbot/bin/python'} 04:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:04 INFO - Downloading/unpacking psutil>=0.7.1 04:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:06 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:18:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:18:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:06 INFO - Installing collected packages: psutil 04:18:06 INFO - Running setup.py install for psutil 04:18:06 INFO - building 'psutil._psutil_linux' extension 04:18:06 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 04:18:06 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 04:18:06 INFO - building 'psutil._psutil_posix' extension 04:18:06 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 04:18:06 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 04:18:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:06 INFO - Successfully installed psutil 04:18:06 INFO - Cleaning up... 04:18:06 INFO - Return code: 0 04:18:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc602014c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c67b70>, '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 0x2cb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9250>, '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': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', '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 04:18:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:18:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:18:06 INFO - Using env: {'DISPLAY': ':0', 04:18:06 INFO - 'HOME': '/home/cltbld', 04:18:06 INFO - 'LANG': 'en_US.UTF-8', 04:18:06 INFO - 'LANGUAGE': 'en_US:en', 04:18:06 INFO - 'LOGNAME': 'cltbld', 04:18:06 INFO - 'MAIL': '/var/mail/cltbld', 04:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:06 INFO - 'MOZ_NO_REMOTE': '1', 04:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:06 INFO - 'NO_EM_RESTART': '1', 04:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:06 INFO - 'PWD': '/builds/slave/test', 04:18:06 INFO - 'SHELL': '/bin/bash', 04:18:06 INFO - 'SHLVL': '1', 04:18:06 INFO - 'TERM': 'linux', 04:18:06 INFO - 'TMOUT': '86400', 04:18:06 INFO - 'USER': 'cltbld', 04:18:06 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', 04:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:06 INFO - '_': '/tools/buildbot/bin/python'} 04:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:18:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:18:08 INFO - Installing collected packages: mozsystemmonitor 04:18:08 INFO - Running setup.py install for mozsystemmonitor 04:18:08 INFO - Successfully installed mozsystemmonitor 04:18:08 INFO - Cleaning up... 04:18:08 INFO - Return code: 0 04:18:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:08 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 0x7fc602014c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c67b70>, '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 0x2cb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9250>, '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': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', '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 04:18:08 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 04:18:08 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 04:18:08 INFO - Using env: {'DISPLAY': ':0', 04:18:08 INFO - 'HOME': '/home/cltbld', 04:18:08 INFO - 'LANG': 'en_US.UTF-8', 04:18:08 INFO - 'LANGUAGE': 'en_US:en', 04:18:08 INFO - 'LOGNAME': 'cltbld', 04:18:08 INFO - 'MAIL': '/var/mail/cltbld', 04:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:08 INFO - 'MOZ_NO_REMOTE': '1', 04:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:08 INFO - 'NO_EM_RESTART': '1', 04:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:08 INFO - 'PWD': '/builds/slave/test', 04:18:08 INFO - 'SHELL': '/bin/bash', 04:18:08 INFO - 'SHLVL': '1', 04:18:08 INFO - 'TERM': 'linux', 04:18:08 INFO - 'TMOUT': '86400', 04:18:08 INFO - 'USER': 'cltbld', 04:18:08 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', 04:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:08 INFO - '_': '/tools/buildbot/bin/python'} 04:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:09 INFO - Downloading/unpacking blobuploader==1.2.4 04:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:18:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:18:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:18:10 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 04:18:10 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 04:18:10 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 04:18:10 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 04:18:10 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 04:18:10 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 04:18:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:18:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:18: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 04:18: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 04:18: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 04:18: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 04:18: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 04:18: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 04:18:11 INFO - Downloading docopt-0.6.1.tar.gz 04:18:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:18:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:18:11 INFO - Running setup.py install for blobuploader 04:18:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:18:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:18:11 INFO - Running setup.py install for requests 04:18:11 INFO - Running setup.py install for docopt 04:18:11 INFO - Successfully installed blobuploader requests docopt 04:18:11 INFO - Cleaning up... 04:18:11 INFO - Return code: 0 04:18:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18: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')]} 04:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18: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')]} 04:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:11 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 0x7fc602014c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c67b70>, '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 0x2cb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9250>, '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': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', '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 04:18:11 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 04:18:11 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 04:18:11 INFO - Using env: {'DISPLAY': ':0', 04:18:11 INFO - 'HOME': '/home/cltbld', 04:18:11 INFO - 'LANG': 'en_US.UTF-8', 04:18:11 INFO - 'LANGUAGE': 'en_US:en', 04:18:11 INFO - 'LOGNAME': 'cltbld', 04:18:11 INFO - 'MAIL': '/var/mail/cltbld', 04:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:11 INFO - 'MOZ_NO_REMOTE': '1', 04:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:11 INFO - 'NO_EM_RESTART': '1', 04:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:12 INFO - 'PWD': '/builds/slave/test', 04:18:12 INFO - 'SHELL': '/bin/bash', 04:18:12 INFO - 'SHLVL': '1', 04:18:12 INFO - 'TERM': 'linux', 04:18:12 INFO - 'TMOUT': '86400', 04:18:12 INFO - 'USER': 'cltbld', 04:18:12 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', 04:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:12 INFO - '_': '/tools/buildbot/bin/python'} 04:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:12 INFO - Running setup.py (path:/tmp/pip-P7ySgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:12 INFO - Running setup.py (path:/tmp/pip-ku4bCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:12 INFO - Running setup.py (path:/tmp/pip-jUKHEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:12 INFO - Running setup.py (path:/tmp/pip-ZIpvrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:12 INFO - Running setup.py (path:/tmp/pip-OuGHyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:12 INFO - Running setup.py (path:/tmp/pip-f6v9fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:12 INFO - Running setup.py (path:/tmp/pip-XG8mVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:12 INFO - Running setup.py (path:/tmp/pip-cINkwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:12 INFO - Running setup.py (path:/tmp/pip-gLBipZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:12 INFO - Running setup.py (path:/tmp/pip-HfZVPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:12 INFO - Running setup.py (path:/tmp/pip-PLVe00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:12 INFO - Running setup.py (path:/tmp/pip-6TCxjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:13 INFO - Running setup.py (path:/tmp/pip-vORiiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:13 INFO - Running setup.py (path:/tmp/pip-LNdZiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:13 INFO - Running setup.py (path:/tmp/pip-GOWtDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:13 INFO - Running setup.py (path:/tmp/pip-PQMZ3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:13 INFO - Running setup.py (path:/tmp/pip-yhOSZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:18:13 INFO - Running setup.py install for manifestparser 04:18:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:18:13 INFO - Running setup.py install for mozcrash 04:18:13 INFO - Running setup.py install for mozdebug 04:18:13 INFO - Running setup.py install for mozdevice 04:18:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:18:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:18:13 INFO - Running setup.py install for mozfile 04:18:13 INFO - Running setup.py install for mozhttpd 04:18:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Running setup.py install for mozinfo 04:18:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Running setup.py install for mozInstall 04:18:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Running setup.py install for mozleak 04:18:14 INFO - Running setup.py install for mozlog 04:18:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Running setup.py install for moznetwork 04:18:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Running setup.py install for mozprocess 04:18:14 INFO - Running setup.py install for mozprofile 04:18:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Running setup.py install for mozrunner 04:18:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:18:14 INFO - Running setup.py install for mozscreenshot 04:18:14 INFO - Running setup.py install for moztest 04:18:15 INFO - Running setup.py install for mozversion 04:18:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:18:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:18:15 INFO - Cleaning up... 04:18:15 INFO - Return code: 0 04:18:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fc602014c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c67b70>, '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 0x2cb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9250>, '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': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', '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 04:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 04:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 04:18:15 INFO - Using env: {'DISPLAY': ':0', 04:18:15 INFO - 'HOME': '/home/cltbld', 04:18:15 INFO - 'LANG': 'en_US.UTF-8', 04:18:15 INFO - 'LANGUAGE': 'en_US:en', 04:18:15 INFO - 'LOGNAME': 'cltbld', 04:18:15 INFO - 'MAIL': '/var/mail/cltbld', 04:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:15 INFO - 'MOZ_NO_REMOTE': '1', 04:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:15 INFO - 'NO_EM_RESTART': '1', 04:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:15 INFO - 'PWD': '/builds/slave/test', 04:18:15 INFO - 'SHELL': '/bin/bash', 04:18:15 INFO - 'SHLVL': '1', 04:18:15 INFO - 'TERM': 'linux', 04:18:15 INFO - 'TMOUT': '86400', 04:18:15 INFO - 'USER': 'cltbld', 04:18:15 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', 04:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:15 INFO - '_': '/tools/buildbot/bin/python'} 04:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:15 INFO - Running setup.py (path:/tmp/pip-ixXA3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:15 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)) 04:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:15 INFO - Running setup.py (path:/tmp/pip-iXHl3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:15 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)) 04:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:15 INFO - Running setup.py (path:/tmp/pip-hXvi3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:15 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)) 04:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:15 INFO - Running setup.py (path:/tmp/pip-N_HdQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:15 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)) 04:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:15 INFO - Running setup.py (path:/tmp/pip-wq4YJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:15 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)) 04:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:15 INFO - Running setup.py (path:/tmp/pip-377b33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:15 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)) 04:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:15 INFO - Running setup.py (path:/tmp/pip-Os2jPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:15 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)) 04:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:15 INFO - Running setup.py (path:/tmp/pip-efjBoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:15 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)) 04:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:16 INFO - Running setup.py (path:/tmp/pip-A1BB0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:16 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)) 04:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:16 INFO - Running setup.py (path:/tmp/pip-xXb6b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:16 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)) 04:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:16 INFO - Running setup.py (path:/tmp/pip-8kgR1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:16 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)) 04:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:16 INFO - Running setup.py (path:/tmp/pip-5uLHVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:16 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)) 04:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:16 INFO - Running setup.py (path:/tmp/pip-nvrLm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:16 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)) 04:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:16 INFO - Running setup.py (path:/tmp/pip-Yv1NVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:16 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)) 04:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:16 INFO - Running setup.py (path:/tmp/pip-imx45M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:16 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)) 04:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:16 INFO - Running setup.py (path:/tmp/pip-fyR_eQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:16 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)) 04:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:16 INFO - Running setup.py (path:/tmp/pip-U1jGXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:16 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)) 04:18:16 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)) 04:18:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:18:16 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)) 04:18:16 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)) 04:18:16 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)) 04:18:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:18 INFO - Downloading blessings-1.5.1.tar.gz 04:18:18 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 04:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:18:18 INFO - Installing collected packages: blessings 04:18:18 INFO - Running setup.py install for blessings 04:18:18 INFO - Successfully installed blessings 04:18:18 INFO - Cleaning up... 04:18:18 INFO - Return code: 0 04:18:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:18:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:18 INFO - Reading from file tmpfile_stdout 04:18:18 INFO - Current package versions: 04:18:18 INFO - argparse == 1.2.1 04:18:18 INFO - blessings == 1.5.1 04:18:18 INFO - blobuploader == 1.2.4 04:18:18 INFO - docopt == 0.6.1 04:18:18 INFO - manifestparser == 1.1 04:18:18 INFO - mozInstall == 1.12 04:18:18 INFO - mozcrash == 0.16 04:18:18 INFO - mozdebug == 0.1 04:18:18 INFO - mozdevice == 0.47 04:18:18 INFO - mozfile == 1.2 04:18:18 INFO - mozhttpd == 0.7 04:18:18 INFO - mozinfo == 0.9 04:18:18 INFO - mozleak == 0.1 04:18:18 INFO - mozlog == 3.1 04:18:18 INFO - moznetwork == 0.27 04:18:18 INFO - mozprocess == 0.22 04:18:18 INFO - mozprofile == 0.27 04:18:18 INFO - mozrunner == 6.11 04:18:18 INFO - mozscreenshot == 0.1 04:18:18 INFO - mozsystemmonitor == 0.0 04:18:18 INFO - moztest == 0.7 04:18:18 INFO - mozversion == 1.4 04:18:18 INFO - psutil == 3.1.1 04:18:18 INFO - requests == 1.2.3 04:18:18 INFO - wsgiref == 0.1.2 04:18:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fc602014c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c21900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c67b70>, '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 0x2cb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9250>, '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': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', '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 04:18:18 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 04:18:18 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 04:18:18 INFO - Using env: {'DISPLAY': ':0', 04:18:18 INFO - 'HOME': '/home/cltbld', 04:18:18 INFO - 'LANG': 'en_US.UTF-8', 04:18:18 INFO - 'LANGUAGE': 'en_US:en', 04:18:18 INFO - 'LOGNAME': 'cltbld', 04:18:18 INFO - 'MAIL': '/var/mail/cltbld', 04:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:18 INFO - 'MOZ_NO_REMOTE': '1', 04:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:18 INFO - 'NO_EM_RESTART': '1', 04:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:18 INFO - 'PWD': '/builds/slave/test', 04:18:18 INFO - 'SHELL': '/bin/bash', 04:18:18 INFO - 'SHLVL': '1', 04:18:18 INFO - 'TERM': 'linux', 04:18:18 INFO - 'TMOUT': '86400', 04:18:18 INFO - 'USER': 'cltbld', 04:18:18 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', 04:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:18 INFO - '_': '/tools/buildbot/bin/python'} 04:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:18 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)) 04:18:18 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)) 04:18:18 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)) 04:18:18 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)) 04:18:18 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)) 04:18:18 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)) 04:18:18 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)) 04:18:18 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)) 04:18:18 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)) 04:18:18 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)) 04:18:18 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)) 04:18:18 INFO - Cleaning up... 04:18:19 INFO - Return code: 0 04:18:19 INFO - Running post-action listener: _resource_record_post_action 04:18:19 INFO - Running post-action listener: _start_resource_monitoring 04:18:19 INFO - Starting resource monitoring. 04:18:19 INFO - ##### 04:18:19 INFO - ##### Running install step. 04:18:19 INFO - ##### 04:18:19 INFO - Running pre-action listener: _resource_record_pre_action 04:18:19 INFO - Running main action method: install 04:18:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:19 INFO - Reading from file tmpfile_stdout 04:18:19 INFO - Detecting whether we're running mozinstall >=1.0... 04:18:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:18:19 INFO - Reading from file tmpfile_stdout 04:18:19 INFO - Output received: 04:18:19 INFO - Usage: mozinstall [options] installer 04:18:19 INFO - Options: 04:18:19 INFO - -h, --help show this help message and exit 04:18:19 INFO - -d DEST, --destination=DEST 04:18:19 INFO - Directory to install application into. [default: 04:18:19 INFO - "/builds/slave/test"] 04:18:19 INFO - --app=APP Application being installed. [default: firefox] 04:18:19 INFO - mkdir: /builds/slave/test/build/application 04:18:19 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'] 04:18:19 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 04:18:33 INFO - Reading from file tmpfile_stdout 04:18:33 INFO - Output received: 04:18:33 INFO - /builds/slave/test/build/application/firefox/firefox 04:18:33 INFO - Running post-action listener: _resource_record_post_action 04:18:33 INFO - ##### 04:18:33 INFO - ##### Running run-tests step. 04:18:33 INFO - ##### 04:18:33 INFO - Running pre-action listener: _resource_record_pre_action 04:18:33 INFO - Running main action method: run_tests 04:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:18:33 INFO - Python 2.7.3 04:18:33 INFO - Return code: 0 04:18:33 INFO - grabbing minidump binary from tooltool 04:18: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')]} 04:18:33 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 0x2c67b70>, '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 0x2cb8dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cb9250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:18:33 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 04:18:33 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 04:18:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:18:33 INFO - Return code: 0 04:18:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:18:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:18:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:18:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:18:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:18:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test/build 04:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 04:18:33 INFO - Using env: {'DISPLAY': ':0', 04:18:33 INFO - 'HOME': '/home/cltbld', 04:18:33 INFO - 'LANG': 'en_US.UTF-8', 04:18:33 INFO - 'LANGUAGE': 'en_US:en', 04:18:33 INFO - 'LOGNAME': 'cltbld', 04:18:33 INFO - 'MAIL': '/var/mail/cltbld', 04:18:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:18:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:33 INFO - 'MOZ_NO_REMOTE': '1', 04:18:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:33 INFO - 'NO_EM_RESTART': '1', 04:18:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:33 INFO - 'PWD': '/builds/slave/test', 04:18:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:18:33 INFO - 'SHELL': '/bin/bash', 04:18:33 INFO - 'SHLVL': '1', 04:18:33 INFO - 'TERM': 'linux', 04:18:33 INFO - 'TMOUT': '86400', 04:18:33 INFO - 'USER': 'cltbld', 04:18:33 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478', 04:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:33 INFO - '_': '/tools/buildbot/bin/python'} 04:18:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 04:18:33 INFO - mozversion INFO | application_buildid: 20151124025732 04:18:33 INFO - mozversion INFO | application_changeset: c6893ed724af1209d22833aa68c740b35d926b9b 04:18:33 INFO - mozversion INFO | application_display_name: Nightly 04:18:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:18:33 INFO - mozversion INFO | application_name: Firefox 04:18:33 INFO - mozversion INFO | application_remotingname: firefox 04:18:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:18:33 INFO - mozversion INFO | application_vendor: Mozilla 04:18:33 INFO - mozversion INFO | application_version: 45.0a1 04:18:33 INFO - mozversion INFO | platform_buildid: 20151124025732 04:18:33 INFO - mozversion INFO | platform_changeset: c6893ed724af1209d22833aa68c740b35d926b9b 04:18:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:18:33 INFO - mozversion INFO | platform_version: 45.0a1 04:18:33 INFO - 2015-11-24 04:18:33,827 DEBUG : using testdate: 1448367513 04:18:33 INFO - 2015-11-24 04:18:33,827 DEBUG : actual date: 1448367513 04:18:33 INFO - 2015-11-24 04:18:33,836 INFO : starting webserver on 'localhost:37854' 04:18:33 INFO - 2015-11-24 04:18:33,837 INFO : Starting test suite talos-linux64-ix-008 04:18:33 INFO - 2015-11-24 04:18:33,837 INFO : Starting test dromaeo_css 04:18:33 INFO - 2015-11-24 04:18:33,837 DEBUG : operating with platform_type : linux_ 04:18:33 INFO - 2015-11-24 04:18:33,838 INFO : Initialising browser for dromaeo_css test... 04:18:33 INFO - 2015-11-24 04:18:33,851 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXkTXvQ/profile http://localhost:37854/getInfo.html 04:18:37 INFO - 2015-11-24 04:18:37,851 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:18:37 INFO - 2015-11-24 04:18:37,851 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:18:37 INFO - 2015-11-24 04:18:37,851 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:18:37 INFO - 2015-11-24 04:18:37,851 DEBUG : BROWSER_OUTPUT: __metrics 04:18:38 INFO - 2015-11-24 04:18:38,129 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:18:39 INFO - 2015-11-24 04:18:39,320 INFO : Browser initialized. 04:18:39 INFO - 2015-11-24 04:18:39,321 INFO : Running cycle 1/1 for dromaeo_css test... 04:18:39 INFO - 2015-11-24 04:18:39,321 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXkTXvQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:18:51 INFO - 2015-11-24 04:18:51,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 142143488 04:18:51 INFO - 2015-11-24 04:18:51,280 DEBUG : BROWSER_OUTPUT: 04:19:42 INFO - 2015-11-24 04:19:42,554 DEBUG : BROWSER_OUTPUT: 1448367582553 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] 04:21:55 INFO - 2015-11-24 04:21:55,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37854/tests/dromaeo/cssquery-ext.html) 04:21:56 INFO - 2015-11-24 04:21:56,208 DEBUG : BROWSER_OUTPUT: RSS: Main: 254742528 04:21:56 INFO - 2015-11-24 04:21:56,208 DEBUG : BROWSER_OUTPUT: 04:24:58 INFO - 2015-11-24 04:24:58,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-ext.html (next: http://localhost:37854/tests/dromaeo/cssquery-jquery.html) 04:24:59 INFO - 2015-11-24 04:24:59,327 DEBUG : BROWSER_OUTPUT: RSS: Main: 221085696 04:24:59 INFO - 2015-11-24 04:24:59,327 DEBUG : BROWSER_OUTPUT: 04:28:01 INFO - 2015-11-24 04:28:01,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37854/tests/dromaeo/cssquery-mootools.html) 04:28:02 INFO - 2015-11-24 04:28:02,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 216178688 04:28:02 INFO - 2015-11-24 04:28:02,042 DEBUG : BROWSER_OUTPUT: 04:31:03 INFO - 2015-11-24 04:31:03,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37854/tests/dromaeo/cssquery-prototype.html) 04:31:04 INFO - 2015-11-24 04:31:04,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 207687680 04:31:04 INFO - 2015-11-24 04:31:04,551 DEBUG : BROWSER_OUTPUT: 04:34:07 INFO - 2015-11-24 04:34:07,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37854/tests/dromaeo/cssquery-yui.html) 04:34:07 INFO - 2015-11-24 04:34:07,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 207106048 04:34:07 INFO - 2015-11-24 04:34:07,864 DEBUG : BROWSER_OUTPUT: 04:37:10 INFO - 2015-11-24 04:37:10,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/dromaeo/cssquery-yui.html (next: http://localhost:37854/tests/dromaeo/cssquery-dojo.html) 04:37:10 INFO - 2015-11-24 04:37:10,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 211984384 04:37:10 INFO - 2015-11-24 04:37:10,611 DEBUG : BROWSER_OUTPUT: 04:37:10 INFO - 2015-11-24 04:37:10,611 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:37:10 INFO - 2015-11-24 04:37:10,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:37:10 INFO - 2015-11-24 04:37:10,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:37:10 INFO - 2015-11-24 04:37:10,612 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:37:10 INFO - 2015-11-24 04:37:10,612 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2607.3742301847556;2709.701932787393;2731.508328500869;2740.698523162453;2748.725127487251;4559.954400456003;4673.3223682566;4676.672632915697;4741.312509686093;4745.3593764841735;4598;4689.437267527901;4707.082118986799;4733.502982186872;4750.762461876901;4228.112096459748;4304.268274393345;4316.805743741539;4347.760873151976;4402.449693788277;4300.548442413548;4341.413909122275;4387.890302742425;4395.846145384912;4406.096750166208;4133.318002529579;4227.852025179104;4349.608535231812;4392.670549708752;4414.161309351229;4288.76411797351;4302.526722060571;4313.741175529478;4313.870583882489;4316.503602085769;4289.270823959934;4290.635295999844;4292.248856450109;4292.763897985609;4293.785310734451;4528.818847246106;4649.209634362167;4650.581447669692;4671.11248862715;4671.883202919954;5052.4189718182515;5053.343065401511;5061.16490779021;5061.316722242487;5102.081625307444;4849.612031037508;5064.949350506485;5085.974570127126;5090.414602320707;5092.10888094582;4640.907181856378;4656.650751193674;4676.95323046772;4724.71651700899;4786.545278198566;5127.3847138343635;5159.793608255703;5194.298769666122;5196.350456192976;5196.68819870809;4733.976330118397;4988.27669987857;4993.750312484434;4997.175466048134;5011.3986321640905;4893.975530122327;4953.950460495421;4966.15575352191;4974.1543937530705;4990.675606085593;4997.150484417658;5002.874928126826;5016.924746128811;5017.422996355466;5061.316722242524;4746.359241502422;4986.376702912136;4990.326305948651;4993.450720420751;5038;4093.570175131628;4133.111381053028;4146.5853414658895;4154.833806647761;4179.2477354076555;3681.889543313705;3685.963140368562;3689.870854520079;3711.721620878445;3716.7398282120535;4191.790410479525;4336.891577710582;4369;4369.956300437018;4410.184115938561;4903.141950158708;4937.481564435754;4964.478729733398;4965.528274813887;5021.121303771825;4332.090261045153;4353.499347575006;4365.694401391872;4383.3424986251675;4423.402840616475;4288.335308027261;4484.0583477469445;4487.147441986012;4493.078918821634;4512.165249428866;4650.697704649187;4705.717656940595;4724.905501889874;4737.549932756383;4772.5227477252;4977.377827771528;5002.874928126826;5007.173816320266;5009.524095210949;5053.722045287397;4740.715557066587;4741.170295198395;4751.738654374042;4756.738379389167;4790.976045119752;4757.286407038971;4824.179889418737;4840.951590484191;4851.927221091757;4926.285688575208;5055.418626857811;5068.569171620454;5073.162928116967;5079.339685840817;5123.948760512347;4906.754662266943;4913.28757330178;4918;4920.753962301942;4963.205887058053;4684.1334353144775;4795.640326975421;4801.063792560417;4820.084184005028;4954.1825598775795;4726.976365118152;4756.785944632431;4757.405324334458;4758.1435341638835;4806.303086052572;4901.117798796251;4906.656534042583;4909.656324057281;4912.140375434214;4913.70517768935;4586.151561961048;4656.93014604788;4705.411823522059;4705.976470117627;4756.785944632431 04:37:10 INFO - 2015-11-24 04:37:10,612 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.6493109341117;565.6634302589963;569.3225062176011;581.052883799407;583.9854003649908;25921.48157036858;26546.734532654667;26589.202323930265;36782.448263276005;37751.24497510048;40584;41130.17739645213;41167.38248926261;41202.587974120324;41214.793926030405;7828.882566761489;8010.198980101973;8011.0386753589655;8013.839723205532;8019.839603207933;7041.084658994324;7215.13418389794;10222.795544089115;10527.578896844156;10567.682969510926;10151.898481015169;10252.282340236186;10253.128484078863;10260.589576416935;10272.435016074112;10111.747206319827;10183.643572474928;10209.897901021006;10214.540345684461;10222.744431389201;9962.850557241647;10078.79842403155;10087.798244035152;10094.29339946204;10096.29325947184;37401;38007;38025.61974380248;38030.80984595059;38082;2740.1231605886123;2743.6021776842445;2852.1586132090874;2924.0642994241853;3455.3262113887804;28422.715772842213;28695.28261793451;28772.712272877212;28899;29031.41937161266;3341.6491268416707;3363.2432702641954;3386.1703882548686;3391.2708767614836;3500.2299494111508;215755;216932.9153354239;217718;217756;217878;38302.61697382991;39010.80494597566;55152;55786.721066394406;55964.720176398856;64552.35447645463;65708.34291657117;66094;66099;66165.33834661687;13044.282564458856;13245;13252.536161234504;13258.867411325957;13268.668283292802;8470.449420787629;8611.956940215385;8661.437006594677;8662.523561204194;10029.448380339152;19520;19873.60252794965;19969.700454493195;20004.399868003984;20077.899610501852;6899.827504312432;7074.823129421703;7158.2483839197175;7200.963995179991;7249.710011599583;837.8031162676766;847.7372014675346;884.6726711116928;899.4513346858411;903.3315346643436;26585.86707066491;26705.3323666906;27108;27191.184264472096;27197;913.255696607263;945.3004776465366;978.3542861711236;981.1071924548627;1022.1311884897777;13111.2133272004;13456.192628442324;13521.121127126706;13662.521811736542;13686.589402317946;254906;260513;261362;261952;262027;45773.54226457759;45975.77012114918;46149.76925115353;46182.538174617825;46194.76902615465;1175.2697868460898;1191.0531127753457;1195.3306148556835;1198.952041918331;1202.0924202227088;23928.88035559811;24267.39331516726;24595.631065533675;24744.762761862195;24812.50374992526;37291.254174915804;37743.81128094342;38276.80861595674;38320.23359532738;38334;222033;242236;243855;244159;244255;20351.4912127198;28316.292092697848;28709.28226794347;28954.42091158123;29098.418031638827;33831;33894.83052584721;34048;34772.82613587017;34984.12539686528;29188;29450.263743406587;29535.113946581638;30047.849760751058;32582.34835303328;24335.26994190177;29684.851575741985;31686.841565792023;32945;35108;32276.515852261764;32765.344693106483;32979;33033.17417064593;33060.504092439114;28940.56589151122;29265.853670732362;29936.56660506416;30105.247368815955;32146.87485937981;23483.647745284175;23504.76495235026;23873;23895.283141505784;23945.16191933274 04:37:10 INFO - 2015-11-24 04:37:10,612 DEBUG : BROWSER_OUTPUT: |2;jquery.html;325.8659863674413;334.6319049046049;337.6808915574781;338.6562638921495;341.8290854572714;11628.941855290734;12068.396580170978;14667.19330436827;15048.247587620615;15384.307706153222;11237.269577477458;13149.802752958689;13531;14584.416623335053;14657.267136643179;4459.308807134891;4561.954380456186;4585.151746926813;4586.4266966629175;4812.278158276252;3381.0533050745707;3489.145159435942;4977.800887964495;5000.074986127578;5187.247849061884;5118.129917913945;5141.82003629873;5146.099432599299;5158.277841102249;5168.560672342836;4968.627352948525;5145.922811157836;5522.972385138049;5783.566232532577;5791.855203619901;5106.9489305106845;5108.948910510884;5114.897702045975;5115.437301896788;5118.795248190068;10988.725281868017;13846.723065538632;16575.088370139638;16747.743919206107;17243;1656.3705791799039;1736.6787144378332;1797.9011154386503;1856.8143185681458;1898.69620860663;8701.390902636818;8796.780080497974;8822.823543529094;8846.469211847245;9052.321075919266;1692.7460880867845;1730.5414065272712;1753.973690394645;1759.8504127149208;1819.0995457248614;53169.73415132938;55299.723501382636;56195;56513.71743141299;57202.7139864298;9643.662471813454;9675.467849268358;9678.032196780267;9705.272104592184;9706.320557560903;12218.511259549696;12242.326672033123;12270.202436841577;12281.508739650313;12290.262584244794;6327.715252813542;6424.71088801005;6482.35176482348;6525.967370163119;6526.086347911296;6006.579539432285;6325;6373.553851230369;6387.393197646216;6405.039244113327;4032.294348489003;4087.3460246361033;4121.9381709274385;4156.937645935313;4196.118815048874;1490.6646004649085;1526.5038862369775;1599.9200039997954;1659.7676325314465;1721.6556688662317;370.15604421918067;371.9553653561536;414.7698027594714;774.2876553570728;874.8775171475999;8915;9044.81910361789;9084.727458176265;9509.952450237704;9544.093311135432;363.81990914497493;372.92541491701223;378.9696824254053;379.2112406195163;380.8724077434035;4853.2720091985775;5316.6544174628525;5330.466953304638;5356.946430535645;5368.543673787772;445360;447868;454333;456423;463086;66291.66854165794;67956.320436795;68290;68631.65684171548;68651.65674171597;444.9911001780011;445.20753059554045;448.68591985610203;449.5706600196804;1013.2552573858061;13243.66890827737;13869.306534673427;13913.51302704441;13967.092139010932;13991.510297139552;28609.284767880137;29072.41855162927;29911.401771964003;31814;32831.83584082064;37203.441948371335;37401.81299093487;38361.616383835804;38371.6162838368;38944.61055389523;8664.263537599374;8673.522956237468;8755.387122901337;8756.649734010569;8884.866726998971;10227.84658230142;15033.173175475455;15397.84602154009;15566.455174068853;15738.606534836721;12710.936445317715;13025;13054.34728263602;13217.735645286848;13665.111767735065;12450.25298482094;12631.87368126307;12813.231206127663;13027.413766380725;13044.739105218032;13249.337533123113;13286.402111904794;13378.197308161542;13461.394237259152;13589.932050340081;7010.719571217298;7895.960520197362;8540.27407670355;8606.26846718036;8783.604737786687;9115.316351273814;9206.033366496422;10336.276460647683;13312.866871331164;13411 04:37:10 INFO - 2015-11-24 04:37:10,612 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1475.5942115918128;1574.2915687940426;1641.7947756530434;1665.9416920407796;1666.6000159961604;5837.1536127261525;5992.34084250732;6443.710033048518;6621.503387245958;6631.303713110126;6234.314225435199;6470.579412338195;6503.414692677658;6523.575967562105;6540.901886471706;2026.0275067967384;2057.084597354178;2060.8660437071544;2061.9690704639443;2062.6390381683223;1716.1848122141946;1743.8953662780211;1764.4265613675543;1765.4703588923335;1765.7704498415187;1967.9704804427945;2009.437357539891;2011.9195232190696;2012.2152360579387;2012.4868158619531;1989.1744925855896;1996.131682718015;2009.2364901337544;2011.6982452632149;2068.2347531413325;2052.230413594902;2084.520560271146;2085.3431169181813;2085.843561732876;2086.113401804227;6839.0425340452375;6851.520393572452;6865.347791959756;6895.689693963784;6919.619420931846;3853.7880416577077;3931.7247792654525;3932.6067393260446;3983.462232598591;3997.4603428537066;2669.386041210513;2727.699953005168;2735.575985722216;2737.343037670945;2752.3944732158893;853.2491407561369;862.0948004595213;890.7639475538988;897.4032268541412;918.7381596245104;9106.726798196065;9123.361364704473;9125.5437228139;9144.54277286133;9153.496557689325;3751.1372384351753;3790.1282704977457;3813.1992281620614;3830.4637350770913;3834.0798208430333;7829.451938364374;7838.764837054898;7844.215578442224;7846.058472983279;7898.9210107899335;4031.1534577739003;4057.4928133983253;4071.185762847442;4074.9388759168637;4088.7751173685733;3574.982125089358;3652.5251717276583;3680.190358121209;3683.9079023024638;3687.0966613179407;3315.1877789941136;3317.0546394277517;3319.2199833039217;3351.396748585278;3354.547136136639;881.9603117859712;907.464595888429;1003.1423133221136;1011.4133802394593;1018.1854516386861;850.4642075492524;864.762190397633;866.5797088412115;911.280088729896;1001.4191768774239;6366.236051673736;6522.771702990372;6524.478041756648;6543.901841472381;6559.048937903977;1009.8586197932295;1026.2816028779885;1031.5718976624617;1036.5439206749006;1037.8080055189814;4899.118158731391;4960.70235785854;4968.975155124273;4971.90056198874;4976.2038073908;7927.207279272026;8034.035915690155;8132.837343253102;8160.551169685724;8215.712450064339;7977;8032.839343213103;8054.436189466798;8081.353491720648;8084.797880053045;6304.18045654062;6395;6418.133551970424;6431.196100487439;6441.388068133613;6037.63774173551;6202.81391558254;6234.160922527774;6236.532260080421;6253.280872699698;7160.248173941661;7320.707171713072;7371.852562948819;7376.373008294355;7378.040854688856;7326.413886889142;7434.293742094493;7533.924660753322;7546.547207167588;7618.695252190072;5918.378570250062;5982.341942386247;5983.910241346471;5986.730597123053;5992.760289588542;6297.905531417124;6510.902336464862;6555.573887697285;6574.506911981525;6581.6709164542535;6114.174586430953;6140.232470941132;6171.753129874754;6195.535334849995;6212.534059945432;5246.632735708617;5430.239766432624;5863.560232982458;6036.849078773066;6106.542009349406;6141.048137538689;6191.071339299141;6202.131701561875;6217.658028808459;6219.595726277777;5698.772049117989;5717.914231286451;5739.024365857731;5740.483356497935;5741.74162162712;5840.591158619026;5848.64908105515;5851.1223316502865;5855.59010869235;5870.14882841994 04:37:10 INFO - 2015-11-24 04:37:10,612 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.87085488667316;311.3694768094608;314.0860097117389;314.1799902255114;317.6236160150224;5300.416954135047;5398.055340315449;5399.78400863965;5414.675119492828;5440.972795136024;5317.149256119022;5337.546308563767;5340.866478338044;5342.732863356826;5350.3312085989255;3922.941155882664;4022.4167495713104;4170.749755014709;4174.290370636999;4181.289180839264;4027.617376349242;4160.209560183571;4160.583941605845;4163.104932439525;4176.164767046587;4112.527059388164;4129.855455059073;4132.2355364257555;4132.2768515509815;4136.917261654765;3880.1463677990796;3954.7429417088083;3964.385520244338;4020.537638171589;4121.155163191538;3531.523244362004;3533.063738109403;3539.929201415983;3595.6404359564094;3634.8005158297697;5046.19260918255;5108.310378098983;5136.871578210537;5140.820071297524;5142.254373115878;4730.526947305277;4737.052589482083;4743.383360163157;4746.477887432379;4750.334953106568;5405.18922161675;5575.916361254584;5593.496585307342;5599.048161812501;5599.804006859781;3899.74651647642;3902.024493876531;3908.687305015592;3912.256671232457;3912.8434862605463;5821.50517206038;5884.999550076497;5885.70571471429;5907.4683278505145;5907.556933230025;3989.68082553395;3996.140829721624;3997.4803275574573;4001.5398229204015;4003.319435695939;4054.716169868081;4058.228936502055;4058.918821623551;4102.794860256975;4204.663626909901;4718.9292160617615;4769.833055843029;4771.5228477152;4772.5943294819635;4777;5613;5617.887642247132;5620.887582248332;5622.91565626516;5623.847111342165;1470.8014418053426;1495.7681559358316;1497.9925100374646;1498.1535432480614;1499.8650121489118;953.594722243044;1023.8105950399051;1025.1747343388495;1027.7790275090742;1046.1578429364436;4932.334134891816;4962.131626965267;4963.70217786934;4968.205087186105;4972.676776009548;5841.474267315962;5842.649441033552;5846.386129456346;5851.853703657443;5854.736536855767;4971.328870602495;4977.527134922177;4980.327655766425;4985.0029994000615;4990.675606085593;2895.8552072396296;2980.2698338907107;3021.773366997484;3125.6092988376454;3158.652548219694;5497.945020549823;5557.138643510262;5570.972145139248;5574.693391863487;5579.581531385163;6021.488173505213;6025.487833534199;6030.4572588467245;6033;6033.306169790442;5427.077396842467;5554.361248456398;5563.972180139073;5568.554515638739;5571.9442805571425;5870.354261031198;5870.882582348415;5878.764849406147;5880.941190588211;5881.206037184926;5734.082546792493;5735.340435849931;5737.340205876378;5740.167675687086;5744.0522313817755;5559.694216818114;5573.693446860461;5575.303087114111;5578.525825304732;5578.944210557843;3913;4023.5775243599;4036.6972477064924;4153.771542565188;4154.750714956991;5815.098659707752;5837.445442682938;5839.357670656309;5842.678652673973;5846.532277417711;5614.803481878114;5619.438056194348;5624.915626265528;5629.240052592848;5630.18362337467;5460.836174914759;5610.102383618601;5610.607257491936;5617.32592088952;5622.606417550732;5475.780968761205;5503.339599247955;5503.477169668875;5508.944910550843;5509.889802203853;5646.181303711021;5676.545876329967;5712.485876271156;5713.114467257582;5719.599628025998;5542.63972841764;5568.805091821767;5571.637843540157;5573.972130139324;5575.135853942646 04:37:10 INFO - 2015-11-24 04:37:10,613 DEBUG : BROWSER_OUTPUT: |5;yui.html;723.9058922340095;746.2500187311748;759.3735168485998;763.316831435865;781.4842204145265;10810.513526891289;10947.726306842333;10952.452377381129;10961.561537538499;10965.780684386307;10160.745981350452;11185.272957257794;11294.435278236097;12216.45025973831;12226.083043771709;757.8597959377519;772.656168005235;773.3928865840317;773.9845203095934;774.2528460036064;745.5712965045094;754.9660265288076;755.2900273742664;755.697720911637;755.9546427214357;774.8915151878741;785.505131766986;786.095989611948;786.1234723283554;786.2805532937384;777.3431450424439;777.7977725791307;778.1129512355918;778.3150827272021;778.385075790128;576.9884602307931;579.3829571506375;579.9101139323411;580.3384142078035;581.0238798817984;10967.451627418677;11051.28166669172;11053.336799792038;11075.778484430346;11120.55517779288;10756.19328550362;10940.56237750489;10943.56225750969;11116.61091861781;11249.887501124966;9302.441853488745;9419.764505887339;9451.763705907339;9458.196053335474;9516.666916657952;3129.796563223383;3175.6506784253716;3208.7593430492575;3246.5043580413567;3247.5778148840736;32699.182520436705;34134.6586534134;34507.13732156691;34513.48229776556;40056.19887602232;8668.60991255395;9179.082091790768;9288.62845486173;9401.388909720847;9546.856797148048;15357.923210383877;16170.676586468206;16217.837821621868;16273.918630406772;16433.506994790176;6215.627062376272;6293.590916590407;6309.621422714652;6415.871682566416;6481.48148148147;3301.6863397977154;3393.3552625001666;3397.320535892782;3406.6423025582453;3472.7048200903205;2617.2148355493277;2671.853048082335;2681;2681.3564744461187;2685.7582817546513;459.7494365570772;467.3013844302789;477.87575230440336;481.4295060353492;487.97072175669575;409.40022866500124;428.77703594131503;428.9163613095416;448.78458339996985;495.6357077547999;6683.189216304666;6809.727610895508;6814.93185068143;6901.75843845463;6915.481338899603;536.3510152715259;546.7457632201045;555.1977392667557;558.8602849287678;581.2385774635242;3275.5250488679008;3404.063882432351;3458.360203362386;3472.3228970350538;3500.6674365935705;50428.24357634639;51634.22548661773;51811.22283165756;51933.48066519362;52076;44045.33931991023;44866.55133448689;45014;45228.547714522436;45425.77287113609;34625.13437164091;40448.19103617911;40940.1811963759;41091.38362924558;41124.58875411267;7430.071241094864;7487.700491980259;7539.396848252236;7543.622818858926;7684.962530058594;32502.51246231261;33084.007479775646;33405.33189336248;33517.329653406305;33538.664613353554;35080.298394031466;36604.81697591495;42994.35508467313;43441.782791087106;43539.34690979574;8422.663093476192;9043.457392556467;9542.757451998636;9543.952280238555;9711.902880971382;10019.298649094493;10174.13519850821;10289.176865850864;10478.738031549272;10721.249512534048;9790.657326993522;9825.656102036395;9845.163161131097;9954.203663706741;9965.302428829913;9495.38280011797;9619.807603848023;9633.277504187354;9678.70963871085;9709.465979371202;9793.167580755715;9810.411375317504;9818.85271720939;9854.408735475894;9865.605375784888;7712.884306735516;7732.806679833049;7857.4499785014505;7952.6421311042295;8054.879176812469;7449.776506704808;7679.961600192187;7823.569703666353;7831.882521762064;7837.529748215125 04:37:10 INFO - 2015-11-24 04:37:10,613 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:37:10 INFO - 2015-11-24 04:37:10,613 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:37:10 INFO - 2015-11-24 04:37:10,613 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1015 04:37:10 INFO - 2015-11-24 04:37:10,613 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:37:10 INFO - 2015-11-24 04:37:10,613 DEBUG : BROWSER_OUTPUT: __startTimestamp1448368630605__endTimestamp 04:37:10 INFO - 2015-11-24 04:37:10,613 DEBUG : BROWSER_OUTPUT: 04:37:10 INFO - 2015-11-24 04:37:10,613 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:37:10 INFO - 2015-11-24 04:37:10,614 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:37:10 INFO - 2015-11-24 04:37:10,614 DEBUG : BROWSER_OUTPUT: 04:37:10 INFO - 2015-11-24 04:37:10,614 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4624.26 Median:4740.72 stddev:476.32 (10.0%) stddev-sans-first:450.74 04:37:10 INFO - 2015-11-24 04:37:10,614 DEBUG : BROWSER_OUTPUT: Values: 2607.4 2709.7 2731.5 2740.7 2748.7 4560.0 4673.3 4676.7 4741.3 4745.4 4598.0 4689.4 4707.1 4733.5 4750.8 4228.1 4304.3 4316.8 4347.8 4402.4 4300.5 4341.4 4387.9 4395.8 4406.1 4133.3 4227.9 4349.6 4392.7 4414.2 4288.8 4302.5 4313.7 4313.9 4316.5 4289.3 4290.6 4292.2 4292.8 4293.8 4528.8 4649.2 4650.6 4671.1 4671.9 5052.4 5053.3 5061.2 5061.3 5102.1 4849.6 5064.9 5086.0 5090.4 5092.1 4640.9 4656.7 4677.0 4724.7 4786.5 5127.4 5159.8 5194.3 5196.4 5196.7 4734.0 4988.3 4993.8 4997.2 5011.4 4894.0 4954.0 4966.2 4974.2 4990.7 4997.2 5002.9 5016.9 5017.4 5061.3 4746.4 4986.4 4990.3 4993.5 5038.0 4093.6 4133.1 4146.6 4154.8 4179.2 3681.9 3686.0 3689.9 3711.7 3716.7 4191.8 4336.9 4369.0 4370.0 4410.2 4903.1 4937.5 4964.5 4965.5 5021.1 4332.1 4353.5 4365.7 4383.3 4423.4 4288.3 4484.1 4487.1 4493.1 4512.2 4650.7 4705.7 4724.9 4737.5 4772.5 4977.4 5002.9 5007.2 5009.5 5053.7 4740.7 4741.2 4751.7 4756.7 4791.0 4757.3 4824.2 4841.0 4851.9 4926.3 5055.4 5068.6 5073.2 5079.3 5123.9 4906.8 4913.3 4918.0 4920.8 4963.2 4684.1 4795.6 4801.1 4820.1 4954.2 4727.0 4756.8 4757.4 4758.1 4806.3 4901.1 4906.7 4909.7 4912.1 4913.7 4586.2 4656.9 4705.4 4706.0 4756.8 04:37:10 INFO - 2015-11-24 04:37:10,614 DEBUG : BROWSER_OUTPUT: 04:37:10 INFO - 2015-11-24 04:37:10,614 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39839.78 Median:29492.69 stddev:62392.48 (211.6%) stddev-sans-first:62497.79 04:37:10 INFO - 2015-11-24 04:37:10,614 DEBUG : BROWSER_OUTPUT: Values: 556.6 565.7 569.3 581.1 584.0 25921.5 26546.7 26589.2 36782.4 37751.2 40584.0 41130.2 41167.4 41202.6 41214.8 7828.9 8010.2 8011.0 8013.8 8019.8 7041.1 7215.1 10222.8 10527.6 10567.7 10151.9 10252.3 10253.1 10260.6 10272.4 10111.7 10183.6 10209.9 10214.5 10222.7 9962.9 10078.8 10087.8 10094.3 10096.3 37401.0 38007.0 38025.6 38030.8 38082.0 2740.1 2743.6 2852.2 2924.1 3455.3 28422.7 28695.3 28772.7 28899.0 29031.4 3341.6 3363.2 3386.2 3391.3 3500.2 215755.0 216932.9 217718.0 217756.0 217878.0 38302.6 39010.8 55152.0 55786.7 55964.7 64552.4 65708.3 66094.0 66099.0 66165.3 13044.3 13245.0 13252.5 13258.9 13268.7 8470.4 8612.0 8661.4 8662.5 10029.4 19520.0 19873.6 19969.7 20004.4 20077.9 6899.8 7074.8 7158.2 7201.0 7249.7 837.8 847.7 884.7 899.5 903.3 26585.9 26705.3 27108.0 27191.2 27197.0 913.3 945.3 978.4 981.1 1022.1 13111.2 13456.2 13521.1 13662.5 13686.6 254906.0 260513.0 261362.0 261952.0 262027.0 45773.5 45975.8 46149.8 46182.5 46194.8 1175.3 1191.1 1195.3 1199.0 1202.1 23928.9 24267.4 24595.6 24744.8 24812.5 37291.3 37743.8 38276.8 38320.2 38334.0 222033.0 242236.0 243855.0 244159.0 244255.0 20351.5 28316.3 28709.3 28954.4 29098.4 33831.0 33894.8 34048.0 34772.8 34984.1 29188.0 29450.3 29535.1 30047.8 32582.3 24335.3 29684.9 31686.8 32945.0 35108.0 32276.5 32765.3 32979.0 33033.2 33060.5 28940.6 29265.9 29936.6 30105.2 32146.9 23483.6 23504.8 23873.0 23895.3 23945.2 04:37:10 INFO - 2015-11-24 04:37:10,614 DEBUG : BROWSER_OUTPUT: 04:37:10 INFO - 2015-11-24 04:37:10,614 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24365.05 Median:2268.35 stddev:74145.75 (3268.7%) stddev-sans-first:74331.77 04:37:10 INFO - 2015-11-24 04:37:10,615 DEBUG : BROWSER_OUTPUT: Values: 325.9 334.6 337.7 338.7 341.8 11628.9 12068.4 14667.2 15048.2 15384.3 11237.3 13149.8 13531.0 14584.4 14657.3 4459.3 4562.0 4585.2 4586.4 4812.3 3381.1 3489.1 4977.8 5000.1 5187.2 5118.1 5141.8 5146.1 5158.3 5168.6 4968.6 5145.9 5523.0 5783.6 5791.9 5106.9 5108.9 5114.9 5115.4 5118.8 10988.7 13846.7 16575.1 16747.7 17243.0 1656.4 1736.7 1797.9 1856.8 1898.7 8701.4 8796.8 8822.8 8846.5 9052.3 1692.7 1730.5 1754.0 1759.9 1819.1 53169.7 55299.7 56195.0 56513.7 57202.7 9643.7 9675.5 9678.0 9705.3 9706.3 12218.5 12242.3 12270.2 12281.5 12290.3 6327.7 6424.7 6482.4 6526.0 6526.1 6006.6 6325.0 6373.6 6387.4 6405.0 4032.3 4087.3 4121.9 4156.9 4196.1 1490.7 1526.5 1599.9 1659.8 1721.7 370.2 372.0 414.8 774.3 874.9 8915.0 9044.8 9084.7 9510.0 9544.1 363.8 372.9 379.0 379.2 380.9 4853.3 5316.7 5330.5 5356.9 5368.5 445360.0 447868.0 454333.0 456423.0 463086.0 66291.7 67956.3 68290.0 68631.7 68651.7 445.0 445.2 448.7 449.6 1013.3 13243.7 13869.3 13913.5 13967.1 13991.5 28609.3 29072.4 29911.4 31814.0 32831.8 37203.4 37401.8 38361.6 38371.6 38944.6 8664.3 8673.5 8755.4 8756.6 8884.9 10227.8 15033.2 15397.8 15566.5 15738.6 12710.9 13025.0 13054.3 13217.7 13665.1 12450.3 12631.9 12813.2 13027.4 13044.7 13249.3 13286.4 13378.2 13461.4 13589.9 7010.7 7896.0 8540.3 8606.3 8783.6 9115.3 9206.0 10336.3 13312.9 13411.0 04:37:10 INFO - 2015-11-24 04:37:10,615 DEBUG : BROWSER_OUTPUT: 04:37:10 INFO - 2015-11-24 04:37:10,615 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4738.26 Median:5985.32 stddev:2424.67 (40.5%) stddev-sans-first:2419.07 04:37:10 INFO - 2015-11-24 04:37:10,616 DEBUG : BROWSER_OUTPUT: Values: 1475.6 1574.3 1641.8 1665.9 1666.6 5837.2 5992.3 6443.7 6621.5 6631.3 6234.3 6470.6 6503.4 6523.6 6540.9 2026.0 2057.1 2060.9 2062.0 2062.6 1716.2 1743.9 1764.4 1765.5 1765.8 1968.0 2009.4 2011.9 2012.2 2012.5 1989.2 1996.1 2009.2 2011.7 2068.2 2052.2 2084.5 2085.3 2085.8 2086.1 6839.0 6851.5 6865.3 6895.7 6919.6 3853.8 3931.7 3932.6 3983.5 3997.5 2669.4 2727.7 2735.6 2737.3 2752.4 853.2 862.1 890.8 897.4 918.7 9106.7 9123.4 9125.5 9144.5 9153.5 3751.1 3790.1 3813.2 3830.5 3834.1 7829.5 7838.8 7844.2 7846.1 7898.9 4031.2 4057.5 4071.2 4074.9 4088.8 3575.0 3652.5 3680.2 3683.9 3687.1 3315.2 3317.1 3319.2 3351.4 3354.5 882.0 907.5 1003.1 1011.4 1018.2 850.5 864.8 866.6 911.3 1001.4 6366.2 6522.8 6524.5 6543.9 6559.0 1009.9 1026.3 1031.6 1036.5 1037.8 4899.1 4960.7 4969.0 4971.9 4976.2 7927.2 8034.0 8132.8 8160.6 8215.7 7977.0 8032.8 8054.4 8081.4 8084.8 6304.2 6395.0 6418.1 6431.2 6441.4 6037.6 6202.8 6234.2 6236.5 6253.3 7160.2 7320.7 7371.9 7376.4 7378.0 7326.4 7434.3 7533.9 7546.5 7618.7 5918.4 5982.3 5983.9 5986.7 5992.8 6297.9 6510.9 6555.6 6574.5 6581.7 6114.2 6140.2 6171.8 6195.5 6212.5 5246.6 5430.2 5863.6 6036.8 6106.5 6141.0 6191.1 6202.1 6217.7 6219.6 5698.8 5717.9 5739.0 5740.5 5741.7 5840.6 5848.6 5851.1 5855.6 5870.1 04:37:10 INFO - 2015-11-24 04:37:10,616 DEBUG : BROWSER_OUTPUT: 04:37:10 INFO - 2015-11-24 04:37:10,617 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4670.41 Median:5327.35 stddev:1376.62 (25.8%) stddev-sans-first:1340.90 04:37:10 INFO - 2015-11-24 04:37:10,618 DEBUG : BROWSER_OUTPUT: Values: 303.9 311.4 314.1 314.2 317.6 5300.4 5398.1 5399.8 5414.7 5441.0 5317.1 5337.5 5340.9 5342.7 5350.3 3922.9 4022.4 4170.7 4174.3 4181.3 4027.6 4160.2 4160.6 4163.1 4176.2 4112.5 4129.9 4132.2 4132.3 4136.9 3880.1 3954.7 3964.4 4020.5 4121.2 3531.5 3533.1 3539.9 3595.6 3634.8 5046.2 5108.3 5136.9 5140.8 5142.3 4730.5 4737.1 4743.4 4746.5 4750.3 5405.2 5575.9 5593.5 5599.0 5599.8 3899.7 3902.0 3908.7 3912.3 3912.8 5821.5 5885.0 5885.7 5907.5 5907.6 3989.7 3996.1 3997.5 4001.5 4003.3 4054.7 4058.2 4058.9 4102.8 4204.7 4718.9 4769.8 4771.5 4772.6 4777.0 5613.0 5617.9 5620.9 5622.9 5623.8 1470.8 1495.8 1498.0 1498.2 1499.9 953.6 1023.8 1025.2 1027.8 1046.2 4932.3 4962.1 4963.7 4968.2 4972.7 5841.5 5842.6 5846.4 5851.9 5854.7 4971.3 4977.5 4980.3 4985.0 4990.7 2895.9 2980.3 3021.8 3125.6 3158.7 5497.9 5557.1 5571.0 5574.7 5579.6 6021.5 6025.5 6030.5 6033.0 6033.3 5427.1 5554.4 5564.0 5568.6 5571.9 5870.4 5870.9 5878.8 5880.9 5881.2 5734.1 5735.3 5737.3 5740.2 5744.1 5559.7 5573.7 5575.3 5578.5 5578.9 3913.0 4023.6 4036.7 4153.8 4154.8 5815.1 5837.4 5839.4 5842.7 5846.5 5614.8 5619.4 5624.9 5629.2 5630.2 5460.8 5610.1 5610.6 5617.3 5622.6 5475.8 5503.3 5503.5 5508.9 5509.9 5646.2 5676.5 5712.5 5713.1 5719.6 5542.6 5568.8 5571.6 5574.0 5575.1 04:37:10 INFO - 2015-11-24 04:37:10,618 DEBUG : BROWSER_OUTPUT: 04:37:10 INFO - 2015-11-24 04:37:10,618 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11883.09 Median:541.55 stddev:13859.24 (2559.2%) stddev-sans-first:13872.79 04:37:10 INFO - 2015-11-24 04:37:10,618 DEBUG : BROWSER_OUTPUT: Values: 723.9 746.3 759.4 763.3 781.5 10810.5 10947.7 10952.5 10961.6 10965.8 10160.7 11185.3 11294.4 12216.5 12226.1 757.9 772.7 773.4 774.0 774.3 745.6 755.0 755.3 755.7 756.0 774.9 785.5 786.1 786.1 786.3 777.3 777.8 778.1 778.3 778.4 577.0 579.4 579.9 580.3 581.0 10967.5 11051.3 11053.3 11075.8 11120.6 10756.2 10940.6 10943.6 11116.6 11249.9 9302.4 9419.8 9451.8 9458.2 9516.7 3129.8 3175.7 3208.8 3246.5 3247.6 32699.2 34134.7 34507.1 34513.5 40056.2 8668.6 9179.1 9288.6 9401.4 9546.9 15357.9 16170.7 16217.8 16273.9 16433.5 6215.6 6293.6 6309.6 6415.9 6481.5 3301.7 3393.4 3397.3 3406.6 3472.7 2617.2 2671.9 2681.0 2681.4 2685.8 459.7 467.3 477.9 481.4 488.0 409.4 428.8 428.9 448.8 495.6 6683.2 6809.7 6814.9 6901.8 6915.5 536.4 546.7 555.2 558.9 581.2 3275.5 3404.1 3458.4 3472.3 3500.7 50428.2 51634.2 51811.2 51933.5 52076.0 44045.3 44866.6 45014.0 45228.5 45425.8 34625.1 40448.2 40940.2 41091.4 41124.6 7430.1 7487.7 7539.4 7543.6 7685.0 32502.5 33084.0 33405.3 33517.3 33538.7 35080.3 36604.8 42994.4 43441.8 43539.3 8422.7 9043.5 9542.8 9544.0 9711.9 10019.3 10174.1 10289.2 10478.7 10721.2 9790.7 9825.7 9845.2 9954.2 9965.3 9495.4 9619.8 9633.3 9678.7 9709.5 9793.2 9810.4 9818.9 9854.4 9865.6 7712.9 7732.8 7857.4 7952.6 8054.9 7449.8 7680.0 7823.6 7831.9 7837.5 04:37:10 INFO - 2015-11-24 04:37:10,618 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:37:10 INFO - 2015-11-24 04:37:10,618 DEBUG : BROWSER_OUTPUT: 04:37:11 INFO - 2015-11-24 04:37:11,289 INFO : Browser exited with error code: 0 04:37:11 INFO - 2015-11-24 04:37:11,308 INFO : Completed test dromaeo_css (00:18:37) 04:37:11 INFO - 2015-11-24 04:37:11,308 INFO : Starting test kraken 04:37:11 INFO - 2015-11-24 04:37:11,308 DEBUG : operating with platform_type : linux_ 04:37:11 INFO - 2015-11-24 04:37:11,308 INFO : Initialising browser for kraken test... 04:37:11 INFO - 2015-11-24 04:37:11,314 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppIh9vV/profile http://localhost:37854/getInfo.html 04:37:15 INFO - 2015-11-24 04:37:15,278 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:37:15 INFO - 2015-11-24 04:37:15,279 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:37:15 INFO - 2015-11-24 04:37:15,279 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:37:15 INFO - 2015-11-24 04:37:15,279 DEBUG : BROWSER_OUTPUT: __metrics 04:37:15 INFO - 2015-11-24 04:37:15,355 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:16 INFO - 2015-11-24 04:37:16,733 INFO : Browser initialized. 04:37:16 INFO - 2015-11-24 04:37:16,734 INFO : Running cycle 1/1 for kraken test... 04:37:16 INFO - 2015-11-24 04:37:16,734 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppIh9vV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:37:28 INFO - 2015-11-24 04:37:28,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 139919360 04:37:28 INFO - 2015-11-24 04:37:28,620 DEBUG : BROWSER_OUTPUT: 04:37:31 INFO - 2015-11-24 04:37:31,235 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37854/tests/kraken/driver.html?testName=audio-beat-detection) 04:37:31 INFO - 2015-11-24 04:37:31,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 179982336 04:37:31 INFO - 2015-11-24 04:37:31,810 DEBUG : BROWSER_OUTPUT: 04:37:34 INFO - 2015-11-24 04:37:34,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37854/tests/kraken/driver.html?testName=audio-dft) 04:37:35 INFO - 2015-11-24 04:37:35,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 169148416 04:37:35 INFO - 2015-11-24 04:37:35,112 DEBUG : BROWSER_OUTPUT: 04:37:38 INFO - 2015-11-24 04:37:38,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37854/tests/kraken/driver.html?testName=audio-fft) 04:37:38 INFO - 2015-11-24 04:37:38,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 154091520 04:37:38 INFO - 2015-11-24 04:37:38,640 DEBUG : BROWSER_OUTPUT: 04:37:40 INFO - 2015-11-24 04:37:40,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37854/tests/kraken/driver.html?testName=audio-oscillator) 04:37:41 INFO - 2015-11-24 04:37:41,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 154025984 04:37:41 INFO - 2015-11-24 04:37:41,230 DEBUG : BROWSER_OUTPUT: 04:37:43 INFO - 2015-11-24 04:37:43,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37854/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:37:44 INFO - 2015-11-24 04:37:44,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 155303936 04:37:44 INFO - 2015-11-24 04:37:44,070 DEBUG : BROWSER_OUTPUT: 04:37:47 INFO - 2015-11-24 04:37:47,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37854/tests/kraken/driver.html?testName=imaging-darkroom) 04:37:47 INFO - 2015-11-24 04:37:47,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 157425664 04:37:47 INFO - 2015-11-24 04:37:47,594 DEBUG : BROWSER_OUTPUT: 04:37:51 INFO - 2015-11-24 04:37:51,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37854/tests/kraken/driver.html?testName=imaging-desaturate) 04:37:51 INFO - 2015-11-24 04:37:51,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 157679616 04:37:51 INFO - 2015-11-24 04:37:51,625 DEBUG : BROWSER_OUTPUT: 04:37:54 INFO - 2015-11-24 04:37:54,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37854/tests/kraken/driver.html?testName=json-parse-financial) 04:37:55 INFO - 2015-11-24 04:37:55,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 158519296 04:37:55 INFO - 2015-11-24 04:37:55,056 DEBUG : BROWSER_OUTPUT: 04:37:56 INFO - 2015-11-24 04:37:56,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37854/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:37:57 INFO - 2015-11-24 04:37:57,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 168411136 04:37:57 INFO - 2015-11-24 04:37:57,403 DEBUG : BROWSER_OUTPUT: 04:37:59 INFO - 2015-11-24 04:37:59,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:37:59 INFO - 2015-11-24 04:37:59,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 168005632 04:37:59 INFO - 2015-11-24 04:37:59,868 DEBUG : BROWSER_OUTPUT: 04:38:01 INFO - 2015-11-24 04:38:01,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:38:02 INFO - 2015-11-24 04:38:02,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 176115712 04:38:02 INFO - 2015-11-24 04:38:02,550 DEBUG : BROWSER_OUTPUT: 04:38:05 INFO - 2015-11-24 04:38:05,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:38:05 INFO - 2015-11-24 04:38:05,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 180322304 04:38:05 INFO - 2015-11-24 04:38:05,663 DEBUG : BROWSER_OUTPUT: 04:38:08 INFO - 2015-11-24 04:38:08,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:38:08 INFO - 2015-11-24 04:38:08,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 179068928 04:38:08 INFO - 2015-11-24 04:38:08,906 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37854/tests/kraken/driver.html?testName=ai-astar) 04:38:10 INFO - 2015-11-24 04:38:10,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 238579712 04:38:10 INFO - 2015-11-24 04:38:10,925 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,925 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:38:10 INFO - 2015-11-24 04:38:10,925 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:38:10 INFO - 2015-11-24 04:38:10,925 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:38:10 INFO - 2015-11-24 04:38:10,926 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:38:10 INFO - 2015-11-24 04:38:10,926 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;113;108;113;113;114;103;115;114;106 04:38:10 INFO - 2015-11-24 04:38:10,926 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;144;161;165;133;154;158;132;170;130 04:38:10 INFO - 2015-11-24 04:38:10,926 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;159;160;160;159;159;159;161;159;161 04:38:10 INFO - 2015-11-24 04:38:10,926 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;80;90;74;72;73;121;89;71 04:38:10 INFO - 2015-11-24 04:38:10,926 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;96;132;95;94;94;138;94;94;125 04:38:10 INFO - 2015-11-24 04:38:10,926 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;110;109;110;109;109 04:38:10 INFO - 2015-11-24 04:38:10,926 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;146;146;147;147;146;146 04:38:10 INFO - 2015-11-24 04:38:10,927 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 04:38:10 INFO - 2015-11-24 04:38:10,927 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;70;71;71;71;71;72;71;68 04:38:10 INFO - 2015-11-24 04:38:10,927 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;69;69;69;69;69 04:38:10 INFO - 2015-11-24 04:38:10,927 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;83;83;83;83;83;83;83;83 04:38:10 INFO - 2015-11-24 04:38:10,927 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;119;127;119;120;127;126;118;129;137 04:38:10 INFO - 2015-11-24 04:38:10,927 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;149;149;153;154;142;148;149;146;139 04:38:10 INFO - 2015-11-24 04:38:10,927 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;69;69;69;68;69;68;70;70 04:38:10 INFO - 2015-11-24 04:38:10,928 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:38:10 INFO - 2015-11-24 04:38:10,928 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:38:10 INFO - 2015-11-24 04:38:10,928 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,953 04:38:10 INFO - 2015-11-24 04:38:10,928 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:38:10 INFO - 2015-11-24 04:38:10,928 DEBUG : BROWSER_OUTPUT: __startTimestamp1448368690923__endTimestamp 04:38:10 INFO - 2015-11-24 04:38:10,928 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:4.05 (3.6%) stddev-sans-first:4.24 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: Values: 113.0 113.0 108.0 113.0 113.0 114.0 103.0 115.0 114.0 106.0 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.90 Median:156.00 stddev:14.45 (9.3%) stddev-sans-first:15.31 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: Values: 152.0 144.0 161.0 165.0 133.0 154.0 158.0 132.0 170.0 130.0 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: Values: 160.0 159.0 160.0 160.0 159.0 159.0 159.0 161.0 159.0 161.0 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:73.50 stddev:15.64 (21.3%) stddev-sans-first:16.29 04:38:10 INFO - 2015-11-24 04:38:10,932 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 80.0 90.0 74.0 72.0 73.0 121.0 89.0 71.0 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.80 Median:94.00 stddev:18.13 (19.3%) stddev-sans-first:18.88 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 132.0 95.0 94.0 94.0 138.0 94.0 94.0 125.0 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.70 Median:71.00 stddev:1.06 (1.5%) stddev-sans-first:1.12 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 70.0 71.0 71.0 71.0 71.0 72.0 71.0 68.0 04:38:10 INFO - 2015-11-24 04:38:10,933 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 83.0 83.0 83.0 83.0 83.0 83.0 83.0 83.0 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:126.50 stddev:5.97 (4.7%) stddev-sans-first:6.26 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: Values: 122.0 119.0 127.0 119.0 120.0 127.0 126.0 118.0 129.0 137.0 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:149.00 stddev:4.52 (3.0%) stddev-sans-first:4.80 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 149.0 153.0 154.0 142.0 148.0 149.0 146.0 139.0 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: 04:38:10 INFO - 2015-11-24 04:38:10,934 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 04:38:10 INFO - 2015-11-24 04:38:10,935 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 69.0 69.0 68.0 69.0 68.0 70.0 70.0 04:38:10 INFO - 2015-11-24 04:38:10,935 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:38:10 INFO - 2015-11-24 04:38:10,935 DEBUG : BROWSER_OUTPUT: 04:38:11 INFO - 2015-11-24 04:38:11,805 INFO : Browser exited with error code: 0 04:38:11 INFO - 2015-11-24 04:38:11,856 INFO : Completed test kraken (00:01:00) 04:38:11 INFO - 2015-11-24 04:38:11,856 INFO : Starting test v8_7 04:38:11 INFO - 2015-11-24 04:38:11,856 DEBUG : operating with platform_type : linux_ 04:38:11 INFO - 2015-11-24 04:38:11,856 INFO : Initialising browser for v8_7 test... 04:38:11 INFO - 2015-11-24 04:38:11,862 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNK7Ycu/profile http://localhost:37854/getInfo.html 04:38:15 INFO - 2015-11-24 04:38:15,765 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:38:15 INFO - 2015-11-24 04:38:15,765 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:38:15 INFO - 2015-11-24 04:38:15,765 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:38:15 INFO - 2015-11-24 04:38:15,765 DEBUG : BROWSER_OUTPUT: __metrics 04:38:15 INFO - 2015-11-24 04:38:15,943 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:38:17 INFO - 2015-11-24 04:38:17,182 INFO : Browser initialized. 04:38:17 INFO - 2015-11-24 04:38:17,182 INFO : Running cycle 1/1 for v8_7 test... 04:38:17 INFO - 2015-11-24 04:38:17,182 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNK7Ycu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:38:29 INFO - 2015-11-24 04:38:29,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 140509184 04:38:29 INFO - 2015-11-24 04:38:29,200 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37854/tests/v8_7/run.html (next: http://localhost:37854/tests/v8_7/run.html) 04:38:50 INFO - 2015-11-24 04:38:50,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 440086528 04:38:50 INFO - 2015-11-24 04:38:50,968 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,969 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:38:50 INFO - 2015-11-24 04:38:50,969 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:38:50 INFO - 2015-11-24 04:38:50,969 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:38:50 INFO - 2015-11-24 04:38:50,969 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:38:50 INFO - 2015-11-24 04:38:50,970 DEBUG : BROWSER_OUTPUT: |0;Richards;190.8761213972132 04:38:50 INFO - 2015-11-24 04:38:50,970 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.3143294432753 04:38:50 INFO - 2015-11-24 04:38:50,970 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.87685418415896 04:38:50 INFO - 2015-11-24 04:38:50,970 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 04:38:50 INFO - 2015-11-24 04:38:50,970 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2006.0120240480962 04:38:50 INFO - 2015-11-24 04:38:50,970 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 04:38:50 INFO - 2015-11-24 04:38:50,970 DEBUG : BROWSER_OUTPUT: |6;Boyer;12228.915662650603 04:38:50 INFO - 2015-11-24 04:38:50,970 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 04:38:50 INFO - 2015-11-24 04:38:50,971 DEBUG : BROWSER_OUTPUT: |8;Splay;594.3060498220641 04:38:50 INFO - 2015-11-24 04:38:50,971 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4882.926829268293 04:38:50 INFO - 2015-11-24 04:38:50,971 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:38:50 INFO - 2015-11-24 04:38:50,971 DEBUG : BROWSER_OUTPUT: __startTimestamp1448368730968__endTimestamp 04:38:50 INFO - 2015-11-24 04:38:50,971 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,972 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:38:50 INFO - 2015-11-24 04:38:50,972 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:38:50 INFO - 2015-11-24 04:38:50,972 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,972 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:190.88 Median:190.88 stddev:0.00 (0.0%) 04:38:50 INFO - 2015-11-24 04:38:50,973 DEBUG : BROWSER_OUTPUT: Values: 190.9 04:38:50 INFO - 2015-11-24 04:38:50,973 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,973 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.31 Median:191.31 stddev:0.00 (0.0%) 04:38:50 INFO - 2015-11-24 04:38:50,973 DEBUG : BROWSER_OUTPUT: Values: 191.3 04:38:50 INFO - 2015-11-24 04:38:50,973 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,974 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 04:38:50 INFO - 2015-11-24 04:38:50,974 DEBUG : BROWSER_OUTPUT: Values: 279.9 04:38:50 INFO - 2015-11-24 04:38:50,974 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,974 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 04:38:50 INFO - 2015-11-24 04:38:50,974 DEBUG : BROWSER_OUTPUT: Values: 5000.0 04:38:50 INFO - 2015-11-24 04:38:50,974 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: Values: 2006.0 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: Values: 796.2 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12228.92 Median:12228.92 stddev:0.00 (0.0%) 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: Values: 12228.9 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: Values: 26763.2 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.31 Median:594.31 stddev:0.00 (0.0%) 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: Values: 594.3 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: 04:38:50 INFO - 2015-11-24 04:38:50,975 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4882.93 Median:4882.93 stddev:0.00 (0.0%) 04:38:50 INFO - 2015-11-24 04:38:50,976 DEBUG : BROWSER_OUTPUT: Values: 4882.9 04:38:50 INFO - 2015-11-24 04:38:50,976 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:38:50 INFO - 2015-11-24 04:38:50,976 DEBUG : BROWSER_OUTPUT: 04:38:51 INFO - 2015-11-24 04:38:51,962 INFO : Browser exited with error code: 0 04:38:51 INFO - 2015-11-24 04:38:51,974 INFO : Completed test v8_7 (00:00:40) 04:38:52 INFO - 2015-11-24 04:38:52,400 INFO : Completed test suite (00:20:18) 04:38:52 INFO - 2015-11-24 04:38:52,400 DEBUG : Working with test: dromaeo_css 04:38:52 INFO - 2015-11-24 04:38:52,400 DEBUG : Generating results file: dromaeo_css 04:38:52 INFO - 2015-11-24 04:38:52,401 DEBUG : Working with test: kraken 04:38:52 INFO - 2015-11-24 04:38:52,402 DEBUG : Generating results file: kraken 04:38:52 INFO - 2015-11-24 04:38:52,402 INFO : javascript benchmark 04:38:52 INFO - 2015-11-24 04:38:52,402 DEBUG : Working with test: v8_7 04:38:52 INFO - 2015-11-24 04:38:52,402 DEBUG : Generating results file: v8_7 04:38:52 INFO - 2015-11-24 04:38:52,403 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:38:52 INFO - 2015-11-24 04:38:52,458 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:38:52 INFO - 2015-11-24 04:38:52,459 DEBUG : process_Request line: dromaeo_css 6079.06 graph.html#tests=[[72,94,35]] 04:38:52 INFO - 2015-11-24 04:38:52,459 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:38:52 INFO - 2015-11-24 04:38:52,492 DEBUG : process_Request line: kraken 1522.40 graph.html#tests=[[232,94,35]] 04:38:52 INFO - 2015-11-24 04:38:52,492 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:38:52 INFO - 2015-11-24 04:38:52,524 DEBUG : process_Request line: v8_7 19519.11 graph.html#tests=[[230,94,35]] 04:38:52 INFO - 2015-11-24 04:38:52,526 INFO : javascript benchmark 04:38:52 INFO - 2015-11-24 04:38:52,529 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2607.3742301847556, 2709.701932787393, 2731.508328500869, 2740.698523162453, 2748.725127487251, 4559.954400456003, 4673.3223682566, 4676.672632915697, 4741.312509686093, 4745.3593764841735, 4598.0, 4689.437267527901, 4707.082118986799, 4733.502982186872, 4750.762461876901, 4228.112096459748, 4304.268274393345, 4316.805743741539, 4347.760873151976, 4402.449693788277, 4300.548442413548, 4341.413909122275, 4387.890302742425, 4395.846145384912, 4406.096750166208, 4133.318002529579, 4227.852025179104, 4349.608535231812, 4392.670549708752, 4414.161309351229, 4288.76411797351, 4302.526722060571, 4313.741175529478, 4313.870583882489, 4316.503602085769, 4289.270823959934, 4290.635295999844, 4292.248856450109, 4292.763897985609, 4293.785310734451, 4528.818847246106, 4649.209634362167, 4650.581447669692, 4671.11248862715, 4671.883202919954, 5052.4189718182515, 5053.343065401511, 5061.16490779021, 5061.316722242487, 5102.081625307444, 4849.612031037508, 5064.949350506485, 5085.974570127126, 5090.414602320707, 5092.10888094582, 4640.907181856378, 4656.650751193674, 4676.95323046772, 4724.71651700899, 4786.545278198566, 5127.3847138343635, 5159.793608255703, 5194.298769666122, 5196.350456192976, 5196.68819870809, 4733.976330118397, 4988.27669987857, 4993.750312484434, 4997.175466048134, 5011.3986321640905, 4893.975530122327, 4953.950460495421, 4966.15575352191, 4974.1543937530705, 4990.675606085593, 4997.150484417658, 5002.874928126826, 5016.924746128811, 5017.422996355466, 5061.316722242524, 4746.359241502422, 4986.376702912136, 4990.326305948651, 4993.450720420751, 5038.0, 4093.570175131628, 4133.111381053028, 4146.5853414658895, 4154.833806647761, 4179.2477354076555, 3681.889543313705, 3685.963140368562, 3689.870854520079, 3711.721620878445, 3716.7398282120535, 4191.790410479525, 4336.891577710582, 4369.0, 4369.956300437018, 4410.184115938561, 4903.141950158708, 4937.481564435754, 4964.478729733398, 4965.528274813887, 5021.121303771825, 4332.090261045153, 4353.499347575006, 4365.694401391872, 4383.3424986251675, 4423.402840616475, 4288.335308027261, 4484.0583477469445, 4487.147441986012, 4493.078918821634, 4512.165249428866, 4650.697704649187, 4705.717656940595, 4724.905501889874, 4737.549932756383, 4772.5227477252, 4977.377827771528, 5002.874928126826, 5007.173816320266, 5009.524095210949, 5053.722045287397, 4740.715557066587, 4741.170295198395, 4751.738654374042, 4756.738379389167, 4790.976045119752, 4757.286407038971, 4824.179889418737, 4840.951590484191, 4851.927221091757, 4926.285688575208, 5055.418626857811, 5068.569171620454, 5073.162928116967, 5079.339685840817, 5123.948760512347, 4906.754662266943, 4913.28757330178, 4918.0, 4920.753962301942, 4963.205887058053, 4684.1334353144775, 4795.640326975421, 4801.063792560417, 4820.084184005028, 4954.1825598775795, 4726.976365118152, 4756.785944632431, 4757.405324334458, 4758.1435341638835, 4806.303086052572, 4901.117798796251, 4906.656534042583, 4909.656324057281, 4912.140375434214, 4913.70517768935, 4586.151561961048, 4656.93014604788, 4705.411823522059, 4705.976470117627, 4756.785944632431], "unit": "ms", "name": "dojo.html", "value": 4595.15178423668}, {"lowerIsBetter": false, "replicates": [556.6493109341117, 565.6634302589963, 569.3225062176011, 581.052883799407, 583.9854003649908, 25921.48157036858, 26546.734532654667, 26589.202323930265, 36782.448263276005, 37751.24497510048, 40584.0, 41130.17739645213, 41167.38248926261, 41202.587974120324, 41214.793926030405, 7828.882566761489, 8010.198980101973, 8011.0386753589655, 8013.839723205532, 8019.839603207933, 7041.084658994324, 7215.13418389794, 10222.795544089115, 10527.578896844156, 10567.682969510926, 10151.898481015169, 10252.282340236186, 10253.128484078863, 10260.589576416935, 10272.435016074112, 10111.747206319827, 10183.643572474928, 10209.897901021006, 10214.540345684461, 10222.744431389201, 9962.850557241647, 10078.79842403155, 10087.798244035152, 10094.29339946204, 10096.29325947184, 37401.0, 38007.0, 38025.61974380248, 38030.80984595059, 38082.0, 2740.1231605886123, 2743.6021776842445, 2852.1586132090874, 2924.0642994241853, 3455.3262113887804, 28422.715772842213, 28695.28261793451, 28772.712272877212, 28899.0, 29031.41937161266, 3341.6491268416707, 3363.2432702641954, 3386.1703882548686, 3391.2708767614836, 3500.2299494111508, 215755.0, 216932.9153354239, 217718.0, 217756.0, 217878.0, 38302.61697382991, 39010.80494597566, 55152.0, 55786.721066394406, 55964.720176398856, 64552.35447645463, 65708.34291657117, 66094.0, 66099.0, 66165.33834661687, 13044.282564458856, 13245.0, 13252.536161234504, 13258.867411325957, 13268.668283292802, 8470.449420787629, 8611.956940215385, 8661.437006594677, 8662.523561204194, 10029.448380339152, 19520.0, 19873.60252794965, 19969.700454493195, 20004.399868003984, 20077.899610501852, 6899.827504312432, 7074.823129421703, 7158.2483839197175, 7200.963995179991, 7249.710011599583, 837.8031162676766, 847.7372014675346, 884.6726711116928, 899.4513346858411, 903.3315346643436, 26585.86707066491, 26705.3323666906, 27108.0, 27191.184264472096, 27197.0, 913.255696607263, 945.3004776465366, 978.3542861711236, 981.1071924548627, 1022.1311884897777, 13111.2133272004, 13456.192628442324, 13521.121127126706, 13662.521811736542, 13686.589402317946, 254906.0, 260513.0, 261362.0, 261952.0, 262027.0, 45773.54226457759, 45975.77012114918, 46149.76925115353, 46182.538174617825, 46194.76902615465, 1175.2697868460898, 1191.0531127753457, 1195.3306148556835, 1198.952041918331, 1202.0924202227088, 23928.88035559811, 24267.39331516726, 24595.631065533675, 24744.762761862195, 24812.50374992526, 37291.254174915804, 37743.81128094342, 38276.80861595674, 38320.23359532738, 38334.0, 222033.0, 242236.0, 243855.0, 244159.0, 244255.0, 20351.4912127198, 28316.292092697848, 28709.28226794347, 28954.42091158123, 29098.418031638827, 33831.0, 33894.83052584721, 34048.0, 34772.82613587017, 34984.12539686528, 29188.0, 29450.263743406587, 29535.113946581638, 30047.849760751058, 32582.34835303328, 24335.26994190177, 29684.851575741985, 31686.841565792023, 32945.0, 35108.0, 32276.515852261764, 32765.344693106483, 32979.0, 33033.17417064593, 33060.504092439114, 28940.56589151122, 29265.853670732362, 29936.56660506416, 30105.247368815955, 32146.87485937981, 23483.647745284175, 23504.76495235026, 23873.0, 23895.283141505784, 23945.16191933274], "unit": "ms", "name": "ext.html", "value": 16830.95562232166}, {"lowerIsBetter": false, "replicates": [325.8659863674413, 334.6319049046049, 337.6808915574781, 338.6562638921495, 341.8290854572714, 11628.941855290734, 12068.396580170978, 14667.19330436827, 15048.247587620615, 15384.307706153222, 11237.269577477458, 13149.802752958689, 13531.0, 14584.416623335053, 14657.267136643179, 4459.308807134891, 4561.954380456186, 4585.151746926813, 4586.4266966629175, 4812.278158276252, 3381.0533050745707, 3489.145159435942, 4977.800887964495, 5000.074986127578, 5187.247849061884, 5118.129917913945, 5141.82003629873, 5146.099432599299, 5158.277841102249, 5168.560672342836, 4968.627352948525, 5145.922811157836, 5522.972385138049, 5783.566232532577, 5791.855203619901, 5106.9489305106845, 5108.948910510884, 5114.897702045975, 5115.437301896788, 5118.795248190068, 10988.725281868017, 13846.723065538632, 16575.088370139638, 16747.743919206107, 17243.0, 1656.3705791799039, 1736.6787144378332, 1797.9011154386503, 1856.8143185681458, 1898.69620860663, 8701.390902636818, 8796.780080497974, 8822.823543529094, 8846.469211847245, 9052.321075919266, 1692.7460880867845, 1730.5414065272712, 1753.973690394645, 1759.8504127149208, 1819.0995457248614, 53169.73415132938, 55299.723501382636, 56195.0, 56513.71743141299, 57202.7139864298, 9643.662471813454, 9675.467849268358, 9678.032196780267, 9705.272104592184, 9706.320557560903, 12218.511259549696, 12242.326672033123, 12270.202436841577, 12281.508739650313, 12290.262584244794, 6327.715252813542, 6424.71088801005, 6482.35176482348, 6525.967370163119, 6526.086347911296, 6006.579539432285, 6325.0, 6373.553851230369, 6387.393197646216, 6405.039244113327, 4032.294348489003, 4087.3460246361033, 4121.9381709274385, 4156.937645935313, 4196.118815048874, 1490.6646004649085, 1526.5038862369775, 1599.9200039997954, 1659.7676325314465, 1721.6556688662317, 370.15604421918067, 371.9553653561536, 414.7698027594714, 774.2876553570728, 874.8775171475999, 8915.0, 9044.81910361789, 9084.727458176265, 9509.952450237704, 9544.093311135432, 363.81990914497493, 372.92541491701223, 378.9696824254053, 379.2112406195163, 380.8724077434035, 4853.2720091985775, 5316.6544174628525, 5330.466953304638, 5356.946430535645, 5368.543673787772, 445360.0, 447868.0, 454333.0, 456423.0, 463086.0, 66291.66854165794, 67956.320436795, 68290.0, 68631.65684171548, 68651.65674171597, 444.9911001780011, 445.20753059554045, 448.68591985610203, 449.5706600196804, 1013.2552573858061, 13243.66890827737, 13869.306534673427, 13913.51302704441, 13967.092139010932, 13991.510297139552, 28609.284767880137, 29072.41855162927, 29911.401771964003, 31814.0, 32831.83584082064, 37203.441948371335, 37401.81299093487, 38361.616383835804, 38371.6162838368, 38944.61055389523, 8664.263537599374, 8673.522956237468, 8755.387122901337, 8756.649734010569, 8884.866726998971, 10227.84658230142, 15033.173175475455, 15397.84602154009, 15566.455174068853, 15738.606534836721, 12710.936445317715, 13025.0, 13054.34728263602, 13217.735645286848, 13665.111767735065, 12450.25298482094, 12631.87368126307, 12813.231206127663, 13027.413766380725, 13044.739105218032, 13249.337533123113, 13286.402111904794, 13378.197308161542, 13461.394237259152, 13589.932050340081, 7010.719571217298, 7895.960520197362, 8540.27407670355, 8606.26846718036, 8783.604737786687, 9115.316351273814, 9206.033366496422, 10336.276460647683, 13312.866871331164, 13411.0], "unit": "ms", "name": "jquery.html", "value": 7256.744007485449}, {"lowerIsBetter": false, "replicates": [1475.5942115918128, 1574.2915687940426, 1641.7947756530434, 1665.9416920407796, 1666.6000159961604, 5837.1536127261525, 5992.34084250732, 6443.710033048518, 6621.503387245958, 6631.303713110126, 6234.314225435199, 6470.579412338195, 6503.414692677658, 6523.575967562105, 6540.901886471706, 2026.0275067967384, 2057.084597354178, 2060.8660437071544, 2061.9690704639443, 2062.6390381683223, 1716.1848122141946, 1743.8953662780211, 1764.4265613675543, 1765.4703588923335, 1765.7704498415187, 1967.9704804427945, 2009.437357539891, 2011.9195232190696, 2012.2152360579387, 2012.4868158619531, 1989.1744925855896, 1996.131682718015, 2009.2364901337544, 2011.6982452632149, 2068.2347531413325, 2052.230413594902, 2084.520560271146, 2085.3431169181813, 2085.843561732876, 2086.113401804227, 6839.0425340452375, 6851.520393572452, 6865.347791959756, 6895.689693963784, 6919.619420931846, 3853.7880416577077, 3931.7247792654525, 3932.6067393260446, 3983.462232598591, 3997.4603428537066, 2669.386041210513, 2727.699953005168, 2735.575985722216, 2737.343037670945, 2752.3944732158893, 853.2491407561369, 862.0948004595213, 890.7639475538988, 897.4032268541412, 918.7381596245104, 9106.726798196065, 9123.361364704473, 9125.5437228139, 9144.54277286133, 9153.496557689325, 3751.1372384351753, 3790.1282704977457, 3813.1992281620614, 3830.4637350770913, 3834.0798208430333, 7829.451938364374, 7838.764837054898, 7844.215578442224, 7846.058472983279, 7898.9210107899335, 4031.1534577739003, 4057.4928133983253, 4071.185762847442, 4074.9388759168637, 4088.7751173685733, 3574.982125089358, 3652.5251717276583, 3680.190358121209, 3683.9079023024638, 3687.0966613179407, 3315.1877789941136, 3317.0546394277517, 3319.2199833039217, 3351.396748585278, 3354.547136136639, 881.9603117859712, 907.464595888429, 1003.1423133221136, 1011.4133802394593, 1018.1854516386861, 850.4642075492524, 864.762190397633, 866.5797088412115, 911.280088729896, 1001.4191768774239, 6366.236051673736, 6522.771702990372, 6524.478041756648, 6543.901841472381, 6559.048937903977, 1009.8586197932295, 1026.2816028779885, 1031.5718976624617, 1036.5439206749006, 1037.8080055189814, 4899.118158731391, 4960.70235785854, 4968.975155124273, 4971.90056198874, 4976.2038073908, 7927.207279272026, 8034.035915690155, 8132.837343253102, 8160.551169685724, 8215.712450064339, 7977.0, 8032.839343213103, 8054.436189466798, 8081.353491720648, 8084.797880053045, 6304.18045654062, 6395.0, 6418.133551970424, 6431.196100487439, 6441.388068133613, 6037.63774173551, 6202.81391558254, 6234.160922527774, 6236.532260080421, 6253.280872699698, 7160.248173941661, 7320.707171713072, 7371.852562948819, 7376.373008294355, 7378.040854688856, 7326.413886889142, 7434.293742094493, 7533.924660753322, 7546.547207167588, 7618.695252190072, 5918.378570250062, 5982.341942386247, 5983.910241346471, 5986.730597123053, 5992.760289588542, 6297.905531417124, 6510.902336464862, 6555.573887697285, 6574.506911981525, 6581.6709164542535, 6114.174586430953, 6140.232470941132, 6171.753129874754, 6195.535334849995, 6212.534059945432, 5246.632735708617, 5430.239766432624, 5863.560232982458, 6036.849078773066, 6106.542009349406, 6141.048137538689, 6191.071339299141, 6202.131701561875, 6217.658028808459, 6219.595726277777, 5698.772049117989, 5717.914231286451, 5739.024365857731, 5740.483356497935, 5741.74162162712, 5840.591158619026, 5848.64908105515, 5851.1223316502865, 5855.59010869235, 5870.14882841994], "unit": "ms", "name": "mootools.html", "value": 3906.789842334182}, {"lowerIsBetter": false, "replicates": [303.87085488667316, 311.3694768094608, 314.0860097117389, 314.1799902255114, 317.6236160150224, 5300.416954135047, 5398.055340315449, 5399.78400863965, 5414.675119492828, 5440.972795136024, 5317.149256119022, 5337.546308563767, 5340.866478338044, 5342.732863356826, 5350.3312085989255, 3922.941155882664, 4022.4167495713104, 4170.749755014709, 4174.290370636999, 4181.289180839264, 4027.617376349242, 4160.209560183571, 4160.583941605845, 4163.104932439525, 4176.164767046587, 4112.527059388164, 4129.855455059073, 4132.2355364257555, 4132.2768515509815, 4136.917261654765, 3880.1463677990796, 3954.7429417088083, 3964.385520244338, 4020.537638171589, 4121.155163191538, 3531.523244362004, 3533.063738109403, 3539.929201415983, 3595.6404359564094, 3634.8005158297697, 5046.19260918255, 5108.310378098983, 5136.871578210537, 5140.820071297524, 5142.254373115878, 4730.526947305277, 4737.052589482083, 4743.383360163157, 4746.477887432379, 4750.334953106568, 5405.18922161675, 5575.916361254584, 5593.496585307342, 5599.048161812501, 5599.804006859781, 3899.74651647642, 3902.024493876531, 3908.687305015592, 3912.256671232457, 3912.8434862605463, 5821.50517206038, 5884.999550076497, 5885.70571471429, 5907.4683278505145, 5907.556933230025, 3989.68082553395, 3996.140829721624, 3997.4803275574573, 4001.5398229204015, 4003.319435695939, 4054.716169868081, 4058.228936502055, 4058.918821623551, 4102.794860256975, 4204.663626909901, 4718.9292160617615, 4769.833055843029, 4771.5228477152, 4772.5943294819635, 4777.0, 5613.0, 5617.887642247132, 5620.887582248332, 5622.91565626516, 5623.847111342165, 1470.8014418053426, 1495.7681559358316, 1497.9925100374646, 1498.1535432480614, 1499.8650121489118, 953.594722243044, 1023.8105950399051, 1025.1747343388495, 1027.7790275090742, 1046.1578429364436, 4932.334134891816, 4962.131626965267, 4963.70217786934, 4968.205087186105, 4972.676776009548, 5841.474267315962, 5842.649441033552, 5846.386129456346, 5851.853703657443, 5854.736536855767, 4971.328870602495, 4977.527134922177, 4980.327655766425, 4985.0029994000615, 4990.675606085593, 2895.8552072396296, 2980.2698338907107, 3021.773366997484, 3125.6092988376454, 3158.652548219694, 5497.945020549823, 5557.138643510262, 5570.972145139248, 5574.693391863487, 5579.581531385163, 6021.488173505213, 6025.487833534199, 6030.4572588467245, 6033.0, 6033.306169790442, 5427.077396842467, 5554.361248456398, 5563.972180139073, 5568.554515638739, 5571.9442805571425, 5870.354261031198, 5870.882582348415, 5878.764849406147, 5880.941190588211, 5881.206037184926, 5734.082546792493, 5735.340435849931, 5737.340205876378, 5740.167675687086, 5744.0522313817755, 5559.694216818114, 5573.693446860461, 5575.303087114111, 5578.525825304732, 5578.944210557843, 3913.0, 4023.5775243599, 4036.6972477064924, 4153.771542565188, 4154.750714956991, 5815.098659707752, 5837.445442682938, 5839.357670656309, 5842.678652673973, 5846.532277417711, 5614.803481878114, 5619.438056194348, 5624.915626265528, 5629.240052592848, 5630.18362337467, 5460.836174914759, 5610.102383618601, 5610.607257491936, 5617.32592088952, 5622.606417550732, 5475.780968761205, 5503.339599247955, 5503.477169668875, 5508.944910550843, 5509.889802203853, 5646.181303711021, 5676.545876329967, 5712.485876271156, 5713.114467257582, 5719.599628025998, 5542.63972841764, 5568.805091821767, 5571.637843540157, 5573.972130139324, 5575.135853942646], "unit": "ms", "name": "prototype.html", "value": 4233.878194679029}, {"lowerIsBetter": false, "replicates": [723.9058922340095, 746.2500187311748, 759.3735168485998, 763.316831435865, 781.4842204145265, 10810.513526891289, 10947.726306842333, 10952.452377381129, 10961.561537538499, 10965.780684386307, 10160.745981350452, 11185.272957257794, 11294.435278236097, 12216.45025973831, 12226.083043771709, 757.8597959377519, 772.656168005235, 773.3928865840317, 773.9845203095934, 774.2528460036064, 745.5712965045094, 754.9660265288076, 755.2900273742664, 755.697720911637, 755.9546427214357, 774.8915151878741, 785.505131766986, 786.095989611948, 786.1234723283554, 786.2805532937384, 777.3431450424439, 777.7977725791307, 778.1129512355918, 778.3150827272021, 778.385075790128, 576.9884602307931, 579.3829571506375, 579.9101139323411, 580.3384142078035, 581.0238798817984, 10967.451627418677, 11051.28166669172, 11053.336799792038, 11075.778484430346, 11120.55517779288, 10756.19328550362, 10940.56237750489, 10943.56225750969, 11116.61091861781, 11249.887501124966, 9302.441853488745, 9419.764505887339, 9451.763705907339, 9458.196053335474, 9516.666916657952, 3129.796563223383, 3175.6506784253716, 3208.7593430492575, 3246.5043580413567, 3247.5778148840736, 32699.182520436705, 34134.6586534134, 34507.13732156691, 34513.48229776556, 40056.19887602232, 8668.60991255395, 9179.082091790768, 9288.62845486173, 9401.388909720847, 9546.856797148048, 15357.923210383877, 16170.676586468206, 16217.837821621868, 16273.918630406772, 16433.506994790176, 6215.627062376272, 6293.590916590407, 6309.621422714652, 6415.871682566416, 6481.48148148147, 3301.6863397977154, 3393.3552625001666, 3397.320535892782, 3406.6423025582453, 3472.7048200903205, 2617.2148355493277, 2671.853048082335, 2681.0, 2681.3564744461187, 2685.7582817546513, 459.7494365570772, 467.3013844302789, 477.87575230440336, 481.4295060353492, 487.97072175669575, 409.40022866500124, 428.77703594131503, 428.9163613095416, 448.78458339996985, 495.6357077547999, 6683.189216304666, 6809.727610895508, 6814.93185068143, 6901.75843845463, 6915.481338899603, 536.3510152715259, 546.7457632201045, 555.1977392667557, 558.8602849287678, 581.2385774635242, 3275.5250488679008, 3404.063882432351, 3458.360203362386, 3472.3228970350538, 3500.6674365935705, 50428.24357634639, 51634.22548661773, 51811.22283165756, 51933.48066519362, 52076.0, 44045.33931991023, 44866.55133448689, 45014.0, 45228.547714522436, 45425.77287113609, 34625.13437164091, 40448.19103617911, 40940.1811963759, 41091.38362924558, 41124.58875411267, 7430.071241094864, 7487.700491980259, 7539.396848252236, 7543.622818858926, 7684.962530058594, 32502.51246231261, 33084.007479775646, 33405.33189336248, 33517.329653406305, 33538.664613353554, 35080.298394031466, 36604.81697591495, 42994.35508467313, 43441.782791087106, 43539.34690979574, 8422.663093476192, 9043.457392556467, 9542.757451998636, 9543.952280238555, 9711.902880971382, 10019.298649094493, 10174.13519850821, 10289.176865850864, 10478.738031549272, 10721.249512534048, 9790.657326993522, 9825.656102036395, 9845.163161131097, 9954.203663706741, 9965.302428829913, 9495.38280011797, 9619.807603848023, 9633.277504187354, 9678.70963871085, 9709.465979371202, 9793.167580755715, 9810.411375317504, 9818.85271720939, 9854.408735475894, 9865.605375784888, 7712.884306735516, 7732.806679833049, 7857.4499785014505, 7952.6421311042295, 8054.879176812469, 7449.776506704808, 7679.961600192187, 7823.569703666353, 7831.882521762064, 7837.529748215125], "unit": "ms", "name": "yui.html", "value": 5435.84045427672}], "name": "dromaeo_css", "value": 6079.064917058143}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 108.0, 113.0, 113.0, 114.0, 103.0, 115.0, 114.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [152.0, 144.0, 161.0, 165.0, 133.0, 154.0, 158.0, 132.0, 170.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.9}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 160.0, 160.0, 159.0, 159.0, 159.0, 161.0, 159.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 159.7}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 80.0, 90.0, 74.0, 72.0, 73.0, 121.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 132.0, 95.0, 94.0, 94.0, 138.0, 94.0, 94.0, 125.0], "unit": "ms", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 71.0, 71.0, 71.0, 71.0, 72.0, 71.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 70.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 127.0, 119.0, 120.0, 127.0, 126.0, 118.0, 129.0, 137.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 149.0, 153.0, 154.0, 142.0, 148.0, 149.0, 146.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1522.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [190.8761213972132], "unit": "score", "name": "Richards", "value": 184.94717800000004}, {"lowerIsBetter": false, "replicates": [191.3143294432753], "unit": "score", "name": "DeltaBlue", "value": 345.5987859999999}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [2006.0120240480962], "unit": "score", "name": "RayTrace", "value": 368.8856253746253}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [12228.915662650603], "unit": "score", "name": "Boyer", "value": 54.498944827586165}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [594.3060498220641], "unit": "score", "name": "Splay", "value": 137.11958682634727}, {"lowerIsBetter": false, "replicates": [4882.926829268293], "unit": "score", "name": "NavierStokes", "value": 303.91608391608383}], "name": "v8_7", "value": 19519.110780577645}]} 04:38:52 INFO - RETURN: dromaeo_css: 6079.06 04:38:52 INFO - RETURN: kraken: 1522.40 04:38:52 INFO - RETURN: v8_7: 19519.11 04:38:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19519.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1522.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6079.06"}}} 04:38:52 INFO - Return code: 0 04:38:52 INFO - # TBPL SUCCESS # 04:38:52 INFO - Running post-action listener: _resource_record_post_action 04:38:52 INFO - Running post-run listener: _resource_record_post_run 04:38:53 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 73728; Write bytes: 505118720; Read time: 40; Write time: 615920 04:38:53 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 186822656; Read time: 0; Write time: 347592 04:38:53 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 69632; Write bytes: 270233600; Read time: 16; Write time: 136040 04:38:53 INFO - Running post-run listener: _upload_blobber_files 04:38:53 INFO - Blob upload gear active. 04:38:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:38:53 INFO - Copying logs to upload dir... 04:38:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.725749 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-11-24 04:38:53.619654) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 04:38:53.623413) ========= 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=7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009137 build_url: 'https://queue.taskcluster.net/v1/task/Zwdp_kvRSeuTkCDsuVQvhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 04:38:53.674112) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:38:53.674430) ========= 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=7d909545e45784438f4e8e36000001b3-1448367399.129442-2062755478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 04:38:53.724262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 04:38:53.724579) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 04:38:53.724865) ========= ========= Total master_lag: 1.53 =========