builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1447950256.82 results: success (0) buildid: 20151119064919 builduid: d34d47921cc0487180da06e33f8a512b revision: f23ae6d4207719a808b285f0eb0504145b37d709 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.824489) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.824927) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.825216) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005799 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.842629) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.842919) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.853002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.853307) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004312 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.903888) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.904209) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.904605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:16.904914) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 08:24:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.5M=0s 2015-11-19 08:24:17 (47.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:17.099336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:17.099677) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016959 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:17.149745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:17.150153) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f23ae6d4207719a808b285f0eb0504145b37d709 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f23ae6d4207719a808b285f0eb0504145b37d709 --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=8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 08:24:17,676 truncating revision to first 12 chars 2015-11-19 08:24:17,676 Setting DEBUG logging. 2015-11-19 08:24:17,676 attempt 1/10 2015-11-19 08:24:17,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f23ae6d42077?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 08:24:18,351 unpacking tar archive at: mozilla-inbound-f23ae6d42077/testing/mozharness/ program finished with exit code 0 elapsedTime=0.987435 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:18.148444) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:18.148947) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:18.156261) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:18.156528) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 08:24:18.156965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-19 08:24:18.157250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-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=8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:24:18 INFO - MultiFileLogger online at 20151119 08:24:18 in /builds/slave/test 08:24:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 08:24:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:18 INFO - {'append_to_log': False, 08:24:18 INFO - 'base_work_dir': '/builds/slave/test', 08:24:18 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 08:24:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:18 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 08:24:18 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:18 INFO - 'config_files': ('talos/linux_config.py',), 08:24:18 INFO - 'default_actions': ('clobber', 08:24:18 INFO - 'read-buildbot-config', 08:24:18 INFO - 'download-and-extract', 08:24:18 INFO - 'populate-webroot', 08:24:18 INFO - 'create-virtualenv', 08:24:18 INFO - 'install', 08:24:18 INFO - 'run-tests'), 08:24:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:18 INFO - 'download_minidump_stackwalk': True, 08:24:18 INFO - 'download_symbols': 'ondemand', 08:24:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:18 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:18 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:18 INFO - 'installer_path': 'installer.exe', 08:24:18 INFO - 'log_level': 'info', 08:24:18 INFO - 'log_name': 'talos', 08:24:18 INFO - 'log_to_console': True, 08:24:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:24:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:24:18 INFO - 'opt_config_files': (), 08:24:18 INFO - 'pip_index': False, 08:24:18 INFO - 'sps_profile': False, 08:24:18 INFO - 'sps_profile_interval': 0, 08:24:18 INFO - 'suite': 'dromaeojs-e10s', 08:24:18 INFO - 'system_bits': '64', 08:24:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:18 INFO - 'title': 'talos-linux64-ix-004', 08:24:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:18 INFO - 'use_talos_json': True, 08:24:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:18 INFO - 'work_dir': 'build'} 08:24:18 INFO - ##### 08:24:18 INFO - ##### Running clobber step. 08:24:18 INFO - ##### 08:24:18 INFO - Running pre-action listener: _resource_record_pre_action 08:24:18 INFO - Running main action method: clobber 08:24:18 INFO - rmtree: /builds/slave/test/build 08:24:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:19 INFO - Running post-action listener: _resource_record_post_action 08:24:19 INFO - ##### 08:24:19 INFO - ##### Running read-buildbot-config step. 08:24:19 INFO - ##### 08:24:19 INFO - Running pre-action listener: _resource_record_pre_action 08:24:19 INFO - Running main action method: read_buildbot_config 08:24:19 INFO - Using buildbot properties: 08:24:19 INFO - { 08:24:19 INFO - "properties": { 08:24:19 INFO - "buildnumber": 1134, 08:24:19 INFO - "product": "firefox", 08:24:19 INFO - "script_repo_revision": "production", 08:24:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 08:24:19 INFO - "repository": "", 08:24:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs-e10s", 08:24:19 INFO - "buildid": "20151119064919", 08:24:19 INFO - "slavename": "talos-linux64-ix-004", 08:24:19 INFO - "pgo_build": "False", 08:24:19 INFO - "basedir": "/builds/slave/test", 08:24:19 INFO - "project": "", 08:24:19 INFO - "platform": "ubuntu64_hw", 08:24:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:24:19 INFO - "slavebuilddir": "test", 08:24:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 08:24:19 INFO - "branch": "mozilla-inbound", 08:24:19 INFO - "repo_path": "integration/mozilla-inbound", 08:24:19 INFO - "stage_platform": "linux64", 08:24:19 INFO - "builduid": "d34d47921cc0487180da06e33f8a512b", 08:24:19 INFO - "revision": "f23ae6d4207719a808b285f0eb0504145b37d709" 08:24:19 INFO - }, 08:24:19 INFO - "sourcestamp": { 08:24:19 INFO - "repository": "", 08:24:19 INFO - "hasPatch": false, 08:24:19 INFO - "project": "", 08:24:19 INFO - "branch": "mozilla-inbound-linux64-talos", 08:24:19 INFO - "changes": [ 08:24:19 INFO - { 08:24:19 INFO - "category": null, 08:24:19 INFO - "files": [ 08:24:19 INFO - { 08:24:19 INFO - "url": null, 08:24:19 INFO - "name": "https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:24:19 INFO - } 08:24:19 INFO - ], 08:24:19 INFO - "repository": "", 08:24:19 INFO - "rev": "f23ae6d4207719a808b285f0eb0504145b37d709", 08:24:19 INFO - "who": "rjesup@wgate.com", 08:24:19 INFO - "when": 1447947963, 08:24:19 INFO - "number": 6683177, 08:24:19 INFO - "comments": "Bug 1226146: fix sndio audio_device backend after webrtc 43 landing in bug 1198458 r=jesup NPOTB", 08:24:19 INFO - "project": "", 08:24:19 INFO - "at": "Thu 19 Nov 2015 07:46:03", 08:24:19 INFO - "branch": "mozilla-inbound-linux64-talos", 08:24:19 INFO - "revlink": "", 08:24:19 INFO - "properties": [ 08:24:19 INFO - [ 08:24:19 INFO - "buildid", 08:24:19 INFO - "20151119064919", 08:24:19 INFO - "Change" 08:24:19 INFO - ], 08:24:19 INFO - [ 08:24:19 INFO - "builduid", 08:24:19 INFO - "d34d47921cc0487180da06e33f8a512b", 08:24:19 INFO - "Change" 08:24:19 INFO - ], 08:24:19 INFO - [ 08:24:19 INFO - "pgo_build", 08:24:19 INFO - "False", 08:24:19 INFO - "Change" 08:24:19 INFO - ] 08:24:19 INFO - ], 08:24:19 INFO - "revision": "f23ae6d4207719a808b285f0eb0504145b37d709" 08:24:19 INFO - } 08:24:19 INFO - ], 08:24:19 INFO - "revision": "f23ae6d4207719a808b285f0eb0504145b37d709" 08:24:19 INFO - } 08:24:19 INFO - } 08:24:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:24:19 INFO - Running post-action listener: _resource_record_post_action 08:24:19 INFO - ##### 08:24:19 INFO - ##### Running download-and-extract step. 08:24:19 INFO - ##### 08:24:19 INFO - Running pre-action listener: _resource_record_pre_action 08:24:19 INFO - Running main action method: download_and_extract 08:24:19 INFO - mkdir: /builds/slave/test/build/tests 08:24:19 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')]} 08:24:19 INFO - https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:24:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/test_packages.json 08:24:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/test_packages.json 08:24:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:24:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:24:20 INFO - Downloaded 1302 bytes. 08:24:20 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:24:20 INFO - Using the following test package requirements: 08:24:20 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:20 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:24:20 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:20 INFO - u'jsshell-linux-x86_64.zip'], 08:24:20 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:24:20 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:20 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:24:20 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:24:20 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:24:20 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:24:20 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:24:20 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:24:20 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:24:20 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')]} 08:24:20 INFO - https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:24:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:24:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:24:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/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 08:24:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/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 08:24:21 INFO - Downloaded 21336529 bytes. 08:24:21 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 08:24:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:24:21 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 08:24:22 INFO - Return code: 0 08:24:22 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 08:24:22 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')]} 08:24:22 INFO - https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:24:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:24:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:24:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/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 08:24:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/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 08:24:35 INFO - Downloaded 21336529 bytes. 08:24:35 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 08:24:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:24:35 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 08:24:36 INFO - Return code: 0 08:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:36 INFO - https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/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 08:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/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 08:24:37 INFO - Downloaded 11130997 bytes. 08:24:37 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 08:24:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:24:37 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 08:24:37 INFO - Return code: 0 08:24:37 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')]} 08:24:37 INFO - https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/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 08:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/crBC-Ju-RDyyGPmgAHL2tA/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 08:24:38 INFO - Downloaded 55780441 bytes. 08:24:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:24:38 INFO - mkdir: /builds/slave/test/properties 08:24:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:24:38 INFO - Writing to file /builds/slave/test/properties/build_url 08:24:38 INFO - Contents: 08:24:38 INFO - build_url:https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:24:38 INFO - Running post-action listener: _resource_record_post_action 08:24:38 INFO - Running post-action listener: set_extra_try_arguments 08:24:38 INFO - ##### 08:24:38 INFO - ##### Running populate-webroot step. 08:24:38 INFO - ##### 08:24:38 INFO - Running pre-action listener: _resource_record_pre_action 08:24:38 INFO - Running main action method: populate_webroot 08:24:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:24:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:24:38 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:24:38 INFO - '../fennec_ids.txt'], 08:24:38 INFO - 'tests': ['tcheck2']}, 08:24:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:24:38 INFO - '--tppagecycles', 08:24:38 INFO - '7'], 08:24:38 INFO - 'tests': ['tsvgm']}}, 08:24:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:24:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:24:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:24:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:24:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:24:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:24:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:38 INFO - 'talos_options': ['--e10s'], 08:24:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:38 INFO - 'tests': ['damp', 'tps']}, 08:24:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:38 INFO - 'talos_options': ['--e10s'], 08:24:38 INFO - 'tests': ['damp', 'tps']}, 08:24:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:24:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:24:38 INFO - 'other': {'tests': ['a11yr', 08:24:38 INFO - 'ts_paint', 08:24:38 INFO - 'tpaint', 08:24:38 INFO - 'sessionrestore', 08:24:38 INFO - 'sessionrestore_no_auto_restore']}, 08:24:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:24:38 INFO - 'tests': ['a11yr', 08:24:38 INFO - 'ts_paint', 08:24:38 INFO - 'tpaint', 08:24:38 INFO - 'sessionrestore', 08:24:38 INFO - 'sessionrestore_no_auto_restore']}, 08:24:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:24:38 INFO - 'tests': ['a11yr', 08:24:38 INFO - 'ts_paint', 08:24:38 INFO - 'tpaint', 08:24:38 INFO - 'sessionrestore', 08:24:38 INFO - 'sessionrestore_no_auto_restore']}, 08:24:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:24:38 INFO - 'tests': ['a11yr', 08:24:38 INFO - 'ts_paint', 08:24:38 INFO - 'tpaint', 08:24:38 INFO - 'sessionrestore', 08:24:38 INFO - 'sessionrestore_no_auto_restore']}, 08:24:38 INFO - 'other_l64': {'tests': ['a11yr', 08:24:38 INFO - 'ts_paint', 08:24:38 INFO - 'tpaint', 08:24:38 INFO - 'sessionrestore', 08:24:38 INFO - 'sessionrestore_no_auto_restore']}, 08:24:38 INFO - 'other_nol64': {'tests': ['a11yr', 08:24:38 INFO - 'ts_paint', 08:24:38 INFO - 'tpaint', 08:24:38 INFO - 'sessionrestore', 08:24:38 INFO - 'sessionrestore_no_auto_restore']}, 08:24:38 INFO - 'svgr': {'tests': ['tsvgx', 08:24:38 INFO - 'tsvgr_opacity', 08:24:38 INFO - 'tart', 08:24:38 INFO - 'tscrollx', 08:24:38 INFO - 'cart']}, 08:24:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:24:38 INFO - 'tests': ['tsvgx', 08:24:38 INFO - 'tsvgr_opacity', 08:24:38 INFO - 'tart', 08:24:38 INFO - 'tscrollx', 08:24:38 INFO - 'cart']}, 08:24:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:38 INFO - 'tests': ['tp5o']}, 08:24:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:38 INFO - 'talos_options': ['--e10s'], 08:24:38 INFO - 'tests': ['tp5o']}, 08:24:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:38 INFO - 'talos_options': ['--xperf_path', 08:24:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:38 INFO - 'tests': ['tp5n']}, 08:24:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:38 INFO - 'talos_options': ['--e10s', 08:24:38 INFO - '--xperf_path', 08:24:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:38 INFO - 'tests': ['tp5n']}}, 08:24:38 INFO - 'talos.zip': {'path': '', 08:24:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:24:38 INFO - Running post-action listener: _resource_record_post_action 08:24:38 INFO - ##### 08:24:38 INFO - ##### Running create-virtualenv step. 08:24:38 INFO - ##### 08:24:38 INFO - Running pre-action listener: _resource_record_pre_action 08:24:38 INFO - Running main action method: create_virtualenv 08:24:38 INFO - Creating virtualenv /builds/slave/test/build/venv 08:24:38 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 08:24:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:24:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:24:39 INFO - Using real prefix '/usr' 08:24:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:24:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:24:41 INFO - Installing pip.................done. 08:24:41 INFO - Return code: 0 08:24:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:24:41 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')]} 08:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:41 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')]} 08:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:41 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 0x7f0a38c5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795b70>, '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 0x17e6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e7250>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', '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 08:24:41 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 08:24:41 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 08:24:41 INFO - Using env: {'DISPLAY': ':0', 08:24:41 INFO - 'HOME': '/home/cltbld', 08:24:41 INFO - 'LANG': 'en_US.UTF-8', 08:24:41 INFO - 'LANGUAGE': 'en_US:en', 08:24:41 INFO - 'LOGNAME': 'cltbld', 08:24:41 INFO - 'MAIL': '/var/mail/cltbld', 08:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:41 INFO - 'MOZ_NO_REMOTE': '1', 08:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:41 INFO - 'NO_EM_RESTART': '1', 08:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:41 INFO - 'PWD': '/builds/slave/test', 08:24:41 INFO - 'SHELL': '/bin/bash', 08:24:41 INFO - 'SHLVL': '1', 08:24:41 INFO - 'TERM': 'linux', 08:24:41 INFO - 'TMOUT': '86400', 08:24:41 INFO - 'USER': 'cltbld', 08:24:41 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', 08:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:41 INFO - '_': '/tools/buildbot/bin/python'} 08:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:41 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 08:24:41 INFO - Cleaning up... 08:24:41 INFO - Return code: 0 08:24:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:24:41 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')]} 08:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:41 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')]} 08:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:41 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 0x7f0a38c5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795b70>, '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 0x17e6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e7250>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', '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 08:24:41 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 08:24:41 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 08:24:41 INFO - Using env: {'DISPLAY': ':0', 08:24:41 INFO - 'HOME': '/home/cltbld', 08:24:41 INFO - 'LANG': 'en_US.UTF-8', 08:24:41 INFO - 'LANGUAGE': 'en_US:en', 08:24:41 INFO - 'LOGNAME': 'cltbld', 08:24:41 INFO - 'MAIL': '/var/mail/cltbld', 08:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:41 INFO - 'MOZ_NO_REMOTE': '1', 08:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:41 INFO - 'NO_EM_RESTART': '1', 08:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:41 INFO - 'PWD': '/builds/slave/test', 08:24:41 INFO - 'SHELL': '/bin/bash', 08:24:41 INFO - 'SHLVL': '1', 08:24:41 INFO - 'TERM': 'linux', 08:24:41 INFO - 'TMOUT': '86400', 08:24:41 INFO - 'USER': 'cltbld', 08:24:41 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', 08:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:41 INFO - '_': '/tools/buildbot/bin/python'} 08:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:42 INFO - Downloading/unpacking psutil>=0.7.1 08:24:42 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 08:24:42 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 08:24:42 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 08:24:42 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 08:24:42 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 08:24:42 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 08:24:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:24:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:24:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:43 INFO - Installing collected packages: psutil 08:24:43 INFO - Running setup.py install for psutil 08:24:43 INFO - building 'psutil._psutil_linux' extension 08:24:43 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 08:24:44 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 08:24:44 INFO - building 'psutil._psutil_posix' extension 08:24:44 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 08:24:44 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 08:24:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:44 INFO - Successfully installed psutil 08:24:44 INFO - Cleaning up... 08:24:44 INFO - Return code: 0 08:24:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:24:44 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')]} 08:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:44 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')]} 08:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:44 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 0x7f0a38c5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795b70>, '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 0x17e6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e7250>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', '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 08:24:44 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 08:24:44 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 08:24:44 INFO - Using env: {'DISPLAY': ':0', 08:24:44 INFO - 'HOME': '/home/cltbld', 08:24:44 INFO - 'LANG': 'en_US.UTF-8', 08:24:44 INFO - 'LANGUAGE': 'en_US:en', 08:24:44 INFO - 'LOGNAME': 'cltbld', 08:24:44 INFO - 'MAIL': '/var/mail/cltbld', 08:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:44 INFO - 'MOZ_NO_REMOTE': '1', 08:24:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:44 INFO - 'NO_EM_RESTART': '1', 08:24:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:44 INFO - 'PWD': '/builds/slave/test', 08:24:44 INFO - 'SHELL': '/bin/bash', 08:24:44 INFO - 'SHLVL': '1', 08:24:44 INFO - 'TERM': 'linux', 08:24:44 INFO - 'TMOUT': '86400', 08:24:44 INFO - 'USER': 'cltbld', 08:24:44 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', 08:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:44 INFO - '_': '/tools/buildbot/bin/python'} 08:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:24:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:24:46 INFO - Installing collected packages: mozsystemmonitor 08:24:46 INFO - Running setup.py install for mozsystemmonitor 08:24:46 INFO - Successfully installed mozsystemmonitor 08:24:46 INFO - Cleaning up... 08:24:46 INFO - Return code: 0 08:24:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:46 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 0x7f0a38c5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795b70>, '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 0x17e6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e7250>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', '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 08:24:46 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 08:24:46 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 08:24:46 INFO - Using env: {'DISPLAY': ':0', 08:24:46 INFO - 'HOME': '/home/cltbld', 08:24:46 INFO - 'LANG': 'en_US.UTF-8', 08:24:46 INFO - 'LANGUAGE': 'en_US:en', 08:24:46 INFO - 'LOGNAME': 'cltbld', 08:24:46 INFO - 'MAIL': '/var/mail/cltbld', 08:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:46 INFO - 'MOZ_NO_REMOTE': '1', 08:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:46 INFO - 'NO_EM_RESTART': '1', 08:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:46 INFO - 'PWD': '/builds/slave/test', 08:24:46 INFO - 'SHELL': '/bin/bash', 08:24:46 INFO - 'SHLVL': '1', 08:24:46 INFO - 'TERM': 'linux', 08:24:46 INFO - 'TMOUT': '86400', 08:24:46 INFO - 'USER': 'cltbld', 08:24:46 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', 08:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:46 INFO - '_': '/tools/buildbot/bin/python'} 08:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:46 INFO - Downloading/unpacking blobuploader==1.2.4 08:24:46 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 08:24:46 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 08:24:46 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 08:24:46 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 08:24:46 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 08:24:46 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 08:24:48 INFO - Downloading blobuploader-1.2.4.tar.gz 08:24:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:24:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:24:48 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 08:24:48 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 08:24:48 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 08:24:48 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 08:24:48 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 08:24:48 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 08:24:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:24:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:24:48 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 08:24:48 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 08:24:48 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 08:24:48 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 08:24:48 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 08:24:48 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 08:24:48 INFO - Downloading docopt-0.6.1.tar.gz 08:24:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:24:49 INFO - Installing collected packages: blobuploader, requests, docopt 08:24:49 INFO - Running setup.py install for blobuploader 08:24:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:24:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:24:49 INFO - Running setup.py install for requests 08:24:49 INFO - Running setup.py install for docopt 08:24:49 INFO - Successfully installed blobuploader requests docopt 08:24:49 INFO - Cleaning up... 08:24:49 INFO - Return code: 0 08:24:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:49 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 0x7f0a38c5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795b70>, '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 0x17e6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e7250>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', '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 08:24:49 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 08:24:49 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 08:24:49 INFO - Using env: {'DISPLAY': ':0', 08:24:49 INFO - 'HOME': '/home/cltbld', 08:24:49 INFO - 'LANG': 'en_US.UTF-8', 08:24:49 INFO - 'LANGUAGE': 'en_US:en', 08:24:49 INFO - 'LOGNAME': 'cltbld', 08:24:49 INFO - 'MAIL': '/var/mail/cltbld', 08:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:49 INFO - 'MOZ_NO_REMOTE': '1', 08:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:49 INFO - 'NO_EM_RESTART': '1', 08:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:49 INFO - 'PWD': '/builds/slave/test', 08:24:49 INFO - 'SHELL': '/bin/bash', 08:24:49 INFO - 'SHLVL': '1', 08:24:49 INFO - 'TERM': 'linux', 08:24:49 INFO - 'TMOUT': '86400', 08:24:49 INFO - 'USER': 'cltbld', 08:24:49 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', 08:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:49 INFO - '_': '/tools/buildbot/bin/python'} 08:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:49 INFO - Running setup.py (path:/tmp/pip-nwluAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:49 INFO - Running setup.py (path:/tmp/pip-mw4rcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:50 INFO - Running setup.py (path:/tmp/pip-AJDBd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:50 INFO - Running setup.py (path:/tmp/pip-8AY57n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:50 INFO - Running setup.py (path:/tmp/pip-DPeHaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:50 INFO - Running setup.py (path:/tmp/pip-4xRfSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:50 INFO - Running setup.py (path:/tmp/pip-JpfVmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:50 INFO - Running setup.py (path:/tmp/pip-Dkw15X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:50 INFO - Running setup.py (path:/tmp/pip-mfWXo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:50 INFO - Running setup.py (path:/tmp/pip-IWGFTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:50 INFO - Running setup.py (path:/tmp/pip-2dCaZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:50 INFO - Running setup.py (path:/tmp/pip-zUX8Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:50 INFO - Running setup.py (path:/tmp/pip-57p5w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:50 INFO - Running setup.py (path:/tmp/pip-dwS0h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:50 INFO - Running setup.py (path:/tmp/pip-iSSKYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:50 INFO - Running setup.py (path:/tmp/pip-Gc5ehY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:51 INFO - Running setup.py (path:/tmp/pip-o1Np0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:24:51 INFO - Running setup.py install for manifestparser 08:24:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:24:51 INFO - Running setup.py install for mozcrash 08:24:51 INFO - Running setup.py install for mozdebug 08:24:51 INFO - Running setup.py install for mozdevice 08:24:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:24:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:24:51 INFO - Running setup.py install for mozfile 08:24:51 INFO - Running setup.py install for mozhttpd 08:24:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:24:51 INFO - Running setup.py install for mozinfo 08:24:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:24:51 INFO - Running setup.py install for mozInstall 08:24:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:24:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:24:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:24:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:24:51 INFO - Running setup.py install for mozleak 08:24:51 INFO - Running setup.py install for mozlog 08:24:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:24:52 INFO - Running setup.py install for moznetwork 08:24:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:24:52 INFO - Running setup.py install for mozprocess 08:24:52 INFO - Running setup.py install for mozprofile 08:24:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:24:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:24:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:24:52 INFO - Running setup.py install for mozrunner 08:24:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:24:52 INFO - Running setup.py install for mozscreenshot 08:24:52 INFO - Running setup.py install for moztest 08:24:52 INFO - Running setup.py install for mozversion 08:24:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:24:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:24:52 INFO - Cleaning up... 08:24:52 INFO - Return code: 0 08:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f0a38c5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795b70>, '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 0x17e6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e7250>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', '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 08:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 08:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 08:24:52 INFO - Using env: {'DISPLAY': ':0', 08:24:52 INFO - 'HOME': '/home/cltbld', 08:24:52 INFO - 'LANG': 'en_US.UTF-8', 08:24:52 INFO - 'LANGUAGE': 'en_US:en', 08:24:52 INFO - 'LOGNAME': 'cltbld', 08:24:52 INFO - 'MAIL': '/var/mail/cltbld', 08:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:52 INFO - 'MOZ_NO_REMOTE': '1', 08:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:52 INFO - 'NO_EM_RESTART': '1', 08:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:52 INFO - 'PWD': '/builds/slave/test', 08:24:52 INFO - 'SHELL': '/bin/bash', 08:24:52 INFO - 'SHLVL': '1', 08:24:52 INFO - 'TERM': 'linux', 08:24:52 INFO - 'TMOUT': '86400', 08:24:52 INFO - 'USER': 'cltbld', 08:24:52 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', 08:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:52 INFO - '_': '/tools/buildbot/bin/python'} 08:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:24:53 INFO - Running setup.py (path:/tmp/pip-Y3LCcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:24:53 INFO - Running setup.py (path:/tmp/pip-Nee_r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:24:53 INFO - Running setup.py (path:/tmp/pip-rpSMUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:24:53 INFO - Running setup.py (path:/tmp/pip-A8IVhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:24:53 INFO - Running setup.py (path:/tmp/pip-x2vIxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:24:53 INFO - Running setup.py (path:/tmp/pip-WL4j1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:24:53 INFO - Running setup.py (path:/tmp/pip-aeaO7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:24:53 INFO - Running setup.py (path:/tmp/pip-RpjMEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:24:53 INFO - Running setup.py (path:/tmp/pip-GDpnPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:24:53 INFO - Running setup.py (path:/tmp/pip-LeHANi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:24:53 INFO - Running setup.py (path:/tmp/pip-ce4qMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:24:53 INFO - Running setup.py (path:/tmp/pip-o7LTHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:24:53 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)) 08:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:24:53 INFO - Running setup.py (path:/tmp/pip-AsEYok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:24:54 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)) 08:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:24:54 INFO - Running setup.py (path:/tmp/pip-lOwAkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:24:54 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)) 08:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:54 INFO - Running setup.py (path:/tmp/pip-irLSZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:24:54 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)) 08:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:24:54 INFO - Running setup.py (path:/tmp/pip-5NKAVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:24:54 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)) 08:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:24:54 INFO - Running setup.py (path:/tmp/pip-QuuaUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:24:54 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)) 08:24:54 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)) 08:24:54 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)) 08:24:54 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)) 08:24:54 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)) 08:24:54 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)) 08:24:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:24:54 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 08:24:54 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 08:24:54 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 08:24:54 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 08:24:54 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 08:24:54 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 08:24:55 INFO - Downloading blessings-1.5.1.tar.gz 08:24:55 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 08:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:24:56 INFO - Installing collected packages: blessings 08:24:56 INFO - Running setup.py install for blessings 08:24:56 INFO - Successfully installed blessings 08:24:56 INFO - Cleaning up... 08:24:56 INFO - Return code: 0 08:24:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:56 INFO - Reading from file tmpfile_stdout 08:24:56 INFO - Current package versions: 08:24:56 INFO - argparse == 1.2.1 08:24:56 INFO - blessings == 1.5.1 08:24:56 INFO - blobuploader == 1.2.4 08:24:56 INFO - docopt == 0.6.1 08:24:56 INFO - manifestparser == 1.1 08:24:56 INFO - mozInstall == 1.12 08:24:56 INFO - mozcrash == 0.16 08:24:56 INFO - mozdebug == 0.1 08:24:56 INFO - mozdevice == 0.47 08:24:56 INFO - mozfile == 1.2 08:24:56 INFO - mozhttpd == 0.7 08:24:56 INFO - mozinfo == 0.9 08:24:56 INFO - mozleak == 0.1 08:24:56 INFO - mozlog == 3.0 08:24:56 INFO - moznetwork == 0.27 08:24:56 INFO - mozprocess == 0.22 08:24:56 INFO - mozprofile == 0.27 08:24:56 INFO - mozrunner == 6.11 08:24:56 INFO - mozscreenshot == 0.1 08:24:56 INFO - mozsystemmonitor == 0.0 08:24:56 INFO - moztest == 0.7 08:24:56 INFO - mozversion == 1.4 08:24:56 INFO - psutil == 3.1.1 08:24:56 INFO - requests == 1.2.3 08:24:56 INFO - wsgiref == 0.1.2 08:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:24: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')]} 08:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24: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')]} 08:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f0a38c5bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169e6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1795b70>, '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 0x17e6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e7250>, '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': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', '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 08:24:56 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 08:24:56 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 08:24:56 INFO - Using env: {'DISPLAY': ':0', 08:24:56 INFO - 'HOME': '/home/cltbld', 08:24:56 INFO - 'LANG': 'en_US.UTF-8', 08:24:56 INFO - 'LANGUAGE': 'en_US:en', 08:24:56 INFO - 'LOGNAME': 'cltbld', 08:24:56 INFO - 'MAIL': '/var/mail/cltbld', 08:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:56 INFO - 'MOZ_NO_REMOTE': '1', 08:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:56 INFO - 'NO_EM_RESTART': '1', 08:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:56 INFO - 'PWD': '/builds/slave/test', 08:24:56 INFO - 'SHELL': '/bin/bash', 08:24:56 INFO - 'SHLVL': '1', 08:24:56 INFO - 'TERM': 'linux', 08:24:56 INFO - 'TMOUT': '86400', 08:24:56 INFO - 'USER': 'cltbld', 08:24:56 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', 08:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:56 INFO - '_': '/tools/buildbot/bin/python'} 08:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:56 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)) 08:24:56 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)) 08:24:56 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)) 08:24:56 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)) 08:24:56 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)) 08:24:56 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)) 08:24:56 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)) 08:24:56 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)) 08:24:56 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)) 08:24:56 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)) 08:24:56 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)) 08:24:56 INFO - Cleaning up... 08:24:56 INFO - Return code: 0 08:24:56 INFO - Running post-action listener: _resource_record_post_action 08:24:56 INFO - Running post-action listener: _start_resource_monitoring 08:24:56 INFO - Starting resource monitoring. 08:24:56 INFO - ##### 08:24:56 INFO - ##### Running install step. 08:24:56 INFO - ##### 08:24:56 INFO - Running pre-action listener: _resource_record_pre_action 08:24:56 INFO - Running main action method: install 08:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:24:56 INFO - Reading from file tmpfile_stdout 08:24:56 INFO - Detecting whether we're running mozinstall >=1.0... 08:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:24:56 INFO - Reading from file tmpfile_stdout 08:24:56 INFO - Output received: 08:24:56 INFO - Usage: mozinstall [options] installer 08:24:56 INFO - Options: 08:24:56 INFO - -h, --help show this help message and exit 08:24:56 INFO - -d DEST, --destination=DEST 08:24:56 INFO - Directory to install application into. [default: 08:24:56 INFO - "/builds/slave/test"] 08:24:56 INFO - --app=APP Application being installed. [default: firefox] 08:24:56 INFO - mkdir: /builds/slave/test/build/application 08:24:56 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'] 08:24:56 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 08:25:11 INFO - Reading from file tmpfile_stdout 08:25:11 INFO - Output received: 08:25:11 INFO - /builds/slave/test/build/application/firefox/firefox 08:25:11 INFO - Running post-action listener: _resource_record_post_action 08:25:11 INFO - ##### 08:25:11 INFO - ##### Running run-tests step. 08:25:11 INFO - ##### 08:25:11 INFO - Running pre-action listener: _resource_record_pre_action 08:25:11 INFO - Running main action method: run_tests 08:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:25:11 INFO - Python 2.7.3 08:25:11 INFO - Return code: 0 08:25:11 INFO - grabbing minidump binary from tooltool 08:25: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')]} 08:25:11 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 0x1795b70>, '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 0x17e6dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e7250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:25:11 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 08:25:11 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 08:25:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:25:11 INFO - Return code: 0 08:25:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:25:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:25:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:25:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:25:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] in /builds/slave/test/build 08:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost 08:25:11 INFO - Using env: {'DISPLAY': ':0', 08:25:11 INFO - 'HOME': '/home/cltbld', 08:25:11 INFO - 'LANG': 'en_US.UTF-8', 08:25:11 INFO - 'LANGUAGE': 'en_US:en', 08:25:11 INFO - 'LOGNAME': 'cltbld', 08:25:11 INFO - 'MAIL': '/var/mail/cltbld', 08:25:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:25:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:11 INFO - 'MOZ_NO_REMOTE': '1', 08:25:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:11 INFO - 'NO_EM_RESTART': '1', 08:25:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:11 INFO - 'PWD': '/builds/slave/test', 08:25:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:25:11 INFO - 'SHELL': '/bin/bash', 08:25:11 INFO - 'SHLVL': '1', 08:25:11 INFO - 'TERM': 'linux', 08:25:11 INFO - 'TMOUT': '86400', 08:25:11 INFO - 'USER': 'cltbld', 08:25:11 INFO - 'XDG_SESSION_COOKIE': '8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445', 08:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:11 INFO - '_': '/tools/buildbot/bin/python'} 08:25:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost'] with output_timeout 3600 08:25:11 INFO - mozversion INFO | application_buildid: 20151119064919 08:25:11 INFO - mozversion INFO | application_changeset: f23ae6d4207719a808b285f0eb0504145b37d709 08:25:11 INFO - mozversion INFO | application_display_name: Nightly 08:25:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:25:11 INFO - mozversion INFO | application_name: Firefox 08:25:11 INFO - mozversion INFO | application_remotingname: firefox 08:25:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:25:11 INFO - mozversion INFO | application_vendor: Mozilla 08:25:11 INFO - mozversion INFO | application_version: 45.0a1 08:25:11 INFO - mozversion INFO | platform_buildid: 20151119064919 08:25:11 INFO - mozversion INFO | platform_changeset: f23ae6d4207719a808b285f0eb0504145b37d709 08:25:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:25:11 INFO - mozversion INFO | platform_version: 45.0a1 08:25:11 INFO - 2015-11-19 08:25:11,348 DEBUG : using testdate: 1447950311 08:25:11 INFO - 2015-11-19 08:25:11,348 DEBUG : actual date: 1447950311 08:25:11 INFO - 2015-11-19 08:25:11,439 INFO : starting webserver on 'localhost:41544' 08:25:11 INFO - 2015-11-19 08:25:11,440 INFO : Starting test suite talos-linux64-ix-004.e 08:25:11 INFO - 2015-11-19 08:25:11,440 INFO : Starting test dromaeo_css 08:25:11 INFO - 2015-11-19 08:25:11,440 DEBUG : operating with platform_type : linux_ 08:25:11 INFO - 2015-11-19 08:25:11,441 INFO : Initialising browser for dromaeo_css test... 08:25:11 INFO - 2015-11-19 08:25:11,458 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYoYSP0/profile http://localhost:41544/getInfo.html 08:25:16 INFO - 2015-11-19 08:25:16,999 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:25:17 INFO - 2015-11-19 08:25:16,999 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:25:17 INFO - 2015-11-19 08:25:16,999 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:25:17 INFO - 2015-11-19 08:25:17,000 DEBUG : BROWSER_OUTPUT: __metrics 08:25:18 INFO - 2015-11-19 08:25:18,134 INFO : Browser initialized. 08:25:18 INFO - 2015-11-19 08:25:18,135 INFO : Running cycle 1/1 for dromaeo_css test... 08:25:18 INFO - 2015-11-19 08:25:18,135 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYoYSP0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:25:30 INFO - 2015-11-19 08:25:30,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 142008320 08:25:30 INFO - 2015-11-19 08:25:30,092 DEBUG : BROWSER_OUTPUT: 08:26:19 INFO - 2015-11-19 08:26:19,748 DEBUG : BROWSER_OUTPUT: 1447950379742 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] 08:28:31 INFO - 2015-11-19 08:28:31,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41544/tests/dromaeo/cssquery-ext.html) 08:28:33 INFO - 2015-11-19 08:28:33,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 145637376 08:28:33 INFO - 2015-11-19 08:28:33,033 DEBUG : BROWSER_OUTPUT: 08:31:35 INFO - 2015-11-19 08:31:35,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/dromaeo/cssquery-ext.html (next: http://localhost:41544/tests/dromaeo/cssquery-jquery.html) 08:31:35 INFO - 2015-11-19 08:31:35,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 143101952 08:31:35 INFO - 2015-11-19 08:31:35,644 DEBUG : BROWSER_OUTPUT: 08:34:37 INFO - 2015-11-19 08:34:37,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41544/tests/dromaeo/cssquery-mootools.html) 08:34:38 INFO - 2015-11-19 08:34:38,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 142020608 08:34:38 INFO - 2015-11-19 08:34:38,049 DEBUG : BROWSER_OUTPUT: 08:37:39 INFO - 2015-11-19 08:37:39,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41544/tests/dromaeo/cssquery-prototype.html) 08:37:40 INFO - 2015-11-19 08:37:40,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 141279232 08:37:40 INFO - 2015-11-19 08:37:40,353 DEBUG : BROWSER_OUTPUT: 08:40:42 INFO - 2015-11-19 08:40:42,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41544/tests/dromaeo/cssquery-yui.html) 08:40:43 INFO - 2015-11-19 08:40:43,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 142028800 08:40:43 INFO - 2015-11-19 08:40:43,542 DEBUG : BROWSER_OUTPUT: 08:43:45 INFO - 2015-11-19 08:43:45,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/dromaeo/cssquery-yui.html (next: http://localhost:41544/tests/dromaeo/cssquery-dojo.html) 08:43:46 INFO - 2015-11-19 08:43:46,147 DEBUG : BROWSER_OUTPUT: RSS: Main: 144601088 08:43:46 INFO - 2015-11-19 08:43:46,148 DEBUG : BROWSER_OUTPUT: 08:43:46 INFO - 2015-11-19 08:43:46,149 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:43:46 INFO - 2015-11-19 08:43:46,149 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:43:46 INFO - 2015-11-19 08:43:46,149 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:43:46 INFO - 2015-11-19 08:43:46,150 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:43:46 INFO - 2015-11-19 08:43:46,151 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2706.9593956090657;2766.585012248164;2793.231861238159;2810.3957649105437;2814.8451835149067;4675.055750238932;4740.69185502942;4744.430668319797;4802.087603355369;4830.855074347771;4818.301346304784;4832.226843705008;4850.708957462554;4851.369321988137;4945.159322915104;4375.474943006828;4458.643308535326;4486.842960496383;4510;4529.524399938008;4296.591823776736;4474.619657329131;4546.522615125397;4548.113117941986;4560.429946256718;4351.390805287278;4458.71018383804;4460.598546130831;4471.575200355961;4498.865034048984;4444.35556844259;4456.86349980756;4459.9331010034875;4467.977660111678;4504.986378064909;4305.526392096866;4361.6074553290355;4398.47218333802;4443.555644435531;4474;4679.532046795327;4750.311204875274;4755.310479980383;4792.209285467894;4804.927926081112;5149.948500515022;5150.690958542499;5153;5154.742262886841;5177.58579313654;4963.4292056413615;5034.219695947134;5096;5165.1219292720325;5246.37043554772;4744.454387745384;4825.686330388514;4869.805207791719;4873.926891096637;4930.506949305112;5364.436734142937;5367.355917289872;5367.651102678314;5373.919391209135;5378;4870.610351171968;4961.90076198474;4994.926090890476;5039;5119.129747942859;5214.504622060898;5241.135212689864;5280.3663560373;5280.577553795764;5329.040772660881;4824.204006338985;5198.246254293182;5206.427292997767;5210.609204309692;5215.921761173586;4976.402831660224;5032.069067222503;5122.795088196431;5159.948400516022;5211.843644690665;4226.281532139544;4249.32010878258;4257.042165512735;4270.978645106755;4277.294246449301;3611.1874828163454;3681.6686498214754;3709.4621279914263;3717.8698745543775;3758.342290099222;4322.394864718942;4396.4284642996845;4401.207782599163;4409.889752756143;4417.469903611523;5172.8965420691375;5175.534201921845;5178.559822415062;5195.090859099718;5210.348706411699;4217.451731274976;4330.783460827009;4447.755373454426;4450.06548624786;4470.664700147437;4575.2450845610765;4604.746738929324;4610.400647915817;4631.3516107744945;4649.023705021916;4927;4946.258061290835;4964.304997300381;4972.453030166606;5008.524190201925;5050.949490505195;5148.922766158586;5181.119209734279;5244.9737751310995;5333.173358129496;4862.3922009748785;4895.755212239303;4899.485554016919;4904.411470623548;4947.257911313188;5098.592112631055;5100.795968161232;5106.591472682102;5110.66780659256;5111.693298402108;4996.800127994839;5097.949020509747;5106.183010718267;5246.029484545371;5256.842294731164;4987.351644286219;5018.197088465828;5024.045431368028;5028.547430731252;5045.7981680732355;4998.225275082368;5004.549590536869;5004.549590536869;5018.874528136826;5020.347354843847;4751.738654373904;4796.328514008112;4853.296272040464;4879.414470263591;4881.267809828554;5083.085044691991;5129.230615407719;5141.074606570854;5158.148905430712;5167.405748338989;4677.064587082529;4979.053979743837;4981.651284410056;4986.32684587576;4999.300097986357 08:43:46 INFO - 2015-11-19 08:43:46,152 DEBUG : BROWSER_OUTPUT: |1;ext.html;529.2114749023953;550.3945659774246;571.3172758553527;572.6420986883198;579.6551052123988;35743;37177.25645487092;37236.25527489449;37252.06869828256;37302.8134859326;39268.41097383542;39638.40542391859;39660.628846548;40067.799661001656;40174.397384039265;7934.404919631007;8035.316998055172;8087.191280871924;8091.878621820678;8110.878336824952;7858.607069646523;7939.285464308211;7963.084245311777;7976.880346794803;7980.04239491259;7889.605519724019;7925.207479252086;8004.559749213791;8028.718994835182;8032.3172530335;7868.977032985704;8008.799780005517;8023.077346105214;8026.518408895456;8034.9598252008955;7843.098043724987;7913.089994650573;8012.198780121999;8023.598820058974;8030.156833532454;37667.62332376696;37676.43485347722;37785.811070944466;37983.43024854629;38127.237455251015;2454.1410506322823;2776.8611569421446;2856.814307070034;2941.1323659520494;3080;25980.610290845652;26058;26094;26401;26427.867860660765;3401.4727717203627;3485.860565577374;3501.124718820295;3516.8593256269974;3582.5163602913535;211795;214973;216009;216210;216344.99999999843;49572.75213623909;51276.23085653718;55667.44332556704;59911.40088599058;62337.376626234065;56318.71840640771;56466.71766641222;56773.71613141908;56956;57084.42915570874;14419.711605767827;14620.122792632263;14628.853711462962;14668.486602968846;14696.55910322692;10931.398773067558;11048.502817373237;11071.501782419811;11075.224734268684;11099.334039957628;19139.712904306445;19498.12258448373;19531.21875124979;19599.412017639494;19619.509512262306;7780.49426787257;7882.5270483771155;7972.521648701097;8081.595920203967;8114.553699546464;870.7997160652959;879.8944126704837;899.6446403670514;979.9265055120752;1020.8519764634086;25697.486050279265;26014.86992565063;26019.21942341733;26027.349316267246;26396.47207055848;932.7621456528542;944.7071407863584;960.1358777100666;995.8356871116184;1129.1587767113554;13885.86114138866;13901.652458688613;14839.258037098101;15909;16304.918475407547;305382;308218;309212;309926;310667;47953.52046479491;48605;48735.268970965466;48804.755976219894;48975.51024489781;1193.5345215366015;1194.2714943884223;1199.2504684572143;1201.6515210589007;1207.7886369885234;26858.115698188565;26888.865555672095;26924.730752692223;27168.456630867666;27197.72802271952;39129.804350979204;39480;39584.802075989435;39628.60371396249;39698.40452393159;227348;228700;228821;230101;230372;27873.44253114886;40679.38980915348;41354.793226033675;41995.16009679851;42080.15839683128;39554.60445395509;39556.40665389964;39711.20577588374;40519.59480405158;40996;33589.49615755815;34262.94422334568;34543.82728086444;34840.30319393649;34854.12864678302;34041.659583403845;34398;34662.480062798575;34740;34743;34441.82779086089;34642.65357346495;34810.82594587011;37635;38923.61076389313;29658;30848.537271941386;31299.53050704287;31491.84254078715;31504;24222.152224672052;24236.75763242345;24313.635295470936;24432.75567244376;24662.136825211033 08:43:46 INFO - 2015-11-19 08:43:46,152 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.20731622158155;326.3082265596935;339.1994892054752;343.28767806800863;343.3339321715871;15109.168995705246;15335.960542295583;15758.684826303466;16200.918995405007;16576.585585360357;10449.216308776853;10459.843102353452;10602.734931626714;10640.148788096953;10710.946445267782;4552.954470455286;4652.790624421909;4676.134915040711;4680.063987202556;4689.343491911135;6202.72087756052;6311.589746666475;6321.683915804214;6323.05154226865;6325.778597749079;3856.5179352580926;6290;6300.369963003709;6329.36706329368;6570.967145164267;6463.967680161616;6500.512461565354;6508.44678202351;6518.804435866931;6558.508111891603;6094.512439004913;6213.316535181127;6243.594166379216;6248.593841400295;6270.561060725751;20933.37199884006;21431.24990625336;21688.34934951954;21736.13055477779;22402.551948961092;1988.9005549722456;2004.6191223667456;2022.1911235505768;2069.193014724259;2084.0413409831344;13990.650233744136;14020.929895350459;14060.367283472267;14196.787048194285;14283.21442320672;1820.1627251464342;1820.9908950455294;1842.1157844234842;1884.4252502986583;1913.9904300478408;60853;64903.67548162276;65566.3443365565;65637.67181164064;66522.66954660928;14858.479953201586;15135.545933621788;15138.697226055418;15182.013169143971;15189.468368607046;22643.20748773785;22724.65913011306;22850;22851.88574057119;22887.198948036737;8097.35221182304;8170.550619715973;8201.8359632807;8218.958905205554;8251.546164960984;6835.179778426621;6878.243393226741;6882.346177113166;6895;6971.860562788817;7315.158756742936;7339.302766237199;7348.162959260185;7407.8888816667795;7442.441816863757;2972.658144313388;3083.599132112856;3094.381123775254;3108.4094022135723;3130.1235654016914;414.4756882543585;416.4149370134965;416.56260926028153;425.406557851795;426.7695444460019;10057.74278215223;15233.923830380998;15669.764953525706;15812.288447019911;15872.841271587367;821.0164400885208;890.4301247201796;952.7570469530225;983.6557204978343;984.675057231112;8635.956820215859;8730.781730456789;8951.104889511127;8982.550872456351;9016.18854303116;402667;403585;404196;412284;414987;72276.277237228;72537;73195.26804731991;74494;75085.62457187679;1008.702432782331;1035.4563853976722;1041.1982773264695;1058.1006144776877;1093.049047328813;14694.11835289886;14713.92643036778;14747.852521474648;14865.925670371578;15114.017588856688;31420.371592567564;32054;32129.196770080936;32576.51135233021;32926.50610240896;38448.23103537969;38681.03297417587;40426.79786601048;40649.59350406458;41438.79280603577;7894.723684671009;8162.306203972729;8234.588270586566;8307.6676932922;8318;9582.952085239529;9718.805623887623;15404.69190616159;16219.107949062914;16276.755848662517;13417.720255356753;13834.30828458553;14138.929305353407;14140.646483837987;14425.85574144245;13650.522231721841;13811.447542098203;13828.93085534566;14173.929130354281;14267.286635668383;13957.511487097903;14090.647733806327;14162.433502659778;14579.635509112357;14822.703545928805;8708.259797917248;8918.331125165769;8953.194212520904;8994.100589940954;9061.818763624822;9782.9021709782;10688.358698478116;14015.719685606435;14240.928795355956;14367.640808979859 08:43:46 INFO - 2015-11-19 08:43:46,153 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1465.1794994802904;1628.430049482681;1680.6638672265549;1695.4489790817988;1712.820153883842;5590.329160500741;5745.224394706714;5748.453896879801;5884.352721200665;5937.970310148443;6989.82525436863;7260.636968151584;7262.891056634155;7306.81732956675;7324.230955749649;2061.7732049474507;2099.727035485385;2100.69539916712;2102.7056212130315;2106.926257580985;2123.702681624574;2129.2866889592005;2136.1028368085363;2137.529743456445;2138.7433507979063;2051.8563700540967;2057.084597354178;2065.1532871522677;2075.2632815350557;2092.3722883135074;2065.132644289402;2072.005437390054;2080.771115177329;2087.3529205946206;2091.947701307472;2091.9267825626184;2102.16964299101;2107.4625970377456;2119.5760847830343;2132.7547332056856;7167.928320716778;7168.175659799138;7188.568685878864;7215.639218039077;7218.350348468611;4288.185244803477;4349.9130017399475;4362.214801335758;4377.9124417511475;4382.233109205877;2821;2827.9293017674518;2962.6444826620727;2963.955540666892;2967.2878509157863;888.2982443869336;898.8471959766855;915.3866909170805;915.6428992692855;948.2603569216022;9428;9440.575174117113;9517.904820951771;9563.760905977337;9585.712428627083;4021;4055.7160998729805;4094.6314831665295;4108;4124.731892426983;8045.15525869787;8048.718294859652;8050.919490805134;8060.355171586259;8063.435559510778;4361.6074553290355;4379.824807007748;4384.868453946323;4386.934195987063;4417.757023363746;3361.8823341182942;3488.3197776433353;3932.1545867638597;3951.38753493209;3964.980175099106;3596.1009747563107;3610.5125808016105;3628.6552777486095;3628.7278454115517;3663.87176448823;1167.8656954450346;1183.923045002072;1187.4597058338436;1192.528951064342;1198.4666823263738;882.8410886040574;895.2256298301922;1176.1061593189238;1179.227605918125;1192.9403529823473;6748.257691653914;6785.728570857111;6792.42264407521;6806;6835.043093966849;1019.7399663086014;1051.3429106808244;1063.3885515828429;1066.8133076711545;1090.225939582905;5121.539061484485;5127.846164615067;5140.511651393112;5161.690298582022;5226.216067589892;8713.172248636369;8787.165219304155;9074;9163.862542061874;9164.450132992042;8870.112988701077;8909;8988.46069235848;9023.458592484472;9026.729198124067;6603.141591593062;6614.305497922649;6667.33326667339;6670.466362690973;6809.012693159464;6379.2344918608205;6390.392912673288;6405;6429.324920883427;6434.260060092962;7368.963155184189;7522.699092036257;7799.610019499116;7840.372770178258;7902.881456778268;7718.228177182237;7731.0336207974005;7748.1864404238995;7786.961065194638;7870.055593328837;5909.970450147722;5987.88024239504;6131.570790044654;6342.334054924167;6361.840953976188;6715.697793599202;6729.5625784323865;6732.293109223461;6813.386795188457;6868.896966545406;6157.168782214523;6215.881141394592;6267.4986001120715;6272.74909003653;6356.173697419306;6029.547783916136;6037.124616930609;6082.90875636857;6101.298350689727;6155.169052177898;6363.809085727436;6389.137466441971;6436.034594810629;6440.452561532322;6477.255115661759;5775.48020678141;5838.540364908773;5840.766369345179;5844.532437405082;5877.23595932526;5810.622309549865;5938.376470470711;5962.046072628359;5972.462478376967;5982.910256346246 08:43:46 INFO - 2015-11-19 08:43:46,155 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.4077338030769;312.06847560033304;313.4436375433605;319.8512691598406;322.9531717900906;5525.336959564853;5645.1814486899375;5668.518175955039;5672.546196304296;5692.573057020724;5559.722013899309;5610;5610.859728506789;5611.719414029302;5615.66306021639;4151.958480415187;4232.978835105836;4307.310830267158;4314.331278651806;4317.935230971522;4215.367694845767;4221.810018549173;4225.514065882432;4242.53332133465;4243.002894319832;4182.519010313822;4188.685848561355;4208.431861698662;4210.789460526977;4212.052288235153;4201.6008479194425;4214.599613036757;4218.831246750142;4220;4226.957730422687;3574.267275208576;3732.8133593320226;3735.2156047230114;3747.756395834262;3756.7370284080125;5258.13240815265;5323.441038690959;5350.866228344284;5411.675299482044;5426.62013659044;4861.73260470674;4884.7069175849565;4896.4858689837765;4899.240617704261;4904.60763138948;5846.649201047951;5879.911801322984;5892.558058145613;5894.823155305305;5911.970440147772;3942.173568017031;3971.62269584389;4026.2551427985622;4032.6572241359518;4051.270771261172;6105.45050945417;6169.81490555284;6179.66011869347;6184.628922264678;6186.319504854462;4117.744088053172;4150.024744185114;4168.145530166309;4169.10364271683;4175.853845115467;4241.088166044254;4248.192843359751;4249.5113061997645;4255.255330317182;4255.489341279066;4727.7163370197895;4857.392825896763;4860.78126484302;4877.317175595419;4887.462379138292;5821.214136091573;5841.182234487175;5863.648181109147;5870.14882841994;5876.823695289148;1475.5720840956003;1486.4871619291328;1488.3302513868587;1489.3223583269587;1490.6571488557693;983.1004630762772;989.1493315748451;992.0922356044283;996.1980605612407;1000.5947591225565;5071.264666623319;5084.7966081356335;5087.26234695967;5087.745612719349;5102;6064.939350606525;6097.847553811191;6109.389061093944;6116.113163591254;6150.292716337678;5024.296598476216;5065.56942659878;5092.490750924952;5092.872678183001;5095.949040509621;3210.4863221884852;3255.0723043932367;3286.786358886665;3313.2379552703014;3319.6680331967095;5658.122990936411;5738.856528586819;5790.88418231633;5795.39148389413;5805.36141024487;6334.144890439824;6343.397377249246;6346.492280617539;6363.7772677956045;6377.3303803100935;5804.158397032491;5815.41845815415;5818;5819.418058194231;5822.534197264209;5958.76164953397;6113.786017489544;6124.203853499017;6125.448709616156;6140.232470941132;6017.939820601913;6035.366286540026;6038.365971572922;6038.788642397495;6048.939510604838;5806.187133801355;5810.215620891295;5810.360860305447;5810.796622118206;5814.331351894586;4172.332426811696;4217.114405974657;4217.34631132175;4227.429297044982;4228.090960443519;5996.88006239864;6122.877542449037;6125.203723515914;6129.387061293835;6154.1999540059505;5834.27071616048;5859.619124756877;5893.823185304448;5902.38025007368;5904.996150654485;5865.442782935615;5906.675132867734;5908.704564771659;5910.527157827278;5914.408559144224;5607.579431542732;5744.712764361681;5754.482096611325;5765.4811067004175;5771.7402716877;5959.67221802805;5961.52307815365;5961.552883533839;5966.850828729316;5980.9401905980385;5718.942810571841;5763.9135412968;5777.971110144423;5781.884362312646;5787.189793428839 08:43:46 INFO - 2015-11-19 08:43:46,155 DEBUG : BROWSER_OUTPUT: |5;yui.html;731.6597782031355;732.1799584465399;778.120723582352;782.0146615264765;788.4993029426314;11614.36121013344;13846.100003499765;14127.858721412782;14158.221297828628;14181.290935453238;13379.799303010463;13440;13475;13502.054856160074;13504.18974861509;778.8442311537701;798.2974982015847;798.321426787232;798.6246464161835;798.744401791427;768.3699366519456;786.5595266650665;789.2659826361481;792.7700966719644;794.1780257433558;834.7161964931922;834.995825020874;838.6310023589601;840.5587066789953;841.4068082002204;830.393812516863;836.9163083691643;838.5890913452395;840.3991146330342;841.4068082002174;610.9847253818646;618.11300783376;619.2816333053636;619.6746707978302;622.9065640153968;12501.624951251477;12657.177283476545;12683.936580317039;12706.301153436558;12743.235405875585;10513.264071514997;10883.891161088446;11314.321140731583;11418.143639227008;11644.126690498162;9274.489903055397;9291.72124836256;9334.906650933539;9445;9498.620055197784;3126.624805023389;3168.4930411134337;3177.6663450337614;3228.4673028950197;3277.8197199154038;42137.578624213675;42341.94145146365;42545.57454425447;42614.36078458826;42929.57070429287;8991.55042247885;9036.412633178823;9046.231070358961;9286.210672092948;9296.907030929739;15547.766783498257;15616;15642.608934776494;15667.29497172607;15669.529914102595;5784.739686714108;5919.644821310735;5953.940460595425;6102.176206212193;6157.076438534166;3436.896893093211;3467.219875527986;3569.1790888095884;3570.6786389225094;3639.47227651989;2650.08572042645;2672.7460891215305;2678.611601317837;2681.075029114952;2681.570948648207;482.642844295219;484.06333744205074;484.8933234688363;493.92591111333587;494.1549949586176;448.90797386535684;536.5117742853984;552.3813329071465;562.8367773345766;568.5167607533564;7022.789316320519;7160.57036577807;7246.635349150632;7260.854782904313;7518.699252029857;566.4165909113538;583.9270091238595;590.8316129902958;591.1989254560009;602.5541099586275;3499.545059142295;3603.9099022524124;3610.097475631092;3716.349638813197;3719.386301260316;47619.523804761506;47867.52132478631;48276;48459.27311090336;48463;43306;44247.77876110599;44707.552924470336;44999;45573.54426455693;39606.40590391089;40568.1886362277;41233.58766412357;41785.582144178166;42412.78793606012;7316.743913963199;7449.8882516761205;7558.659860306409;7727.343175830118;8115.83768324642;32687.67312326846;33565.83217083899;33874.661253388134;34153;35461.46807797936;42494.36258456064;43029.56970430381;43981.78009110062;46483.767581161876;46606.53393466157;10619.893801062199;10782.67651970442;10798.244122911321;11062.059724923472;11344.602938897098;10638.468076596295;10963.83554246671;11434.771304573696;11709.590164344549;11907.76184476323;10568.234792354853;10838.349699018085;10858.077063449695;10882;10906.781864362827;10689.9465502672;10934.617288395186;11038.337699738042;11398.715032124263;11402.94298528502;10922.726931826768;10989.120870330515;11037.779244415227;11062;11387.544498219979;8942.239909607497;9074.137956894085;9279.582418791306;9365.484898330657;9749.268804839523;7980.521168729895;8152.510849349058;9250.167484926389;9263.675771347971;9320.673776418063 08:43:46 INFO - 2015-11-19 08:43:46,155 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:43:46 INFO - 2015-11-19 08:43:46,155 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:43:46 INFO - 2015-11-19 08:43:46,155 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,296 08:43:46 INFO - 2015-11-19 08:43:46,155 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:43:46 INFO - 2015-11-19 08:43:46,155 DEBUG : BROWSER_OUTPUT: __startTimestamp1447951426147__endTimestamp 08:43:46 INFO - 2015-11-19 08:43:46,155 DEBUG : BROWSER_OUTPUT: 08:43:46 INFO - 2015-11-19 08:43:46,155 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:43:46 INFO - 2015-11-19 08:43:46,155 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:43:46 INFO - 2015-11-19 08:43:46,156 DEBUG : BROWSER_OUTPUT: 08:43:46 INFO - 2015-11-19 08:43:46,156 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4762.11 Median:4895.76 stddev:507.64 (10.4%) stddev-sans-first:482.92 08:43:46 INFO - 2015-11-19 08:43:46,157 DEBUG : BROWSER_OUTPUT: Values: 2707.0 2766.6 2793.2 2810.4 2814.8 4675.1 4740.7 4744.4 4802.1 4830.9 4818.3 4832.2 4850.7 4851.4 4945.2 4375.5 4458.6 4486.8 4510.0 4529.5 4296.6 4474.6 4546.5 4548.1 4560.4 4351.4 4458.7 4460.6 4471.6 4498.9 4444.4 4456.9 4459.9 4468.0 4505.0 4305.5 4361.6 4398.5 4443.6 4474.0 4679.5 4750.3 4755.3 4792.2 4804.9 5149.9 5150.7 5153.0 5154.7 5177.6 4963.4 5034.2 5096.0 5165.1 5246.4 4744.5 4825.7 4869.8 4873.9 4930.5 5364.4 5367.4 5367.7 5373.9 5378.0 4870.6 4961.9 4994.9 5039.0 5119.1 5214.5 5241.1 5280.4 5280.6 5329.0 4824.2 5198.2 5206.4 5210.6 5215.9 4976.4 5032.1 5122.8 5159.9 5211.8 4226.3 4249.3 4257.0 4271.0 4277.3 3611.2 3681.7 3709.5 3717.9 3758.3 4322.4 4396.4 4401.2 4409.9 4417.5 5172.9 5175.5 5178.6 5195.1 5210.3 4217.5 4330.8 4447.8 4450.1 4470.7 4575.2 4604.7 4610.4 4631.4 4649.0 4927.0 4946.3 4964.3 4972.5 5008.5 5050.9 5148.9 5181.1 5245.0 5333.2 4862.4 4895.8 4899.5 4904.4 4947.3 5098.6 5100.8 5106.6 5110.7 5111.7 4996.8 5097.9 5106.2 5246.0 5256.8 4987.4 5018.2 5024.0 5028.5 5045.8 4998.2 5004.5 5004.5 5018.9 5020.3 4751.7 4796.3 4853.3 4879.4 4881.3 5083.1 5129.2 5141.1 5158.1 5167.4 4677.1 4979.1 4981.7 4986.3 4999.3 08:43:46 INFO - 2015-11-19 08:43:46,157 DEBUG : BROWSER_OUTPUT: 08:43:46 INFO - 2015-11-19 08:43:46,157 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41789.16 Median:19662.76 stddev:66352.95 (337.5%) stddev-sans-first:66466.77 08:43:46 INFO - 2015-11-19 08:43:46,157 DEBUG : BROWSER_OUTPUT: Values: 529.2 550.4 571.3 572.6 579.7 35743.0 37177.3 37236.3 37252.1 37302.8 39268.4 39638.4 39660.6 40067.8 40174.4 7934.4 8035.3 8087.2 8091.9 8110.9 7858.6 7939.3 7963.1 7976.9 7980.0 7889.6 7925.2 8004.6 8028.7 8032.3 7869.0 8008.8 8023.1 8026.5 8035.0 7843.1 7913.1 8012.2 8023.6 8030.2 37667.6 37676.4 37785.8 37983.4 38127.2 2454.1 2776.9 2856.8 2941.1 3080.0 25980.6 26058.0 26094.0 26401.0 26427.9 3401.5 3485.9 3501.1 3516.9 3582.5 211795.0 214973.0 216009.0 216210.0 216345.0 49572.8 51276.2 55667.4 59911.4 62337.4 56318.7 56466.7 56773.7 56956.0 57084.4 14419.7 14620.1 14628.9 14668.5 14696.6 10931.4 11048.5 11071.5 11075.2 11099.3 19139.7 19498.1 19531.2 19599.4 19619.5 7780.5 7882.5 7972.5 8081.6 8114.6 870.8 879.9 899.6 979.9 1020.9 25697.5 26014.9 26019.2 26027.3 26396.5 932.8 944.7 960.1 995.8 1129.2 13885.9 13901.7 14839.3 15909.0 16304.9 305382.0 308218.0 309212.0 309926.0 310667.0 47953.5 48605.0 48735.3 48804.8 48975.5 1193.5 1194.3 1199.3 1201.7 1207.8 26858.1 26888.9 26924.7 27168.5 27197.7 39129.8 39480.0 39584.8 39628.6 39698.4 227348.0 228700.0 228821.0 230101.0 230372.0 27873.4 40679.4 41354.8 41995.2 42080.2 39554.6 39556.4 39711.2 40519.6 40996.0 33589.5 34262.9 34543.8 34840.3 34854.1 34041.7 34398.0 34662.5 34740.0 34743.0 34441.8 34642.7 34810.8 37635.0 38923.6 29658.0 30848.5 31299.5 31491.8 31504.0 24222.2 24236.8 24313.6 24432.8 24662.1 08:43:46 INFO - 2015-11-19 08:43:46,157 DEBUG : BROWSER_OUTPUT: 08:43:46 INFO - 2015-11-19 08:43:46,157 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25090.50 Median:343.31 stddev:66734.97 (19438.6%) stddev-sans-first:66896.28 08:43:46 INFO - 2015-11-19 08:43:46,158 DEBUG : BROWSER_OUTPUT: Values: 326.2 326.3 339.2 343.3 343.3 15109.2 15336.0 15758.7 16200.9 16576.6 10449.2 10459.8 10602.7 10640.1 10710.9 4553.0 4652.8 4676.1 4680.1 4689.3 6202.7 6311.6 6321.7 6323.1 6325.8 3856.5 6290.0 6300.4 6329.4 6571.0 6464.0 6500.5 6508.4 6518.8 6558.5 6094.5 6213.3 6243.6 6248.6 6270.6 20933.4 21431.2 21688.3 21736.1 22402.6 1988.9 2004.6 2022.2 2069.2 2084.0 13990.7 14020.9 14060.4 14196.8 14283.2 1820.2 1821.0 1842.1 1884.4 1914.0 60853.0 64903.7 65566.3 65637.7 66522.7 14858.5 15135.5 15138.7 15182.0 15189.5 22643.2 22724.7 22850.0 22851.9 22887.2 8097.4 8170.6 8201.8 8219.0 8251.5 6835.2 6878.2 6882.3 6895.0 6971.9 7315.2 7339.3 7348.2 7407.9 7442.4 2972.7 3083.6 3094.4 3108.4 3130.1 414.5 416.4 416.6 425.4 426.8 10057.7 15233.9 15669.8 15812.3 15872.8 821.0 890.4 952.8 983.7 984.7 8636.0 8730.8 8951.1 8982.6 9016.2 402667.0 403585.0 404196.0 412284.0 414987.0 72276.3 72537.0 73195.3 74494.0 75085.6 1008.7 1035.5 1041.2 1058.1 1093.0 14694.1 14713.9 14747.9 14865.9 15114.0 31420.4 32054.0 32129.2 32576.5 32926.5 38448.2 38681.0 40426.8 40649.6 41438.8 7894.7 8162.3 8234.6 8307.7 8318.0 9583.0 9718.8 15404.7 16219.1 16276.8 13417.7 13834.3 14138.9 14140.6 14425.9 13650.5 13811.4 13828.9 14173.9 14267.3 13957.5 14090.6 14162.4 14579.6 14822.7 8708.3 8918.3 8953.2 8994.1 9061.8 9782.9 10688.4 14015.7 14240.9 14367.6 08:43:46 INFO - 2015-11-19 08:43:46,158 DEBUG : BROWSER_OUTPUT: 08:43:46 INFO - 2015-11-19 08:43:46,158 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4974.34 Median:5950.21 stddev:2538.79 (42.7%) stddev-sans-first:2532.21 08:43:46 INFO - 2015-11-19 08:43:46,159 DEBUG : BROWSER_OUTPUT: Values: 1465.2 1628.4 1680.7 1695.4 1712.8 5590.3 5745.2 5748.5 5884.4 5938.0 6989.8 7260.6 7262.9 7306.8 7324.2 2061.8 2099.7 2100.7 2102.7 2106.9 2123.7 2129.3 2136.1 2137.5 2138.7 2051.9 2057.1 2065.2 2075.3 2092.4 2065.1 2072.0 2080.8 2087.4 2091.9 2091.9 2102.2 2107.5 2119.6 2132.8 7167.9 7168.2 7188.6 7215.6 7218.4 4288.2 4349.9 4362.2 4377.9 4382.2 2821.0 2827.9 2962.6 2964.0 2967.3 888.3 898.8 915.4 915.6 948.3 9428.0 9440.6 9517.9 9563.8 9585.7 4021.0 4055.7 4094.6 4108.0 4124.7 8045.2 8048.7 8050.9 8060.4 8063.4 4361.6 4379.8 4384.9 4386.9 4417.8 3361.9 3488.3 3932.2 3951.4 3965.0 3596.1 3610.5 3628.7 3628.7 3663.9 1167.9 1183.9 1187.5 1192.5 1198.5 882.8 895.2 1176.1 1179.2 1192.9 6748.3 6785.7 6792.4 6806.0 6835.0 1019.7 1051.3 1063.4 1066.8 1090.2 5121.5 5127.8 5140.5 5161.7 5226.2 8713.2 8787.2 9074.0 9163.9 9164.5 8870.1 8909.0 8988.5 9023.5 9026.7 6603.1 6614.3 6667.3 6670.5 6809.0 6379.2 6390.4 6405.0 6429.3 6434.3 7369.0 7522.7 7799.6 7840.4 7902.9 7718.2 7731.0 7748.2 7787.0 7870.1 5910.0 5987.9 6131.6 6342.3 6361.8 6715.7 6729.6 6732.3 6813.4 6868.9 6157.2 6215.9 6267.5 6272.7 6356.2 6029.5 6037.1 6082.9 6101.3 6155.2 6363.8 6389.1 6436.0 6440.5 6477.3 5775.5 5838.5 5840.8 5844.5 5877.2 5810.6 5938.4 5962.0 5972.5 5982.9 08:43:46 INFO - 2015-11-19 08:43:46,159 DEBUG : BROWSER_OUTPUT: 08:43:46 INFO - 2015-11-19 08:43:46,159 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4861.87 Median:5611.29 stddev:1452.53 (25.9%) stddev-sans-first:1415.70 08:43:46 INFO - 2015-11-19 08:43:46,161 DEBUG : BROWSER_OUTPUT: Values: 301.4 312.1 313.4 319.9 323.0 5525.3 5645.2 5668.5 5672.5 5692.6 5559.7 5610.0 5610.9 5611.7 5615.7 4152.0 4233.0 4307.3 4314.3 4317.9 4215.4 4221.8 4225.5 4242.5 4243.0 4182.5 4188.7 4208.4 4210.8 4212.1 4201.6 4214.6 4218.8 4220.0 4227.0 3574.3 3732.8 3735.2 3747.8 3756.7 5258.1 5323.4 5350.9 5411.7 5426.6 4861.7 4884.7 4896.5 4899.2 4904.6 5846.6 5879.9 5892.6 5894.8 5912.0 3942.2 3971.6 4026.3 4032.7 4051.3 6105.5 6169.8 6179.7 6184.6 6186.3 4117.7 4150.0 4168.1 4169.1 4175.9 4241.1 4248.2 4249.5 4255.3 4255.5 4727.7 4857.4 4860.8 4877.3 4887.5 5821.2 5841.2 5863.6 5870.1 5876.8 1475.6 1486.5 1488.3 1489.3 1490.7 983.1 989.1 992.1 996.2 1000.6 5071.3 5084.8 5087.3 5087.7 5102.0 6064.9 6097.8 6109.4 6116.1 6150.3 5024.3 5065.6 5092.5 5092.9 5095.9 3210.5 3255.1 3286.8 3313.2 3319.7 5658.1 5738.9 5790.9 5795.4 5805.4 6334.1 6343.4 6346.5 6363.8 6377.3 5804.2 5815.4 5818.0 5819.4 5822.5 5958.8 6113.8 6124.2 6125.4 6140.2 6017.9 6035.4 6038.4 6038.8 6048.9 5806.2 5810.2 5810.4 5810.8 5814.3 4172.3 4217.1 4217.3 4227.4 4228.1 5996.9 6122.9 6125.2 6129.4 6154.2 5834.3 5859.6 5893.8 5902.4 5905.0 5865.4 5906.7 5908.7 5910.5 5914.4 5607.6 5744.7 5754.5 5765.5 5771.7 5959.7 5961.5 5961.6 5966.9 5980.9 5718.9 5763.9 5778.0 5781.9 5787.2 08:43:46 INFO - 2015-11-19 08:43:46,161 DEBUG : BROWSER_OUTPUT: 08:43:46 INFO - 2015-11-19 08:43:46,161 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12590.18 Median:22578.23 stddev:14251.46 (63.1%) stddev-sans-first:14263.62 08:43:46 INFO - 2015-11-19 08:43:46,161 DEBUG : BROWSER_OUTPUT: Values: 731.7 732.2 778.1 782.0 788.5 11614.4 13846.1 14127.9 14158.2 14181.3 13379.8 13440.0 13475.0 13502.1 13504.2 778.8 798.3 798.3 798.6 798.7 768.4 786.6 789.3 792.8 794.2 834.7 835.0 838.6 840.6 841.4 830.4 836.9 838.6 840.4 841.4 611.0 618.1 619.3 619.7 622.9 12501.6 12657.2 12683.9 12706.3 12743.2 10513.3 10883.9 11314.3 11418.1 11644.1 9274.5 9291.7 9334.9 9445.0 9498.6 3126.6 3168.5 3177.7 3228.5 3277.8 42137.6 42341.9 42545.6 42614.4 42929.6 8991.6 9036.4 9046.2 9286.2 9296.9 15547.8 15616.0 15642.6 15667.3 15669.5 5784.7 5919.6 5953.9 6102.2 6157.1 3436.9 3467.2 3569.2 3570.7 3639.5 2650.1 2672.7 2678.6 2681.1 2681.6 482.6 484.1 484.9 493.9 494.2 448.9 536.5 552.4 562.8 568.5 7022.8 7160.6 7246.6 7260.9 7518.7 566.4 583.9 590.8 591.2 602.6 3499.5 3603.9 3610.1 3716.3 3719.4 47619.5 47867.5 48276.0 48459.3 48463.0 43306.0 44247.8 44707.6 44999.0 45573.5 39606.4 40568.2 41233.6 41785.6 42412.8 7316.7 7449.9 7558.7 7727.3 8115.8 32687.7 33565.8 33874.7 34153.0 35461.5 42494.4 43029.6 43981.8 46483.8 46606.5 10619.9 10782.7 10798.2 11062.1 11344.6 10638.5 10963.8 11434.8 11709.6 11907.8 10568.2 10838.3 10858.1 10882.0 10906.8 10689.9 10934.6 11038.3 11398.7 11402.9 10922.7 10989.1 11037.8 11062.0 11387.5 8942.2 9074.1 9279.6 9365.5 9749.3 7980.5 8152.5 9250.2 9263.7 9320.7 08:43:46 INFO - 2015-11-19 08:43:46,161 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:43:46 INFO - 2015-11-19 08:43:46,161 DEBUG : BROWSER_OUTPUT: 08:43:46 INFO - 2015-11-19 08:43:46,883 INFO : Browser exited with error code: 0 08:43:46 INFO - 2015-11-19 08:43:46,901 INFO : Completed test dromaeo_css (00:18:35) 08:43:46 INFO - 2015-11-19 08:43:46,901 INFO : Starting test kraken 08:43:46 INFO - 2015-11-19 08:43:46,901 DEBUG : operating with platform_type : linux_ 08:43:46 INFO - 2015-11-19 08:43:46,902 INFO : Initialising browser for kraken test... 08:43:46 INFO - 2015-11-19 08:43:46,908 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfA46rF/profile http://localhost:41544/getInfo.html 08:43:51 INFO - 2015-11-19 08:43:51,621 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:43:51 INFO - 2015-11-19 08:43:51,621 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:43:51 INFO - 2015-11-19 08:43:51,621 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:43:51 INFO - 2015-11-19 08:43:51,621 DEBUG : BROWSER_OUTPUT: __metrics 08:43:52 INFO - 2015-11-19 08:43:52,719 INFO : Browser initialized. 08:43:52 INFO - 2015-11-19 08:43:52,719 INFO : Running cycle 1/1 for kraken test... 08:43:52 INFO - 2015-11-19 08:43:52,720 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfA46rF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:44:04 INFO - 2015-11-19 08:44:04,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 141496320 08:44:04 INFO - 2015-11-19 08:44:04,736 DEBUG : BROWSER_OUTPUT: 08:44:07 INFO - 2015-11-19 08:44:07,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41544/tests/kraken/driver.html?testName=audio-beat-detection) 08:44:07 INFO - 2015-11-19 08:44:07,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 141451264 08:44:07 INFO - 2015-11-19 08:44:07,941 DEBUG : BROWSER_OUTPUT: 08:44:10 INFO - 2015-11-19 08:44:10,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41544/tests/kraken/driver.html?testName=audio-dft) 08:44:11 INFO - 2015-11-19 08:44:11,313 DEBUG : BROWSER_OUTPUT: RSS: Main: 141651968 08:44:11 INFO - 2015-11-19 08:44:11,313 DEBUG : BROWSER_OUTPUT: 08:44:14 INFO - 2015-11-19 08:44:14,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41544/tests/kraken/driver.html?testName=audio-fft) 08:44:14 INFO - 2015-11-19 08:44:14,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 135991296 08:44:14 INFO - 2015-11-19 08:44:14,849 DEBUG : BROWSER_OUTPUT: 08:44:16 INFO - 2015-11-19 08:44:16,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41544/tests/kraken/driver.html?testName=audio-oscillator) 08:44:17 INFO - 2015-11-19 08:44:17,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 136839168 08:44:17 INFO - 2015-11-19 08:44:17,524 DEBUG : BROWSER_OUTPUT: 08:44:19 INFO - 2015-11-19 08:44:19,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:44:20 INFO - 2015-11-19 08:44:20,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 136761344 08:44:20 INFO - 2015-11-19 08:44:20,318 DEBUG : BROWSER_OUTPUT: 08:44:23 INFO - 2015-11-19 08:44:23,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41544/tests/kraken/driver.html?testName=imaging-darkroom) 08:44:23 INFO - 2015-11-19 08:44:23,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 136749056 08:44:23 INFO - 2015-11-19 08:44:23,963 DEBUG : BROWSER_OUTPUT: 08:44:27 INFO - 2015-11-19 08:44:27,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41544/tests/kraken/driver.html?testName=imaging-desaturate) 08:44:28 INFO - 2015-11-19 08:44:28,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 136306688 08:44:28 INFO - 2015-11-19 08:44:28,051 DEBUG : BROWSER_OUTPUT: 08:44:31 INFO - 2015-11-19 08:44:31,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41544/tests/kraken/driver.html?testName=json-parse-financial) 08:44:31 INFO - 2015-11-19 08:44:31,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 136691712 08:44:31 INFO - 2015-11-19 08:44:31,613 DEBUG : BROWSER_OUTPUT: 08:44:33 INFO - 2015-11-19 08:44:33,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:44:33 INFO - 2015-11-19 08:44:33,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 138706944 08:44:33 INFO - 2015-11-19 08:44:33,964 DEBUG : BROWSER_OUTPUT: 08:44:35 INFO - 2015-11-19 08:44:35,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41544/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:44:36 INFO - 2015-11-19 08:44:36,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 139001856 08:44:36 INFO - 2015-11-19 08:44:36,476 DEBUG : BROWSER_OUTPUT: 08:44:38 INFO - 2015-11-19 08:44:38,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:44:39 INFO - 2015-11-19 08:44:39,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 139386880 08:44:39 INFO - 2015-11-19 08:44:39,243 DEBUG : BROWSER_OUTPUT: 08:44:41 INFO - 2015-11-19 08:44:41,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:44:42 INFO - 2015-11-19 08:44:42,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 139296768 08:44:42 INFO - 2015-11-19 08:44:42,441 DEBUG : BROWSER_OUTPUT: 08:44:45 INFO - 2015-11-19 08:44:45,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:44:45 INFO - 2015-11-19 08:44:45,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 138375168 08:44:45 INFO - 2015-11-19 08:44:45,656 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41544/tests/kraken/driver.html?testName=ai-astar) 08:44:47 INFO - 2015-11-19 08:44:47,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 138596352 08:44:47 INFO - 2015-11-19 08:44:47,696 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,699 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:44:47 INFO - 2015-11-19 08:44:47,700 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:44:47 INFO - 2015-11-19 08:44:47,700 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:44:47 INFO - 2015-11-19 08:44:47,700 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:44:47 INFO - 2015-11-19 08:44:47,700 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;113;113;113;125;113;111;114;112 08:44:47 INFO - 2015-11-19 08:44:47,700 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;134;153;177;137;159;158;137;176;133 08:44:47 INFO - 2015-11-19 08:44:47,701 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;165;166;163;164;174;166;163;167;163 08:44:47 INFO - 2015-11-19 08:44:47,701 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;76;74;152;72;73;75;74;154;72 08:44:47 INFO - 2015-11-19 08:44:47,701 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;130;92;93;92;131;91;93;131 08:44:47 INFO - 2015-11-19 08:44:47,701 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;110;111;109;110;110 08:44:47 INFO - 2015-11-19 08:44:47,701 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;150;148;147;149;149;150;147;149;148 08:44:47 INFO - 2015-11-19 08:44:47,702 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;96;101;95;96;96 08:44:47 INFO - 2015-11-19 08:44:47,702 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;73;73;73;73;71;71;79;70;71 08:44:47 INFO - 2015-11-19 08:44:47,702 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;68;68;68;68;69 08:44:47 INFO - 2015-11-19 08:44:47,702 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;83;84;91;85;85;89;86 08:44:47 INFO - 2015-11-19 08:44:47,703 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;136;120;120;146;123;127;131;140;124;122 08:44:47 INFO - 2015-11-19 08:44:47,703 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;149;151;152;158;141;152;147;148;141 08:44:47 INFO - 2015-11-19 08:44:47,703 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;70;74;73;72;75;73;71;71;71 08:44:47 INFO - 2015-11-19 08:44:47,703 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:44:47 INFO - 2015-11-19 08:44:47,703 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:44:47 INFO - 2015-11-19 08:44:47,704 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,783 08:44:47 INFO - 2015-11-19 08:44:47,704 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:44:47 INFO - 2015-11-19 08:44:47,704 DEBUG : BROWSER_OUTPUT: __startTimestamp1447951487697__endTimestamp 08:44:47 INFO - 2015-11-19 08:44:47,704 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,712 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:44:47 INFO - 2015-11-19 08:44:47,712 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:44:47 INFO - 2015-11-19 08:44:47,712 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,712 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:4.53 (4.0%) stddev-sans-first:4.80 08:44:47 INFO - 2015-11-19 08:44:47,712 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 113.0 113.0 113.0 125.0 113.0 111.0 114.0 112.0 08:44:47 INFO - 2015-11-19 08:44:47,712 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,712 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.70 Median:155.50 stddev:16.40 (10.5%) stddev-sans-first:17.39 08:44:47 INFO - 2015-11-19 08:44:47,713 DEBUG : BROWSER_OUTPUT: Values: 153.0 134.0 153.0 177.0 137.0 159.0 158.0 137.0 176.0 133.0 08:44:47 INFO - 2015-11-19 08:44:47,713 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,713 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:3.27 (2.0%) stddev-sans-first:3.46 08:44:47 INFO - 2015-11-19 08:44:47,713 DEBUG : BROWSER_OUTPUT: Values: 165.0 165.0 166.0 163.0 164.0 174.0 166.0 163.0 167.0 163.0 08:44:47 INFO - 2015-11-19 08:44:47,713 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,713 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.70 Median:74.00 stddev:33.39 (45.1%) stddev-sans-first:34.99 08:44:47 INFO - 2015-11-19 08:44:47,713 DEBUG : BROWSER_OUTPUT: Values: 75.0 76.0 74.0 152.0 72.0 73.0 75.0 74.0 154.0 72.0 08:44:47 INFO - 2015-11-19 08:44:47,713 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,713 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.80 Median:92.00 stddev:18.55 (20.2%) stddev-sans-first:19.26 08:44:47 INFO - 2015-11-19 08:44:47,713 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 130.0 92.0 93.0 92.0 131.0 91.0 93.0 131.0 08:44:47 INFO - 2015-11-19 08:44:47,714 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,714 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:44:47 INFO - 2015-11-19 08:44:47,714 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 110.0 111.0 109.0 110.0 110.0 08:44:47 INFO - 2015-11-19 08:44:47,714 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,714 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:1.17 (0.8%) stddev-sans-first:1.13 08:44:47 INFO - 2015-11-19 08:44:47,714 DEBUG : BROWSER_OUTPUT: Values: 147.0 150.0 148.0 147.0 149.0 149.0 150.0 147.0 149.0 148.0 08:44:47 INFO - 2015-11-19 08:44:47,714 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,714 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.65 (1.7%) stddev-sans-first:1.74 08:44:47 INFO - 2015-11-19 08:44:47,714 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 96.0 101.0 95.0 96.0 96.0 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.60 Median:73.00 stddev:2.50 (3.4%) stddev-sans-first:2.65 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 73.0 73.0 73.0 71.0 71.0 79.0 70.0 71.0 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 69.0 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.50 (2.9%) stddev-sans-first:2.59 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 83.0 84.0 91.0 85.0 85.0 89.0 86.0 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,715 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:129.00 stddev:9.06 (7.0%) stddev-sans-first:9.24 08:44:47 INFO - 2015-11-19 08:44:47,716 DEBUG : BROWSER_OUTPUT: Values: 136.0 120.0 120.0 146.0 123.0 127.0 131.0 140.0 124.0 122.0 08:44:47 INFO - 2015-11-19 08:44:47,716 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,716 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:150.00 stddev:5.82 (3.9%) stddev-sans-first:5.43 08:44:47 INFO - 2015-11-19 08:44:47,716 DEBUG : BROWSER_OUTPUT: Values: 140.0 149.0 151.0 152.0 158.0 141.0 152.0 147.0 148.0 141.0 08:44:47 INFO - 2015-11-19 08:44:47,716 DEBUG : BROWSER_OUTPUT: 08:44:47 INFO - 2015-11-19 08:44:47,716 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.50 stddev:1.55 (2.1%) stddev-sans-first:1.64 08:44:47 INFO - 2015-11-19 08:44:47,716 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 74.0 73.0 72.0 75.0 73.0 71.0 71.0 71.0 08:44:47 INFO - 2015-11-19 08:44:47,716 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:44:47 INFO - 2015-11-19 08:44:47,716 DEBUG : BROWSER_OUTPUT: 08:44:48 INFO - 2015-11-19 08:44:48,639 INFO : Browser exited with error code: 0 08:44:48 INFO - 2015-11-19 08:44:48,697 INFO : Completed test kraken (00:01:01) 08:44:48 INFO - 2015-11-19 08:44:48,698 INFO : Starting test v8_7 08:44:48 INFO - 2015-11-19 08:44:48,698 DEBUG : operating with platform_type : linux_ 08:44:48 INFO - 2015-11-19 08:44:48,698 INFO : Initialising browser for v8_7 test... 08:44:48 INFO - 2015-11-19 08:44:48,704 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5AZt1Q/profile http://localhost:41544/getInfo.html 08:44:53 INFO - 2015-11-19 08:44:53,283 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:44:53 INFO - 2015-11-19 08:44:53,284 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:44:53 INFO - 2015-11-19 08:44:53,284 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:44:53 INFO - 2015-11-19 08:44:53,284 DEBUG : BROWSER_OUTPUT: __metrics 08:44:54 INFO - 2015-11-19 08:44:54,414 INFO : Browser initialized. 08:44:54 INFO - 2015-11-19 08:44:54,415 INFO : Running cycle 1/1 for v8_7 test... 08:44:54 INFO - 2015-11-19 08:44:54,415 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5AZt1Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:45:06 INFO - 2015-11-19 08:45:06,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 141664256 08:45:06 INFO - 2015-11-19 08:45:06,388 DEBUG : BROWSER_OUTPUT: 08:45:27 INFO - 2015-11-19 08:45:27,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41544/tests/v8_7/run.html (next: http://localhost:41544/tests/v8_7/run.html) 08:45:28 INFO - 2015-11-19 08:45:28,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 138498048 08:45:28 INFO - 2015-11-19 08:45:28,118 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,118 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:45:28 INFO - 2015-11-19 08:45:28,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:45:28 INFO - 2015-11-19 08:45:28,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:45:28 INFO - 2015-11-19 08:45:28,118 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:45:28 INFO - 2015-11-19 08:45:28,118 DEBUG : BROWSER_OUTPUT: |0;Richards;161.94331983805668 08:45:28 INFO - 2015-11-19 08:45:28,118 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.51247856734616 08:45:28 INFO - 2015-11-19 08:45:28,118 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.29395218002816 08:45:28 INFO - 2015-11-19 08:45:28,119 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 08:45:28 INFO - 2015-11-19 08:45:28,119 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1069.51871657754 08:45:28 INFO - 2015-11-19 08:45:28,119 DEBUG : BROWSER_OUTPUT: |5;Earley;715 08:45:28 INFO - 2015-11-19 08:45:28,119 DEBUG : BROWSER_OUTPUT: |6;Boyer;12382.716049382716 08:45:28 INFO - 2015-11-19 08:45:28,119 DEBUG : BROWSER_OUTPUT: |7;RegExp;25692.30769230769 08:45:28 INFO - 2015-11-19 08:45:28,120 DEBUG : BROWSER_OUTPUT: |8;Splay;603.003003003003 08:45:28 INFO - 2015-11-19 08:45:28,120 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 08:45:28 INFO - 2015-11-19 08:45:28,120 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:45:28 INFO - 2015-11-19 08:45:28,120 DEBUG : BROWSER_OUTPUT: __startTimestamp1447951528117__endTimestamp 08:45:28 INFO - 2015-11-19 08:45:28,120 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,121 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:45:28 INFO - 2015-11-19 08:45:28,121 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:45:28 INFO - 2015-11-19 08:45:28,121 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,121 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:161.94 Median:161.94 stddev:0.00 (0.0%) 08:45:28 INFO - 2015-11-19 08:45:28,121 DEBUG : BROWSER_OUTPUT: Values: 161.9 08:45:28 INFO - 2015-11-19 08:45:28,122 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,122 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.51 Median:190.51 stddev:0.00 (0.0%) 08:45:28 INFO - 2015-11-19 08:45:28,122 DEBUG : BROWSER_OUTPUT: Values: 190.5 08:45:28 INFO - 2015-11-19 08:45:28,122 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,122 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 08:45:28 INFO - 2015-11-19 08:45:28,122 DEBUG : BROWSER_OUTPUT: Values: 281.3 08:45:28 INFO - 2015-11-19 08:45:28,123 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,123 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 08:45:28 INFO - 2015-11-19 08:45:28,123 DEBUG : BROWSER_OUTPUT: Values: 5050.5 08:45:28 INFO - 2015-11-19 08:45:28,124 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,124 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1069.52 Median:1069.52 stddev:0.00 (0.0%) 08:45:28 INFO - 2015-11-19 08:45:28,124 DEBUG : BROWSER_OUTPUT: Values: 1069.5 08:45:28 INFO - 2015-11-19 08:45:28,125 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,125 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:715.00 Median:715.00 stddev:0.00 (0.0%) 08:45:28 INFO - 2015-11-19 08:45:28,125 DEBUG : BROWSER_OUTPUT: Values: 715.0 08:45:28 INFO - 2015-11-19 08:45:28,125 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,125 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 08:45:28 INFO - 2015-11-19 08:45:28,125 DEBUG : BROWSER_OUTPUT: Values: 12382.7 08:45:28 INFO - 2015-11-19 08:45:28,125 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,126 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25692.31 Median:25692.31 stddev:0.00 (0.0%) 08:45:28 INFO - 2015-11-19 08:45:28,126 DEBUG : BROWSER_OUTPUT: Values: 25692.3 08:45:28 INFO - 2015-11-19 08:45:28,126 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,126 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.00 Median:603.00 stddev:0.00 (0.0%) 08:45:28 INFO - 2015-11-19 08:45:28,126 DEBUG : BROWSER_OUTPUT: Values: 603.0 08:45:28 INFO - 2015-11-19 08:45:28,126 DEBUG : BROWSER_OUTPUT: 08:45:28 INFO - 2015-11-19 08:45:28,126 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:45:28 INFO - 2015-11-19 08:45:28,126 DEBUG : BROWSER_OUTPUT: Values: 4840.6 08:45:28 INFO - 2015-11-19 08:45:28,126 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:45:28 INFO - 2015-11-19 08:45:28,126 DEBUG : BROWSER_OUTPUT: 08:45:29 INFO - 2015-11-19 08:45:29,043 INFO : Browser exited with error code: 0 08:45:29 INFO - 2015-11-19 08:45:29,061 INFO : Completed test v8_7 (00:00:40) 08:45:29 INFO - 2015-11-19 08:45:29,110 INFO : Completed test suite (00:20:17) 08:45:29 INFO - 2015-11-19 08:45:29,111 DEBUG : Working with test: dromaeo_css 08:45:29 INFO - 2015-11-19 08:45:29,111 DEBUG : Generating results file: dromaeo_css 08:45:29 INFO - 2015-11-19 08:45:29,112 DEBUG : Working with test: kraken 08:45:29 INFO - 2015-11-19 08:45:29,112 DEBUG : Generating results file: kraken 08:45:29 INFO - 2015-11-19 08:45:29,112 INFO : javascript benchmark 08:45:29 INFO - 2015-11-19 08:45:29,112 DEBUG : Working with test: v8_7 08:45:29 INFO - 2015-11-19 08:45:29,112 DEBUG : Generating results file: v8_7 08:45:29 INFO - 2015-11-19 08:45:29,113 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:45:29 INFO - 2015-11-19 08:45:29,280 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,43]] 08:45:29 INFO - 2015-11-19 08:45:29,280 DEBUG : process_Request line: dromaeo_css 6511.73 graph.html#tests=[[72,131,43]] 08:45:29 INFO - 2015-11-19 08:45:29,280 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:45:29 INFO - 2015-11-19 08:45:29,317 DEBUG : process_Request line: kraken 1554.70 graph.html#tests=[[232,131,43]] 08:45:29 INFO - 2015-11-19 08:45:29,318 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:45:29 INFO - 2015-11-19 08:45:29,440 DEBUG : process_Request line: v8_7 21387.38 graph.html#tests=[[230,131,43]] 08:45:29 INFO - 2015-11-19 08:45:29,441 INFO : javascript benchmark 08:45:29 INFO - 2015-11-19 08:45:29,445 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2706.9593956090657, 2766.585012248164, 2793.231861238159, 2810.3957649105437, 2814.8451835149067, 4675.055750238932, 4740.69185502942, 4744.430668319797, 4802.087603355369, 4830.855074347771, 4818.301346304784, 4832.226843705008, 4850.708957462554, 4851.369321988137, 4945.159322915104, 4375.474943006828, 4458.643308535326, 4486.842960496383, 4510.0, 4529.524399938008, 4296.591823776736, 4474.619657329131, 4546.522615125397, 4548.113117941986, 4560.429946256718, 4351.390805287278, 4458.71018383804, 4460.598546130831, 4471.575200355961, 4498.865034048984, 4444.35556844259, 4456.86349980756, 4459.9331010034875, 4467.977660111678, 4504.986378064909, 4305.526392096866, 4361.6074553290355, 4398.47218333802, 4443.555644435531, 4474.0, 4679.532046795327, 4750.311204875274, 4755.310479980383, 4792.209285467894, 4804.927926081112, 5149.948500515022, 5150.690958542499, 5153.0, 5154.742262886841, 5177.58579313654, 4963.4292056413615, 5034.219695947134, 5096.0, 5165.1219292720325, 5246.37043554772, 4744.454387745384, 4825.686330388514, 4869.805207791719, 4873.926891096637, 4930.506949305112, 5364.436734142937, 5367.355917289872, 5367.651102678314, 5373.919391209135, 5378.0, 4870.610351171968, 4961.90076198474, 4994.926090890476, 5039.0, 5119.129747942859, 5214.504622060898, 5241.135212689864, 5280.3663560373, 5280.577553795764, 5329.040772660881, 4824.204006338985, 5198.246254293182, 5206.427292997767, 5210.609204309692, 5215.921761173586, 4976.402831660224, 5032.069067222503, 5122.795088196431, 5159.948400516022, 5211.843644690665, 4226.281532139544, 4249.32010878258, 4257.042165512735, 4270.978645106755, 4277.294246449301, 3611.1874828163454, 3681.6686498214754, 3709.4621279914263, 3717.8698745543775, 3758.342290099222, 4322.394864718942, 4396.4284642996845, 4401.207782599163, 4409.889752756143, 4417.469903611523, 5172.8965420691375, 5175.534201921845, 5178.559822415062, 5195.090859099718, 5210.348706411699, 4217.451731274976, 4330.783460827009, 4447.755373454426, 4450.06548624786, 4470.664700147437, 4575.2450845610765, 4604.746738929324, 4610.400647915817, 4631.3516107744945, 4649.023705021916, 4927.0, 4946.258061290835, 4964.304997300381, 4972.453030166606, 5008.524190201925, 5050.949490505195, 5148.922766158586, 5181.119209734279, 5244.9737751310995, 5333.173358129496, 4862.3922009748785, 4895.755212239303, 4899.485554016919, 4904.411470623548, 4947.257911313188, 5098.592112631055, 5100.795968161232, 5106.591472682102, 5110.66780659256, 5111.693298402108, 4996.800127994839, 5097.949020509747, 5106.183010718267, 5246.029484545371, 5256.842294731164, 4987.351644286219, 5018.197088465828, 5024.045431368028, 5028.547430731252, 5045.7981680732355, 4998.225275082368, 5004.549590536869, 5004.549590536869, 5018.874528136826, 5020.347354843847, 4751.738654373904, 4796.328514008112, 4853.296272040464, 4879.414470263591, 4881.267809828554, 5083.085044691991, 5129.230615407719, 5141.074606570854, 5158.148905430712, 5167.405748338989, 4677.064587082529, 4979.053979743837, 4981.651284410056, 4986.32684587576, 4999.300097986357], "unit": "ms", "name": "dojo.html", "value": 4730.176165473167}, {"lowerIsBetter": false, "replicates": [529.2114749023953, 550.3945659774246, 571.3172758553527, 572.6420986883198, 579.6551052123988, 35743.0, 37177.25645487092, 37236.25527489449, 37252.06869828256, 37302.8134859326, 39268.41097383542, 39638.40542391859, 39660.628846548, 40067.799661001656, 40174.397384039265, 7934.404919631007, 8035.316998055172, 8087.191280871924, 8091.878621820678, 8110.878336824952, 7858.607069646523, 7939.285464308211, 7963.084245311777, 7976.880346794803, 7980.04239491259, 7889.605519724019, 7925.207479252086, 8004.559749213791, 8028.718994835182, 8032.3172530335, 7868.977032985704, 8008.799780005517, 8023.077346105214, 8026.518408895456, 8034.9598252008955, 7843.098043724987, 7913.089994650573, 8012.198780121999, 8023.598820058974, 8030.156833532454, 37667.62332376696, 37676.43485347722, 37785.811070944466, 37983.43024854629, 38127.237455251015, 2454.1410506322823, 2776.8611569421446, 2856.814307070034, 2941.1323659520494, 3080.0, 25980.610290845652, 26058.0, 26094.0, 26401.0, 26427.867860660765, 3401.4727717203627, 3485.860565577374, 3501.124718820295, 3516.8593256269974, 3582.5163602913535, 211795.0, 214973.0, 216009.0, 216210.0, 216344.99999999843, 49572.75213623909, 51276.23085653718, 55667.44332556704, 59911.40088599058, 62337.376626234065, 56318.71840640771, 56466.71766641222, 56773.71613141908, 56956.0, 57084.42915570874, 14419.711605767827, 14620.122792632263, 14628.853711462962, 14668.486602968846, 14696.55910322692, 10931.398773067558, 11048.502817373237, 11071.501782419811, 11075.224734268684, 11099.334039957628, 19139.712904306445, 19498.12258448373, 19531.21875124979, 19599.412017639494, 19619.509512262306, 7780.49426787257, 7882.5270483771155, 7972.521648701097, 8081.595920203967, 8114.553699546464, 870.7997160652959, 879.8944126704837, 899.6446403670514, 979.9265055120752, 1020.8519764634086, 25697.486050279265, 26014.86992565063, 26019.21942341733, 26027.349316267246, 26396.47207055848, 932.7621456528542, 944.7071407863584, 960.1358777100666, 995.8356871116184, 1129.1587767113554, 13885.86114138866, 13901.652458688613, 14839.258037098101, 15909.0, 16304.918475407547, 305382.0, 308218.0, 309212.0, 309926.0, 310667.0, 47953.52046479491, 48605.0, 48735.268970965466, 48804.755976219894, 48975.51024489781, 1193.5345215366015, 1194.2714943884223, 1199.2504684572143, 1201.6515210589007, 1207.7886369885234, 26858.115698188565, 26888.865555672095, 26924.730752692223, 27168.456630867666, 27197.72802271952, 39129.804350979204, 39480.0, 39584.802075989435, 39628.60371396249, 39698.40452393159, 227348.0, 228700.0, 228821.0, 230101.0, 230372.0, 27873.44253114886, 40679.38980915348, 41354.793226033675, 41995.16009679851, 42080.15839683128, 39554.60445395509, 39556.40665389964, 39711.20577588374, 40519.59480405158, 40996.0, 33589.49615755815, 34262.94422334568, 34543.82728086444, 34840.30319393649, 34854.12864678302, 34041.659583403845, 34398.0, 34662.480062798575, 34740.0, 34743.0, 34441.82779086089, 34642.65357346495, 34810.82594587011, 37635.0, 38923.61076389313, 29658.0, 30848.537271941386, 31299.53050704287, 31491.84254078715, 31504.0, 24222.152224672052, 24236.75763242345, 24313.635295470936, 24432.75567244376, 24662.136825211033], "unit": "ms", "name": "ext.html", "value": 17280.157104825314}, {"lowerIsBetter": false, "replicates": [326.20731622158155, 326.3082265596935, 339.1994892054752, 343.28767806800863, 343.3339321715871, 15109.168995705246, 15335.960542295583, 15758.684826303466, 16200.918995405007, 16576.585585360357, 10449.216308776853, 10459.843102353452, 10602.734931626714, 10640.148788096953, 10710.946445267782, 4552.954470455286, 4652.790624421909, 4676.134915040711, 4680.063987202556, 4689.343491911135, 6202.72087756052, 6311.589746666475, 6321.683915804214, 6323.05154226865, 6325.778597749079, 3856.5179352580926, 6290.0, 6300.369963003709, 6329.36706329368, 6570.967145164267, 6463.967680161616, 6500.512461565354, 6508.44678202351, 6518.804435866931, 6558.508111891603, 6094.512439004913, 6213.316535181127, 6243.594166379216, 6248.593841400295, 6270.561060725751, 20933.37199884006, 21431.24990625336, 21688.34934951954, 21736.13055477779, 22402.551948961092, 1988.9005549722456, 2004.6191223667456, 2022.1911235505768, 2069.193014724259, 2084.0413409831344, 13990.650233744136, 14020.929895350459, 14060.367283472267, 14196.787048194285, 14283.21442320672, 1820.1627251464342, 1820.9908950455294, 1842.1157844234842, 1884.4252502986583, 1913.9904300478408, 60853.0, 64903.67548162276, 65566.3443365565, 65637.67181164064, 66522.66954660928, 14858.479953201586, 15135.545933621788, 15138.697226055418, 15182.013169143971, 15189.468368607046, 22643.20748773785, 22724.65913011306, 22850.0, 22851.88574057119, 22887.198948036737, 8097.35221182304, 8170.550619715973, 8201.8359632807, 8218.958905205554, 8251.546164960984, 6835.179778426621, 6878.243393226741, 6882.346177113166, 6895.0, 6971.860562788817, 7315.158756742936, 7339.302766237199, 7348.162959260185, 7407.8888816667795, 7442.441816863757, 2972.658144313388, 3083.599132112856, 3094.381123775254, 3108.4094022135723, 3130.1235654016914, 414.4756882543585, 416.4149370134965, 416.56260926028153, 425.406557851795, 426.7695444460019, 10057.74278215223, 15233.923830380998, 15669.764953525706, 15812.288447019911, 15872.841271587367, 821.0164400885208, 890.4301247201796, 952.7570469530225, 983.6557204978343, 984.675057231112, 8635.956820215859, 8730.781730456789, 8951.104889511127, 8982.550872456351, 9016.18854303116, 402667.0, 403585.0, 404196.0, 412284.0, 414987.0, 72276.277237228, 72537.0, 73195.26804731991, 74494.0, 75085.62457187679, 1008.702432782331, 1035.4563853976722, 1041.1982773264695, 1058.1006144776877, 1093.049047328813, 14694.11835289886, 14713.92643036778, 14747.852521474648, 14865.925670371578, 15114.017588856688, 31420.371592567564, 32054.0, 32129.196770080936, 32576.51135233021, 32926.50610240896, 38448.23103537969, 38681.03297417587, 40426.79786601048, 40649.59350406458, 41438.79280603577, 7894.723684671009, 8162.306203972729, 8234.588270586566, 8307.6676932922, 8318.0, 9582.952085239529, 9718.805623887623, 15404.69190616159, 16219.107949062914, 16276.755848662517, 13417.720255356753, 13834.30828458553, 14138.929305353407, 14140.646483837987, 14425.85574144245, 13650.522231721841, 13811.447542098203, 13828.93085534566, 14173.929130354281, 14267.286635668383, 13957.511487097903, 14090.647733806327, 14162.433502659778, 14579.635509112357, 14822.703545928805, 8708.259797917248, 8918.331125165769, 8953.194212520904, 8994.100589940954, 9061.818763624822, 9782.9021709782, 10688.358698478116, 14015.719685606435, 14240.928795355956, 14367.640808979859], "unit": "ms", "name": "jquery.html", "value": 8871.04060455516}, {"lowerIsBetter": false, "replicates": [1465.1794994802904, 1628.430049482681, 1680.6638672265549, 1695.4489790817988, 1712.820153883842, 5590.329160500741, 5745.224394706714, 5748.453896879801, 5884.352721200665, 5937.970310148443, 6989.82525436863, 7260.636968151584, 7262.891056634155, 7306.81732956675, 7324.230955749649, 2061.7732049474507, 2099.727035485385, 2100.69539916712, 2102.7056212130315, 2106.926257580985, 2123.702681624574, 2129.2866889592005, 2136.1028368085363, 2137.529743456445, 2138.7433507979063, 2051.8563700540967, 2057.084597354178, 2065.1532871522677, 2075.2632815350557, 2092.3722883135074, 2065.132644289402, 2072.005437390054, 2080.771115177329, 2087.3529205946206, 2091.947701307472, 2091.9267825626184, 2102.16964299101, 2107.4625970377456, 2119.5760847830343, 2132.7547332056856, 7167.928320716778, 7168.175659799138, 7188.568685878864, 7215.639218039077, 7218.350348468611, 4288.185244803477, 4349.9130017399475, 4362.214801335758, 4377.9124417511475, 4382.233109205877, 2821.0, 2827.9293017674518, 2962.6444826620727, 2963.955540666892, 2967.2878509157863, 888.2982443869336, 898.8471959766855, 915.3866909170805, 915.6428992692855, 948.2603569216022, 9428.0, 9440.575174117113, 9517.904820951771, 9563.760905977337, 9585.712428627083, 4021.0, 4055.7160998729805, 4094.6314831665295, 4108.0, 4124.731892426983, 8045.15525869787, 8048.718294859652, 8050.919490805134, 8060.355171586259, 8063.435559510778, 4361.6074553290355, 4379.824807007748, 4384.868453946323, 4386.934195987063, 4417.757023363746, 3361.8823341182942, 3488.3197776433353, 3932.1545867638597, 3951.38753493209, 3964.980175099106, 3596.1009747563107, 3610.5125808016105, 3628.6552777486095, 3628.7278454115517, 3663.87176448823, 1167.8656954450346, 1183.923045002072, 1187.4597058338436, 1192.528951064342, 1198.4666823263738, 882.8410886040574, 895.2256298301922, 1176.1061593189238, 1179.227605918125, 1192.9403529823473, 6748.257691653914, 6785.728570857111, 6792.42264407521, 6806.0, 6835.043093966849, 1019.7399663086014, 1051.3429106808244, 1063.3885515828429, 1066.8133076711545, 1090.225939582905, 5121.539061484485, 5127.846164615067, 5140.511651393112, 5161.690298582022, 5226.216067589892, 8713.172248636369, 8787.165219304155, 9074.0, 9163.862542061874, 9164.450132992042, 8870.112988701077, 8909.0, 8988.46069235848, 9023.458592484472, 9026.729198124067, 6603.141591593062, 6614.305497922649, 6667.33326667339, 6670.466362690973, 6809.012693159464, 6379.2344918608205, 6390.392912673288, 6405.0, 6429.324920883427, 6434.260060092962, 7368.963155184189, 7522.699092036257, 7799.610019499116, 7840.372770178258, 7902.881456778268, 7718.228177182237, 7731.0336207974005, 7748.1864404238995, 7786.961065194638, 7870.055593328837, 5909.970450147722, 5987.88024239504, 6131.570790044654, 6342.334054924167, 6361.840953976188, 6715.697793599202, 6729.5625784323865, 6732.293109223461, 6813.386795188457, 6868.896966545406, 6157.168782214523, 6215.881141394592, 6267.4986001120715, 6272.74909003653, 6356.173697419306, 6029.547783916136, 6037.124616930609, 6082.90875636857, 6101.298350689727, 6155.169052177898, 6363.809085727436, 6389.137466441971, 6436.034594810629, 6440.452561532322, 6477.255115661759, 5775.48020678141, 5838.540364908773, 5840.766369345179, 5844.532437405082, 5877.23595932526, 5810.622309549865, 5938.376470470711, 5962.046072628359, 5972.462478376967, 5982.910256346246], "unit": "ms", "name": "mootools.html", "value": 4127.089263905805}, {"lowerIsBetter": false, "replicates": [301.4077338030769, 312.06847560033304, 313.4436375433605, 319.8512691598406, 322.9531717900906, 5525.336959564853, 5645.1814486899375, 5668.518175955039, 5672.546196304296, 5692.573057020724, 5559.722013899309, 5610.0, 5610.859728506789, 5611.719414029302, 5615.66306021639, 4151.958480415187, 4232.978835105836, 4307.310830267158, 4314.331278651806, 4317.935230971522, 4215.367694845767, 4221.810018549173, 4225.514065882432, 4242.53332133465, 4243.002894319832, 4182.519010313822, 4188.685848561355, 4208.431861698662, 4210.789460526977, 4212.052288235153, 4201.6008479194425, 4214.599613036757, 4218.831246750142, 4220.0, 4226.957730422687, 3574.267275208576, 3732.8133593320226, 3735.2156047230114, 3747.756395834262, 3756.7370284080125, 5258.13240815265, 5323.441038690959, 5350.866228344284, 5411.675299482044, 5426.62013659044, 4861.73260470674, 4884.7069175849565, 4896.4858689837765, 4899.240617704261, 4904.60763138948, 5846.649201047951, 5879.911801322984, 5892.558058145613, 5894.823155305305, 5911.970440147772, 3942.173568017031, 3971.62269584389, 4026.2551427985622, 4032.6572241359518, 4051.270771261172, 6105.45050945417, 6169.81490555284, 6179.66011869347, 6184.628922264678, 6186.319504854462, 4117.744088053172, 4150.024744185114, 4168.145530166309, 4169.10364271683, 4175.853845115467, 4241.088166044254, 4248.192843359751, 4249.5113061997645, 4255.255330317182, 4255.489341279066, 4727.7163370197895, 4857.392825896763, 4860.78126484302, 4877.317175595419, 4887.462379138292, 5821.214136091573, 5841.182234487175, 5863.648181109147, 5870.14882841994, 5876.823695289148, 1475.5720840956003, 1486.4871619291328, 1488.3302513868587, 1489.3223583269587, 1490.6571488557693, 983.1004630762772, 989.1493315748451, 992.0922356044283, 996.1980605612407, 1000.5947591225565, 5071.264666623319, 5084.7966081356335, 5087.26234695967, 5087.745612719349, 5102.0, 6064.939350606525, 6097.847553811191, 6109.389061093944, 6116.113163591254, 6150.292716337678, 5024.296598476216, 5065.56942659878, 5092.490750924952, 5092.872678183001, 5095.949040509621, 3210.4863221884852, 3255.0723043932367, 3286.786358886665, 3313.2379552703014, 3319.6680331967095, 5658.122990936411, 5738.856528586819, 5790.88418231633, 5795.39148389413, 5805.36141024487, 6334.144890439824, 6343.397377249246, 6346.492280617539, 6363.7772677956045, 6377.3303803100935, 5804.158397032491, 5815.41845815415, 5818.0, 5819.418058194231, 5822.534197264209, 5958.76164953397, 6113.786017489544, 6124.203853499017, 6125.448709616156, 6140.232470941132, 6017.939820601913, 6035.366286540026, 6038.365971572922, 6038.788642397495, 6048.939510604838, 5806.187133801355, 5810.215620891295, 5810.360860305447, 5810.796622118206, 5814.331351894586, 4172.332426811696, 4217.114405974657, 4217.34631132175, 4227.429297044982, 4228.090960443519, 5996.88006239864, 6122.877542449037, 6125.203723515914, 6129.387061293835, 6154.1999540059505, 5834.27071616048, 5859.619124756877, 5893.823185304448, 5902.38025007368, 5904.996150654485, 5865.442782935615, 5906.675132867734, 5908.704564771659, 5910.527157827278, 5914.408559144224, 5607.579431542732, 5744.712764361681, 5754.482096611325, 5765.4811067004175, 5771.7402716877, 5959.67221802805, 5961.52307815365, 5961.552883533839, 5966.850828729316, 5980.9401905980385, 5718.942810571841, 5763.9135412968, 5777.971110144423, 5781.884362312646, 5787.189793428839], "unit": "ms", "name": "prototype.html", "value": 4392.050440527401}, {"lowerIsBetter": false, "replicates": [731.6597782031355, 732.1799584465399, 778.120723582352, 782.0146615264765, 788.4993029426314, 11614.36121013344, 13846.100003499765, 14127.858721412782, 14158.221297828628, 14181.290935453238, 13379.799303010463, 13440.0, 13475.0, 13502.054856160074, 13504.18974861509, 778.8442311537701, 798.2974982015847, 798.321426787232, 798.6246464161835, 798.744401791427, 768.3699366519456, 786.5595266650665, 789.2659826361481, 792.7700966719644, 794.1780257433558, 834.7161964931922, 834.995825020874, 838.6310023589601, 840.5587066789953, 841.4068082002204, 830.393812516863, 836.9163083691643, 838.5890913452395, 840.3991146330342, 841.4068082002174, 610.9847253818646, 618.11300783376, 619.2816333053636, 619.6746707978302, 622.9065640153968, 12501.624951251477, 12657.177283476545, 12683.936580317039, 12706.301153436558, 12743.235405875585, 10513.264071514997, 10883.891161088446, 11314.321140731583, 11418.143639227008, 11644.126690498162, 9274.489903055397, 9291.72124836256, 9334.906650933539, 9445.0, 9498.620055197784, 3126.624805023389, 3168.4930411134337, 3177.6663450337614, 3228.4673028950197, 3277.8197199154038, 42137.578624213675, 42341.94145146365, 42545.57454425447, 42614.36078458826, 42929.57070429287, 8991.55042247885, 9036.412633178823, 9046.231070358961, 9286.210672092948, 9296.907030929739, 15547.766783498257, 15616.0, 15642.608934776494, 15667.29497172607, 15669.529914102595, 5784.739686714108, 5919.644821310735, 5953.940460595425, 6102.176206212193, 6157.076438534166, 3436.896893093211, 3467.219875527986, 3569.1790888095884, 3570.6786389225094, 3639.47227651989, 2650.08572042645, 2672.7460891215305, 2678.611601317837, 2681.075029114952, 2681.570948648207, 482.642844295219, 484.06333744205074, 484.8933234688363, 493.92591111333587, 494.1549949586176, 448.90797386535684, 536.5117742853984, 552.3813329071465, 562.8367773345766, 568.5167607533564, 7022.789316320519, 7160.57036577807, 7246.635349150632, 7260.854782904313, 7518.699252029857, 566.4165909113538, 583.9270091238595, 590.8316129902958, 591.1989254560009, 602.5541099586275, 3499.545059142295, 3603.9099022524124, 3610.097475631092, 3716.349638813197, 3719.386301260316, 47619.523804761506, 47867.52132478631, 48276.0, 48459.27311090336, 48463.0, 43306.0, 44247.77876110599, 44707.552924470336, 44999.0, 45573.54426455693, 39606.40590391089, 40568.1886362277, 41233.58766412357, 41785.582144178166, 42412.78793606012, 7316.743913963199, 7449.8882516761205, 7558.659860306409, 7727.343175830118, 8115.83768324642, 32687.67312326846, 33565.83217083899, 33874.661253388134, 34153.0, 35461.46807797936, 42494.36258456064, 43029.56970430381, 43981.78009110062, 46483.767581161876, 46606.53393466157, 10619.893801062199, 10782.67651970442, 10798.244122911321, 11062.059724923472, 11344.602938897098, 10638.468076596295, 10963.83554246671, 11434.771304573696, 11709.590164344549, 11907.76184476323, 10568.234792354853, 10838.349699018085, 10858.077063449695, 10882.0, 10906.781864362827, 10689.9465502672, 10934.617288395186, 11038.337699738042, 11398.715032124263, 11402.94298528502, 10922.726931826768, 10989.120870330515, 11037.779244415227, 11062.0, 11387.544498219979, 8942.239909607497, 9074.137956894085, 9279.582418791306, 9365.484898330657, 9749.268804839523, 7980.521168729895, 8152.510849349058, 9250.167484926389, 9263.675771347971, 9320.673776418063], "unit": "ms", "name": "yui.html", "value": 5799.908105371883}], "name": "dromaeo_css", "value": 6511.725677176577}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 113.0, 113.0, 113.0, 125.0, 113.0, 111.0, 114.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.4}, {"lowerIsBetter": true, "replicates": [153.0, 134.0, 153.0, 177.0, 137.0, 159.0, 158.0, 137.0, 176.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.7}, {"lowerIsBetter": true, "replicates": [165.0, 165.0, 166.0, 163.0, 164.0, 174.0, 166.0, 163.0, 167.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 165.6}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 74.0, 152.0, 72.0, 73.0, 75.0, 74.0, 154.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 89.7}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 130.0, 92.0, 93.0, 92.0, 131.0, 91.0, 93.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 103.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 150.0, 148.0, 147.0, 149.0, 149.0, 150.0, 147.0, 149.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 101.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 73.0, 73.0, 71.0, 71.0, 79.0, 70.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 72.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 83.0, 84.0, 91.0, 85.0, 85.0, 89.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [136.0, 120.0, 120.0, 146.0, 123.0, 127.0, 131.0, 140.0, 124.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.9}, {"lowerIsBetter": true, "replicates": [140.0, 149.0, 151.0, 152.0, 158.0, 141.0, 152.0, 147.0, 148.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 74.0, 73.0, 72.0, 75.0, 73.0, 71.0, 71.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 72.2}], "name": "kraken", "value": 1554.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [161.94331983805668], "unit": "score", "name": "Richards", "value": 217.98985000000005}, {"lowerIsBetter": false, "replicates": [190.51247856734616], "unit": "score", "name": "DeltaBlue", "value": 347.05338199999983}, {"lowerIsBetter": false, "replicates": [281.29395218002816], "unit": "score", "name": "Encrypt", "value": 946.2734550000002}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1069.51871657754], "unit": "score", "name": "RayTrace", "value": 691.889715}, {"lowerIsBetter": false, "replicates": [715.0], "unit": "score", "name": "Earley", "value": 932.1160839160838}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [25692.30769230769], "unit": "score", "name": "RegExp", "value": 35.4575}, {"lowerIsBetter": false, "replicates": [603.003003003003], "unit": "score", "name": "Splay", "value": 135.1419472111554}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21387.382543760163}]} 08:45:29 INFO - RETURN: dromaeo_css: 6511.73 08:45:29 INFO - RETURN: kraken: 1554.70 08:45:29 INFO - RETURN: v8_7: 21387.38 08:45:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,43]]", "result": "21387.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,43]]", "result": "1554.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,43]]", "result": "6511.73"}}} 08:45:29 INFO - Return code: 0 08:45:29 INFO - # TBPL SUCCESS # 08:45:29 INFO - Running post-action listener: _resource_record_post_action 08:45:29 INFO - Running post-run listener: _resource_record_post_run 08:45:30 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 501395456; Read time: 244; Write time: 660468 08:45:30 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 110084096; Read time: 0; Write time: 175660 08:45:30 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 309805056; Read time: 244; Write time: 268476 08:45:30 INFO - Running post-run listener: _upload_blobber_files 08:45:30 INFO - Blob upload gear active. 08:45:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:45:30 INFO - Copying logs to upload dir... 08:45:30 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.986927 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-19 08:45:30.163680) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 08:45:30.167276) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010029 build_url: 'https://queue.taskcluster.net/v1/task/crBC-Ju-RDyyGPmgAHL2tA/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-19 08:45:30.219594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 08:45:30.220024) ========= 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=8e92d6ac3b8b0dffa3775d33000001f9-1447950256.340680-1474587445 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 08:45:30.270358) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 08:45:30.270731) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 08:45:30.271095) ========= ========= Total master_lag: 0.22 =========