builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1447653648.81 results: success (0) buildid: 20151115210907 builduid: a89dd5d0cfca4e208dbc92de74ff1128 revision: 951e77fb1760a8f2047fe7f83217f69f480181a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.807571) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.808108) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.808423) ========= 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=6e558709db315bacd2260379000001b6-1447650943.589097-32196527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006489 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.830921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.831236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.863898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.864295) ========= 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=6e558709db315bacd2260379000001b6-1447650943.589097-32196527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.926994) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.927317) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.927696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:48.927968) ========= 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=6e558709db315bacd2260379000001b6-1447650943.589097-32196527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-15 22:00:50-- 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% 224M=0s 2015-11-15 22:00:50 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:49.146999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:49.147337) ========= 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=6e558709db315bacd2260379000001b6-1447650943.589097-32196527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019861 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:49.209878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-15 22:00:49.213256) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 951e77fb1760a8f2047fe7f83217f69f480181a2 --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 951e77fb1760a8f2047fe7f83217f69f480181a2 --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=6e558709db315bacd2260379000001b6-1447650943.589097-32196527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-15 22:00:50,432 truncating revision to first 12 chars 2015-11-15 22:00:50,432 Setting DEBUG logging. 2015-11-15 22:00:50,432 attempt 1/10 2015-11-15 22:00:50,432 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/951e77fb1760?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 22:00:51,023 unpacking tar archive at: mozilla-inbound-951e77fb1760/testing/mozharness/ program finished with exit code 0 elapsedTime=1.172822 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-15 22:00:50.413481) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:50.413846) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:50.423383) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:50.423771) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 22:00:50.424228) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-15 22:00:50.424529) ========= /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=6e558709db315bacd2260379000001b6-1447650943.589097-32196527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:51 INFO - MultiFileLogger online at 20151115 22:00:51 in /builds/slave/test 22:00:51 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 22:00:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:00:51 INFO - {'append_to_log': False, 22:00:51 INFO - 'base_work_dir': '/builds/slave/test', 22:00:51 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 22:00:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:00:51 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 22:00:51 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:51 INFO - 'config_files': ('talos/linux_config.py',), 22:00:51 INFO - 'default_actions': ('clobber', 22:00:51 INFO - 'read-buildbot-config', 22:00:51 INFO - 'download-and-extract', 22:00:51 INFO - 'populate-webroot', 22:00:51 INFO - 'create-virtualenv', 22:00:51 INFO - 'install', 22:00:51 INFO - 'run-tests'), 22:00:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:51 INFO - 'download_minidump_stackwalk': True, 22:00:51 INFO - 'download_symbols': 'ondemand', 22:00:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:51 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:51 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:51 INFO - 'installer_path': 'installer.exe', 22:00:51 INFO - 'log_level': 'info', 22:00:51 INFO - 'log_name': 'talos', 22:00:51 INFO - 'log_to_console': True, 22:00:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:51 INFO - 'opt_config_files': (), 22:00:51 INFO - 'pip_index': False, 22:00:51 INFO - 'sps_profile': False, 22:00:51 INFO - 'sps_profile_interval': 0, 22:00:51 INFO - 'suite': 'dromaeojs-e10s', 22:00:51 INFO - 'system_bits': '64', 22:00:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:51 INFO - 'title': 'talos-linux64-ix-039', 22:00:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:51 INFO - 'use_talos_json': True, 22:00:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:00:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:51 INFO - 'work_dir': 'build'} 22:00:51 INFO - ##### 22:00:51 INFO - ##### Running clobber step. 22:00:51 INFO - ##### 22:00:51 INFO - Running pre-action listener: _resource_record_pre_action 22:00:51 INFO - Running main action method: clobber 22:00:51 INFO - rmtree: /builds/slave/test/build 22:00:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:00:52 INFO - Running post-action listener: _resource_record_post_action 22:00:52 INFO - ##### 22:00:52 INFO - ##### Running read-buildbot-config step. 22:00:52 INFO - ##### 22:00:52 INFO - Running pre-action listener: _resource_record_pre_action 22:00:52 INFO - Running main action method: read_buildbot_config 22:00:52 INFO - Using buildbot properties: 22:00:52 INFO - { 22:00:52 INFO - "properties": { 22:00:52 INFO - "buildnumber": 1065, 22:00:52 INFO - "product": "firefox", 22:00:52 INFO - "script_repo_revision": "production", 22:00:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:00:52 INFO - "repository": "", 22:00:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs-e10s", 22:00:52 INFO - "buildid": "20151115210907", 22:00:52 INFO - "slavename": "talos-linux64-ix-039", 22:00:52 INFO - "pgo_build": "False", 22:00:52 INFO - "basedir": "/builds/slave/test", 22:00:52 INFO - "project": "", 22:00:52 INFO - "platform": "ubuntu64_hw", 22:00:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:00:52 INFO - "slavebuilddir": "test", 22:00:52 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 22:00:52 INFO - "branch": "mozilla-inbound", 22:00:52 INFO - "repo_path": "integration/mozilla-inbound", 22:00:52 INFO - "stage_platform": "linux64", 22:00:52 INFO - "builduid": "a89dd5d0cfca4e208dbc92de74ff1128", 22:00:52 INFO - "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2" 22:00:52 INFO - }, 22:00:52 INFO - "sourcestamp": { 22:00:52 INFO - "repository": "", 22:00:52 INFO - "hasPatch": false, 22:00:52 INFO - "project": "", 22:00:52 INFO - "branch": "mozilla-inbound-linux64-talos", 22:00:52 INFO - "changes": [ 22:00:52 INFO - { 22:00:52 INFO - "category": null, 22:00:52 INFO - "files": [ 22:00:52 INFO - { 22:00:52 INFO - "url": null, 22:00:52 INFO - "name": "https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:00:52 INFO - } 22:00:52 INFO - ], 22:00:52 INFO - "repository": "", 22:00:52 INFO - "rev": "951e77fb1760a8f2047fe7f83217f69f480181a2", 22:00:52 INFO - "who": "nnethercote@mozilla.com", 22:00:52 INFO - "when": 1447653577, 22:00:52 INFO - "number": 6664906, 22:00:52 INFO - "comments": "Bug 1217465 - Fill in missing pixels caused by truncated BMP files. r=seth.\n\nThis fixes failures for\nimage/test/reftest/bmp/bmpsuite/b/{badrle.bmp,shortfile.bmp} with the Skia\nback-end.", 22:00:52 INFO - "project": "", 22:00:52 INFO - "at": "Sun 15 Nov 2015 21:59:37", 22:00:52 INFO - "branch": "mozilla-inbound-linux64-talos", 22:00:52 INFO - "revlink": "", 22:00:52 INFO - "properties": [ 22:00:52 INFO - [ 22:00:52 INFO - "buildid", 22:00:52 INFO - "20151115210907", 22:00:52 INFO - "Change" 22:00:52 INFO - ], 22:00:52 INFO - [ 22:00:52 INFO - "builduid", 22:00:52 INFO - "a89dd5d0cfca4e208dbc92de74ff1128", 22:00:52 INFO - "Change" 22:00:52 INFO - ], 22:00:52 INFO - [ 22:00:52 INFO - "pgo_build", 22:00:52 INFO - "False", 22:00:52 INFO - "Change" 22:00:52 INFO - ] 22:00:52 INFO - ], 22:00:52 INFO - "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2" 22:00:52 INFO - } 22:00:52 INFO - ], 22:00:52 INFO - "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2" 22:00:52 INFO - } 22:00:52 INFO - } 22:00:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:00:52 INFO - Running post-action listener: _resource_record_post_action 22:00:52 INFO - ##### 22:00:52 INFO - ##### Running download-and-extract step. 22:00:52 INFO - ##### 22:00:52 INFO - Running pre-action listener: _resource_record_pre_action 22:00:52 INFO - Running main action method: download_and_extract 22:00:52 INFO - mkdir: /builds/slave/test/build/tests 22:00: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')]} 22:00:52 INFO - https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:00:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/test_packages.json 22:00:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/test_packages.json 22:00:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:00:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:00:54 INFO - Downloaded 1302 bytes. 22:00:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:00:54 INFO - Using the following test package requirements: 22:00:54 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:00:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:54 INFO - u'jsshell-linux-x86_64.zip'], 22:00:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:00:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:00:54 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:00:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:00:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:00:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:00:54 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')]} 22:00:54 INFO - https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:00:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:00:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/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 22:00:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/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 22:00:55 INFO - Downloaded 21278031 bytes. 22:00:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:00:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:00:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:00:56 INFO - Return code: 0 22:00:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:00: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')]} 22:00:56 INFO - https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:00:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:00:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/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 22:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/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 22:00:58 INFO - Downloaded 21278031 bytes. 22:00:58 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 22:00:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:00:58 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 22:01:00 INFO - Return code: 0 22:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:00 INFO - https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/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 22:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/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 22:01:01 INFO - Downloaded 11131693 bytes. 22:01:01 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 22:01:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:01 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 22:01:01 INFO - Return code: 0 22:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:01 INFO - https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:01:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/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 22:01:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HoKzcQykRJuTEX_MmKlTPQ/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 22:01:02 INFO - Downloaded 55601110 bytes. 22:01:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:02 INFO - mkdir: /builds/slave/test/properties 22:01:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:01:02 INFO - Writing to file /builds/slave/test/properties/build_url 22:01:02 INFO - Contents: 22:01:02 INFO - build_url:https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:02 INFO - Running post-action listener: _resource_record_post_action 22:01:02 INFO - Running post-action listener: set_extra_try_arguments 22:01:02 INFO - ##### 22:01:02 INFO - ##### Running populate-webroot step. 22:01:02 INFO - ##### 22:01:02 INFO - Running pre-action listener: _resource_record_pre_action 22:01:02 INFO - Running main action method: populate_webroot 22:01:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:02 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:01:02 INFO - '../fennec_ids.txt'], 22:01:02 INFO - 'tests': ['tcheck2']}, 22:01:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:02 INFO - '--tppagecycles', 22:01:02 INFO - '7'], 22:01:02 INFO - 'tests': ['tsvgm']}}, 22:01:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:01:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:01:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:01:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:01:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:01:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:01:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:02 INFO - 'talos_options': ['--e10s'], 22:01:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:02 INFO - 'tests': ['damp', 'tps']}, 22:01:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:02 INFO - 'talos_options': ['--e10s'], 22:01:02 INFO - 'tests': ['damp', 'tps']}, 22:01:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:01:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:02 INFO - 'other': {'tests': ['a11yr', 22:01:02 INFO - 'ts_paint', 22:01:02 INFO - 'tpaint', 22:01:02 INFO - 'sessionrestore', 22:01:02 INFO - 'sessionrestore_no_auto_restore']}, 22:01:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:01:02 INFO - 'tests': ['a11yr', 22:01:02 INFO - 'ts_paint', 22:01:02 INFO - 'tpaint', 22:01:02 INFO - 'sessionrestore', 22:01:02 INFO - 'sessionrestore_no_auto_restore']}, 22:01:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:01:02 INFO - 'tests': ['a11yr', 22:01:02 INFO - 'ts_paint', 22:01:02 INFO - 'tpaint', 22:01:02 INFO - 'sessionrestore', 22:01:02 INFO - 'sessionrestore_no_auto_restore']}, 22:01:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:01:02 INFO - 'tests': ['a11yr', 22:01:02 INFO - 'ts_paint', 22:01:02 INFO - 'tpaint', 22:01:02 INFO - 'sessionrestore', 22:01:02 INFO - 'sessionrestore_no_auto_restore']}, 22:01:02 INFO - 'other_l64': {'tests': ['a11yr', 22:01:02 INFO - 'ts_paint', 22:01:02 INFO - 'tpaint', 22:01:02 INFO - 'sessionrestore', 22:01:02 INFO - 'sessionrestore_no_auto_restore']}, 22:01:02 INFO - 'other_nol64': {'tests': ['a11yr', 22:01:02 INFO - 'ts_paint', 22:01:02 INFO - 'tpaint', 22:01:02 INFO - 'sessionrestore', 22:01:02 INFO - 'sessionrestore_no_auto_restore']}, 22:01:02 INFO - 'svgr': {'tests': ['tsvgx', 22:01:02 INFO - 'tsvgr_opacity', 22:01:02 INFO - 'tart', 22:01:02 INFO - 'tscrollx', 22:01:02 INFO - 'cart']}, 22:01:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:01:02 INFO - 'tests': ['tsvgx', 22:01:02 INFO - 'tsvgr_opacity', 22:01:02 INFO - 'tart', 22:01:02 INFO - 'tscrollx', 22:01:02 INFO - 'cart']}, 22:01:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:02 INFO - 'tests': ['tp5o']}, 22:01:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:02 INFO - 'talos_options': ['--e10s'], 22:01:02 INFO - 'tests': ['tp5o']}, 22:01:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:02 INFO - 'talos_options': ['--xperf_path', 22:01:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:02 INFO - 'tests': ['tp5n']}, 22:01:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:02 INFO - 'talos_options': ['--e10s', 22:01:02 INFO - '--xperf_path', 22:01:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:02 INFO - 'tests': ['tp5n']}}, 22:01:02 INFO - 'talos.zip': {'path': '', 22:01:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:02 INFO - Running post-action listener: _resource_record_post_action 22:01:02 INFO - ##### 22:01:02 INFO - ##### Running create-virtualenv step. 22:01:02 INFO - ##### 22:01:02 INFO - Running pre-action listener: _resource_record_pre_action 22:01:02 INFO - Running main action method: create_virtualenv 22:01:02 INFO - Creating virtualenv /builds/slave/test/build/venv 22:01:02 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 22:01:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:01:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:03 INFO - Using real prefix '/usr' 22:01:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:01:03 INFO - Installing distribute.............................................................................................................................................................................................done. 22:01:05 INFO - Installing pip.................done. 22:01:05 INFO - Return code: 0 22:01:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f555aa31c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8ac0>, '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 0x2ab99a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9e50>, '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': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', '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 22:01:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:01:05 INFO - Using env: {'DISPLAY': ':0', 22:01:05 INFO - 'HOME': '/home/cltbld', 22:01:05 INFO - 'LANG': 'en_US.UTF-8', 22:01:05 INFO - 'LANGUAGE': 'en_US:en', 22:01:05 INFO - 'LOGNAME': 'cltbld', 22:01:05 INFO - 'MAIL': '/var/mail/cltbld', 22:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:05 INFO - 'MOZ_NO_REMOTE': '1', 22:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:05 INFO - 'NO_EM_RESTART': '1', 22:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:05 INFO - 'PWD': '/builds/slave/test', 22:01:05 INFO - 'SHELL': '/bin/bash', 22:01:05 INFO - 'SHLVL': '1', 22:01:05 INFO - 'TERM': 'linux', 22:01:05 INFO - 'TMOUT': '86400', 22:01:05 INFO - 'USER': 'cltbld', 22:01:05 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', 22:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:05 INFO - '_': '/tools/buildbot/bin/python'} 22:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:05 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 22:01:05 INFO - Cleaning up... 22:01:05 INFO - Return code: 0 22:01:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f555aa31c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8ac0>, '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 0x2ab99a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9e50>, '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': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', '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 22:01:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:01:05 INFO - Using env: {'DISPLAY': ':0', 22:01:05 INFO - 'HOME': '/home/cltbld', 22:01:05 INFO - 'LANG': 'en_US.UTF-8', 22:01:05 INFO - 'LANGUAGE': 'en_US:en', 22:01:05 INFO - 'LOGNAME': 'cltbld', 22:01:05 INFO - 'MAIL': '/var/mail/cltbld', 22:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:05 INFO - 'MOZ_NO_REMOTE': '1', 22:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:05 INFO - 'NO_EM_RESTART': '1', 22:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:05 INFO - 'PWD': '/builds/slave/test', 22:01:05 INFO - 'SHELL': '/bin/bash', 22:01:05 INFO - 'SHLVL': '1', 22:01:05 INFO - 'TERM': 'linux', 22:01:05 INFO - 'TMOUT': '86400', 22:01:05 INFO - 'USER': 'cltbld', 22:01:05 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', 22:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:05 INFO - '_': '/tools/buildbot/bin/python'} 22:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:05 INFO - Downloading/unpacking psutil>=0.7.1 22:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:07 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:01:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:01:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:07 INFO - Installing collected packages: psutil 22:01:07 INFO - Running setup.py install for psutil 22:01:07 INFO - building 'psutil._psutil_linux' extension 22:01:07 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 22:01:07 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 22:01:07 INFO - building 'psutil._psutil_posix' extension 22:01:07 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 22:01:08 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 22:01:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:08 INFO - Successfully installed psutil 22:01:08 INFO - Cleaning up... 22:01:08 INFO - Return code: 0 22:01:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f555aa31c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8ac0>, '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 0x2ab99a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9e50>, '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': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', '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 22:01:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:01:08 INFO - Using env: {'DISPLAY': ':0', 22:01:08 INFO - 'HOME': '/home/cltbld', 22:01:08 INFO - 'LANG': 'en_US.UTF-8', 22:01:08 INFO - 'LANGUAGE': 'en_US:en', 22:01:08 INFO - 'LOGNAME': 'cltbld', 22:01:08 INFO - 'MAIL': '/var/mail/cltbld', 22:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:08 INFO - 'MOZ_NO_REMOTE': '1', 22:01:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:08 INFO - 'NO_EM_RESTART': '1', 22:01:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:08 INFO - 'PWD': '/builds/slave/test', 22:01:08 INFO - 'SHELL': '/bin/bash', 22:01:08 INFO - 'SHLVL': '1', 22:01:08 INFO - 'TERM': 'linux', 22:01:08 INFO - 'TMOUT': '86400', 22:01:08 INFO - 'USER': 'cltbld', 22:01:08 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', 22:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:08 INFO - '_': '/tools/buildbot/bin/python'} 22:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:01:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:01:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:01:10 INFO - Installing collected packages: mozsystemmonitor 22:01:10 INFO - Running setup.py install for mozsystemmonitor 22:01:10 INFO - Successfully installed mozsystemmonitor 22:01:10 INFO - Cleaning up... 22:01:10 INFO - Return code: 0 22:01:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:01:10 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')]} 22:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:10 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')]} 22:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:10 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 0x7f555aa31c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8ac0>, '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 0x2ab99a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9e50>, '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': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', '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 22:01:10 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 22:01:10 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 22:01:10 INFO - Using env: {'DISPLAY': ':0', 22:01:10 INFO - 'HOME': '/home/cltbld', 22:01:10 INFO - 'LANG': 'en_US.UTF-8', 22:01:10 INFO - 'LANGUAGE': 'en_US:en', 22:01:10 INFO - 'LOGNAME': 'cltbld', 22:01:10 INFO - 'MAIL': '/var/mail/cltbld', 22:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:10 INFO - 'MOZ_NO_REMOTE': '1', 22:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:10 INFO - 'NO_EM_RESTART': '1', 22:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:10 INFO - 'PWD': '/builds/slave/test', 22:01:10 INFO - 'SHELL': '/bin/bash', 22:01:10 INFO - 'SHLVL': '1', 22:01:10 INFO - 'TERM': 'linux', 22:01:10 INFO - 'TMOUT': '86400', 22:01:10 INFO - 'USER': 'cltbld', 22:01:10 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', 22:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:10 INFO - '_': '/tools/buildbot/bin/python'} 22:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:10 INFO - Downloading/unpacking blobuploader==1.2.4 22:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:12 INFO - Downloading blobuploader-1.2.4.tar.gz 22:01:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:01:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:01:12 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 22:01:12 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 22:01:12 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 22:01:12 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 22:01:12 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 22:01:12 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 22:01:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:01:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:01:12 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 22:01:12 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 22:01:12 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 22:01:12 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 22:01:12 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 22:01:12 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 22:01:12 INFO - Downloading docopt-0.6.1.tar.gz 22:01:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:01:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:01:12 INFO - Installing collected packages: blobuploader, requests, docopt 22:01:12 INFO - Running setup.py install for blobuploader 22:01:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:01:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:01:12 INFO - Running setup.py install for requests 22:01:13 INFO - Running setup.py install for docopt 22:01:13 INFO - Successfully installed blobuploader requests docopt 22:01:13 INFO - Cleaning up... 22:01:13 INFO - Return code: 0 22:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:13 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 0x7f555aa31c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8ac0>, '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 0x2ab99a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9e50>, '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': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', '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 22:01:13 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 22:01:13 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 22:01:13 INFO - Using env: {'DISPLAY': ':0', 22:01:13 INFO - 'HOME': '/home/cltbld', 22:01:13 INFO - 'LANG': 'en_US.UTF-8', 22:01:13 INFO - 'LANGUAGE': 'en_US:en', 22:01:13 INFO - 'LOGNAME': 'cltbld', 22:01:13 INFO - 'MAIL': '/var/mail/cltbld', 22:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:13 INFO - 'MOZ_NO_REMOTE': '1', 22:01:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:13 INFO - 'NO_EM_RESTART': '1', 22:01:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:13 INFO - 'PWD': '/builds/slave/test', 22:01:13 INFO - 'SHELL': '/bin/bash', 22:01:13 INFO - 'SHLVL': '1', 22:01:13 INFO - 'TERM': 'linux', 22:01:13 INFO - 'TMOUT': '86400', 22:01:13 INFO - 'USER': 'cltbld', 22:01:13 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', 22:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:13 INFO - '_': '/tools/buildbot/bin/python'} 22:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:13 INFO - Running setup.py (path:/tmp/pip-HqOCdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:13 INFO - Running setup.py (path:/tmp/pip-7HFczz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:13 INFO - Running setup.py (path:/tmp/pip-2VufsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:13 INFO - Running setup.py (path:/tmp/pip-35mFUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:13 INFO - Running setup.py (path:/tmp/pip-kBueYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:13 INFO - Running setup.py (path:/tmp/pip-SyQw2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:14 INFO - Running setup.py (path:/tmp/pip-qzSrvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:14 INFO - Running setup.py (path:/tmp/pip-tQDz2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:14 INFO - Running setup.py (path:/tmp/pip-vYB5iU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:14 INFO - Running setup.py (path:/tmp/pip-txG_KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:14 INFO - Running setup.py (path:/tmp/pip-Qyw1Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:14 INFO - Running setup.py (path:/tmp/pip-dynYZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:14 INFO - Running setup.py (path:/tmp/pip-vAUhb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:14 INFO - Running setup.py (path:/tmp/pip-yUtc6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:14 INFO - Running setup.py (path:/tmp/pip-fot1t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:14 INFO - Running setup.py (path:/tmp/pip-pO_Z1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:14 INFO - Running setup.py (path:/tmp/pip-52wKHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:01:14 INFO - Running setup.py install for manifestparser 22:01:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:01:14 INFO - Running setup.py install for mozcrash 22:01:15 INFO - Running setup.py install for mozdebug 22:01:15 INFO - Running setup.py install for mozdevice 22:01:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:01:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:01:15 INFO - Running setup.py install for mozfile 22:01:15 INFO - Running setup.py install for mozhttpd 22:01:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:01:15 INFO - Running setup.py install for mozinfo 22:01:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:01:15 INFO - Running setup.py install for mozInstall 22:01:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:01:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:01:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:01:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:01:15 INFO - Running setup.py install for mozleak 22:01:15 INFO - Running setup.py install for mozlog 22:01:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:01:15 INFO - Running setup.py install for moznetwork 22:01:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:01:15 INFO - Running setup.py install for mozprocess 22:01:16 INFO - Running setup.py install for mozprofile 22:01:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:01:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:01:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:01:16 INFO - Running setup.py install for mozrunner 22:01:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:01:16 INFO - Running setup.py install for mozscreenshot 22:01:16 INFO - Running setup.py install for moztest 22:01:16 INFO - Running setup.py install for mozversion 22:01:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:01:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:01:16 INFO - Cleaning up... 22:01:16 INFO - Return code: 0 22:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:16 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')]} 22:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:16 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')]} 22:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:16 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 0x7f555aa31c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8ac0>, '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 0x2ab99a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9e50>, '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': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', '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 22:01:16 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 22:01:16 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 22:01:16 INFO - Using env: {'DISPLAY': ':0', 22:01:16 INFO - 'HOME': '/home/cltbld', 22:01:16 INFO - 'LANG': 'en_US.UTF-8', 22:01:16 INFO - 'LANGUAGE': 'en_US:en', 22:01:16 INFO - 'LOGNAME': 'cltbld', 22:01:16 INFO - 'MAIL': '/var/mail/cltbld', 22:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:16 INFO - 'MOZ_NO_REMOTE': '1', 22:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:16 INFO - 'NO_EM_RESTART': '1', 22:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:16 INFO - 'PWD': '/builds/slave/test', 22:01:16 INFO - 'SHELL': '/bin/bash', 22:01:16 INFO - 'SHLVL': '1', 22:01:16 INFO - 'TERM': 'linux', 22:01:16 INFO - 'TMOUT': '86400', 22:01:16 INFO - 'USER': 'cltbld', 22:01:16 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', 22:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:16 INFO - '_': '/tools/buildbot/bin/python'} 22:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:16 INFO - Running setup.py (path:/tmp/pip-kjkzAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:16 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)) 22:01:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:16 INFO - Running setup.py (path:/tmp/pip-_V714l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:17 INFO - Running setup.py (path:/tmp/pip-TL4FZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:17 INFO - Running setup.py (path:/tmp/pip-QdoKQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:17 INFO - Running setup.py (path:/tmp/pip-KHYxbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:17 INFO - Running setup.py (path:/tmp/pip-2dKG6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:17 INFO - Running setup.py (path:/tmp/pip-M88kKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:17 INFO - Running setup.py (path:/tmp/pip-qdX7PC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:17 INFO - Running setup.py (path:/tmp/pip-B2wwMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:17 INFO - Running setup.py (path:/tmp/pip-qM2QqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:17 INFO - Running setup.py (path:/tmp/pip-RnDwmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:17 INFO - Running setup.py (path:/tmp/pip-qSYKwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:17 INFO - Running setup.py (path:/tmp/pip-CBWJDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:17 INFO - Running setup.py (path:/tmp/pip-XH1HNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:17 INFO - Running setup.py (path:/tmp/pip-_Ui5Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:17 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)) 22:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:17 INFO - Running setup.py (path:/tmp/pip-JK_oe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:18 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)) 22:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:18 INFO - Running setup.py (path:/tmp/pip-31mKlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:18 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)) 22:01:18 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)) 22:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:01:18 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)) 22:01:18 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)) 22:01:18 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)) 22:01:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:01:18 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 22:01:18 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 22:01:18 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 22:01:18 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 22:01:18 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 22:01:18 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 22:01:19 INFO - Downloading blessings-1.5.1.tar.gz 22:01:19 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 22:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:01:19 INFO - Installing collected packages: blessings 22:01:19 INFO - Running setup.py install for blessings 22:01:19 INFO - Successfully installed blessings 22:01:19 INFO - Cleaning up... 22:01:19 INFO - Return code: 0 22:01:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:01:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:20 INFO - Reading from file tmpfile_stdout 22:01:20 INFO - Current package versions: 22:01:20 INFO - argparse == 1.2.1 22:01:20 INFO - blessings == 1.5.1 22:01:20 INFO - blobuploader == 1.2.4 22:01:20 INFO - docopt == 0.6.1 22:01:20 INFO - manifestparser == 1.1 22:01:20 INFO - mozInstall == 1.12 22:01:20 INFO - mozcrash == 0.16 22:01:20 INFO - mozdebug == 0.1 22:01:20 INFO - mozdevice == 0.47 22:01:20 INFO - mozfile == 1.2 22:01:20 INFO - mozhttpd == 0.7 22:01:20 INFO - mozinfo == 0.9 22:01:20 INFO - mozleak == 0.1 22:01:20 INFO - mozlog == 3.0 22:01:20 INFO - moznetwork == 0.27 22:01:20 INFO - mozprocess == 0.22 22:01:20 INFO - mozprofile == 0.27 22:01:20 INFO - mozrunner == 6.11 22:01:20 INFO - mozscreenshot == 0.1 22:01:20 INFO - mozsystemmonitor == 0.0 22:01:20 INFO - moztest == 0.7 22:01:20 INFO - mozversion == 1.4 22:01:20 INFO - psutil == 3.1.1 22:01:20 INFO - requests == 1.2.3 22:01:20 INFO - wsgiref == 0.1.2 22:01:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:20 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 0x7f555aa31c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8ac0>, '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 0x2ab99a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9e50>, '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': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', '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 22:01:20 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 22:01:20 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 22:01:20 INFO - Using env: {'DISPLAY': ':0', 22:01:20 INFO - 'HOME': '/home/cltbld', 22:01:20 INFO - 'LANG': 'en_US.UTF-8', 22:01:20 INFO - 'LANGUAGE': 'en_US:en', 22:01:20 INFO - 'LOGNAME': 'cltbld', 22:01:20 INFO - 'MAIL': '/var/mail/cltbld', 22:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:20 INFO - 'MOZ_NO_REMOTE': '1', 22:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:20 INFO - 'NO_EM_RESTART': '1', 22:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:20 INFO - 'PWD': '/builds/slave/test', 22:01:20 INFO - 'SHELL': '/bin/bash', 22:01:20 INFO - 'SHLVL': '1', 22:01:20 INFO - 'TERM': 'linux', 22:01:20 INFO - 'TMOUT': '86400', 22:01:20 INFO - 'USER': 'cltbld', 22:01:20 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', 22:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:20 INFO - '_': '/tools/buildbot/bin/python'} 22:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:20 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)) 22:01:20 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)) 22:01:20 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)) 22:01:20 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)) 22:01:20 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)) 22:01:20 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)) 22:01:20 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)) 22:01:20 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)) 22:01:20 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)) 22:01:20 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)) 22:01:20 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)) 22:01:20 INFO - Cleaning up... 22:01:20 INFO - Return code: 0 22:01:20 INFO - Running post-action listener: _resource_record_post_action 22:01:20 INFO - Running post-action listener: _start_resource_monitoring 22:01:20 INFO - Starting resource monitoring. 22:01:20 INFO - ##### 22:01:20 INFO - ##### Running install step. 22:01:20 INFO - ##### 22:01:20 INFO - Running pre-action listener: _resource_record_pre_action 22:01:20 INFO - Running main action method: install 22:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:20 INFO - Reading from file tmpfile_stdout 22:01:20 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:01:20 INFO - Reading from file tmpfile_stdout 22:01:20 INFO - Output received: 22:01:20 INFO - Usage: mozinstall [options] installer 22:01:20 INFO - Options: 22:01:20 INFO - -h, --help show this help message and exit 22:01:20 INFO - -d DEST, --destination=DEST 22:01:20 INFO - Directory to install application into. [default: 22:01:20 INFO - "/builds/slave/test"] 22:01:20 INFO - --app=APP Application being installed. [default: firefox] 22:01:20 INFO - mkdir: /builds/slave/test/build/application 22:01:20 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'] 22:01:20 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 22:01:34 INFO - Reading from file tmpfile_stdout 22:01:34 INFO - Output received: 22:01:34 INFO - /builds/slave/test/build/application/firefox/firefox 22:01:34 INFO - Running post-action listener: _resource_record_post_action 22:01:34 INFO - ##### 22:01:34 INFO - ##### Running run-tests step. 22:01:34 INFO - ##### 22:01:34 INFO - Running pre-action listener: _resource_record_pre_action 22:01:34 INFO - Running main action method: run_tests 22:01:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:01:34 INFO - Python 2.7.3 22:01:34 INFO - Return code: 0 22:01:34 INFO - grabbing minidump binary from tooltool 22:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:34 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 0x2ab8ac0>, '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 0x2ab99a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:01:34 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 22:01:34 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 22:01:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:34 INFO - Return code: 0 22:01:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:01:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:01:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:01:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:01:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:01:34 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/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test/build 22:01:34 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/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost 22:01:34 INFO - Using env: {'DISPLAY': ':0', 22:01:34 INFO - 'HOME': '/home/cltbld', 22:01:34 INFO - 'LANG': 'en_US.UTF-8', 22:01:34 INFO - 'LANGUAGE': 'en_US:en', 22:01:34 INFO - 'LOGNAME': 'cltbld', 22:01:34 INFO - 'MAIL': '/var/mail/cltbld', 22:01:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:01:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:34 INFO - 'MOZ_NO_REMOTE': '1', 22:01:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:01:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:34 INFO - 'NO_EM_RESTART': '1', 22:01:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:34 INFO - 'PWD': '/builds/slave/test', 22:01:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:01:34 INFO - 'SHELL': '/bin/bash', 22:01:34 INFO - 'SHLVL': '1', 22:01:34 INFO - 'TERM': 'linux', 22:01:34 INFO - 'TMOUT': '86400', 22:01:34 INFO - 'USER': 'cltbld', 22:01:34 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447650943.589097-32196527', 22:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:34 INFO - '_': '/tools/buildbot/bin/python'} 22:01:34 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/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600 22:01:35 INFO - mozversion INFO | application_buildid: 20151115210907 22:01:35 INFO - mozversion INFO | application_changeset: 951e77fb1760a8f2047fe7f83217f69f480181a2 22:01:35 INFO - mozversion INFO | application_display_name: Nightly 22:01:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:35 INFO - mozversion INFO | application_name: Firefox 22:01:35 INFO - mozversion INFO | application_remotingname: firefox 22:01:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:01:35 INFO - mozversion INFO | application_vendor: Mozilla 22:01:35 INFO - mozversion INFO | application_version: 45.0a1 22:01:35 INFO - mozversion INFO | platform_buildid: 20151115210907 22:01:35 INFO - mozversion INFO | platform_changeset: 951e77fb1760a8f2047fe7f83217f69f480181a2 22:01:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:01:35 INFO - mozversion INFO | platform_version: 45.0a1 22:01:35 INFO - 2015-11-15 22:01:35,120 DEBUG : using testdate: 1447653695 22:01:35 INFO - 2015-11-15 22:01:35,120 DEBUG : actual date: 1447653695 22:01:35 INFO - 2015-11-15 22:01:35,127 INFO : starting webserver on 'localhost:40246' 22:01:35 INFO - 2015-11-15 22:01:35,128 INFO : Starting test suite talos-linux64-ix-039.e 22:01:35 INFO - 2015-11-15 22:01:35,128 INFO : Starting test dromaeo_css 22:01:35 INFO - 2015-11-15 22:01:35,128 DEBUG : operating with platform_type : linux_ 22:01:35 INFO - 2015-11-15 22:01:35,128 INFO : Initialising browser for dromaeo_css test... 22:01:35 INFO - 2015-11-15 22:01:35,136 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq7W1IJ/profile http://localhost:40246/getInfo.html 22:01:40 INFO - 2015-11-15 22:01:40,153 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:01:40 INFO - 2015-11-15 22:01:40,153 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:01:40 INFO - 2015-11-15 22:01:40,154 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:01:40 INFO - 2015-11-15 22:01:40,154 DEBUG : BROWSER_OUTPUT: __metrics 22:01:41 INFO - 2015-11-15 22:01:41,305 INFO : Browser initialized. 22:01:41 INFO - 2015-11-15 22:01:41,306 INFO : Running cycle 1/1 for dromaeo_css test... 22:01:41 INFO - 2015-11-15 22:01:41,306 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq7W1IJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:01:53 INFO - 2015-11-15 22:01:53,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 140763136 22:01:53 INFO - 2015-11-15 22:01:53,234 DEBUG : BROWSER_OUTPUT: 22:02:42 INFO - 2015-11-15 22:02:42,890 DEBUG : BROWSER_OUTPUT: 1447653762889 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] 22:04:56 INFO - 2015-11-15 22:04:56,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40246/tests/dromaeo/cssquery-ext.html) 22:04:57 INFO - 2015-11-15 22:04:57,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 144703488 22:04:57 INFO - 2015-11-15 22:04:57,396 DEBUG : BROWSER_OUTPUT: 22:07:59 INFO - 2015-11-15 22:07:59,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/dromaeo/cssquery-ext.html (next: http://localhost:40246/tests/dromaeo/cssquery-jquery.html) 22:07:59 INFO - 2015-11-15 22:07:59,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 140967936 22:07:59 INFO - 2015-11-15 22:07:59,933 DEBUG : BROWSER_OUTPUT: 22:11:01 INFO - 2015-11-15 22:11:01,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40246/tests/dromaeo/cssquery-mootools.html) 22:11:02 INFO - 2015-11-15 22:11:02,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 141512704 22:11:02 INFO - 2015-11-15 22:11:02,215 DEBUG : BROWSER_OUTPUT: 22:14:03 INFO - 2015-11-15 22:14:03,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40246/tests/dromaeo/cssquery-prototype.html) 22:14:04 INFO - 2015-11-15 22:14:04,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 140333056 22:14:04 INFO - 2015-11-15 22:14:04,517 DEBUG : BROWSER_OUTPUT: 22:17:06 INFO - 2015-11-15 22:17:06,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40246/tests/dromaeo/cssquery-yui.html) 22:17:07 INFO - 2015-11-15 22:17:07,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 141000704 22:17:07 INFO - 2015-11-15 22:17:07,604 DEBUG : BROWSER_OUTPUT: 22:20:09 INFO - 2015-11-15 22:20:09,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/dromaeo/cssquery-yui.html (next: http://localhost:40246/tests/dromaeo/cssquery-dojo.html) 22:20:10 INFO - 2015-11-15 22:20:10,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 143491072 22:20:10 INFO - 2015-11-15 22:20:10,027 DEBUG : BROWSER_OUTPUT: 22:20:10 INFO - 2015-11-15 22:20:10,027 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:20:10 INFO - 2015-11-15 22:20:10,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:20:10 INFO - 2015-11-15 22:20:10,028 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:20:10 INFO - 2015-11-15 22:20:10,028 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:20:10 INFO - 2015-11-15 22:20:10,028 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2705.648265725456;2750.4499100179946;2780.138157171276;2781.8887244510206;2800.635917330747;4681.438227412716;4912.140375434298;4914.238293064576;4980;4980.128477516434;4879.1705410080285;4899.583535399486;4935.506449355063;4939.753012349386;5042.773075211615;4513.954860451387;4542.6138778203895;4623.680985856103;4630.259158534635;4632.374629425035;4398.362237475564;4633.62930965522;4663.463701674317;4665.463471700747;4680.274557443602;4356.3683265926265;4511.481179664315;4518.661100417449;4544.295634176708;4555.430571178603;4522.932156017662;4562.954370456286;4564.995700945819;4579;4625.1443482955765;4452.5992660660695;4471.77641117946;4555.157295900269;4560.1335746208115;4569.6801223914335;4769.833055843063;4815.6388270879825;4852.830150944736;4870.780814863304;4885.291632713237;5309.309789727349;5316.654417462892;5325.733713314319;5333.706646134461;5344.331958505187;5079.1365467870555;5197.1424714922;5212.192110222922;5311.973440132813;5339.786408543654;4893.486183950669;4924.532169443897;4929.112759703288;4933.087378834927;4958.578520825698;5443.292371991695;5476.123820188751;5483.287172667608;5487.64330318528;5509.779608815603;4980.8256711015665;5083.847484575469;5083.974580127076;5087.974560127176;5156.793728250903;5295.761690723926;5298.417174110845;5337.839864804062;5346.97326513365;5363.892722145535;5227.529522343008;5228.346456692913;5235.476452354734;5235.58115350771;5289.994900968803;5058.962912602908;5060.291559181717;5152.9742351288005;5216.765245563959;5219.451957544479;4436.7559784211535;4449.644028477714;4463.687541872037;4473.507914129443;4486.6186374157905;3893.6690381317903;3901.0637447012514;3917.6865850731874;3951.1110000249714;3954.683625309968;4335.804888780012;4444.1333939881415;4459.977700111479;4503.189425903369;4534.569215924482;5244.423113457517;5312.601554883399;5327.760250788724;5334.146536554133;5378.300820893337;4399.450068741407;4510.954890451119;4551.45382554089;4557.361969324297;4592.3800286961505;4605.263157894721;4686.086213188463;4687.6249900007915;4706.694064885772;4725.8582242532775;4972.950270497321;5028.34631497903;5034.421041580265;5038.496150384932;5072.670276432168;5153.510416510426;5232.895342093213;5309.415964243853;5330.387005494418;5363.9731801342305;4830.806767729251;4900.387451568554;4929.06347793918;4937.851864444073;4945.060438516671;5201.505856943584;5308.57531397495;5309.867253318698;5312.814051508179;5350.277712508917;5023.196288593807;5031.371078615173;5130.948690513196;5366.570674345965;5390.164524498552;5075.670081444694;5155.43290238081;5177.326947496801;5189.429162792166;5208.687478751287;5173.715445650375;5174.870628234325;5176.275321455075;5176.559992400688;5180.352455943007;4702.76486175683;4794.113089078532;4917.286993385867;5055.823046193365;5067.569256613229;5142.228665700175;5143.5113664201845;5149.150390185578;5182.8963420732125;5184.377874655065;5064.772085256099;5073.492650735045;5078.720670363018;5089.185730283137;5104.336436263262 22:20:10 INFO - 2015-11-15 22:20:10,028 DEBUG : BROWSER_OUTPUT: |1;ext.html;522.3444577055792;560.520754754685;568.1704711121762;575.2205761193583;575.7121439280359;27594.5860812088;28214.294642633944;36309.81845090778;36703;36966.815165924134;38849.61150388495;39223.41164882522;39354.40968385476;39467.60532394675;39468;7916.960415197916;8081.878771818398;8082.474639148466;8089.595520223995;8096.554689492075;7913.762587122395;7984.720534781284;7986.121526632066;7993.320567751748;7994;8016.438849280553;8072.71745488908;8073.798155046112;8084.878726819103;8091;7939.126696063428;8062.475939063971;8069.596520173968;8074.838503229961;8096.3118134958895;7925.3356795073105;8048.034235891672;8052.19478052196;8056;8063.153368896299;37625.435618465744;38006.80996595027;38023.619763802286;38042.619573804186;38363.616363836285;2921.1090617361697;3160.225744692542;3195.6644552322136;3284;3297.55483009793;28228;28307.433851322858;28613.28466788326;28676.856615716995;28927.132186034454;3088.2125058110037;3103.984480077585;3105.596272484585;3179.5707579476707;3190.88831890885;214795;215740;216069;216653.99999999843;216692;47358.76320618375;48128.5187148131;54811;55155;62031.689841550506;57180.42819571834;57198.714006430535;57356.42643573594;57433;57588.13617795736;13305.866941330463;13442.395092220873;13494.392752326168;13516.797248041286;13520.59438216855;9954.800903982024;9959.302848800658;9988.550515226832;10098.646547370954;10113.747156321004;19132.556139894954;19512.512187195432;19527.428437236267;19556.315528956417;19683.53988653696;7482.289182527651;7629.2370762923265;7675.73781143012;7709.575973321521;7751.883721744179;804.6419343392251;823.8434697407473;840.9369297302727;844.5270648436895;884.0540621535024;22897.88551057234;22937.885310573674;22962.65556016661;22976.195833146096;23152.88423557905;965.9420434773936;977.6138425321958;980.4950450517989;1031.3605564550028;1052.1582733813073;12707.174033687781;12823.230606163661;12886.548970785978;12925.741485170243;12957.805632915513;280908;281657;282263;284451;284748;45810.54189458063;46014;46622.5337746625;46681.76659116683;46719.29921051187;1179.0331927819107;1183.230899915062;1196.910231732641;1196.946137423818;1197.5688752049255;24729.1344802931;25345.493090137727;25529.361765956;25541.3614659635;25686.229413117635;39701;39717.60282397139;39762.204755905295;39876.80061599673;40057.39913901352;249580;251540;251660;252195;253099;28261;29108.27229319284;29470;29585.26036849096;29606.407871842013;31836.363272734878;32086.19784505406;32203.355932880742;32395.676043240208;33011.834940826106;32375.676243237267;32417.675823241465;33155.668443315255;33505.83247083749;33821;31746;33242.83378583092;35083.64916350804;36158.27683446264;36418.8179059103;33287.83356083301;33441.331173376886;33723.66276337205;33731.988040358825;33754.493682595275;28481.572776407957;29164.70835291705;30116;30519.389612208077;30659.846700766353;23140.305790826304;23450.296491105295;23519.88240058789;23592.17427390033;23782.405439864142 22:20:10 INFO - 2015-11-15 22:20:10,029 DEBUG : BROWSER_OUTPUT: |2;jquery.html;328.4023077998043;328.56137057028866;331.4895061605128;339.9800598205384;340.37201363484365;10785.191110666692;10854.511546980375;11111.499982500787;15356.385744570218;15857.76213356799;9841;10085.747856303597;10118.949405252983;10257.07686308232;10268.794624107513;4042.555318914917;4148.149629325981;4163.396307535406;4166.8749937501925;4173.833046678129;3434.450487921933;3671.4676371926053;4129.132882094764;4165.604267594574;4180.289350810354;4165.062860856298;4175.979120104395;4245.193413251488;4387.780610969438;4412.514623391425;4360.672949528766;4364.672649551297;4393.29707246839;4394.494633117184;4410.3825464435;3779.546454425459;4036.919261614751;4040.4343391925154;4041;4042.090529630839;12038.879611203864;12039.81940270888;12232.571859984946;12274.263544187288;12280.815787763191;1655.5778276539406;1670.905908660453;1675.585534011992;1700.3538655311027;1708.1288542843115;9189;9197.494137822418;9254.167124958785;9448.669296574655;9534.141927226514;1609.7504886742574;1622.7160246956853;1633.5997680568219;1644.1203955883545;1647.3462468526461;54405.45594544044;55029.44970550323;55119.173212401845;55513.167302490896;55736.72131639316;6051.092336149525;6207.6275423474735;6250.749970001149;6285.120083188357;6356.237251529754;7298.452616053817;7298.671559779823;7305.780826575211;7314.561126332437;7327;4871.683340582922;4889.364382630307;4918.95081049185;4935.481774413706;4982.950170498249;4914.5822605078965;4926.556609905054;4936.012797440526;4952.009598080398;4952.653314267966;2781.36028713393;2826.3781967967016;2827.2083816531403;2832.532632115719;2853.657561092682;1018.5518371916334;1025.5026312238558;1034.4930983818026;1035.0942924940678;1059.3855563773147;386.1832224844434;411.9732217405859;414.53364964415033;420.94948606166844;430.5006192816318;9928.106470417697;10303.793924121475;10328.948355258326;10408.47957602117;10607.151427885905;426.61178327721626;441.5804985264012;450.0212038815563;451.3094964704008;467.3013844302789;5624.493795558419;5703.458171473703;5857;5881.941180588139;5956.225690660186;511742;512886;522796;535128;540948;65781;67463.32536674669;68072.65963670249;68137;68226;496.35226030030435;501.47345287448036;503.8992201559703;507.15811752491425;507.2492710788054;9717.17404020666;9735.26985476078;9785.31502794826;9858.211343092393;9870.802583948425;29836;30479.847600761856;30569.54145687772;30824.69175308218;31114.844425777726;42609;42795;44206.33690494709;44419;44468.55531444644;5967.4629283362965;6041.758329666764;6056.212692349966;6083.935311320412;6093.786717464867;10930.234883558393;11031;11235.831462528233;11311.943440282746;11376.772464550497;9999.800003999733;10013.098821106136;10013.449260290754;10102.949485252526;10131.189504839447;9247.537623118951;9608.95195524018;9706.9029309706;9709.951450242703;9943.204543636348;9792.314537982273;9961.551730172016;9982.450965196984;9996.450195239331;10000.299979001691;5862.413758624274;5914.556408269483;5914.674692891932;5960.672163031075;5971.4327138921735;9327.253819694544;9335.953320233355;9384.718458446258;9711.465869376969;9713.46575938302 22:20:10 INFO - 2015-11-15 22:20:10,030 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1384.3839491426313;1402.5792262321302;1463.8609332113444;1675.9581010474737;1733.3586572968;6441.7423303067935;6498.577592456487;6920.619365934872;7028.367446929769;7114.893276600848;6996.440284777218;7193.604351760651;7225.169105552863;7237.059182306293;7271.636418179083;2037.673972164454;2051.7332746742977;2065.1945741160957;2071.3682326890294;2078.3453212238096;2043.7956204379518;2139.497218153733;2139.732533433321;2163.6754486826944;2164.967525487119;2062.2678948973125;2084.4476213803355;2085.9897991711823;2119.9364019079453;2125.9255926042592;2069.5860827834417;2084.697718830776;2090.278853795438;2094.98952505238;2097.1192099318323;2139.0267428320076;2139.5827813576357;2158.115172779169;2159.470929622237;2167.934961951144;7347;7389.150247721527;7410.851782964311;7412.4440666950195;7439.3676537494375;4277.615014648696;4327.502337231227;4346.239408103569;4355.150745604608;4380.693351465398;2371.845830021043;2419.951600967971;2766.460540194663;2784.0673374419594;2807.985960070207;907.1155623267261;917.7338571814166;928.2063835420686;943.3679434778714;954.8281309364312;10074.9496252519;10077.69766906994;10183.796324073552;10223.948880255626;10255.487225638763;3895.376739721631;3907.8046097695;3993.2412841560013;4015.678745700337;4017.1764788218347;8841.248493878093;8842.823143537093;8869;8884.600192991331;8889.688860889837;4318.222719910384;4319.373690814877;4352.347147927773;4355.695101342875;4362.280223763044;3862.6909847212155;3919.9020024499614;3951.3677811550015;3951.7431366961055;3959.821808018646;3375.1899544109237;3436.810975396377;3437.295354452331;3452.9309413811584;3485.2506711057245;1089.9237053406187;1090.2422816142864;1094.0481780850712;1095.5070218401752;1096.7313008313015;861.4529773593688;863.1066845814552;870.5386145342978;873.3188113271658;980.6175591519313;6863.382295593321;6866.450683945272;6945;6978.127734033246;6984.126984126984;1023.4217667018111;1047.8899715529913;1050.8896565860475;1053.8682664666917;1055.5513906589822;5441.646292991022;5463.043967305705;5476.2333273341765;5498.3127109111365;5505.201745746845;7956.880646790303;7981.321587664997;8549.316054715608;8552.95723521391;8788.912110878937;8688.304935605263;8715.956420217859;8719.52042637661;8813.074627164184;8865.512396818109;6830.419414349836;6918.515703900679;7009.088818453569;7033.753818616324;7053.89419158713;6992.16094068715;7041.718331266692;7047.894281585883;7050.929490705233;7066.823329416806;7791.181925897699;7994.440389172702;8003.359731221604;8075.959620201861;8080.393970452357;8040.2361775631225;8124.918750812416;8218.835623287381;8267.586620669063;8310.875336870073;6155.876882462415;6201.286852012076;6246.875062498633;6496.577722448026;6532.706028228836;6930.13373328334;7112.964435177791;7137.964310178623;7139;7165;6399.93600064012;6484.383983521558;6526.902096468461;6635.63504007265;6754.93245067543;6493.383128602775;6536.673166341759;6599.53803233769;6661.533692641468;6688.6990085445295;6796.388325050769;6815.079964204967;6836.93163068363;6874.140732408449;6894.034835122987;6182.598131121463;6191.473724733448;6303.558750887394;6355.428011478989;6383.0744542042075;6428.067930150009;6458.257300410325;6460.095586617783;6468.288488266381;6472.093906853139 22:20:10 INFO - 2015-11-15 22:20:10,031 DEBUG : BROWSER_OUTPUT: |4;prototype.html;290.3669999401305;291.43607120222373;294.76860664378455;296.7032967032967;299.69880270328326;5612.354579223391;5659.971700141498;5688.089905615102;5720.084786434171;5773.711314434283;5642.520385767204;5666.971665141668;5682.488576028157;5684.602077854552;5688.345840228375;4303.419038429819;4309.2889673204045;4310.741355518663;4315.115401342718;4316.805743741524;4122.50529936408;4199.9370009449885;4211.68412369072;4238.279492486285;4254.468191476066;4174.77038762868;4199.034222128912;4202.180574787918;4204.348326009474;4211.136716973028;4189.727667701605;4201.033762234688;4204.62158405745;4216.51510076342;4230.238557059728;3583.94624080639;3585.713142948558;3590.784552926833;3591.2637909228806;3604.7476676632646;5301.522862942354;5302;5435.565154787608;5471.781128754845;5482.205080263339;4759.714417134983;4845.248986407112;4853.611711063107;4859.41686997559;4860.05228980349;5937.287525496925;5967.283925928873;5980.97009514954;5989.8203053908455;5994.700264986734;3909.2963266612;3909.9218015639526;3910.530736311632;3912.3544615138467;3918.960810391888;6065.120557519135;6289.119523266746;6296.96851515744;6298.118263443076;6304.464120549759;4013.6789056875964;4015.678745700337;4031.3751368537337;4033.233685599727;4034.6973976951845;4069.2471892699946;4085.7344272622186;4090.9181816363507;4091.9386209206887;4097.1396006838895;4819.49395313487;4821.228603423436;4838.879028024327;4843.225083986616;4854.708717476963;5801.622894511843;5906.409359064145;5962.25471816023;5971.373005834412;5984.251968503937;1414;1424.4159894443228;1434.9928250358682;1440.6326386771307;1442.386985531145;927.8515437529962;928.7353104365224;938.4088024544493;954.346272803132;956.2923436656824;5122.103631864409;5145.897082058338;5157.742112894341;5162.896742065138;5181.248718935733;6162.969185154046;6183.907241391383;6186.350433204539;6188.44304012632;6188.690565471708;5135.460776618476;5146.716930568855;5149.073166830007;5152.175651895679;5167.22491626259;3263.885763998249;3331.0839519132433;3357.781744186669;3381.1040074380307;3383.035834787074;5856.443637854397;5901.262342207224;5917.082852157922;5919.289685237713;5925.881482370329;6283.612227353668;6416.743330266737;6473.643949582818;6491.221053473613;6509.869802603921;5890.204822348928;5902.734376953047;5905.320888097838;5918.260217472816;5934.703264836741;6260.874782504416;6269.467095296951;6270.561060725706;6274.498040156868;6276.874462510816;6016.849578760566;6130.601510901777;6136.662483563268;6140.600860944024;6158.3841615838055;5882.735276912635;5900.793472228452;5909.379515151019;5918.3489816121055;5919.6152250103605;3993.4209539617173;4039.41428492861;4043.1509383028715;4044.2315959967514;4055.4727885374714;6082.939170608237;6252.468540174136;6252.562320637694;6264.843378915563;6267.091271765659;5994.310654274815;6018.458338749533;6028.819135425944;6031.487323577369;6040.848978775566;5993.280806303272;6012.3085845126625;6014.308354539284;6017.969910150597;6032.788852390146;5720.771169153354;5851.912221316768;5883.499902508334;5887.205227294432;5888.411158884077;5970.97014514942;6014.609050411709;6023.728932198149;6041.728122234598;6058.606190597597;5852.678102704222;5900.498457631149;5902.321233058082;5904.346782900795;5914.408559144051 22:20:10 INFO - 2015-11-15 22:20:10,031 DEBUG : BROWSER_OUTPUT: |5;yui.html;696.6899729620319;740.4187712645568;783.9294463498284;799.1329407592762;810.6514198894477;11276.718082047953;11446.08431325494;11534.250273732201;11542;11542.69146170767;11150.386728729916;11721.472533735981;11730.120240981918;11766.882331176686;11789.941050294758;617.4134572156447;629.0250112325899;796.1202870827739;805.64551597297;815.5310696349593;801.3068695578341;803.4656953126164;815.4617952151581;816.6733306677318;816.9509829410225;841.032812265893;846.5090247656344;846.949183049019;851.059579165023;854.4744981836188;839.2279103225047;841.2302742990126;841.6843683618642;842.6081871929551;843.6119385082869;618.4681174190193;618.5577312221783;624.8750249950028;625.9780907668255;627.5701144715885;12175.51297948081;12212.816807747891;12216.144869859114;12226.14416990811;12307.56923507673;11179.161562882735;11200.103991680646;11331.603393881174;11493.31040137586;11654.359010254433;8993;9716.902830971741;9742.464164470952;9971.90028099717;9997;2968.391479746668;3020.5771192033135;3024.1985873743474;3034.605501284841;3037.0736925237793;34452.31095378078;34636.6536334636;34951.12622184466;34984.65015349839;35199.29601407983;6803;6918.100646915868;7003.124609423822;7024.473164512682;7090;9910.256730745223;10009.549570269355;10021.699349019542;10030.097291243823;10051.849222261671;5849.707514624337;5850.3272123705465;5861.062230043172;5888.676122813201;6167.105769663463;3687.1703866629796;3747.3442147624055;3747.756395834262;3807.6192380761704;3816.9618303816605;2617.8952841886494;2675.0904692404674;2679.3569543309854;2680.477306925131;2692.9730702693114;425.55529471702147;428.31255834385985;433.93707912353165;434.0624251616556;435.7494440696549;580.1616663920594;580.1819434597197;583.8511179649163;610.3377835049022;650.9283978762332;7986.840263194704;8584.785380365542;8652.134786521423;8776;9007.234385077341;447.2754138295916;465.19056841096926;487.92681097835606;489.9020195960822;515.6261710260106;3588.9102772430374;3697.59326474093;3796;3934.449177115206;3984.08763793375;45861.770691147;46323.5367646326;46466.07067858624;46680.533194667616;46822.29766553504;42398.15203695909;42421;42763.57236427596;44311.11377772426;44444.77777611091;40264.194716105514;40660.59339406627;40734.38898416526;41025.79487102546;41437.37843932343;7445;7450.590217537871;7549.886751698619;7697.114831794415;7730.072391313079;30653.846730766203;31027.53458698076;31243.84378078095;31428.528572071893;31895.68104318927;36314.455283170246;37342.8132859334;38825.417618736305;38911.221775564896;38940.41589376105;6095.969520152548;6096.420840020191;6172.845678858064;6484.675766211765;6538.019297105472;9879.901200988186;9901.851472228067;9909.65316213929;10033.749156271151;10298.734278458727;9152.588133533874;9289.535523223947;9495.560815331937;9829.901700982899;9854.950725246616;9353.906460935303;9459.95270023673;9540.475273860004;9559.952200238955;9958.701238962552;9604.75988100303;9757.12185903272;9773.41359518431;9798.118169364792;9876.160526355054;8410;8450.450720703135;8543.145685431407;8670.0896405879;8693.869591956252;7625.580593067434;7646.273604007611;7900.802479938047;8011;8038.356931445353 22:20:10 INFO - 2015-11-15 22:20:10,032 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:20:10 INFO - 2015-11-15 22:20:10,032 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:20:10 INFO - 2015-11-15 22:20:10,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,292 22:20:10 INFO - 2015-11-15 22:20:10,032 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:20:10 INFO - 2015-11-15 22:20:10,032 DEBUG : BROWSER_OUTPUT: __startTimestamp1447654810020__endTimestamp 22:20:10 INFO - 2015-11-15 22:20:10,032 DEBUG : BROWSER_OUTPUT: 22:20:10 INFO - 2015-11-15 22:20:10,032 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:20:10 INFO - 2015-11-15 22:20:10,032 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:20:10 INFO - 2015-11-15 22:20:10,033 DEBUG : BROWSER_OUTPUT: 22:20:10 INFO - 2015-11-15 22:20:10,033 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4864.57 Median:4980.13 stddev:512.91 (10.3%) stddev-sans-first:485.71 22:20:10 INFO - 2015-11-15 22:20:10,033 DEBUG : BROWSER_OUTPUT: Values: 2705.6 2750.4 2780.1 2781.9 2800.6 4681.4 4912.1 4914.2 4980.0 4980.1 4879.2 4899.6 4935.5 4939.8 5042.8 4514.0 4542.6 4623.7 4630.3 4632.4 4398.4 4633.6 4663.5 4665.5 4680.3 4356.4 4511.5 4518.7 4544.3 4555.4 4522.9 4563.0 4565.0 4579.0 4625.1 4452.6 4471.8 4555.2 4560.1 4569.7 4769.8 4815.6 4852.8 4870.8 4885.3 5309.3 5316.7 5325.7 5333.7 5344.3 5079.1 5197.1 5212.2 5312.0 5339.8 4893.5 4924.5 4929.1 4933.1 4958.6 5443.3 5476.1 5483.3 5487.6 5509.8 4980.8 5083.8 5084.0 5088.0 5156.8 5295.8 5298.4 5337.8 5347.0 5363.9 5227.5 5228.3 5235.5 5235.6 5290.0 5059.0 5060.3 5153.0 5216.8 5219.5 4436.8 4449.6 4463.7 4473.5 4486.6 3893.7 3901.1 3917.7 3951.1 3954.7 4335.8 4444.1 4460.0 4503.2 4534.6 5244.4 5312.6 5327.8 5334.1 5378.3 4399.5 4511.0 4551.5 4557.4 4592.4 4605.3 4686.1 4687.6 4706.7 4725.9 4973.0 5028.3 5034.4 5038.5 5072.7 5153.5 5232.9 5309.4 5330.4 5364.0 4830.8 4900.4 4929.1 4937.9 4945.1 5201.5 5308.6 5309.9 5312.8 5350.3 5023.2 5031.4 5130.9 5366.6 5390.2 5075.7 5155.4 5177.3 5189.4 5208.7 5173.7 5174.9 5176.3 5176.6 5180.4 4702.8 4794.1 4917.3 5055.8 5067.6 5142.2 5143.5 5149.2 5182.9 5184.4 5064.8 5073.5 5078.7 5089.2 5104.3 22:20:10 INFO - 2015-11-15 22:20:10,033 DEBUG : BROWSER_OUTPUT: 22:20:10 INFO - 2015-11-15 22:20:10,033 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40675.26 Median:33265.33 stddev:65667.44 (197.4%) stddev-sans-first:65782.45 22:20:10 INFO - 2015-11-15 22:20:10,034 DEBUG : BROWSER_OUTPUT: Values: 522.3 560.5 568.2 575.2 575.7 27594.6 28214.3 36309.8 36703.0 36966.8 38849.6 39223.4 39354.4 39467.6 39468.0 7917.0 8081.9 8082.5 8089.6 8096.6 7913.8 7984.7 7986.1 7993.3 7994.0 8016.4 8072.7 8073.8 8084.9 8091.0 7939.1 8062.5 8069.6 8074.8 8096.3 7925.3 8048.0 8052.2 8056.0 8063.2 37625.4 38006.8 38023.6 38042.6 38363.6 2921.1 3160.2 3195.7 3284.0 3297.6 28228.0 28307.4 28613.3 28676.9 28927.1 3088.2 3104.0 3105.6 3179.6 3190.9 214795.0 215740.0 216069.0 216654.0 216692.0 47358.8 48128.5 54811.0 55155.0 62031.7 57180.4 57198.7 57356.4 57433.0 57588.1 13305.9 13442.4 13494.4 13516.8 13520.6 9954.8 9959.3 9988.6 10098.6 10113.7 19132.6 19512.5 19527.4 19556.3 19683.5 7482.3 7629.2 7675.7 7709.6 7751.9 804.6 823.8 840.9 844.5 884.1 22897.9 22937.9 22962.7 22976.2 23152.9 965.9 977.6 980.5 1031.4 1052.2 12707.2 12823.2 12886.5 12925.7 12957.8 280908.0 281657.0 282263.0 284451.0 284748.0 45810.5 46014.0 46622.5 46681.8 46719.3 1179.0 1183.2 1196.9 1196.9 1197.6 24729.1 25345.5 25529.4 25541.4 25686.2 39701.0 39717.6 39762.2 39876.8 40057.4 249580.0 251540.0 251660.0 252195.0 253099.0 28261.0 29108.3 29470.0 29585.3 29606.4 31836.4 32086.2 32203.4 32395.7 33011.8 32375.7 32417.7 33155.7 33505.8 33821.0 31746.0 33242.8 35083.6 36158.3 36418.8 33287.8 33441.3 33723.7 33732.0 33754.5 28481.6 29164.7 30116.0 30519.4 30659.8 23140.3 23450.3 23519.9 23592.2 23782.4 22:20:10 INFO - 2015-11-15 22:20:10,035 DEBUG : BROWSER_OUTPUT: 22:20:10 INFO - 2015-11-15 22:20:10,035 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25201.03 Median:4411.45 stddev:85970.90 (1948.8%) stddev-sans-first:86191.79 22:20:10 INFO - 2015-11-15 22:20:10,036 DEBUG : BROWSER_OUTPUT: Values: 328.4 328.6 331.5 340.0 340.4 10785.2 10854.5 11111.5 15356.4 15857.8 9841.0 10085.7 10118.9 10257.1 10268.8 4042.6 4148.1 4163.4 4166.9 4173.8 3434.5 3671.5 4129.1 4165.6 4180.3 4165.1 4176.0 4245.2 4387.8 4412.5 4360.7 4364.7 4393.3 4394.5 4410.4 3779.5 4036.9 4040.4 4041.0 4042.1 12038.9 12039.8 12232.6 12274.3 12280.8 1655.6 1670.9 1675.6 1700.4 1708.1 9189.0 9197.5 9254.2 9448.7 9534.1 1609.8 1622.7 1633.6 1644.1 1647.3 54405.5 55029.4 55119.2 55513.2 55736.7 6051.1 6207.6 6250.7 6285.1 6356.2 7298.5 7298.7 7305.8 7314.6 7327.0 4871.7 4889.4 4919.0 4935.5 4983.0 4914.6 4926.6 4936.0 4952.0 4952.7 2781.4 2826.4 2827.2 2832.5 2853.7 1018.6 1025.5 1034.5 1035.1 1059.4 386.2 412.0 414.5 420.9 430.5 9928.1 10303.8 10328.9 10408.5 10607.2 426.6 441.6 450.0 451.3 467.3 5624.5 5703.5 5857.0 5881.9 5956.2 511742.0 512886.0 522796.0 535128.0 540948.0 65781.0 67463.3 68072.7 68137.0 68226.0 496.4 501.5 503.9 507.2 507.2 9717.2 9735.3 9785.3 9858.2 9870.8 29836.0 30479.8 30569.5 30824.7 31114.8 42609.0 42795.0 44206.3 44419.0 44468.6 5967.5 6041.8 6056.2 6083.9 6093.8 10930.2 11031.0 11235.8 11311.9 11376.8 9999.8 10013.1 10013.4 10102.9 10131.2 9247.5 9609.0 9706.9 9710.0 9943.2 9792.3 9961.6 9982.5 9996.5 10000.3 5862.4 5914.6 5914.7 5960.7 5971.4 9327.3 9336.0 9384.7 9711.5 9713.5 22:20:10 INFO - 2015-11-15 22:20:10,036 DEBUG : BROWSER_OUTPUT: 22:20:10 INFO - 2015-11-15 22:20:10,037 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5137.76 Median:6450.00 stddev:2691.67 (41.7%) stddev-sans-first:2684.43 22:20:10 INFO - 2015-11-15 22:20:10,037 DEBUG : BROWSER_OUTPUT: Values: 1384.4 1402.6 1463.9 1676.0 1733.4 6441.7 6498.6 6920.6 7028.4 7114.9 6996.4 7193.6 7225.2 7237.1 7271.6 2037.7 2051.7 2065.2 2071.4 2078.3 2043.8 2139.5 2139.7 2163.7 2165.0 2062.3 2084.4 2086.0 2119.9 2125.9 2069.6 2084.7 2090.3 2095.0 2097.1 2139.0 2139.6 2158.1 2159.5 2167.9 7347.0 7389.2 7410.9 7412.4 7439.4 4277.6 4327.5 4346.2 4355.2 4380.7 2371.8 2420.0 2766.5 2784.1 2808.0 907.1 917.7 928.2 943.4 954.8 10074.9 10077.7 10183.8 10223.9 10255.5 3895.4 3907.8 3993.2 4015.7 4017.2 8841.2 8842.8 8869.0 8884.6 8889.7 4318.2 4319.4 4352.3 4355.7 4362.3 3862.7 3919.9 3951.4 3951.7 3959.8 3375.2 3436.8 3437.3 3452.9 3485.3 1089.9 1090.2 1094.0 1095.5 1096.7 861.5 863.1 870.5 873.3 980.6 6863.4 6866.5 6945.0 6978.1 6984.1 1023.4 1047.9 1050.9 1053.9 1055.6 5441.6 5463.0 5476.2 5498.3 5505.2 7956.9 7981.3 8549.3 8553.0 8788.9 8688.3 8716.0 8719.5 8813.1 8865.5 6830.4 6918.5 7009.1 7033.8 7053.9 6992.2 7041.7 7047.9 7050.9 7066.8 7791.2 7994.4 8003.4 8076.0 8080.4 8040.2 8124.9 8218.8 8267.6 8310.9 6155.9 6201.3 6246.9 6496.6 6532.7 6930.1 7113.0 7138.0 7139.0 7165.0 6399.9 6484.4 6526.9 6635.6 6754.9 6493.4 6536.7 6599.5 6661.5 6688.7 6796.4 6815.1 6836.9 6874.1 6894.0 6182.6 6191.5 6303.6 6355.4 6383.1 6428.1 6458.3 6460.1 6468.3 6472.1 22:20:10 INFO - 2015-11-15 22:20:10,037 DEBUG : BROWSER_OUTPUT: 22:20:10 INFO - 2015-11-15 22:20:10,037 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4895.03 Median:5686.35 stddev:1508.68 (26.5%) stddev-sans-first:1472.79 22:20:10 INFO - 2015-11-15 22:20:10,039 DEBUG : BROWSER_OUTPUT: Values: 290.4 291.4 294.8 296.7 299.7 5612.4 5660.0 5688.1 5720.1 5773.7 5642.5 5667.0 5682.5 5684.6 5688.3 4303.4 4309.3 4310.7 4315.1 4316.8 4122.5 4199.9 4211.7 4238.3 4254.5 4174.8 4199.0 4202.2 4204.3 4211.1 4189.7 4201.0 4204.6 4216.5 4230.2 3583.9 3585.7 3590.8 3591.3 3604.7 5301.5 5302.0 5435.6 5471.8 5482.2 4759.7 4845.2 4853.6 4859.4 4860.1 5937.3 5967.3 5981.0 5989.8 5994.7 3909.3 3909.9 3910.5 3912.4 3919.0 6065.1 6289.1 6297.0 6298.1 6304.5 4013.7 4015.7 4031.4 4033.2 4034.7 4069.2 4085.7 4090.9 4091.9 4097.1 4819.5 4821.2 4838.9 4843.2 4854.7 5801.6 5906.4 5962.3 5971.4 5984.3 1414.0 1424.4 1435.0 1440.6 1442.4 927.9 928.7 938.4 954.3 956.3 5122.1 5145.9 5157.7 5162.9 5181.2 6163.0 6183.9 6186.4 6188.4 6188.7 5135.5 5146.7 5149.1 5152.2 5167.2 3263.9 3331.1 3357.8 3381.1 3383.0 5856.4 5901.3 5917.1 5919.3 5925.9 6283.6 6416.7 6473.6 6491.2 6509.9 5890.2 5902.7 5905.3 5918.3 5934.7 6260.9 6269.5 6270.6 6274.5 6276.9 6016.8 6130.6 6136.7 6140.6 6158.4 5882.7 5900.8 5909.4 5918.3 5919.6 3993.4 4039.4 4043.2 4044.2 4055.5 6082.9 6252.5 6252.6 6264.8 6267.1 5994.3 6018.5 6028.8 6031.5 6040.8 5993.3 6012.3 6014.3 6018.0 6032.8 5720.8 5851.9 5883.5 5887.2 5888.4 5971.0 6014.6 6023.7 6041.7 6058.6 5852.7 5900.5 5902.3 5904.3 5914.4 22:20:10 INFO - 2015-11-15 22:20:10,039 DEBUG : BROWSER_OUTPUT: 22:20:10 INFO - 2015-11-15 22:20:10,039 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11418.48 Median:5855.69 stddev:13159.27 (224.7%) stddev-sans-first:13171.55 22:20:10 INFO - 2015-11-15 22:20:10,039 DEBUG : BROWSER_OUTPUT: Values: 696.7 740.4 783.9 799.1 810.7 11276.7 11446.1 11534.3 11542.0 11542.7 11150.4 11721.5 11730.1 11766.9 11789.9 617.4 629.0 796.1 805.6 815.5 801.3 803.5 815.5 816.7 817.0 841.0 846.5 846.9 851.1 854.5 839.2 841.2 841.7 842.6 843.6 618.5 618.6 624.9 626.0 627.6 12175.5 12212.8 12216.1 12226.1 12307.6 11179.2 11200.1 11331.6 11493.3 11654.4 8993.0 9716.9 9742.5 9971.9 9997.0 2968.4 3020.6 3024.2 3034.6 3037.1 34452.3 34636.7 34951.1 34984.7 35199.3 6803.0 6918.1 7003.1 7024.5 7090.0 9910.3 10009.5 10021.7 10030.1 10051.8 5849.7 5850.3 5861.1 5888.7 6167.1 3687.2 3747.3 3747.8 3807.6 3817.0 2617.9 2675.1 2679.4 2680.5 2693.0 425.6 428.3 433.9 434.1 435.7 580.2 580.2 583.9 610.3 650.9 7986.8 8584.8 8652.1 8776.0 9007.2 447.3 465.2 487.9 489.9 515.6 3588.9 3697.6 3796.0 3934.4 3984.1 45861.8 46323.5 46466.1 46680.5 46822.3 42398.2 42421.0 42763.6 44311.1 44444.8 40264.2 40660.6 40734.4 41025.8 41437.4 7445.0 7450.6 7549.9 7697.1 7730.1 30653.8 31027.5 31243.8 31428.5 31895.7 36314.5 37342.8 38825.4 38911.2 38940.4 6096.0 6096.4 6172.8 6484.7 6538.0 9879.9 9901.9 9909.7 10033.7 10298.7 9152.6 9289.5 9495.6 9829.9 9855.0 9353.9 9460.0 9540.5 9560.0 9958.7 9604.8 9757.1 9773.4 9798.1 9876.2 8410.0 8450.5 8543.1 8670.1 8693.9 7625.6 7646.3 7900.8 8011.0 8038.4 22:20:10 INFO - 2015-11-15 22:20:10,039 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:20:10 INFO - 2015-11-15 22:20:10,039 DEBUG : BROWSER_OUTPUT: 22:20:10 INFO - 2015-11-15 22:20:10,773 INFO : Browser exited with error code: 0 22:20:10 INFO - 2015-11-15 22:20:10,792 INFO : Completed test dromaeo_css (00:18:35) 22:20:10 INFO - 2015-11-15 22:20:10,792 INFO : Starting test kraken 22:20:10 INFO - 2015-11-15 22:20:10,792 DEBUG : operating with platform_type : linux_ 22:20:10 INFO - 2015-11-15 22:20:10,792 INFO : Initialising browser for kraken test... 22:20:10 INFO - 2015-11-15 22:20:10,798 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpll9CFk/profile http://localhost:40246/getInfo.html 22:20:15 INFO - 2015-11-15 22:20:15,510 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:20:15 INFO - 2015-11-15 22:20:15,510 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:20:15 INFO - 2015-11-15 22:20:15,510 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:20:15 INFO - 2015-11-15 22:20:15,511 DEBUG : BROWSER_OUTPUT: __metrics 22:20:16 INFO - 2015-11-15 22:20:16,593 INFO : Browser initialized. 22:20:16 INFO - 2015-11-15 22:20:16,594 INFO : Running cycle 1/1 for kraken test... 22:20:16 INFO - 2015-11-15 22:20:16,594 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpll9CFk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:20:28 INFO - 2015-11-15 22:20:28,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 141119488 22:20:28 INFO - 2015-11-15 22:20:28,475 DEBUG : BROWSER_OUTPUT: 22:20:31 INFO - 2015-11-15 22:20:31,091 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40246/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:31 INFO - 2015-11-15 22:20:31,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 142110720 22:20:31 INFO - 2015-11-15 22:20:31,713 DEBUG : BROWSER_OUTPUT: 22:20:34 INFO - 2015-11-15 22:20:34,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40246/tests/kraken/driver.html?testName=audio-dft) 22:20:35 INFO - 2015-11-15 22:20:35,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 141869056 22:20:35 INFO - 2015-11-15 22:20:35,084 DEBUG : BROWSER_OUTPUT: 22:20:38 INFO - 2015-11-15 22:20:38,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40246/tests/kraken/driver.html?testName=audio-fft) 22:20:38 INFO - 2015-11-15 22:20:38,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 137318400 22:20:38 INFO - 2015-11-15 22:20:38,592 DEBUG : BROWSER_OUTPUT: 22:20:40 INFO - 2015-11-15 22:20:40,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40246/tests/kraken/driver.html?testName=audio-oscillator) 22:20:41 INFO - 2015-11-15 22:20:41,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 137285632 22:20:41 INFO - 2015-11-15 22:20:41,266 DEBUG : BROWSER_OUTPUT: 22:20:43 INFO - 2015-11-15 22:20:43,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:44 INFO - 2015-11-15 22:20:44,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 137117696 22:20:44 INFO - 2015-11-15 22:20:44,086 DEBUG : BROWSER_OUTPUT: 22:20:47 INFO - 2015-11-15 22:20:47,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40246/tests/kraken/driver.html?testName=imaging-darkroom) 22:20:47 INFO - 2015-11-15 22:20:47,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 136425472 22:20:47 INFO - 2015-11-15 22:20:47,755 DEBUG : BROWSER_OUTPUT: 22:20:51 INFO - 2015-11-15 22:20:51,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40246/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:51 INFO - 2015-11-15 22:20:51,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 135823360 22:20:51 INFO - 2015-11-15 22:20:51,819 DEBUG : BROWSER_OUTPUT: 22:20:54 INFO - 2015-11-15 22:20:54,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40246/tests/kraken/driver.html?testName=json-parse-financial) 22:20:55 INFO - 2015-11-15 22:20:55,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 136781824 22:20:55 INFO - 2015-11-15 22:20:55,384 DEBUG : BROWSER_OUTPUT: 22:20:57 INFO - 2015-11-15 22:20:57,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:57 INFO - 2015-11-15 22:20:57,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 139010048 22:20:57 INFO - 2015-11-15 22:20:57,721 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-15 22:20:59,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40246/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:00 INFO - 2015-11-15 22:21:00,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 138874880 22:21:00 INFO - 2015-11-15 22:21:00,218 DEBUG : BROWSER_OUTPUT: 22:21:02 INFO - 2015-11-15 22:21:02,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:02 INFO - 2015-11-15 22:21:02,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 138465280 22:21:02 INFO - 2015-11-15 22:21:02,973 DEBUG : BROWSER_OUTPUT: 22:21:05 INFO - 2015-11-15 22:21:05,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:06 INFO - 2015-11-15 22:21:06,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 139608064 22:21:06 INFO - 2015-11-15 22:21:06,151 DEBUG : BROWSER_OUTPUT: 22:21:08 INFO - 2015-11-15 22:21:08,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:09 INFO - 2015-11-15 22:21:09,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 139403264 22:21:09 INFO - 2015-11-15 22:21:09,421 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40246/tests/kraken/driver.html?testName=ai-astar) 22:21:11 INFO - 2015-11-15 22:21:11,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 138805248 22:21:11 INFO - 2015-11-15 22:21:11,448 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,452 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:21:11 INFO - 2015-11-15 22:21:11,452 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:21:11 INFO - 2015-11-15 22:21:11,452 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:21:11 INFO - 2015-11-15 22:21:11,452 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:21:11 INFO - 2015-11-15 22:21:11,452 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;109;115;113;114;124;112;112;112;111 22:21:11 INFO - 2015-11-15 22:21:11,453 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;131;168;168;130;163;152;132;182;137 22:21:11 INFO - 2015-11-15 22:21:11,453 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;162;161;161;167;170;164;165;162 22:21:11 INFO - 2015-11-15 22:21:11,453 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;74;73;72;73;143;73;74;73 22:21:11 INFO - 2015-11-15 22:21:11,453 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;136;91;93;93;125;92;93;134 22:21:11 INFO - 2015-11-15 22:21:11,453 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;110;110;110;109;110;110 22:21:11 INFO - 2015-11-15 22:21:11,453 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;150;150;148;151;149;149;148;149;148 22:21:11 INFO - 2015-11-15 22:21:11,453 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;97;97;96;96;100;96;96;96;95 22:21:11 INFO - 2015-11-15 22:21:11,454 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;73;72;73;72;72;72;72;74 22:21:11 INFO - 2015-11-15 22:21:11,454 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;69;69;70;69;69;68 22:21:11 INFO - 2015-11-15 22:21:11,454 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;83;94;85;91;84;84;96;81 22:21:11 INFO - 2015-11-15 22:21:11,454 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;122;127;124;129;125;121;123;131;130 22:21:11 INFO - 2015-11-15 22:21:11,454 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;157;154;154;159;154;150;150;164;152;150 22:21:11 INFO - 2015-11-15 22:21:11,454 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;80;73;71;74;71;70;74;70;72 22:21:11 INFO - 2015-11-15 22:21:11,454 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:21:11 INFO - 2015-11-15 22:21:11,454 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:21:11 INFO - 2015-11-15 22:21:11,455 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,765 22:21:11 INFO - 2015-11-15 22:21:11,455 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:21:11 INFO - 2015-11-15 22:21:11,455 DEBUG : BROWSER_OUTPUT: __startTimestamp1447654871451__endTimestamp 22:21:11 INFO - 2015-11-15 22:21:11,455 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,458 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:4.03 (3.6%) stddev-sans-first:4.28 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: Values: 113.0 109.0 115.0 113.0 114.0 124.0 112.0 112.0 112.0 111.0 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.40 Median:162.00 stddev:18.75 (11.6%) stddev-sans-first:19.62 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: Values: 161.0 131.0 168.0 168.0 130.0 163.0 152.0 132.0 182.0 137.0 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.85 (1.7%) stddev-sans-first:3.00 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 162.0 161.0 161.0 167.0 170.0 164.0 165.0 162.0 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,459 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:73.00 stddev:22.07 (30.2%) stddev-sans-first:23.26 22:21:11 INFO - 2015-11-15 22:21:11,460 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 74.0 73.0 72.0 73.0 143.0 73.0 74.0 73.0 22:21:11 INFO - 2015-11-15 22:21:11,460 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,460 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.00 Median:92.00 stddev:19.30 (21.0%) stddev-sans-first:19.89 22:21:11 INFO - 2015-11-15 22:21:11,460 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 136.0 91.0 93.0 93.0 125.0 92.0 93.0 134.0 22:21:11 INFO - 2015-11-15 22:21:11,460 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,460 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 22:21:11 INFO - 2015-11-15 22:21:11,460 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 22:21:11 INFO - 2015-11-15 22:21:11,460 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,461 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 22:21:11 INFO - 2015-11-15 22:21:11,461 DEBUG : BROWSER_OUTPUT: Values: 148.0 150.0 150.0 148.0 151.0 149.0 149.0 148.0 149.0 148.0 22:21:11 INFO - 2015-11-15 22:21:11,461 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,461 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.43 (1.5%) stddev-sans-first:1.42 22:21:11 INFO - 2015-11-15 22:21:11,461 DEBUG : BROWSER_OUTPUT: Values: 95.0 97.0 97.0 96.0 96.0 100.0 96.0 96.0 96.0 95.0 22:21:11 INFO - 2015-11-15 22:21:11,461 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,461 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.40 Median:72.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 72.0 73.0 72.0 72.0 72.0 72.0 74.0 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 69.0 69.0 70.0 69.0 69.0 68.0 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.00 stddev:5.08 (6.0%) stddev-sans-first:5.29 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 83.0 94.0 85.0 91.0 84.0 84.0 96.0 81.0 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.50 Median:126.00 stddev:3.54 (2.8%) stddev-sans-first:3.63 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: Values: 123.0 122.0 127.0 124.0 129.0 125.0 121.0 123.0 131.0 130.0 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:154.00 stddev:4.53 (2.9%) stddev-sans-first:4.70 22:21:11 INFO - 2015-11-15 22:21:11,462 DEBUG : BROWSER_OUTPUT: Values: 157.0 154.0 154.0 159.0 154.0 150.0 150.0 164.0 152.0 150.0 22:21:11 INFO - 2015-11-15 22:21:11,463 DEBUG : BROWSER_OUTPUT: 22:21:11 INFO - 2015-11-15 22:21:11,463 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.50 stddev:3.06 (4.2%) stddev-sans-first:3.11 22:21:11 INFO - 2015-11-15 22:21:11,463 DEBUG : BROWSER_OUTPUT: Values: 70.0 80.0 73.0 71.0 74.0 71.0 70.0 74.0 70.0 72.0 22:21:11 INFO - 2015-11-15 22:21:11,464 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:21:11 INFO - 2015-11-15 22:21:11,464 DEBUG : BROWSER_OUTPUT: 22:21:12 INFO - 2015-11-15 22:21:12,369 INFO : Browser exited with error code: 0 22:21:12 INFO - 2015-11-15 22:21:12,420 INFO : Completed test kraken (00:01:01) 22:21:12 INFO - 2015-11-15 22:21:12,421 INFO : Starting test v8_7 22:21:12 INFO - 2015-11-15 22:21:12,421 DEBUG : operating with platform_type : linux_ 22:21:12 INFO - 2015-11-15 22:21:12,421 INFO : Initialising browser for v8_7 test... 22:21:12 INFO - 2015-11-15 22:21:12,427 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW2lWZv/profile http://localhost:40246/getInfo.html 22:21:17 INFO - 2015-11-15 22:21:17,274 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:21:17 INFO - 2015-11-15 22:21:17,274 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:21:17 INFO - 2015-11-15 22:21:17,274 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:21:17 INFO - 2015-11-15 22:21:17,274 DEBUG : BROWSER_OUTPUT: __metrics 22:21:18 INFO - 2015-11-15 22:21:18,385 INFO : Browser initialized. 22:21:18 INFO - 2015-11-15 22:21:18,386 INFO : Running cycle 1/1 for v8_7 test... 22:21:18 INFO - 2015-11-15 22:21:18,386 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW2lWZv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:21:30 INFO - 2015-11-15 22:21:30,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 140894208 22:21:30 INFO - 2015-11-15 22:21:30,397 DEBUG : BROWSER_OUTPUT: 22:21:51 INFO - 2015-11-15 22:21:51,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40246/tests/v8_7/run.html (next: http://localhost:40246/tests/v8_7/run.html) 22:21:52 INFO - 2015-11-15 22:21:52,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 138719232 22:21:52 INFO - 2015-11-15 22:21:52,142 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,142 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:21:52 INFO - 2015-11-15 22:21:52,143 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:21:52 INFO - 2015-11-15 22:21:52,143 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:21:52 INFO - 2015-11-15 22:21:52,143 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:21:52 INFO - 2015-11-15 22:21:52,143 DEBUG : BROWSER_OUTPUT: |0;Richards;164.50074025333114 22:21:52 INFO - 2015-11-15 22:21:52,143 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.9696048632219 22:21:52 INFO - 2015-11-15 22:21:52,143 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 22:21:52 INFO - 2015-11-15 22:21:52,143 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 22:21:52 INFO - 2015-11-15 22:21:52,143 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1064.9627263045793 22:21:52 INFO - 2015-11-15 22:21:52,144 DEBUG : BROWSER_OUTPUT: |5;Earley;737.1134020618557 22:21:52 INFO - 2015-11-15 22:21:52,144 DEBUG : BROWSER_OUTPUT: |6;Boyer;12204.819277108434 22:21:52 INFO - 2015-11-15 22:21:52,144 DEBUG : BROWSER_OUTPUT: |7;RegExp;25575 22:21:52 INFO - 2015-11-15 22:21:52,144 DEBUG : BROWSER_OUTPUT: |8;Splay;616.1429451632779 22:21:52 INFO - 2015-11-15 22:21:52,144 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 22:21:52 INFO - 2015-11-15 22:21:52,144 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:21:52 INFO - 2015-11-15 22:21:52,144 DEBUG : BROWSER_OUTPUT: __startTimestamp1447654912135__endTimestamp 22:21:52 INFO - 2015-11-15 22:21:52,145 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,145 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:21:52 INFO - 2015-11-15 22:21:52,145 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:21:52 INFO - 2015-11-15 22:21:52,145 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,145 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.50 Median:164.50 stddev:0.00 (0.0%) 22:21:52 INFO - 2015-11-15 22:21:52,145 DEBUG : BROWSER_OUTPUT: Values: 164.5 22:21:52 INFO - 2015-11-15 22:21:52,145 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,146 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.97 Median:189.97 stddev:0.00 (0.0%) 22:21:52 INFO - 2015-11-15 22:21:52,146 DEBUG : BROWSER_OUTPUT: Values: 190.0 22:21:52 INFO - 2015-11-15 22:21:52,146 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,146 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 22:21:52 INFO - 2015-11-15 22:21:52,146 DEBUG : BROWSER_OUTPUT: Values: 279.7 22:21:52 INFO - 2015-11-15 22:21:52,146 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,146 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 22:21:52 INFO - 2015-11-15 22:21:52,147 DEBUG : BROWSER_OUTPUT: Values: 5045.2 22:21:52 INFO - 2015-11-15 22:21:52,147 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,147 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1064.96 Median:1064.96 stddev:0.00 (0.0%) 22:21:52 INFO - 2015-11-15 22:21:52,147 DEBUG : BROWSER_OUTPUT: Values: 1065.0 22:21:52 INFO - 2015-11-15 22:21:52,147 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,147 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:737.11 Median:737.11 stddev:0.00 (0.0%) 22:21:52 INFO - 2015-11-15 22:21:52,147 DEBUG : BROWSER_OUTPUT: Values: 737.1 22:21:52 INFO - 2015-11-15 22:21:52,147 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,148 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12204.82 Median:12204.82 stddev:0.00 (0.0%) 22:21:52 INFO - 2015-11-15 22:21:52,148 DEBUG : BROWSER_OUTPUT: Values: 12204.8 22:21:52 INFO - 2015-11-15 22:21:52,148 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,148 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25575.00 Median:25575.00 stddev:0.00 (0.0%) 22:21:52 INFO - 2015-11-15 22:21:52,148 DEBUG : BROWSER_OUTPUT: Values: 25575.0 22:21:52 INFO - 2015-11-15 22:21:52,148 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,148 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.14 Median:616.14 stddev:0.00 (0.0%) 22:21:52 INFO - 2015-11-15 22:21:52,149 DEBUG : BROWSER_OUTPUT: Values: 616.1 22:21:52 INFO - 2015-11-15 22:21:52,149 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-15 22:21:52,149 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 22:21:52 INFO - 2015-11-15 22:21:52,149 DEBUG : BROWSER_OUTPUT: Values: 4826.9 22:21:52 INFO - 2015-11-15 22:21:52,149 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:21:52 INFO - 2015-11-15 22:21:52,149 DEBUG : BROWSER_OUTPUT: 22:21:53 INFO - 2015-11-15 22:21:53,125 INFO : Browser exited with error code: 0 22:21:53 INFO - 2015-11-15 22:21:53,137 INFO : Completed test v8_7 (00:00:40) 22:21:53 INFO - 2015-11-15 22:21:53,637 INFO : Completed test suite (00:20:18) 22:21:53 INFO - 2015-11-15 22:21:53,637 DEBUG : Working with test: dromaeo_css 22:21:53 INFO - 2015-11-15 22:21:53,637 DEBUG : Generating results file: dromaeo_css 22:21:53 INFO - 2015-11-15 22:21:53,639 DEBUG : Working with test: kraken 22:21:53 INFO - 2015-11-15 22:21:53,639 DEBUG : Generating results file: kraken 22:21:53 INFO - 2015-11-15 22:21:53,639 INFO : javascript benchmark 22:21:53 INFO - 2015-11-15 22:21:53,639 DEBUG : Working with test: v8_7 22:21:53 INFO - 2015-11-15 22:21:53,640 DEBUG : Generating results file: v8_7 22:21:53 INFO - 2015-11-15 22:21:53,640 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:53 INFO - 2015-11-15 22:21:53,685 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,43]] 22:21:53 INFO - 2015-11-15 22:21:53,685 DEBUG : process_Request line: dromaeo_css 6047.60 graph.html#tests=[[72,131,43]] 22:21:53 INFO - 2015-11-15 22:21:53,685 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:53 INFO - 2015-11-15 22:21:53,789 DEBUG : process_Request line: kraken 1549.60 graph.html#tests=[[232,131,43]] 22:21:53 INFO - 2015-11-15 22:21:53,789 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:53 INFO - 2015-11-15 22:21:53,900 DEBUG : process_Request line: v8_7 21318.29 graph.html#tests=[[230,131,43]] 22:21:53 INFO - 2015-11-15 22:21:53,902 INFO : javascript benchmark 22:21:53 INFO - 2015-11-15 22:21:53,906 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [328.4023077998043, 328.56137057028866, 331.4895061605128, 339.9800598205384, 340.37201363484365, 10785.191110666692, 10854.511546980375, 11111.499982500787, 15356.385744570218, 15857.76213356799, 9841.0, 10085.747856303597, 10118.949405252983, 10257.07686308232, 10268.794624107513, 4042.555318914917, 4148.149629325981, 4163.396307535406, 4166.8749937501925, 4173.833046678129, 3434.450487921933, 3671.4676371926053, 4129.132882094764, 4165.604267594574, 4180.289350810354, 4165.062860856298, 4175.979120104395, 4245.193413251488, 4387.780610969438, 4412.514623391425, 4360.672949528766, 4364.672649551297, 4393.29707246839, 4394.494633117184, 4410.3825464435, 3779.546454425459, 4036.919261614751, 4040.4343391925154, 4041.0, 4042.090529630839, 12038.879611203864, 12039.81940270888, 12232.571859984946, 12274.263544187288, 12280.815787763191, 1655.5778276539406, 1670.905908660453, 1675.585534011992, 1700.3538655311027, 1708.1288542843115, 9189.0, 9197.494137822418, 9254.167124958785, 9448.669296574655, 9534.141927226514, 1609.7504886742574, 1622.7160246956853, 1633.5997680568219, 1644.1203955883545, 1647.3462468526461, 54405.45594544044, 55029.44970550323, 55119.173212401845, 55513.167302490896, 55736.72131639316, 6051.092336149525, 6207.6275423474735, 6250.749970001149, 6285.120083188357, 6356.237251529754, 7298.452616053817, 7298.671559779823, 7305.780826575211, 7314.561126332437, 7327.0, 4871.683340582922, 4889.364382630307, 4918.95081049185, 4935.481774413706, 4982.950170498249, 4914.5822605078965, 4926.556609905054, 4936.012797440526, 4952.009598080398, 4952.653314267966, 2781.36028713393, 2826.3781967967016, 2827.2083816531403, 2832.532632115719, 2853.657561092682, 1018.5518371916334, 1025.5026312238558, 1034.4930983818026, 1035.0942924940678, 1059.3855563773147, 386.1832224844434, 411.9732217405859, 414.53364964415033, 420.94948606166844, 430.5006192816318, 9928.106470417697, 10303.793924121475, 10328.948355258326, 10408.47957602117, 10607.151427885905, 426.61178327721626, 441.5804985264012, 450.0212038815563, 451.3094964704008, 467.3013844302789, 5624.493795558419, 5703.458171473703, 5857.0, 5881.941180588139, 5956.225690660186, 511742.0, 512886.0, 522796.0, 535128.0, 540948.0, 65781.0, 67463.32536674669, 68072.65963670249, 68137.0, 68226.0, 496.35226030030435, 501.47345287448036, 503.8992201559703, 507.15811752491425, 507.2492710788054, 9717.17404020666, 9735.26985476078, 9785.31502794826, 9858.211343092393, 9870.802583948425, 29836.0, 30479.847600761856, 30569.54145687772, 30824.69175308218, 31114.844425777726, 42609.0, 42795.0, 44206.33690494709, 44419.0, 44468.55531444644, 5967.4629283362965, 6041.758329666764, 6056.212692349966, 6083.935311320412, 6093.786717464867, 10930.234883558393, 11031.0, 11235.831462528233, 11311.943440282746, 11376.772464550497, 9999.800003999733, 10013.098821106136, 10013.449260290754, 10102.949485252526, 10131.189504839447, 9247.537623118951, 9608.95195524018, 9706.9029309706, 9709.951450242703, 9943.204543636348, 9792.314537982273, 9961.551730172016, 9982.450965196984, 9996.450195239331, 10000.299979001691, 5862.413758624274, 5914.556408269483, 5914.674692891932, 5960.672163031075, 5971.4327138921735, 9327.253819694544, 9335.953320233355, 9384.718458446258, 9711.465869376969, 9713.46575938302], "dojo.html": [2705.648265725456, 2750.4499100179946, 2780.138157171276, 2781.8887244510206, 2800.635917330747, 4681.438227412716, 4912.140375434298, 4914.238293064576, 4980.0, 4980.128477516434, 4879.1705410080285, 4899.583535399486, 4935.506449355063, 4939.753012349386, 5042.773075211615, 4513.954860451387, 4542.6138778203895, 4623.680985856103, 4630.259158534635, 4632.374629425035, 4398.362237475564, 4633.62930965522, 4663.463701674317, 4665.463471700747, 4680.274557443602, 4356.3683265926265, 4511.481179664315, 4518.661100417449, 4544.295634176708, 4555.430571178603, 4522.932156017662, 4562.954370456286, 4564.995700945819, 4579.0, 4625.1443482955765, 4452.5992660660695, 4471.77641117946, 4555.157295900269, 4560.1335746208115, 4569.6801223914335, 4769.833055843063, 4815.6388270879825, 4852.830150944736, 4870.780814863304, 4885.291632713237, 5309.309789727349, 5316.654417462892, 5325.733713314319, 5333.706646134461, 5344.331958505187, 5079.1365467870555, 5197.1424714922, 5212.192110222922, 5311.973440132813, 5339.786408543654, 4893.486183950669, 4924.532169443897, 4929.112759703288, 4933.087378834927, 4958.578520825698, 5443.292371991695, 5476.123820188751, 5483.287172667608, 5487.64330318528, 5509.779608815603, 4980.8256711015665, 5083.847484575469, 5083.974580127076, 5087.974560127176, 5156.793728250903, 5295.761690723926, 5298.417174110845, 5337.839864804062, 5346.97326513365, 5363.892722145535, 5227.529522343008, 5228.346456692913, 5235.476452354734, 5235.58115350771, 5289.994900968803, 5058.962912602908, 5060.291559181717, 5152.9742351288005, 5216.765245563959, 5219.451957544479, 4436.7559784211535, 4449.644028477714, 4463.687541872037, 4473.507914129443, 4486.6186374157905, 3893.6690381317903, 3901.0637447012514, 3917.6865850731874, 3951.1110000249714, 3954.683625309968, 4335.804888780012, 4444.1333939881415, 4459.977700111479, 4503.189425903369, 4534.569215924482, 5244.423113457517, 5312.601554883399, 5327.760250788724, 5334.146536554133, 5378.300820893337, 4399.450068741407, 4510.954890451119, 4551.45382554089, 4557.361969324297, 4592.3800286961505, 4605.263157894721, 4686.086213188463, 4687.6249900007915, 4706.694064885772, 4725.8582242532775, 4972.950270497321, 5028.34631497903, 5034.421041580265, 5038.496150384932, 5072.670276432168, 5153.510416510426, 5232.895342093213, 5309.415964243853, 5330.387005494418, 5363.9731801342305, 4830.806767729251, 4900.387451568554, 4929.06347793918, 4937.851864444073, 4945.060438516671, 5201.505856943584, 5308.57531397495, 5309.867253318698, 5312.814051508179, 5350.277712508917, 5023.196288593807, 5031.371078615173, 5130.948690513196, 5366.570674345965, 5390.164524498552, 5075.670081444694, 5155.43290238081, 5177.326947496801, 5189.429162792166, 5208.687478751287, 5173.715445650375, 5174.870628234325, 5176.275321455075, 5176.559992400688, 5180.352455943007, 4702.76486175683, 4794.113089078532, 4917.286993385867, 5055.823046193365, 5067.569256613229, 5142.228665700175, 5143.5113664201845, 5149.150390185578, 5182.8963420732125, 5184.377874655065, 5064.772085256099, 5073.492650735045, 5078.720670363018, 5089.185730283137, 5104.336436263262], "mootools.html": [1384.3839491426313, 1402.5792262321302, 1463.8609332113444, 1675.9581010474737, 1733.3586572968, 6441.7423303067935, 6498.577592456487, 6920.619365934872, 7028.367446929769, 7114.893276600848, 6996.440284777218, 7193.604351760651, 7225.169105552863, 7237.059182306293, 7271.636418179083, 2037.673972164454, 2051.7332746742977, 2065.1945741160957, 2071.3682326890294, 2078.3453212238096, 2043.7956204379518, 2139.497218153733, 2139.732533433321, 2163.6754486826944, 2164.967525487119, 2062.2678948973125, 2084.4476213803355, 2085.9897991711823, 2119.9364019079453, 2125.9255926042592, 2069.5860827834417, 2084.697718830776, 2090.278853795438, 2094.98952505238, 2097.1192099318323, 2139.0267428320076, 2139.5827813576357, 2158.115172779169, 2159.470929622237, 2167.934961951144, 7347.0, 7389.150247721527, 7410.851782964311, 7412.4440666950195, 7439.3676537494375, 4277.615014648696, 4327.502337231227, 4346.239408103569, 4355.150745604608, 4380.693351465398, 2371.845830021043, 2419.951600967971, 2766.460540194663, 2784.0673374419594, 2807.985960070207, 907.1155623267261, 917.7338571814166, 928.2063835420686, 943.3679434778714, 954.8281309364312, 10074.9496252519, 10077.69766906994, 10183.796324073552, 10223.948880255626, 10255.487225638763, 3895.376739721631, 3907.8046097695, 3993.2412841560013, 4015.678745700337, 4017.1764788218347, 8841.248493878093, 8842.823143537093, 8869.0, 8884.600192991331, 8889.688860889837, 4318.222719910384, 4319.373690814877, 4352.347147927773, 4355.695101342875, 4362.280223763044, 3862.6909847212155, 3919.9020024499614, 3951.3677811550015, 3951.7431366961055, 3959.821808018646, 3375.1899544109237, 3436.810975396377, 3437.295354452331, 3452.9309413811584, 3485.2506711057245, 1089.9237053406187, 1090.2422816142864, 1094.0481780850712, 1095.5070218401752, 1096.7313008313015, 861.4529773593688, 863.1066845814552, 870.5386145342978, 873.3188113271658, 980.6175591519313, 6863.382295593321, 6866.450683945272, 6945.0, 6978.127734033246, 6984.126984126984, 1023.4217667018111, 1047.8899715529913, 1050.8896565860475, 1053.8682664666917, 1055.5513906589822, 5441.646292991022, 5463.043967305705, 5476.2333273341765, 5498.3127109111365, 5505.201745746845, 7956.880646790303, 7981.321587664997, 8549.316054715608, 8552.95723521391, 8788.912110878937, 8688.304935605263, 8715.956420217859, 8719.52042637661, 8813.074627164184, 8865.512396818109, 6830.419414349836, 6918.515703900679, 7009.088818453569, 7033.753818616324, 7053.89419158713, 6992.16094068715, 7041.718331266692, 7047.894281585883, 7050.929490705233, 7066.823329416806, 7791.181925897699, 7994.440389172702, 8003.359731221604, 8075.959620201861, 8080.393970452357, 8040.2361775631225, 8124.918750812416, 8218.835623287381, 8267.586620669063, 8310.875336870073, 6155.876882462415, 6201.286852012076, 6246.875062498633, 6496.577722448026, 6532.706028228836, 6930.13373328334, 7112.964435177791, 7137.964310178623, 7139.0, 7165.0, 6399.93600064012, 6484.383983521558, 6526.902096468461, 6635.63504007265, 6754.93245067543, 6493.383128602775, 6536.673166341759, 6599.53803233769, 6661.533692641468, 6688.6990085445295, 6796.388325050769, 6815.079964204967, 6836.93163068363, 6874.140732408449, 6894.034835122987, 6182.598131121463, 6191.473724733448, 6303.558750887394, 6355.428011478989, 6383.0744542042075, 6428.067930150009, 6458.257300410325, 6460.095586617783, 6468.288488266381, 6472.093906853139], "ext.html": [522.3444577055792, 560.520754754685, 568.1704711121762, 575.2205761193583, 575.7121439280359, 27594.5860812088, 28214.294642633944, 36309.81845090778, 36703.0, 36966.815165924134, 38849.61150388495, 39223.41164882522, 39354.40968385476, 39467.60532394675, 39468.0, 7916.960415197916, 8081.878771818398, 8082.474639148466, 8089.595520223995, 8096.554689492075, 7913.762587122395, 7984.720534781284, 7986.121526632066, 7993.320567751748, 7994.0, 8016.438849280553, 8072.71745488908, 8073.798155046112, 8084.878726819103, 8091.0, 7939.126696063428, 8062.475939063971, 8069.596520173968, 8074.838503229961, 8096.3118134958895, 7925.3356795073105, 8048.034235891672, 8052.19478052196, 8056.0, 8063.153368896299, 37625.435618465744, 38006.80996595027, 38023.619763802286, 38042.619573804186, 38363.616363836285, 2921.1090617361697, 3160.225744692542, 3195.6644552322136, 3284.0, 3297.55483009793, 28228.0, 28307.433851322858, 28613.28466788326, 28676.856615716995, 28927.132186034454, 3088.2125058110037, 3103.984480077585, 3105.596272484585, 3179.5707579476707, 3190.88831890885, 214795.0, 215740.0, 216069.0, 216653.99999999843, 216692.0, 47358.76320618375, 48128.5187148131, 54811.0, 55155.0, 62031.689841550506, 57180.42819571834, 57198.714006430535, 57356.42643573594, 57433.0, 57588.13617795736, 13305.866941330463, 13442.395092220873, 13494.392752326168, 13516.797248041286, 13520.59438216855, 9954.800903982024, 9959.302848800658, 9988.550515226832, 10098.646547370954, 10113.747156321004, 19132.556139894954, 19512.512187195432, 19527.428437236267, 19556.315528956417, 19683.53988653696, 7482.289182527651, 7629.2370762923265, 7675.73781143012, 7709.575973321521, 7751.883721744179, 804.6419343392251, 823.8434697407473, 840.9369297302727, 844.5270648436895, 884.0540621535024, 22897.88551057234, 22937.885310573674, 22962.65556016661, 22976.195833146096, 23152.88423557905, 965.9420434773936, 977.6138425321958, 980.4950450517989, 1031.3605564550028, 1052.1582733813073, 12707.174033687781, 12823.230606163661, 12886.548970785978, 12925.741485170243, 12957.805632915513, 280908.0, 281657.0, 282263.0, 284451.0, 284748.0, 45810.54189458063, 46014.0, 46622.5337746625, 46681.76659116683, 46719.29921051187, 1179.0331927819107, 1183.230899915062, 1196.910231732641, 1196.946137423818, 1197.5688752049255, 24729.1344802931, 25345.493090137727, 25529.361765956, 25541.3614659635, 25686.229413117635, 39701.0, 39717.60282397139, 39762.204755905295, 39876.80061599673, 40057.39913901352, 249580.0, 251540.0, 251660.0, 252195.0, 253099.0, 28261.0, 29108.27229319284, 29470.0, 29585.26036849096, 29606.407871842013, 31836.363272734878, 32086.19784505406, 32203.355932880742, 32395.676043240208, 33011.834940826106, 32375.676243237267, 32417.675823241465, 33155.668443315255, 33505.83247083749, 33821.0, 31746.0, 33242.83378583092, 35083.64916350804, 36158.27683446264, 36418.8179059103, 33287.83356083301, 33441.331173376886, 33723.66276337205, 33731.988040358825, 33754.493682595275, 28481.572776407957, 29164.70835291705, 30116.0, 30519.389612208077, 30659.846700766353, 23140.305790826304, 23450.296491105295, 23519.88240058789, 23592.17427390033, 23782.405439864142], "prototype.html": [290.3669999401305, 291.43607120222373, 294.76860664378455, 296.7032967032967, 299.69880270328326, 5612.354579223391, 5659.971700141498, 5688.089905615102, 5720.084786434171, 5773.711314434283, 5642.520385767204, 5666.971665141668, 5682.488576028157, 5684.602077854552, 5688.345840228375, 4303.419038429819, 4309.2889673204045, 4310.741355518663, 4315.115401342718, 4316.805743741524, 4122.50529936408, 4199.9370009449885, 4211.68412369072, 4238.279492486285, 4254.468191476066, 4174.77038762868, 4199.034222128912, 4202.180574787918, 4204.348326009474, 4211.136716973028, 4189.727667701605, 4201.033762234688, 4204.62158405745, 4216.51510076342, 4230.238557059728, 3583.94624080639, 3585.713142948558, 3590.784552926833, 3591.2637909228806, 3604.7476676632646, 5301.522862942354, 5302.0, 5435.565154787608, 5471.781128754845, 5482.205080263339, 4759.714417134983, 4845.248986407112, 4853.611711063107, 4859.41686997559, 4860.05228980349, 5937.287525496925, 5967.283925928873, 5980.97009514954, 5989.8203053908455, 5994.700264986734, 3909.2963266612, 3909.9218015639526, 3910.530736311632, 3912.3544615138467, 3918.960810391888, 6065.120557519135, 6289.119523266746, 6296.96851515744, 6298.118263443076, 6304.464120549759, 4013.6789056875964, 4015.678745700337, 4031.3751368537337, 4033.233685599727, 4034.6973976951845, 4069.2471892699946, 4085.7344272622186, 4090.9181816363507, 4091.9386209206887, 4097.1396006838895, 4819.49395313487, 4821.228603423436, 4838.879028024327, 4843.225083986616, 4854.708717476963, 5801.622894511843, 5906.409359064145, 5962.25471816023, 5971.373005834412, 5984.251968503937, 1414.0, 1424.4159894443228, 1434.9928250358682, 1440.6326386771307, 1442.386985531145, 927.8515437529962, 928.7353104365224, 938.4088024544493, 954.346272803132, 956.2923436656824, 5122.103631864409, 5145.897082058338, 5157.742112894341, 5162.896742065138, 5181.248718935733, 6162.969185154046, 6183.907241391383, 6186.350433204539, 6188.44304012632, 6188.690565471708, 5135.460776618476, 5146.716930568855, 5149.073166830007, 5152.175651895679, 5167.22491626259, 3263.885763998249, 3331.0839519132433, 3357.781744186669, 3381.1040074380307, 3383.035834787074, 5856.443637854397, 5901.262342207224, 5917.082852157922, 5919.289685237713, 5925.881482370329, 6283.612227353668, 6416.743330266737, 6473.643949582818, 6491.221053473613, 6509.869802603921, 5890.204822348928, 5902.734376953047, 5905.320888097838, 5918.260217472816, 5934.703264836741, 6260.874782504416, 6269.467095296951, 6270.561060725706, 6274.498040156868, 6276.874462510816, 6016.849578760566, 6130.601510901777, 6136.662483563268, 6140.600860944024, 6158.3841615838055, 5882.735276912635, 5900.793472228452, 5909.379515151019, 5918.3489816121055, 5919.6152250103605, 3993.4209539617173, 4039.41428492861, 4043.1509383028715, 4044.2315959967514, 4055.4727885374714, 6082.939170608237, 6252.468540174136, 6252.562320637694, 6264.843378915563, 6267.091271765659, 5994.310654274815, 6018.458338749533, 6028.819135425944, 6031.487323577369, 6040.848978775566, 5993.280806303272, 6012.3085845126625, 6014.308354539284, 6017.969910150597, 6032.788852390146, 5720.771169153354, 5851.912221316768, 5883.499902508334, 5887.205227294432, 5888.411158884077, 5970.97014514942, 6014.609050411709, 6023.728932198149, 6041.728122234598, 6058.606190597597, 5852.678102704222, 5900.498457631149, 5902.321233058082, 5904.346782900795, 5914.408559144051], "yui.html": [696.6899729620319, 740.4187712645568, 783.9294463498284, 799.1329407592762, 810.6514198894477, 11276.718082047953, 11446.08431325494, 11534.250273732201, 11542.0, 11542.69146170767, 11150.386728729916, 11721.472533735981, 11730.120240981918, 11766.882331176686, 11789.941050294758, 617.4134572156447, 629.0250112325899, 796.1202870827739, 805.64551597297, 815.5310696349593, 801.3068695578341, 803.4656953126164, 815.4617952151581, 816.6733306677318, 816.9509829410225, 841.032812265893, 846.5090247656344, 846.949183049019, 851.059579165023, 854.4744981836188, 839.2279103225047, 841.2302742990126, 841.6843683618642, 842.6081871929551, 843.6119385082869, 618.4681174190193, 618.5577312221783, 624.8750249950028, 625.9780907668255, 627.5701144715885, 12175.51297948081, 12212.816807747891, 12216.144869859114, 12226.14416990811, 12307.56923507673, 11179.161562882735, 11200.103991680646, 11331.603393881174, 11493.31040137586, 11654.359010254433, 8993.0, 9716.902830971741, 9742.464164470952, 9971.90028099717, 9997.0, 2968.391479746668, 3020.5771192033135, 3024.1985873743474, 3034.605501284841, 3037.0736925237793, 34452.31095378078, 34636.6536334636, 34951.12622184466, 34984.65015349839, 35199.29601407983, 6803.0, 6918.100646915868, 7003.124609423822, 7024.473164512682, 7090.0, 9910.256730745223, 10009.549570269355, 10021.699349019542, 10030.097291243823, 10051.849222261671, 5849.707514624337, 5850.3272123705465, 5861.062230043172, 5888.676122813201, 6167.105769663463, 3687.1703866629796, 3747.3442147624055, 3747.756395834262, 3807.6192380761704, 3816.9618303816605, 2617.8952841886494, 2675.0904692404674, 2679.3569543309854, 2680.477306925131, 2692.9730702693114, 425.55529471702147, 428.31255834385985, 433.93707912353165, 434.0624251616556, 435.7494440696549, 580.1616663920594, 580.1819434597197, 583.8511179649163, 610.3377835049022, 650.9283978762332, 7986.840263194704, 8584.785380365542, 8652.134786521423, 8776.0, 9007.234385077341, 447.2754138295916, 465.19056841096926, 487.92681097835606, 489.9020195960822, 515.6261710260106, 3588.9102772430374, 3697.59326474093, 3796.0, 3934.449177115206, 3984.08763793375, 45861.770691147, 46323.5367646326, 46466.07067858624, 46680.533194667616, 46822.29766553504, 42398.15203695909, 42421.0, 42763.57236427596, 44311.11377772426, 44444.77777611091, 40264.194716105514, 40660.59339406627, 40734.38898416526, 41025.79487102546, 41437.37843932343, 7445.0, 7450.590217537871, 7549.886751698619, 7697.114831794415, 7730.072391313079, 30653.846730766203, 31027.53458698076, 31243.84378078095, 31428.528572071893, 31895.68104318927, 36314.455283170246, 37342.8132859334, 38825.417618736305, 38911.221775564896, 38940.41589376105, 6095.969520152548, 6096.420840020191, 6172.845678858064, 6484.675766211765, 6538.019297105472, 9879.901200988186, 9901.851472228067, 9909.65316213929, 10033.749156271151, 10298.734278458727, 9152.588133533874, 9289.535523223947, 9495.560815331937, 9829.901700982899, 9854.950725246616, 9353.906460935303, 9459.95270023673, 9540.475273860004, 9559.952200238955, 9958.701238962552, 9604.75988100303, 9757.12185903272, 9773.41359518431, 9798.118169364792, 9876.160526355054, 8410.0, 8450.450720703135, 8543.145685431407, 8670.0896405879, 8693.869591956252, 7625.580593067434, 7646.273604007611, 7900.802479938047, 8011.0, 8038.356931445353]}, "summary": {"lowerIsBetter": false, "suite": 6047.597215460896, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6167.358559617475, "unit": "ms", "value": 6167.358559617475}, "dojo.html": {"lowerIsBetter": false, "filtered": 4832.09573113379, "unit": "ms", "value": 4832.09573113379}, "mootools.html": {"lowerIsBetter": false, "filtered": 4189.723945922094, "unit": "ms", "value": 4189.723945922094}, "ext.html": {"lowerIsBetter": false, "filtered": 16622.445478902373, "unit": "ms", "value": 16622.445478902373}, "prototype.html": {"lowerIsBetter": false, "filtered": 4394.955371615217, "unit": "ms", "value": 4394.955371615217}, "yui.html": {"lowerIsBetter": false, "filtered": 5362.763382638939, "unit": "ms", "value": 5362.763382638939}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-039.e"}, "testrun": {"date": 1447653695, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115210907", "branch": "Mozilla-Inbound-Non-PGO", "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 164.0, 162.0, 161.0, 161.0, 167.0, 170.0, 164.0, 165.0, 162.0], "ai-astar": [113.0, 109.0, 115.0, 113.0, 114.0, 124.0, 112.0, 112.0, 112.0, 111.0], "imaging-gaussian-blur": [111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "audio-beat-detection": [161.0, 131.0, 168.0, 168.0, 130.0, 163.0, 152.0, 132.0, 182.0, 137.0], "json-stringify-tinderbox": [68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 68.0], "stanford-crypto-pbkdf2": [157.0, 154.0, 154.0, 159.0, 154.0, 150.0, 150.0, 164.0, 152.0, 150.0], "json-parse-financial": [72.0, 72.0, 73.0, 72.0, 73.0, 72.0, 72.0, 72.0, 72.0, 74.0], "stanford-crypto-sha256-iterative": [70.0, 80.0, 73.0, 71.0, 74.0, 71.0, 70.0, 74.0, 70.0, 72.0], "audio-fft": [73.0, 74.0, 74.0, 73.0, 72.0, 73.0, 143.0, 73.0, 74.0, 73.0], "imaging-darkroom": [148.0, 150.0, 150.0, 148.0, 151.0, 149.0, 149.0, 148.0, 149.0, 148.0], "stanford-crypto-ccm": [123.0, 122.0, 127.0, 124.0, 129.0, 125.0, 121.0, 123.0, 131.0, 130.0], "audio-oscillator": [91.0, 92.0, 136.0, 91.0, 93.0, 93.0, 125.0, 92.0, 93.0, 134.0], "stanford-crypto-aes": [84.0, 85.0, 83.0, 94.0, 85.0, 91.0, 84.0, 84.0, 96.0, 81.0], "imaging-desaturate": [95.0, 97.0, 97.0, 96.0, 96.0, 100.0, 96.0, 96.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1549.6000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.2, "unit": "ms", "value": 80.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 154.4, "unit": "ms", "value": 154.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 152.4, "unit": "ms", "value": 152.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 125.5, "unit": "ms", "value": 125.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 149.0, "unit": "ms", "value": 149.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.4, "unit": "ms", "value": 72.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.0, "unit": "ms", "value": 104.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 113.5, "unit": "ms", "value": 113.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 163.9, "unit": "ms", "value": 163.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 72.5, "unit": "ms", "value": 72.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.7, "unit": "ms", "value": 68.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.0, "unit": "ms", "value": 110.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.7, "unit": "ms", "value": 86.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.4, "unit": "ms", "value": 96.4}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-039.e"}, "testrun": {"date": 1447653695, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115210907", "branch": "Mozilla-Inbound-Non-PGO", "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2"}}, {"talos_counters": {}, "results": {"DeltaBlue": [189.9696048632219], "Encrypt": [279.72027972027973], "NavierStokes": [4826.923076923077], "Decrypt": [5045.226130653266], "Splay": [616.1429451632779], "Richards": [164.50074025333114], "RegExp": [25575.0], "Earley": [737.1134020618557], "Boyer": [12204.819277108434], "RayTrace": [1064.9627263045793]}, "summary": {"lowerIsBetter": false, "suite": 21318.29409780905, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 348.04515199999986, "unit": "score", "value": 348.04515199999986}, "Encrypt": {"lowerIsBetter": false, "filtered": 951.5970750000004, "unit": "score", "value": 951.5970750000004}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.4422310756973, "unit": "score", "value": 307.4422310756973}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.75898306772911, "unit": "score", "value": 52.75898306772911}, "Splay": {"lowerIsBetter": false, "filtered": 132.25989299999998, "unit": "score", "value": 132.25989299999998}, "RegExp": {"lowerIsBetter": false, "filtered": 35.620136852394914, "unit": "score", "value": 35.620136852394914}, "Richards": {"lowerIsBetter": false, "filtered": 214.60085799999993, "unit": "score", "value": 214.60085799999993}, "Earley": {"lowerIsBetter": false, "filtered": 904.1526013986016, "unit": "score", "value": 904.1526013986016}, "Boyer": {"lowerIsBetter": false, "filtered": 54.606543928923976, "unit": "score", "value": 54.606543928923976}, "RayTrace": {"lowerIsBetter": false, "filtered": 694.8496709999997, "unit": "score", "value": 694.8496709999997}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-039.e"}, "testrun": {"date": 1447653695, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115210907", "branch": "Mozilla-Inbound-Non-PGO", "revision": "951e77fb1760a8f2047fe7f83217f69f480181a2"}}] 22:21:53 INFO - RETURN: dromaeo_css: 6047.60 22:21:53 INFO - RETURN: kraken: 1549.60 22:21:53 INFO - RETURN: v8_7: 21318.29 22:21:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,43]]", "result": "21318.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,43]]", "result": "1549.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,43]]", "result": "6047.60"}}} 22:21:53 INFO - Return code: 0 22:21:53 INFO - # TBPL SUCCESS # 22:21:53 INFO - Running post-action listener: _resource_record_post_action 22:21:53 INFO - Running post-run listener: _resource_record_post_run 22:21:55 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508600320; Read time: 12; Write time: 690652 22:21:55 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 222711808; Read time: 0; Write time: 407120 22:21:55 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 281100288; Read time: 0; Write time: 282804 22:21:55 INFO - Running post-run listener: _upload_blobber_files 22:21:55 INFO - Blob upload gear active. 22:21:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:21:55 INFO - Copying logs to upload dir... 22:21:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.509579 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-15 22:21:53.948662) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 22:21:53.952678) ========= 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=6e558709db315bacd2260379000001b6-1447650943.589097-32196527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009982 build_url: 'https://queue.taskcluster.net/v1/task/HoKzcQykRJuTEX_MmKlTPQ/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-15 22:21:54.004551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:21:54.004945) ========= 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=6e558709db315bacd2260379000001b6-1447650943.589097-32196527 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 22:21:54.055639) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 22:21:54.056022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 22:21:54.056398) ========= ========= Total master_lag: 0.27 =========