builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1447445762.4 results: success (0) buildid: 20151113071449 builduid: 711e742845b04de995278c4edd3802dd revision: d1029ba11d5c64c455412a58a2a77d14511286d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.398369) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.398835) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.399176) ========= 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=801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006525 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.446842) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.447197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.558694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.558994) ========= 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=801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.610386) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.610719) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.611146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.611506) ========= 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=801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-13 12:16:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2015-11-13 12:16:03 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164945 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.795264) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.795605) ========= 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=801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018192 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:02.845323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 12:16:02.845666) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d1029ba11d5c64c455412a58a2a77d14511286d6 --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 d1029ba11d5c64c455412a58a2a77d14511286d6 --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=801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-13 12:16:03,335 truncating revision to first 12 chars 2015-11-13 12:16:03,335 Setting DEBUG logging. 2015-11-13 12:16:03,335 attempt 1/10 2015-11-13 12:16:03,335 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d1029ba11d5c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 12:16:04,459 unpacking tar archive at: mozilla-inbound-d1029ba11d5c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.404103 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-13 12:16:04.262783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:04.263088) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:04.273363) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:04.273639) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 12:16:04.274022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2015-11-13 12:16:04.274387) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:04 INFO - MultiFileLogger online at 20151113 12:16:04 in /builds/slave/test 12:16:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 12:16:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:04 INFO - {'append_to_log': False, 12:16:04 INFO - 'base_work_dir': '/builds/slave/test', 12:16:04 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 12:16:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:04 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 12:16:04 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:04 INFO - 'config_files': ('talos/linux_config.py',), 12:16:04 INFO - 'default_actions': ('clobber', 12:16:04 INFO - 'read-buildbot-config', 12:16:04 INFO - 'download-and-extract', 12:16:04 INFO - 'populate-webroot', 12:16:04 INFO - 'create-virtualenv', 12:16:04 INFO - 'install', 12:16:04 INFO - 'run-tests'), 12:16:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:04 INFO - 'download_minidump_stackwalk': True, 12:16:04 INFO - 'download_symbols': 'ondemand', 12:16:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:04 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:04 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:04 INFO - 'installer_path': 'installer.exe', 12:16:04 INFO - 'log_level': 'info', 12:16:04 INFO - 'log_name': 'talos', 12:16:04 INFO - 'log_to_console': True, 12:16:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:04 INFO - 'opt_config_files': (), 12:16:04 INFO - 'pip_index': False, 12:16:04 INFO - 'sps_profile': False, 12:16:04 INFO - 'sps_profile_interval': 0, 12:16:04 INFO - 'suite': 'dromaeojs', 12:16:04 INFO - 'system_bits': '64', 12:16:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:04 INFO - 'title': 'talos-linux64-ix-006', 12:16:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:04 INFO - 'use_talos_json': True, 12:16:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:04 INFO - 'work_dir': 'build'} 12:16:04 INFO - ##### 12:16:04 INFO - ##### Running clobber step. 12:16:04 INFO - ##### 12:16:04 INFO - Running pre-action listener: _resource_record_pre_action 12:16:04 INFO - Running main action method: clobber 12:16:04 INFO - rmtree: /builds/slave/test/build 12:16:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:05 INFO - Running post-action listener: _resource_record_post_action 12:16:05 INFO - ##### 12:16:05 INFO - ##### Running read-buildbot-config step. 12:16:05 INFO - ##### 12:16:05 INFO - Running pre-action listener: _resource_record_pre_action 12:16:05 INFO - Running main action method: read_buildbot_config 12:16:05 INFO - Using buildbot properties: 12:16:05 INFO - { 12:16:05 INFO - "properties": { 12:16:05 INFO - "buildnumber": 2843, 12:16:05 INFO - "product": "firefox", 12:16:05 INFO - "script_repo_revision": "production", 12:16:05 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 12:16:05 INFO - "repository": "", 12:16:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 12:16:05 INFO - "buildid": "20151113071449", 12:16:05 INFO - "slavename": "talos-linux64-ix-006", 12:16:05 INFO - "pgo_build": "False", 12:16:05 INFO - "basedir": "/builds/slave/test", 12:16:05 INFO - "project": "", 12:16:05 INFO - "platform": "ubuntu64_hw", 12:16:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:16:05 INFO - "slavebuilddir": "test", 12:16:05 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 12:16:05 INFO - "branch": "mozilla-inbound", 12:16:05 INFO - "repo_path": "integration/mozilla-inbound", 12:16:05 INFO - "stage_platform": "linux64", 12:16:05 INFO - "builduid": "711e742845b04de995278c4edd3802dd", 12:16:05 INFO - "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6" 12:16:05 INFO - }, 12:16:05 INFO - "sourcestamp": { 12:16:05 INFO - "repository": "", 12:16:05 INFO - "hasPatch": false, 12:16:05 INFO - "project": "", 12:16:05 INFO - "branch": "mozilla-inbound-linux64-talos", 12:16:05 INFO - "changes": [ 12:16:05 INFO - { 12:16:05 INFO - "category": null, 12:16:05 INFO - "files": [ 12:16:05 INFO - { 12:16:05 INFO - "url": null, 12:16:05 INFO - "name": "https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:16:05 INFO - } 12:16:05 INFO - ], 12:16:05 INFO - "repository": "", 12:16:05 INFO - "rev": "d1029ba11d5c64c455412a58a2a77d14511286d6", 12:16:05 INFO - "who": "mchang@mozilla.com", 12:16:05 INFO - "when": 1447430133, 12:16:05 INFO - "number": 6658796, 12:16:05 INFO - "comments": "Bug 1210261. Tick root refresh driver last. r=mattwoodrow", 12:16:05 INFO - "project": "", 12:16:05 INFO - "at": "Fri 13 Nov 2015 07:55:33", 12:16:05 INFO - "branch": "mozilla-inbound-linux64-talos", 12:16:05 INFO - "revlink": "", 12:16:05 INFO - "properties": [ 12:16:05 INFO - [ 12:16:05 INFO - "buildid", 12:16:05 INFO - "20151113071449", 12:16:05 INFO - "Change" 12:16:05 INFO - ], 12:16:05 INFO - [ 12:16:05 INFO - "builduid", 12:16:05 INFO - "711e742845b04de995278c4edd3802dd", 12:16:05 INFO - "Change" 12:16:05 INFO - ], 12:16:05 INFO - [ 12:16:05 INFO - "pgo_build", 12:16:05 INFO - "False", 12:16:05 INFO - "Change" 12:16:05 INFO - ] 12:16:05 INFO - ], 12:16:05 INFO - "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6" 12:16:05 INFO - } 12:16:05 INFO - ], 12:16:05 INFO - "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6" 12:16:05 INFO - } 12:16:05 INFO - } 12:16:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:16:05 INFO - Running post-action listener: _resource_record_post_action 12:16:05 INFO - ##### 12:16:05 INFO - ##### Running download-and-extract step. 12:16:05 INFO - ##### 12:16:05 INFO - Running pre-action listener: _resource_record_pre_action 12:16:05 INFO - Running main action method: download_and_extract 12:16:05 INFO - mkdir: /builds/slave/test/build/tests 12:16: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')]} 12:16:05 INFO - https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:16:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/test_packages.json 12:16:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/test_packages.json 12:16:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:16:25 INFO - Downloaded 1302 bytes. 12:16:25 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:16:25 INFO - Using the following test package requirements: 12:16:25 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:25 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:16:25 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:25 INFO - u'jsshell-linux-x86_64.zip'], 12:16:25 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:16:25 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:25 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:16:25 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:16:25 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:16:25 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:25 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:25 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:16:25 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:16:25 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')]} 12:16:25 INFO - https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:38 INFO - Downloaded 21256903 bytes. 12:16:38 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 12:16:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:38 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 12:16:39 INFO - Return code: 0 12:16:39 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 12:16:39 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')]} 12:16:39 INFO - https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:44 INFO - Downloaded 21256903 bytes. 12:16:44 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 12:16:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:44 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 12:16:46 INFO - Return code: 0 12:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:46 INFO - https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:47 INFO - Downloaded 11131693 bytes. 12:16:47 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 12:16:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:47 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 12:16:47 INFO - Return code: 0 12:16:47 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')]} 12:16:47 INFO - https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:16:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OOG17jUCTP6c4jwOJuo1-g/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 12:16:49 INFO - Downloaded 55622333 bytes. 12:16:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:49 INFO - mkdir: /builds/slave/test/properties 12:16:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:16:49 INFO - Writing to file /builds/slave/test/properties/build_url 12:16:49 INFO - Contents: 12:16:49 INFO - build_url:https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:49 INFO - Running post-action listener: _resource_record_post_action 12:16:49 INFO - Running post-action listener: set_extra_try_arguments 12:16:49 INFO - ##### 12:16:49 INFO - ##### Running populate-webroot step. 12:16:49 INFO - ##### 12:16:49 INFO - Running pre-action listener: _resource_record_pre_action 12:16:49 INFO - Running main action method: populate_webroot 12:16:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:16:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:16:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:16:49 INFO - '../fennec_ids.txt'], 12:16:49 INFO - 'tests': ['tcheck2']}, 12:16:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:16:49 INFO - '--tppagecycles', 12:16:49 INFO - '7'], 12:16:49 INFO - 'tests': ['tsvgm']}}, 12:16:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:16:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:16:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:16:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:16:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:49 INFO - 'talos_options': ['--e10s'], 12:16:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:49 INFO - 'tests': ['damp', 'tps']}, 12:16:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:49 INFO - 'talos_options': ['--e10s'], 12:16:49 INFO - 'tests': ['damp', 'tps']}, 12:16:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:16:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:16:49 INFO - 'other': {'tests': ['a11yr', 12:16:49 INFO - 'ts_paint', 12:16:49 INFO - 'tpaint', 12:16:49 INFO - 'sessionrestore', 12:16:49 INFO - 'sessionrestore_no_auto_restore']}, 12:16:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:16:49 INFO - 'tests': ['a11yr', 12:16:49 INFO - 'ts_paint', 12:16:49 INFO - 'tpaint', 12:16:49 INFO - 'sessionrestore', 12:16:49 INFO - 'sessionrestore_no_auto_restore']}, 12:16:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:16:49 INFO - 'tests': ['a11yr', 12:16:49 INFO - 'ts_paint', 12:16:49 INFO - 'tpaint', 12:16:49 INFO - 'sessionrestore', 12:16:49 INFO - 'sessionrestore_no_auto_restore']}, 12:16:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:16:49 INFO - 'tests': ['a11yr', 12:16:49 INFO - 'ts_paint', 12:16:49 INFO - 'tpaint', 12:16:49 INFO - 'sessionrestore', 12:16:49 INFO - 'sessionrestore_no_auto_restore']}, 12:16:49 INFO - 'other_l64': {'tests': ['a11yr', 12:16:49 INFO - 'ts_paint', 12:16:49 INFO - 'tpaint', 12:16:49 INFO - 'sessionrestore', 12:16:49 INFO - 'sessionrestore_no_auto_restore']}, 12:16:49 INFO - 'other_nol64': {'tests': ['a11yr', 12:16:49 INFO - 'ts_paint', 12:16:49 INFO - 'tpaint', 12:16:49 INFO - 'sessionrestore', 12:16:49 INFO - 'sessionrestore_no_auto_restore']}, 12:16:49 INFO - 'svgr': {'tests': ['tsvgx', 12:16:49 INFO - 'tsvgr_opacity', 12:16:49 INFO - 'tart', 12:16:49 INFO - 'tscrollx', 12:16:49 INFO - 'cart']}, 12:16:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:16:49 INFO - 'tests': ['tsvgx', 12:16:49 INFO - 'tsvgr_opacity', 12:16:49 INFO - 'tart', 12:16:49 INFO - 'tscrollx', 12:16:49 INFO - 'cart']}, 12:16:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:49 INFO - 'tests': ['tp5o']}, 12:16:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:49 INFO - 'talos_options': ['--e10s'], 12:16:49 INFO - 'tests': ['tp5o']}, 12:16:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:49 INFO - 'talos_options': ['--xperf_path', 12:16:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:49 INFO - 'tests': ['tp5n']}, 12:16:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:49 INFO - 'talos_options': ['--e10s', 12:16:49 INFO - '--xperf_path', 12:16:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:49 INFO - 'tests': ['tp5n']}}, 12:16:49 INFO - 'talos.zip': {'path': '', 12:16:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:16:49 INFO - Running post-action listener: _resource_record_post_action 12:16:49 INFO - ##### 12:16:49 INFO - ##### Running create-virtualenv step. 12:16:49 INFO - ##### 12:16:49 INFO - Running pre-action listener: _resource_record_pre_action 12:16:49 INFO - Running main action method: create_virtualenv 12:16:49 INFO - Creating virtualenv /builds/slave/test/build/venv 12:16:49 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 12:16:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:16:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:16:49 INFO - Using real prefix '/usr' 12:16:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:16:49 INFO - Installing distribute.............................................................................................................................................................................................done. 12:16:51 INFO - Installing pip.................done. 12:16:51 INFO - Return code: 0 12:16:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:51 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 0x7fbf51677c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2ac0>, '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 0x12b39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b3e50>, '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': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', '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 12:16:51 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 12:16:51 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 12:16:51 INFO - Using env: {'DISPLAY': ':0', 12:16:51 INFO - 'HOME': '/home/cltbld', 12:16:51 INFO - 'LANG': 'en_US.UTF-8', 12:16:51 INFO - 'LANGUAGE': 'en_US:en', 12:16:51 INFO - 'LOGNAME': 'cltbld', 12:16:51 INFO - 'MAIL': '/var/mail/cltbld', 12:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:51 INFO - 'MOZ_NO_REMOTE': '1', 12:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:51 INFO - 'NO_EM_RESTART': '1', 12:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:51 INFO - 'PWD': '/builds/slave/test', 12:16:51 INFO - 'SHELL': '/bin/bash', 12:16:51 INFO - 'SHLVL': '1', 12:16:51 INFO - 'TERM': 'linux', 12:16:51 INFO - 'TMOUT': '86400', 12:16:51 INFO - 'USER': 'cltbld', 12:16:51 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', 12:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:51 INFO - '_': '/tools/buildbot/bin/python'} 12:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:51 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 12:16:51 INFO - Cleaning up... 12:16:51 INFO - Return code: 0 12:16:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fbf51677c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2ac0>, '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 0x12b39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b3e50>, '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': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', '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 12:16:52 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 12:16:52 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 12:16:52 INFO - Using env: {'DISPLAY': ':0', 12:16:52 INFO - 'HOME': '/home/cltbld', 12:16:52 INFO - 'LANG': 'en_US.UTF-8', 12:16:52 INFO - 'LANGUAGE': 'en_US:en', 12:16:52 INFO - 'LOGNAME': 'cltbld', 12:16:52 INFO - 'MAIL': '/var/mail/cltbld', 12:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:52 INFO - 'MOZ_NO_REMOTE': '1', 12:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:52 INFO - 'NO_EM_RESTART': '1', 12:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:52 INFO - 'PWD': '/builds/slave/test', 12:16:52 INFO - 'SHELL': '/bin/bash', 12:16:52 INFO - 'SHLVL': '1', 12:16:52 INFO - 'TERM': 'linux', 12:16:52 INFO - 'TMOUT': '86400', 12:16:52 INFO - 'USER': 'cltbld', 12:16:52 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', 12:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:52 INFO - '_': '/tools/buildbot/bin/python'} 12:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:52 INFO - Downloading/unpacking psutil>=0.7.1 12:16:52 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 12:16:52 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 12:16:52 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 12:16:52 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 12:16:52 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 12:16:52 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 12:16:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:16:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:16:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:16:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:53 INFO - Installing collected packages: psutil 12:16:53 INFO - Running setup.py install for psutil 12:16:54 INFO - building 'psutil._psutil_linux' extension 12:16:54 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 12:16:54 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 12:16:54 INFO - building 'psutil._psutil_posix' extension 12:16:54 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 12:16:54 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 12:16:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:54 INFO - Successfully installed psutil 12:16:54 INFO - Cleaning up... 12:16:54 INFO - Return code: 0 12:16:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:54 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 0x7fbf51677c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2ac0>, '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 0x12b39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b3e50>, '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': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', '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 12:16:54 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 12:16:54 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 12:16:54 INFO - Using env: {'DISPLAY': ':0', 12:16:54 INFO - 'HOME': '/home/cltbld', 12:16:54 INFO - 'LANG': 'en_US.UTF-8', 12:16:54 INFO - 'LANGUAGE': 'en_US:en', 12:16:54 INFO - 'LOGNAME': 'cltbld', 12:16:54 INFO - 'MAIL': '/var/mail/cltbld', 12:16:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:54 INFO - 'MOZ_NO_REMOTE': '1', 12:16:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:54 INFO - 'NO_EM_RESTART': '1', 12:16:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:54 INFO - 'PWD': '/builds/slave/test', 12:16:54 INFO - 'SHELL': '/bin/bash', 12:16:54 INFO - 'SHLVL': '1', 12:16:54 INFO - 'TERM': 'linux', 12:16:54 INFO - 'TMOUT': '86400', 12:16:54 INFO - 'USER': 'cltbld', 12:16:54 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', 12:16:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:54 INFO - '_': '/tools/buildbot/bin/python'} 12:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:16:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:16:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:16:56 INFO - Installing collected packages: mozsystemmonitor 12:16:56 INFO - Running setup.py install for mozsystemmonitor 12:16:56 INFO - Successfully installed mozsystemmonitor 12:16:56 INFO - Cleaning up... 12:16:56 INFO - Return code: 0 12:16:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbf51677c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2ac0>, '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 0x12b39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b3e50>, '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': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', '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 12:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:16:56 INFO - Using env: {'DISPLAY': ':0', 12:16:56 INFO - 'HOME': '/home/cltbld', 12:16:56 INFO - 'LANG': 'en_US.UTF-8', 12:16:56 INFO - 'LANGUAGE': 'en_US:en', 12:16:56 INFO - 'LOGNAME': 'cltbld', 12:16:56 INFO - 'MAIL': '/var/mail/cltbld', 12:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:56 INFO - 'MOZ_NO_REMOTE': '1', 12:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:56 INFO - 'NO_EM_RESTART': '1', 12:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:56 INFO - 'PWD': '/builds/slave/test', 12:16:56 INFO - 'SHELL': '/bin/bash', 12:16:56 INFO - 'SHLVL': '1', 12:16:56 INFO - 'TERM': 'linux', 12:16:56 INFO - 'TMOUT': '86400', 12:16:56 INFO - 'USER': 'cltbld', 12:16:56 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', 12:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:56 INFO - '_': '/tools/buildbot/bin/python'} 12:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:58 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16:58 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 12:16:58 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 12:16:58 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 12:16:58 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 12:16:58 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 12:16:58 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 12:16:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16:58 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 12:16:58 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 12:16:58 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 12:16:58 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 12:16:58 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 12:16:58 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 12:16:59 INFO - Downloading docopt-0.6.1.tar.gz 12:16:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:16:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:59 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:59 INFO - Running setup.py install for blobuploader 12:16:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:59 INFO - Running setup.py install for requests 12:16:59 INFO - Running setup.py install for docopt 12:16:59 INFO - Successfully installed blobuploader requests docopt 12:16:59 INFO - Cleaning up... 12:16:59 INFO - Return code: 0 12:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:59 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')]} 12:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:59 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')]} 12:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:59 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 0x7fbf51677c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2ac0>, '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 0x12b39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b3e50>, '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': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', '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 12:16:59 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 12:16:59 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 12:16:59 INFO - Using env: {'DISPLAY': ':0', 12:16:59 INFO - 'HOME': '/home/cltbld', 12:16:59 INFO - 'LANG': 'en_US.UTF-8', 12:16:59 INFO - 'LANGUAGE': 'en_US:en', 12:16:59 INFO - 'LOGNAME': 'cltbld', 12:16:59 INFO - 'MAIL': '/var/mail/cltbld', 12:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:59 INFO - 'MOZ_NO_REMOTE': '1', 12:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:59 INFO - 'NO_EM_RESTART': '1', 12:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:59 INFO - 'PWD': '/builds/slave/test', 12:16:59 INFO - 'SHELL': '/bin/bash', 12:16:59 INFO - 'SHLVL': '1', 12:16:59 INFO - 'TERM': 'linux', 12:16:59 INFO - 'TMOUT': '86400', 12:16:59 INFO - 'USER': 'cltbld', 12:16:59 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', 12:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:59 INFO - '_': '/tools/buildbot/bin/python'} 12:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:59 INFO - Running setup.py (path:/tmp/pip-Qwag73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:59 INFO - Running setup.py (path:/tmp/pip-r1FHMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:00 INFO - Running setup.py (path:/tmp/pip-vItxaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:00 INFO - Running setup.py (path:/tmp/pip-odtfh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:00 INFO - Running setup.py (path:/tmp/pip-5XAD9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:00 INFO - Running setup.py (path:/tmp/pip-DnkRij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:00 INFO - Running setup.py (path:/tmp/pip-C5Axif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:00 INFO - Running setup.py (path:/tmp/pip-ao2Som-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:00 INFO - Running setup.py (path:/tmp/pip-noCs6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:00 INFO - Running setup.py (path:/tmp/pip-jdPTqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:00 INFO - Running setup.py (path:/tmp/pip-noFdN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:00 INFO - Running setup.py (path:/tmp/pip-BRG0A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:00 INFO - Running setup.py (path:/tmp/pip-UbnzM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:00 INFO - Running setup.py (path:/tmp/pip-zpyoAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:00 INFO - Running setup.py (path:/tmp/pip-XvNi9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:00 INFO - Running setup.py (path:/tmp/pip-pTxDY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:01 INFO - Running setup.py (path:/tmp/pip-LG92ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:01 INFO - Running setup.py install for manifestparser 12:17:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Running setup.py install for mozcrash 12:17:01 INFO - Running setup.py install for mozdebug 12:17:01 INFO - Running setup.py install for mozdevice 12:17:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Running setup.py install for mozfile 12:17:01 INFO - Running setup.py install for mozhttpd 12:17:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Running setup.py install for mozinfo 12:17:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Running setup.py install for mozInstall 12:17:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:01 INFO - Running setup.py install for mozleak 12:17:02 INFO - Running setup.py install for mozlog 12:17:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:02 INFO - Running setup.py install for moznetwork 12:17:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:02 INFO - Running setup.py install for mozprocess 12:17:02 INFO - Running setup.py install for mozprofile 12:17:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:02 INFO - Running setup.py install for mozrunner 12:17:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:02 INFO - Running setup.py install for mozscreenshot 12:17:02 INFO - Running setup.py install for moztest 12:17:02 INFO - Running setup.py install for mozversion 12:17:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:02 INFO - Cleaning up... 12:17:02 INFO - Return code: 0 12:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:02 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')]} 12:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:02 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')]} 12:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:02 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 0x7fbf51677c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2ac0>, '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 0x12b39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b3e50>, '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': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', '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 12:17:02 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 12:17:02 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 12:17:02 INFO - Using env: {'DISPLAY': ':0', 12:17:02 INFO - 'HOME': '/home/cltbld', 12:17:02 INFO - 'LANG': 'en_US.UTF-8', 12:17:02 INFO - 'LANGUAGE': 'en_US:en', 12:17:02 INFO - 'LOGNAME': 'cltbld', 12:17:02 INFO - 'MAIL': '/var/mail/cltbld', 12:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:02 INFO - 'MOZ_NO_REMOTE': '1', 12:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:02 INFO - 'NO_EM_RESTART': '1', 12:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:02 INFO - 'PWD': '/builds/slave/test', 12:17:02 INFO - 'SHELL': '/bin/bash', 12:17:02 INFO - 'SHLVL': '1', 12:17:02 INFO - 'TERM': 'linux', 12:17:02 INFO - 'TMOUT': '86400', 12:17:02 INFO - 'USER': 'cltbld', 12:17:02 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', 12:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:02 INFO - '_': '/tools/buildbot/bin/python'} 12:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:03 INFO - Running setup.py (path:/tmp/pip-bW_r2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:03 INFO - Running setup.py (path:/tmp/pip-YpoS4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:03 INFO - Running setup.py (path:/tmp/pip-sNrvh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:03 INFO - Running setup.py (path:/tmp/pip-Z9SCI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:03 INFO - Running setup.py (path:/tmp/pip-xafuNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:03 INFO - Running setup.py (path:/tmp/pip-Nhccfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:03 INFO - Running setup.py (path:/tmp/pip-0azgLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:03 INFO - Running setup.py (path:/tmp/pip-pwaFKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:03 INFO - Running setup.py (path:/tmp/pip-BlITHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:03 INFO - Running setup.py (path:/tmp/pip-pr7Fcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:03 INFO - Running setup.py (path:/tmp/pip-ivLvPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:03 INFO - Running setup.py (path:/tmp/pip-LZRy2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:03 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)) 12:17:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:04 INFO - Running setup.py (path:/tmp/pip-LnMs7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:04 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)) 12:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:04 INFO - Running setup.py (path:/tmp/pip-6qKlxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:04 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)) 12:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:04 INFO - Running setup.py (path:/tmp/pip-086_mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:04 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)) 12:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:04 INFO - Running setup.py (path:/tmp/pip-YfkR2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:04 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)) 12:17:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:04 INFO - Running setup.py (path:/tmp/pip-Ulfqrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 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)) 12:17:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:05 INFO - Downloading blessings-1.5.1.tar.gz 12:17:05 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 12:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:17:06 INFO - Installing collected packages: blessings 12:17:06 INFO - Running setup.py install for blessings 12:17:06 INFO - Successfully installed blessings 12:17:06 INFO - Cleaning up... 12:17:06 INFO - Return code: 0 12:17:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:06 INFO - Reading from file tmpfile_stdout 12:17:06 INFO - Current package versions: 12:17:06 INFO - argparse == 1.2.1 12:17:06 INFO - blessings == 1.5.1 12:17:06 INFO - blobuploader == 1.2.4 12:17:06 INFO - docopt == 0.6.1 12:17:06 INFO - manifestparser == 1.1 12:17:06 INFO - mozInstall == 1.12 12:17:06 INFO - mozcrash == 0.16 12:17:06 INFO - mozdebug == 0.1 12:17:06 INFO - mozdevice == 0.47 12:17:06 INFO - mozfile == 1.2 12:17:06 INFO - mozhttpd == 0.7 12:17:06 INFO - mozinfo == 0.9 12:17:06 INFO - mozleak == 0.1 12:17:06 INFO - mozlog == 3.0 12:17:06 INFO - moznetwork == 0.27 12:17:06 INFO - mozprocess == 0.22 12:17:06 INFO - mozprofile == 0.27 12:17:06 INFO - mozrunner == 6.11 12:17:06 INFO - mozscreenshot == 0.1 12:17:06 INFO - mozsystemmonitor == 0.0 12:17:06 INFO - moztest == 0.7 12:17:06 INFO - mozversion == 1.4 12:17:06 INFO - psutil == 3.1.1 12:17:06 INFO - requests == 1.2.3 12:17:06 INFO - wsgiref == 0.1.2 12:17:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fbf51677c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11726c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b2ac0>, '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 0x12b39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b3e50>, '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': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', '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 12:17:06 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 12:17:06 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 12:17:06 INFO - Using env: {'DISPLAY': ':0', 12:17:06 INFO - 'HOME': '/home/cltbld', 12:17:06 INFO - 'LANG': 'en_US.UTF-8', 12:17:06 INFO - 'LANGUAGE': 'en_US:en', 12:17:06 INFO - 'LOGNAME': 'cltbld', 12:17:06 INFO - 'MAIL': '/var/mail/cltbld', 12:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:06 INFO - 'MOZ_NO_REMOTE': '1', 12:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:06 INFO - 'NO_EM_RESTART': '1', 12:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:06 INFO - 'PWD': '/builds/slave/test', 12:17:06 INFO - 'SHELL': '/bin/bash', 12:17:06 INFO - 'SHLVL': '1', 12:17:06 INFO - 'TERM': 'linux', 12:17:06 INFO - 'TMOUT': '86400', 12:17:06 INFO - 'USER': 'cltbld', 12:17:06 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', 12:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:06 INFO - '_': '/tools/buildbot/bin/python'} 12:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 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)) 12:17:06 INFO - Cleaning up... 12:17:06 INFO - Return code: 0 12:17:06 INFO - Running post-action listener: _resource_record_post_action 12:17:06 INFO - Running post-action listener: _start_resource_monitoring 12:17:06 INFO - Starting resource monitoring. 12:17:06 INFO - ##### 12:17:06 INFO - ##### Running install step. 12:17:06 INFO - ##### 12:17:06 INFO - Running pre-action listener: _resource_record_pre_action 12:17:06 INFO - Running main action method: install 12:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:06 INFO - Reading from file tmpfile_stdout 12:17:06 INFO - Detecting whether we're running mozinstall >=1.0... 12:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:17:06 INFO - Reading from file tmpfile_stdout 12:17:06 INFO - Output received: 12:17:06 INFO - Usage: mozinstall [options] installer 12:17:06 INFO - Options: 12:17:06 INFO - -h, --help show this help message and exit 12:17:06 INFO - -d DEST, --destination=DEST 12:17:06 INFO - Directory to install application into. [default: 12:17:06 INFO - "/builds/slave/test"] 12:17:06 INFO - --app=APP Application being installed. [default: firefox] 12:17:06 INFO - mkdir: /builds/slave/test/build/application 12:17:06 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'] 12:17:06 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 12:17:21 INFO - Reading from file tmpfile_stdout 12:17:21 INFO - Output received: 12:17:21 INFO - /builds/slave/test/build/application/firefox/firefox 12:17:21 INFO - Running post-action listener: _resource_record_post_action 12:17:21 INFO - ##### 12:17:21 INFO - ##### Running run-tests step. 12:17:21 INFO - ##### 12:17:21 INFO - Running pre-action listener: _resource_record_pre_action 12:17:21 INFO - Running main action method: run_tests 12:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:17:21 INFO - Python 2.7.3 12:17:21 INFO - Return code: 0 12:17:21 INFO - grabbing minidump binary from tooltool 12:17:21 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')]} 12:17:21 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 0x12b2ac0>, '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 0x12b39a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12b3e50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:17:21 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 12:17:21 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 12:17:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:17:21 INFO - Return code: 0 12:17:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:17:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:17:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:17:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:17:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:17:21 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] in /builds/slave/test/build 12:17:21 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost 12:17:21 INFO - Using env: {'DISPLAY': ':0', 12:17:21 INFO - 'HOME': '/home/cltbld', 12:17:21 INFO - 'LANG': 'en_US.UTF-8', 12:17:21 INFO - 'LANGUAGE': 'en_US:en', 12:17:21 INFO - 'LOGNAME': 'cltbld', 12:17:21 INFO - 'MAIL': '/var/mail/cltbld', 12:17:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:21 INFO - 'MOZ_NO_REMOTE': '1', 12:17:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:21 INFO - 'NO_EM_RESTART': '1', 12:17:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:21 INFO - 'PWD': '/builds/slave/test', 12:17:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:21 INFO - 'SHELL': '/bin/bash', 12:17:21 INFO - 'SHLVL': '1', 12:17:21 INFO - 'TERM': 'linux', 12:17:21 INFO - 'TMOUT': '86400', 12:17:21 INFO - 'USER': 'cltbld', 12:17:21 INFO - 'XDG_SESSION_COOKIE': '801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794', 12:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:21 INFO - '_': '/tools/buildbot/bin/python'} 12:17:21 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost'] with output_timeout 3600 12:17:21 INFO - mozversion INFO | application_buildid: 20151113071449 12:17:21 INFO - mozversion INFO | application_changeset: d1029ba11d5c64c455412a58a2a77d14511286d6 12:17:21 INFO - mozversion INFO | application_display_name: Nightly 12:17:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:17:21 INFO - mozversion INFO | application_name: Firefox 12:17:21 INFO - mozversion INFO | application_remotingname: firefox 12:17:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:17:21 INFO - mozversion INFO | application_vendor: Mozilla 12:17:21 INFO - mozversion INFO | application_version: 45.0a1 12:17:21 INFO - mozversion INFO | platform_buildid: 20151113071449 12:17:21 INFO - mozversion INFO | platform_changeset: d1029ba11d5c64c455412a58a2a77d14511286d6 12:17:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:17:21 INFO - mozversion INFO | platform_version: 45.0a1 12:17:21 INFO - 2015-11-13 12:17:21,279 DEBUG : using testdate: 1447445841 12:17:21 INFO - 2015-11-13 12:17:21,279 DEBUG : actual date: 1447445841 12:17:21 INFO - 2015-11-13 12:17:21,325 INFO : starting webserver on 'localhost:52493' 12:17:21 INFO - 2015-11-13 12:17:21,327 INFO : Starting test suite talos-linux64-ix-006 12:17:21 INFO - 2015-11-13 12:17:21,327 INFO : Starting test dromaeo_css 12:17:21 INFO - 2015-11-13 12:17:21,327 DEBUG : operating with platform_type : linux_ 12:17:21 INFO - 2015-11-13 12:17:21,328 INFO : Initialising browser for dromaeo_css test... 12:17:21 INFO - 2015-11-13 12:17:21,343 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6SKSQF/profile http://localhost:52493/getInfo.html 12:17:25 INFO - 2015-11-13 12:17:25,405 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:17:25 INFO - 2015-11-13 12:17:25,405 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:17:25 INFO - 2015-11-13 12:17:25,405 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:17:25 INFO - 2015-11-13 12:17:25,405 DEBUG : BROWSER_OUTPUT: __metrics 12:17:25 INFO - 2015-11-13 12:17:25,582 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:17:26 INFO - 2015-11-13 12:17:26,963 INFO : Browser initialized. 12:17:26 INFO - 2015-11-13 12:17:26,963 INFO : Running cycle 1/1 for dromaeo_css test... 12:17:26 INFO - 2015-11-13 12:17:26,964 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6SKSQF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:17:38 INFO - 2015-11-13 12:17:38,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 141320192 12:17:38 INFO - 2015-11-13 12:17:38,820 DEBUG : BROWSER_OUTPUT: 12:18:30 INFO - 2015-11-13 12:18:30,194 DEBUG : BROWSER_OUTPUT: 1447445910192 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] 12:20:41 INFO - 2015-11-13 12:20:41,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52493/tests/dromaeo/cssquery-ext.html) 12:20:42 INFO - 2015-11-13 12:20:42,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 246587392 12:20:42 INFO - 2015-11-13 12:20:42,890 DEBUG : BROWSER_OUTPUT: 12:23:45 INFO - 2015-11-13 12:23:45,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/dromaeo/cssquery-ext.html (next: http://localhost:52493/tests/dromaeo/cssquery-jquery.html) 12:23:45 INFO - 2015-11-13 12:23:45,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 218009600 12:23:45 INFO - 2015-11-13 12:23:45,964 DEBUG : BROWSER_OUTPUT: 12:26:48 INFO - 2015-11-13 12:26:48,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52493/tests/dromaeo/cssquery-mootools.html) 12:26:48 INFO - 2015-11-13 12:26:48,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 209567744 12:26:48 INFO - 2015-11-13 12:26:48,658 DEBUG : BROWSER_OUTPUT: 12:29:50 INFO - 2015-11-13 12:29:50,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52493/tests/dromaeo/cssquery-prototype.html) 12:29:51 INFO - 2015-11-13 12:29:51,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 200368128 12:29:51 INFO - 2015-11-13 12:29:51,112 DEBUG : BROWSER_OUTPUT: 12:32:53 INFO - 2015-11-13 12:32:53,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52493/tests/dromaeo/cssquery-yui.html) 12:32:54 INFO - 2015-11-13 12:32:54,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 179621888 12:32:54 INFO - 2015-11-13 12:32:54,448 DEBUG : BROWSER_OUTPUT: 12:35:56 INFO - 2015-11-13 12:35:56,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/dromaeo/cssquery-yui.html (next: http://localhost:52493/tests/dromaeo/cssquery-dojo.html) 12:35:57 INFO - 2015-11-13 12:35:57,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 250990592 12:35:57 INFO - 2015-11-13 12:35:57,205 DEBUG : BROWSER_OUTPUT: 12:35:57 INFO - 2015-11-13 12:35:57,205 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:35:57 INFO - 2015-11-13 12:35:57,205 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:35:57 INFO - 2015-11-13 12:35:57,205 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:35:57 INFO - 2015-11-13 12:35:57,206 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:35:57 INFO - 2015-11-13 12:35:57,207 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2642.550766369717;2721.6461859958204;2723.114987629021;2733.6446261985925;2743.369025124222;4607.815687372509;4612.538746125386;4711.623070154388;4731;4742.264948932917;4659.161350956835;4726.243800991842;4734.100520901026;4743.075100355432;4833.540813622709;4319.71921825082;4337.221739086975;4338.587834155766;4410.669199810027;4454.48773391061;4388.912221755579;4392.12157568486;4434.06884554244;4462.687611867171;4467.0842477292235;4189.958100418988;4228.386883901848;4293.29160688486;4310.3534469829465;4333.674974376934;4333.761643109628;4377.627901628333;4387.890302742425;4408.6032257096695;4418.1384629997165;4182.728122672017;4342.305231162999;4350.369196466526;4363.80362883671;4400.537943515948;4583.9083218335445;4610.9308360374625;4726.243800991859;4740.478547359788;4758.286257061434;5057.797688092472;5058.924116138261;5060.139776238048;5064.442911279756;5098.923516147261;4818.855434336975;4933.901321973541;5080.13637681595;5085.313482679828;5088.516590923857;4650.51169627191;4695.600873925755;4725.480197178376;4746.121967436001;4757.5718185363485;5203.115470370046;5205.193195054772;5217.739113044333;5220.92168617471;5271.077561426735;4815.590674792612;4919.335889654851;4986.077575648516;4989.476105008922;5029.547340739351;4979.203327467588;5011.899762004739;5055.8988820223385;5069.873253168626;5075.644704870698;4986.152354099811;5004;5014.072396606566;5016.423111342169;5033.84898453047;4818.734969576637;4937.580305673986;4979.253112033151;4988.825391111293;4990.5964870271255;4087.693422993287;4134.64855487287;4153.273177193979;4165.333546632524;4182.790860456965;3673.6142705016123;3676.099355657881;3690.095926498025;3707.073231692077;3724.366857634209;4130.772807495617;4351.956480435155;4352.151330490524;4366.235908715962;4381.298992161239;4983;5013.523715247045;5037.596992240612;5135.229715542699;5167.819126330635;4372.912541749147;4412.955870441255;4418.491873434532;4426.778661066934;4465.866024019285;4403.273459879084;4541.9545804542195;4551.294549344857;4553.203189441834;4609.654275929319;4719.1741445247635;4723.45680246776;4735.147673418749;4803.687760295569;4807.375041244755;5057.14028615129;5062.392512898476;5066.36670416198;5073.923891141562;5107.846764597068;4789.616830653609;4793.281007848851;4795.040991801584;4822.059698358787;4844.539768721966;4751.192297309535;4846.466888642317;4847.5394837490385;4915.6313276505125;5020.22186561069;5012.398512178562;5026.84919452417;5034.0938631046765;5036.043151801146;5074.06129865976;4871.732054737024;4873.342098816614;4878.121938051043;4909.140900342497;4914.459409464885;4710.528947105262;4797.928031079607;4800.015996720594;4861.4895435978715;4967.726775027264;4857.028594281229;4905.1416002200185;4906.754662266943;4910.950890491193;4938.629602779878;4976.5023497649945;5008.749562521786;5022.146235139962;5025.522575355335;5067.797288108582;4278.871633850989;4651.813927443;4699.553542413465;4813.109574728686;4820.204666230033 12:35:57 INFO - 2015-11-13 12:35:57,208 DEBUG : BROWSER_OUTPUT: |1;ext.html;543.7906406033677;550.9917351239731;552.2654869024195;554.2379228560729;565.1889538512232;27491;37534.436983445274;38329.425058624074;38360.232795344076;38400.42399364012;40233.396499052535;40722.59277407225;40782.59217407825;40867.79566102173;40872.59127408725;6940.9305906941045;7075.257098004713;8001.479903806234;8208.05607355156;8211.917880821175;10341.638042668508;10561.207909406825;10613.363198208093;10615.416152111631;10619.946900265526;10192.847107293397;10293;10298.12465940396;10299.433531155784;10313.587456501731;7145.821354466154;7332.853342933112;10176.236782241325;10241.180705543538;10534.420606866619;10032.398056116583;10186.38881667095;10198.541065652063;10203.6428724995;10210.234232432524;37011.4448283276;37596.24807503862;37678.811605941795;37718.62281377206;37719.245615087544;2909.5199292116777;2920.751736102434;2993.491106511898;3442.569678790151;3550.8757193498363;26111.08611198618;28163.718362816315;28640.713592864013;28813.711862881522;28918.566221506695;3060.8775648974015;3125.3280544683003;3130.201798541357;3168.3980043791607;3233.919152021195;221098;224388;225561;226040;226829.86585067134;46867.76566117216;48000.27999580009;57580.71209643925;58254.12618810721;59297.70351148216;56114.43885561174;56579.71710141423;56742.71628641913;56776.71611641916;56808.715956419954;13790.172589644653;13925;13951.023428359917;13953.581392558239;13966.511172108927;10482.528286227138;10593.947030264799;10598;10598.682039538826;10652.36085834837;20029.399118026482;20507;20615;20658;20701;8188.795280117925;8419.747407577783;8452.830943381221;8495.66017359311;8550.957245213734;783.7727059152896;818.7502811642387;891.4294851295176;916.9862452063225;945.7399215215734;26049.869750651127;26398.6040209397;26485.735142648326;26768.732312677013;26786.330341741614;915.2677857713802;951.3150531617224;986.363795351994;997.4015590645555;1115.1079136690614;13582.524611638546;13697.657558561115;13825.10136841102;13897;13902.721945561032;255069;258512;259096;259599;259806;45080.77459612681;45606.77196614062;45651.315230271575;45691.40080097181;45712.542874571496;1057.5769692123058;1065.4140222877386;1066.898644628759;1171.3323405658693;1320.5774152271374;23834.284971450885;30002.69997299999;31101.222469438446;31199.220019498785;31324;35441.64558354383;42946.57053429426;43234.56765432305;43361.3495797557;43474;175199;320656;324050;325070;325437;38669.806650966566;39165.216695666495;39547;39594.40608390819;39596.604033959295;41731.58268417277;42108.789456052524;42428.363574547024;42672.359914601926;43102.137957240055;35009.29981400409;35389;36054;36317.81841090778;38139;34221.82889085539;34650;34936.30127397489;34959.825200873835;35489;33765.32469350648;34325;34715.826420867736;34772.65227347694;34790;30481.695183048774;31295.687043129277;31599.36801263916;31741.04776856698;31770.205744856565;24111.156109536783;24151.51696966086;24324.756752432248;24668.50662986766;24679.87660061688 12:35:57 INFO - 2015-11-13 12:35:57,208 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.5228297393239;332.95784195468184;334.15213867313736;334.6803802368738;334.99497507537393;9345.532723363822;9689.854652180224;10786.946065269682;15183.468578599737;15604.687906241883;9966.501674916262;10164.390136591792;10303.330283531584;10303.690889273334;10478.895211047888;4029.4761680981505;4147.834086636531;4166.375043743433;4167.9788451829345;4171.603697648734;3133.0444214514564;3213.0360891732503;4126.112885729567;4532.3881276027805;4686.484486706459;4604.6776725629215;4625.1443482955765;4628.8148474061;4641.466231383383;4647.69789963653;4494.213512635292;4571.542845715435;4575.6568257380495;4615.169269531483;4628.143793398232;3964.8215830287418;3977.3636218204947;3985.3822657488136;3988.6210809973004;3990.980045099785;11537.884621153766;11958.820617690742;11965.641030769091;12425;12431.31627760482;1640.4012535424483;1659.3196789316323;1674.3051633572054;1691.6362981958814;1781.4655603318952;8737.694180703646;8901.955490222572;8930.553472326423;9334.39326443779;9527.237820974306;1601.1513897634156;1635.6156303268722;1661.4018953176846;1672.046933248049;1677.0524653570694;54012.45987540153;54219;54571.727141364434;55239.72380138114;55559;6435.131257280207;6499.675016249169;6518.543701940914;6539.967300163468;6548.410643042149;7485.625718714043;7570.091589009354;7571.848563028709;7583.165851756303;7585.810354741176;5096.464871188546;5150.716710580879;5175.870603234949;5195.7142357170715;5203.412959047527;5167.22491626259;5170.715610641376;5183.248428977777;5199.870003249949;5204.42751297357;2935.9266018349713;2979.6275465566805;3012.051203870774;3012.7891047626895;3016;1013.3210748798323;1054.2620165883911;1055.6094245129198;1056.4823236614156;1106.0985296983094;392.22339767260985;411.83114922881475;415.3561978932703;419.6999145610842;441.31596026159326;10228.693139205836;10355.741106472398;10408.077911214663;10469.986733644293;10883.18376121794;384.9037740564859;391.53602980468236;417.6011908627254;426.7524835595409;427.4934202969491;5710.7430165642645;5712.143178523254;5727.427257274323;5872.794452194153;5892.823215303548;307024;308367;310743;311050;311230;60023;61925;66437.6678116616;70156.298437016;70609;457.3391449355649;467.1218109953266;467.42273292483753;467.84327250370825;469.9154152252559;9743.45222132845;10164.18686505063;10186.592536298465;10383.94808025955;10620.575176992834;30810.84594577013;32038.83980580082;32804.34391312113;33408;33563.83218083894;42644.786776067165;43594.56405435905;44559;44748.32877506905;45354.31968520541;6009.2188015557695;6057.42454466825;6172.290186628596;6220.098085777447;6220.595661282002;11160.665180044612;11244.437778111225;11316.773664526829;11369;11442.199046066695;9642.517874106126;9862.556184971838;9882.160016398686;9892;10076.445795481319;9469.47917864524;9574.95212523933;9704.272179586418;9930.304878658424;10113.949430252802;2397.700287464067;7013.929860701328;8134.796630084295;9012.431457034714;10299.176065914558;5527.336719593674;6079.088136779518;6121.602095863755;6142.938570614237;6144.170536977451;9283.39657922233;9287.956649537091;9447.574859131493;9716.854247186156;9847.803043939224 12:35:57 INFO - 2015-11-13 12:35:57,209 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1462.0642788615294;1625.520471460919;1656.6769479951415;1687.3082036365092;1690.907000114994;6040.214772079629;6602.240742314623;6711.36242057005;6711.832204194891;6722.462203023759;6892.689828957697;6983;7020.929790702092;7035.331643493872;7037.296270372973;2001.9499512512195;2017.6166528359638;2018.7476565429322;2023.0896096756444;2023.3929821053698;1986.741723575933;1990.870593411431;2007.4680209744429;2007.6285887110857;2015.1234213117268;1950.6488832010232;1956.6380219659338;1967.616314818611;1974.5359840437486;1974.9927536956184;1984.5534754680154;1995.0324092814974;1996.3711430899366;1999.1903279171886;2002.7596688397339;1961.7253584498183;1962;1971.5761111360982;1998.7101870228735;1999.8500112491477;5936.1095835625;6181.196444462236;6900.7929762107215;6918.965405172992;6927.515073944826;4153.210889930903;4260.744355338689;4270.017895883933;4274.722143060691;4288.228118938589;2614.0981361430277;2616.1105224223666;2649.894004239828;2657.0833062593374;2740.6026126211586;893.7408151636083;897.9236764874994;910.2399496420497;918.1919910478736;920.1442658327752;9451.33840631156;9484.14642682155;9514.476703781289;9539.47532885691;9581.952090239574;3940.7832569208967;3966.4050392440786;3992.461017762565;3996.1008773025837;4017.5379831319187;8325.666973321;8326.70856520019;8330.708425205088;8332.083470818205;8356.122607126286;4389.231884420214;4389.363542286351;4390.956090439055;4395.912081758347;4397.450318710161;3911.1395492991496;3944.546377166605;3949.2101579684177;3950.940735888964;3953.2093581283857;3132.9686703133134;3150.952735708966;3181.8886338978486;3189.77671562993;3190.680931906837;1030.701096681969;1032.318669678009;1041.7603951091291;1042.0881728487573;1042.11940909931;853.3514528958036;869.6956065377068;873.0222151190707;873.6636394987976;933.3046880074253;6813.284605116491;6865.725370985205;6878.27778083304;6882.03651488792;6883.8967415488805;946.8911075226299;960.6301573894101;1041.6927006533092;1042.166266986408;1061.2147011211648;4979.502049795064;5345.064613692666;5365.946340536622;5369.677819330853;5374.247605335257;7679.961600192075;7680.270374314431;7832.960835195788;7909.485883417559;7913.881291780628;8256.1331060239;8260.380471464665;8350.24847763692;8352.16478352172;8368;6610.0745895574655;6721.563098398588;6737.090492783412;6764.898526522106;6796;6616.106825578678;6659.667016649051;6707.061011458302;6713.227978782503;6725.12573365479;7434.2565743427385;7550.471466997257;7562.319391254813;7634.580098094658;7644.426667999811;7829.765107046797;7843.529388236724;7843.607819609111;7907.367410607023;7955.920440795518;5429.511343979061;5506.889862202654;5739.655620662774;5755.97122014404;5777.104548794776;6939.548929319578;6980.057692211486;6986.091808064919;6997.930020699931;6999.6850141742725;6391.96804015977;6604.603723776589;6632.403083722488;6643.7674681385915;6707.899381509379;6345.809625711236;6423.646699431576;6438.356164383524;6465.2564955030775;6476.481881449567;6433.131527243762;6453.386928241809;6469.902951455826;6470.6441145737435;6483.805485835433;5529.142982837667;5587.580931430078;5599.468050535193;6023.66869822164;6085.908711369421;5999.52003839683;6014.518838492998;6026.7287972040485;6028.125921741411;6051.0923361496125 12:35:57 INFO - 2015-11-13 12:35:57,211 DEBUG : BROWSER_OUTPUT: |4;prototype.html;285.66149113300736;290.58736594036463;291.18468288791377;297.1664481130431;298.11014122843306;5382.62321637485;5442.700651464168;5447.509724124828;5469;5475.644083134598;5400.729963501819;5423.810166644168;5425.2675888755;5433.891322173554;5443.891122177554;4117.608827161415;4154.3976123462235;4156.085661154541;4164.12553363794;4175.540690524055;3933.547642021161;4051.615096565836;4053.1893621275717;4145.3574695922025;4169.562195969425;4112;4129.967508122969;4136.400221967813;4138.8965275868195;4141.316682747343;3890.7665540067687;3976.1053762903116;4118.732282401635;4132.194222126702;4139.834406623761;3541.592716837571;3605.801680907549;3612.6206748291315;3612.9277414451826;3624.4382120771324;5202.947970520284;5214.426413094557;5220.973895130538;5226.451222621608;5236.7905283788605;4772.093302272592;4778.641601879873;4778.80884764609;4786.593139583139;4793.400824896888;5490.423505531901;5682.943170568283;5698.2592263005545;5708.086706127;5713.171590119409;3833;3872.206197729459;3872.457855900176;3874.5737968823405;3875.9031024224337;5889.676067816268;5973.551983601247;5974.462298393122;5989.101634754778;6020.5785595008365;3922;3926.1166237596885;3927;3929.332013557645;3931.272714547818;3903.355946268834;4016.8393264269685;4017.979910100431;4027.637512623878;4031.9395209071886;4691.272852707836;4691.929621055687;4699.154152252628;4702;4705.223638099744;5700.714964251771;5702.971485142548;5744.224529688522;5744.368119506851;5749;1393.7351903138372;1422.317287701909;1422.381264150098;1423.843377228504;1424.3803945283835;919.2829592917535;925.6390007896925;931.7856892914532;934.3646320501988;939.7180845746249;5024.196128619476;5032;5032.672876263031;5037.370328708911;5044.772985215674;5944.167816505693;5952.10718392236;5954;5955;5956.16613674086;5004.524570165829;5008.474110218374;5014.548690617789;5014.648974571745;5025.6482046256415;3132.9060128195733;3180.220845892725;3204.967950320467;3213.6304325002925;3218.2758879251983;5589.5807814413265;5604.607677462538;5604.8038318658655;5609.439056094439;5615.522680572197;6092.482139018233;6095.969520152371;6103.481204097613;6106.053561697944;6106.786262480792;5581.386047534768;5607.719614019201;5609.49514543693;5610.07433773431;5621.887562248814;5783.450572195635;6015.759369625166;6017.939820601913;6023.096535519707;6026.427489388501;5851.795187168429;5856.092305692625;5859.472647461749;5862.501687356623;5863.648181109147;5669.914951275651;5686.203931449518;5687.829365119053;5690.971545142248;5693.971530142323;3827.808609569455;3924.0974575848286;3964.960350396459;3969.6030396960073;3977.980110099431;5939.940600593939;5945.613535120204;5949.19685842423;5949.345571986992;5949.702514874326;5707.914381284201;5714.171445140514;5714.20001199824;5714.999875021771;5716.342620598518;5595.328560572757;5719.2279042328755;5726.112452569859;5726.312842458931;5736.340320863154;5673.432656734293;5677.687727175045;5678.488935995781;5680.289963754531;5682.573806964577;5569.777208911761;5712.343080545625;5770.432157689787;5823.068309070529;5826.184334193132;5551.084071128219;5661.264035675335;5688.317401911797;5695.430456954271;5706.3152421709665 12:35:57 INFO - 2015-11-13 12:35:57,211 DEBUG : BROWSER_OUTPUT: |5;yui.html;636.8789929913316;759.4342215049788;768.5849641193755;770.8304173081922;783.9176886426925;11509.712257193574;11839.348835814028;11839.46722397492;11865.584704535342;11869.287842729442;11709.121815863802;12766;12922.483100675961;12931.547395841148;12932.935335323311;600.3066458240717;608.3126067543692;762.8016715653943;777.5140537164273;778.622368151446;762.211111499598;769.1885061260368;773.9651715672808;774.1561697749452;775.2209029924918;806.9354451643854;811.119934870666;812.4394168024045;812.553095797312;812.6302532347768;620.7392894984117;627.9026750853625;791.0981481111537;806.7902345390182;807.9394045446586;586.2671660424469;586.633354153654;586.8327526654883;586.9559783016248;587.1398401342012;11671.649850504498;11751.294922304603;11758.941205294004;11774.352410617412;11791.764164716658;8912.55437228136;8952.597133129026;9155.176034156957;9256.583453744597;9814.263930205192;8608.784780380478;8767.956160219159;8786.86819697705;8894.377393582452;9423.528823558863;2831.688514263429;2851.1446566030318;2862.7852911031546;2882.164172390025;2925.9612837442614;36861.81569092164;36933.26133477315;37192;37281.06797330089;37284.81357593222;6668.299828518033;6714;6736.7642132525125;6736.932630673728;6778.559393639496;9877.357971731959;9938.850917236246;9952.054554817281;9956.601735930626;9962.302638815214;5601.915971260434;5661.915071273934;5692.800751973661;5739;5749.9425005750245;3474.7567670263343;3502.0894567412656;3561.94657080144;3595.2449985502813;3623.9456408153897;2409.0484258717706;2426.454047839222;2435.671184390085;2438.597631390801;2446.681931348913;373.3745975491042;381.03217826720373;383.58189573365166;388.11509757752367;388.46391979068704;561.8370672505009;566.7647926110618;571.2602180176681;594.4501336264025;595.0687174571781;7771;7782.64978075988;7825.843483130306;7917.3270272026375;8040.8793868092025;532.9546988506021;567.7133047810829;585.2362666719971;592.7836339735966;647.757091090841;3626.4560315952817;3628.8911332660064;3644.0525463379713;3662.6520480554304;3721.7580857244734;51411.48588514142;51573;51875;51946.22080668793;51988.48011519836;45818.541814581426;46165.07669846584;46266;46273.537264627594;46283.07433851372;38782.224355512735;39054.609453905665;39467.60532394697;39829.80085099556;41465;7601.3918886490055;7793.688252469838;8054.436189466681;8089.959550202211;8151.551664658264;31510.684893150774;31785;32610;32768.83615582002;33564.496532551544;42036.3694544576;42212.36681449842;42324;42478.362824557036;42623.57376426196;6822.181338239245;7002.3697867192195;7107.786766397016;7126.073610430611;7139.21468638439;10933.343999360064;10996.395198263852;11135;11231.887681123411;11239.887601123884;10749.441331007116;10800;10829.729256768644;10913.454327283764;11017.779644407226;9811.215102791903;10295.249807532588;10480.63317783874;10521.631742888962;10708.30396024256;10400.895991040295;10797;10998.725031874266;11101.666949991513;11105.666829995112;9205.723828285161;9344.532773361441;9484.02629965462;9543.761405964906;9851.359661622258;8661.566921654017;9018.684346047858;9186.448813071238;9246.722598322061;9257.537123143951 12:35:57 INFO - 2015-11-13 12:35:57,211 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:35:57 INFO - 2015-11-13 12:35:57,211 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:35:57 INFO - 2015-11-13 12:35:57,211 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,903 12:35:57 INFO - 2015-11-13 12:35:57,211 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:35:57 INFO - 2015-11-13 12:35:57,211 DEBUG : BROWSER_OUTPUT: __startTimestamp1447446957204__endTimestamp 12:35:57 INFO - 2015-11-13 12:35:57,211 DEBUG : BROWSER_OUTPUT: 12:35:57 INFO - 2015-11-13 12:35:57,212 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:35:57 INFO - 2015-11-13 12:35:57,212 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:35:57 INFO - 2015-11-13 12:35:57,212 DEBUG : BROWSER_OUTPUT: 12:35:57 INFO - 2015-11-13 12:35:57,213 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4653.69 Median:4789.62 stddev:483.03 (10.1%) stddev-sans-first:458.03 12:35:57 INFO - 2015-11-13 12:35:57,213 DEBUG : BROWSER_OUTPUT: Values: 2642.6 2721.6 2723.1 2733.6 2743.4 4607.8 4612.5 4711.6 4731.0 4742.3 4659.2 4726.2 4734.1 4743.1 4833.5 4319.7 4337.2 4338.6 4410.7 4454.5 4388.9 4392.1 4434.1 4462.7 4467.1 4190.0 4228.4 4293.3 4310.4 4333.7 4333.8 4377.6 4387.9 4408.6 4418.1 4182.7 4342.3 4350.4 4363.8 4400.5 4583.9 4610.9 4726.2 4740.5 4758.3 5057.8 5058.9 5060.1 5064.4 5098.9 4818.9 4933.9 5080.1 5085.3 5088.5 4650.5 4695.6 4725.5 4746.1 4757.6 5203.1 5205.2 5217.7 5220.9 5271.1 4815.6 4919.3 4986.1 4989.5 5029.5 4979.2 5011.9 5055.9 5069.9 5075.6 4986.2 5004.0 5014.1 5016.4 5033.8 4818.7 4937.6 4979.3 4988.8 4990.6 4087.7 4134.6 4153.3 4165.3 4182.8 3673.6 3676.1 3690.1 3707.1 3724.4 4130.8 4352.0 4352.2 4366.2 4381.3 4983.0 5013.5 5037.6 5135.2 5167.8 4372.9 4413.0 4418.5 4426.8 4465.9 4403.3 4542.0 4551.3 4553.2 4609.7 4719.2 4723.5 4735.1 4803.7 4807.4 5057.1 5062.4 5066.4 5073.9 5107.8 4789.6 4793.3 4795.0 4822.1 4844.5 4751.2 4846.5 4847.5 4915.6 5020.2 5012.4 5026.8 5034.1 5036.0 5074.1 4871.7 4873.3 4878.1 4909.1 4914.5 4710.5 4797.9 4800.0 4861.5 4967.7 4857.0 4905.1 4906.8 4911.0 4938.6 4976.5 5008.7 5022.1 5025.5 5067.8 4278.9 4651.8 4699.6 4813.1 4820.2 12:35:57 INFO - 2015-11-13 12:35:57,213 DEBUG : BROWSER_OUTPUT: 12:35:57 INFO - 2015-11-13 12:35:57,213 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42815.09 Median:324560.00 stddev:68540.38 (21.1%) stddev-sans-first:68659.17 12:35:57 INFO - 2015-11-13 12:35:57,213 DEBUG : BROWSER_OUTPUT: Values: 543.8 551.0 552.3 554.2 565.2 27491.0 37534.4 38329.4 38360.2 38400.4 40233.4 40722.6 40782.6 40867.8 40872.6 6940.9 7075.3 8001.5 8208.1 8211.9 10341.6 10561.2 10613.4 10615.4 10619.9 10192.8 10293.0 10298.1 10299.4 10313.6 7145.8 7332.9 10176.2 10241.2 10534.4 10032.4 10186.4 10198.5 10203.6 10210.2 37011.4 37596.2 37678.8 37718.6 37719.2 2909.5 2920.8 2993.5 3442.6 3550.9 26111.1 28163.7 28640.7 28813.7 28918.6 3060.9 3125.3 3130.2 3168.4 3233.9 221098.0 224388.0 225561.0 226040.0 226829.9 46867.8 48000.3 57580.7 58254.1 59297.7 56114.4 56579.7 56742.7 56776.7 56808.7 13790.2 13925.0 13951.0 13953.6 13966.5 10482.5 10593.9 10598.0 10598.7 10652.4 20029.4 20507.0 20615.0 20658.0 20701.0 8188.8 8419.7 8452.8 8495.7 8551.0 783.8 818.8 891.4 917.0 945.7 26049.9 26398.6 26485.7 26768.7 26786.3 915.3 951.3 986.4 997.4 1115.1 13582.5 13697.7 13825.1 13897.0 13902.7 255069.0 258512.0 259096.0 259599.0 259806.0 45080.8 45606.8 45651.3 45691.4 45712.5 1057.6 1065.4 1066.9 1171.3 1320.6 23834.3 30002.7 31101.2 31199.2 31324.0 35441.6 42946.6 43234.6 43361.3 43474.0 175199.0 320656.0 324050.0 325070.0 325437.0 38669.8 39165.2 39547.0 39594.4 39596.6 41731.6 42108.8 42428.4 42672.4 43102.1 35009.3 35389.0 36054.0 36317.8 38139.0 34221.8 34650.0 34936.3 34959.8 35489.0 33765.3 34325.0 34715.8 34772.7 34790.0 30481.7 31295.7 31599.4 31741.0 31770.2 24111.2 24151.5 24324.8 24668.5 24679.9 12:35:57 INFO - 2015-11-13 12:35:57,213 DEBUG : BROWSER_OUTPUT: 12:35:57 INFO - 2015-11-13 12:35:57,213 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:19210.63 Median:44653.66 stddev:51383.44 (115.1%) stddev-sans-first:51508.03 12:35:57 INFO - 2015-11-13 12:35:57,214 DEBUG : BROWSER_OUTPUT: Values: 332.5 333.0 334.2 334.7 335.0 9345.5 9689.9 10786.9 15183.5 15604.7 9966.5 10164.4 10303.3 10303.7 10478.9 4029.5 4147.8 4166.4 4168.0 4171.6 3133.0 3213.0 4126.1 4532.4 4686.5 4604.7 4625.1 4628.8 4641.5 4647.7 4494.2 4571.5 4575.7 4615.2 4628.1 3964.8 3977.4 3985.4 3988.6 3991.0 11537.9 11958.8 11965.6 12425.0 12431.3 1640.4 1659.3 1674.3 1691.6 1781.5 8737.7 8902.0 8930.6 9334.4 9527.2 1601.2 1635.6 1661.4 1672.0 1677.1 54012.5 54219.0 54571.7 55239.7 55559.0 6435.1 6499.7 6518.5 6540.0 6548.4 7485.6 7570.1 7571.8 7583.2 7585.8 5096.5 5150.7 5175.9 5195.7 5203.4 5167.2 5170.7 5183.2 5199.9 5204.4 2935.9 2979.6 3012.1 3012.8 3016.0 1013.3 1054.3 1055.6 1056.5 1106.1 392.2 411.8 415.4 419.7 441.3 10228.7 10355.7 10408.1 10470.0 10883.2 384.9 391.5 417.6 426.8 427.5 5710.7 5712.1 5727.4 5872.8 5892.8 307024.0 308367.0 310743.0 311050.0 311230.0 60023.0 61925.0 66437.7 70156.3 70609.0 457.3 467.1 467.4 467.8 469.9 9743.5 10164.2 10186.6 10383.9 10620.6 30810.8 32038.8 32804.3 33408.0 33563.8 42644.8 43594.6 44559.0 44748.3 45354.3 6009.2 6057.4 6172.3 6220.1 6220.6 11160.7 11244.4 11316.8 11369.0 11442.2 9642.5 9862.6 9882.2 9892.0 10076.4 9469.5 9575.0 9704.3 9930.3 10113.9 2397.7 7013.9 8134.8 9012.4 10299.2 5527.3 6079.1 6121.6 6142.9 6144.2 9283.4 9288.0 9447.6 9716.9 9847.8 12:35:57 INFO - 2015-11-13 12:35:57,215 DEBUG : BROWSER_OUTPUT: 12:35:57 INFO - 2015-11-13 12:35:57,215 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4911.30 Median:6263.50 stddev:2535.82 (40.5%) stddev-sans-first:2529.68 12:35:57 INFO - 2015-11-13 12:35:57,215 DEBUG : BROWSER_OUTPUT: Values: 1462.1 1625.5 1656.7 1687.3 1690.9 6040.2 6602.2 6711.4 6711.8 6722.5 6892.7 6983.0 7020.9 7035.3 7037.3 2001.9 2017.6 2018.7 2023.1 2023.4 1986.7 1990.9 2007.5 2007.6 2015.1 1950.6 1956.6 1967.6 1974.5 1975.0 1984.6 1995.0 1996.4 1999.2 2002.8 1961.7 1962.0 1971.6 1998.7 1999.9 5936.1 6181.2 6900.8 6919.0 6927.5 4153.2 4260.7 4270.0 4274.7 4288.2 2614.1 2616.1 2649.9 2657.1 2740.6 893.7 897.9 910.2 918.2 920.1 9451.3 9484.1 9514.5 9539.5 9582.0 3940.8 3966.4 3992.5 3996.1 4017.5 8325.7 8326.7 8330.7 8332.1 8356.1 4389.2 4389.4 4391.0 4395.9 4397.5 3911.1 3944.5 3949.2 3950.9 3953.2 3133.0 3151.0 3181.9 3189.8 3190.7 1030.7 1032.3 1041.8 1042.1 1042.1 853.4 869.7 873.0 873.7 933.3 6813.3 6865.7 6878.3 6882.0 6883.9 946.9 960.6 1041.7 1042.2 1061.2 4979.5 5345.1 5365.9 5369.7 5374.2 7680.0 7680.3 7833.0 7909.5 7913.9 8256.1 8260.4 8350.2 8352.2 8368.0 6610.1 6721.6 6737.1 6764.9 6796.0 6616.1 6659.7 6707.1 6713.2 6725.1 7434.3 7550.5 7562.3 7634.6 7644.4 7829.8 7843.5 7843.6 7907.4 7955.9 5429.5 5506.9 5739.7 5756.0 5777.1 6939.5 6980.1 6986.1 6997.9 6999.7 6392.0 6604.6 6632.4 6643.8 6707.9 6345.8 6423.6 6438.4 6465.3 6476.5 6433.1 6453.4 6469.9 6470.6 6483.8 5529.1 5587.6 5599.5 6023.7 6085.9 5999.5 6014.5 6026.7 6028.1 6051.1 12:35:57 INFO - 2015-11-13 12:35:57,215 DEBUG : BROWSER_OUTPUT: 12:35:57 INFO - 2015-11-13 12:35:57,215 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4715.49 Median:5443.30 stddev:1423.80 (26.2%) stddev-sans-first:1388.42 12:35:57 INFO - 2015-11-13 12:35:57,215 DEBUG : BROWSER_OUTPUT: Values: 285.7 290.6 291.2 297.2 298.1 5382.6 5442.7 5447.5 5469.0 5475.6 5400.7 5423.8 5425.3 5433.9 5443.9 4117.6 4154.4 4156.1 4164.1 4175.5 3933.5 4051.6 4053.2 4145.4 4169.6 4112.0 4130.0 4136.4 4138.9 4141.3 3890.8 3976.1 4118.7 4132.2 4139.8 3541.6 3605.8 3612.6 3612.9 3624.4 5202.9 5214.4 5221.0 5226.5 5236.8 4772.1 4778.6 4778.8 4786.6 4793.4 5490.4 5682.9 5698.3 5708.1 5713.2 3833.0 3872.2 3872.5 3874.6 3875.9 5889.7 5973.6 5974.5 5989.1 6020.6 3922.0 3926.1 3927.0 3929.3 3931.3 3903.4 4016.8 4018.0 4027.6 4031.9 4691.3 4691.9 4699.2 4702.0 4705.2 5700.7 5703.0 5744.2 5744.4 5749.0 1393.7 1422.3 1422.4 1423.8 1424.4 919.3 925.6 931.8 934.4 939.7 5024.2 5032.0 5032.7 5037.4 5044.8 5944.2 5952.1 5954.0 5955.0 5956.2 5004.5 5008.5 5014.5 5014.6 5025.6 3132.9 3180.2 3205.0 3213.6 3218.3 5589.6 5604.6 5604.8 5609.4 5615.5 6092.5 6096.0 6103.5 6106.1 6106.8 5581.4 5607.7 5609.5 5610.1 5621.9 5783.5 6015.8 6017.9 6023.1 6026.4 5851.8 5856.1 5859.5 5862.5 5863.6 5669.9 5686.2 5687.8 5691.0 5694.0 3827.8 3924.1 3965.0 3969.6 3978.0 5939.9 5945.6 5949.2 5949.3 5949.7 5707.9 5714.2 5714.2 5715.0 5716.3 5595.3 5719.2 5726.1 5726.3 5736.3 5673.4 5677.7 5678.5 5680.3 5682.6 5569.8 5712.3 5770.4 5823.1 5826.2 5551.1 5661.3 5688.3 5695.4 5706.3 12:35:57 INFO - 2015-11-13 12:35:57,215 DEBUG : BROWSER_OUTPUT: 12:35:57 INFO - 2015-11-13 12:35:57,215 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11922.57 Median:3081.88 stddev:14112.95 (457.9%) stddev-sans-first:14127.09 12:35:57 INFO - 2015-11-13 12:35:57,217 DEBUG : BROWSER_OUTPUT: Values: 636.9 759.4 768.6 770.8 783.9 11509.7 11839.3 11839.5 11865.6 11869.3 11709.1 12766.0 12922.5 12931.5 12932.9 600.3 608.3 762.8 777.5 778.6 762.2 769.2 774.0 774.2 775.2 806.9 811.1 812.4 812.6 812.6 620.7 627.9 791.1 806.8 807.9 586.3 586.6 586.8 587.0 587.1 11671.6 11751.3 11758.9 11774.4 11791.8 8912.6 8952.6 9155.2 9256.6 9814.3 8608.8 8768.0 8786.9 8894.4 9423.5 2831.7 2851.1 2862.8 2882.2 2926.0 36861.8 36933.3 37192.0 37281.1 37284.8 6668.3 6714.0 6736.8 6736.9 6778.6 9877.4 9938.9 9952.1 9956.6 9962.3 5601.9 5661.9 5692.8 5739.0 5749.9 3474.8 3502.1 3561.9 3595.2 3623.9 2409.0 2426.5 2435.7 2438.6 2446.7 373.4 381.0 383.6 388.1 388.5 561.8 566.8 571.3 594.5 595.1 7771.0 7782.6 7825.8 7917.3 8040.9 533.0 567.7 585.2 592.8 647.8 3626.5 3628.9 3644.1 3662.7 3721.8 51411.5 51573.0 51875.0 51946.2 51988.5 45818.5 46165.1 46266.0 46273.5 46283.1 38782.2 39054.6 39467.6 39829.8 41465.0 7601.4 7793.7 8054.4 8090.0 8151.6 31510.7 31785.0 32610.0 32768.8 33564.5 42036.4 42212.4 42324.0 42478.4 42623.6 6822.2 7002.4 7107.8 7126.1 7139.2 10933.3 10996.4 11135.0 11231.9 11239.9 10749.4 10800.0 10829.7 10913.5 11017.8 9811.2 10295.2 10480.6 10521.6 10708.3 10400.9 10797.0 10998.7 11101.7 11105.7 9205.7 9344.5 9484.0 9543.8 9851.4 8661.6 9018.7 9186.4 9246.7 9257.5 12:35:57 INFO - 2015-11-13 12:35:57,217 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:35:57 INFO - 2015-11-13 12:35:57,217 DEBUG : BROWSER_OUTPUT: 12:35:57 INFO - 2015-11-13 12:35:57,923 INFO : Browser exited with error code: 0 12:35:57 INFO - 2015-11-13 12:35:57,944 INFO : Completed test dromaeo_css (00:18:36) 12:35:57 INFO - 2015-11-13 12:35:57,944 INFO : Starting test kraken 12:35:57 INFO - 2015-11-13 12:35:57,944 DEBUG : operating with platform_type : linux_ 12:35:57 INFO - 2015-11-13 12:35:57,944 INFO : Initialising browser for kraken test... 12:35:57 INFO - 2015-11-13 12:35:57,950 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9nVhBW/profile http://localhost:52493/getInfo.html 12:36:01 INFO - 2015-11-13 12:36:01,751 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:36:01 INFO - 2015-11-13 12:36:01,751 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:36:01 INFO - 2015-11-13 12:36:01,751 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:36:01 INFO - 2015-11-13 12:36:01,752 DEBUG : BROWSER_OUTPUT: __metrics 12:36:01 INFO - 2015-11-13 12:36:01,868 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:36:03 INFO - 2015-11-13 12:36:03,069 INFO : Browser initialized. 12:36:03 INFO - 2015-11-13 12:36:03,070 INFO : Running cycle 1/1 for kraken test... 12:36:03 INFO - 2015-11-13 12:36:03,070 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9nVhBW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:36:14 INFO - 2015-11-13 12:36:14,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 141819904 12:36:14 INFO - 2015-11-13 12:36:14,990 DEBUG : BROWSER_OUTPUT: 12:36:17 INFO - 2015-11-13 12:36:17,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52493/tests/kraken/driver.html?testName=audio-beat-detection) 12:36:18 INFO - 2015-11-13 12:36:18,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 180666368 12:36:18 INFO - 2015-11-13 12:36:18,174 DEBUG : BROWSER_OUTPUT: 12:36:20 INFO - 2015-11-13 12:36:20,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52493/tests/kraken/driver.html?testName=audio-dft) 12:36:21 INFO - 2015-11-13 12:36:21,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 170180608 12:36:21 INFO - 2015-11-13 12:36:21,484 DEBUG : BROWSER_OUTPUT: 12:36:24 INFO - 2015-11-13 12:36:24,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52493/tests/kraken/driver.html?testName=audio-fft) 12:36:25 INFO - 2015-11-13 12:36:25,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 154251264 12:36:25 INFO - 2015-11-13 12:36:25,092 DEBUG : BROWSER_OUTPUT: 12:36:27 INFO - 2015-11-13 12:36:27,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52493/tests/kraken/driver.html?testName=audio-oscillator) 12:36:27 INFO - 2015-11-13 12:36:27,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 153923584 12:36:27 INFO - 2015-11-13 12:36:27,719 DEBUG : BROWSER_OUTPUT: 12:36:29 INFO - 2015-11-13 12:36:29,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52493/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:36:30 INFO - 2015-11-13 12:36:30,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 155844608 12:36:30 INFO - 2015-11-13 12:36:30,477 DEBUG : BROWSER_OUTPUT: 12:36:33 INFO - 2015-11-13 12:36:33,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52493/tests/kraken/driver.html?testName=imaging-darkroom) 12:36:34 INFO - 2015-11-13 12:36:34,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 155516928 12:36:34 INFO - 2015-11-13 12:36:34,026 DEBUG : BROWSER_OUTPUT: 12:36:37 INFO - 2015-11-13 12:36:37,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52493/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:38 INFO - 2015-11-13 12:36:38,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 156061696 12:36:38 INFO - 2015-11-13 12:36:38,070 DEBUG : BROWSER_OUTPUT: 12:36:40 INFO - 2015-11-13 12:36:40,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52493/tests/kraken/driver.html?testName=json-parse-financial) 12:36:41 INFO - 2015-11-13 12:36:41,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 157007872 12:36:41 INFO - 2015-11-13 12:36:41,481 DEBUG : BROWSER_OUTPUT: 12:36:43 INFO - 2015-11-13 12:36:43,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52493/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:43 INFO - 2015-11-13 12:36:43,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 165826560 12:36:43 INFO - 2015-11-13 12:36:43,797 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-13 12:36:45,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52493/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:46 INFO - 2015-11-13 12:36:46,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 164818944 12:36:46 INFO - 2015-11-13 12:36:46,274 DEBUG : BROWSER_OUTPUT: 12:36:48 INFO - 2015-11-13 12:36:48,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52493/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:48 INFO - 2015-11-13 12:36:48,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 178356224 12:36:48 INFO - 2015-11-13 12:36:48,980 DEBUG : BROWSER_OUTPUT: 12:36:51 INFO - 2015-11-13 12:36:51,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:52 INFO - 2015-11-13 12:36:52,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 180883456 12:36:52 INFO - 2015-11-13 12:36:52,108 DEBUG : BROWSER_OUTPUT: 12:36:54 INFO - 2015-11-13 12:36:54,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:55 INFO - 2015-11-13 12:36:55,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 179998720 12:36:55 INFO - 2015-11-13 12:36:55,256 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52493/tests/kraken/driver.html?testName=ai-astar) 12:36:57 INFO - 2015-11-13 12:36:57,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 237817856 12:36:57 INFO - 2015-11-13 12:36:57,286 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,290 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:36:57 INFO - 2015-11-13 12:36:57,290 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:36:57 INFO - 2015-11-13 12:36:57,290 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:36:57 INFO - 2015-11-13 12:36:57,290 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:36:57 INFO - 2015-11-13 12:36:57,290 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;106;113;113;113;102;113;116;112 12:36:57 INFO - 2015-11-13 12:36:57,290 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;129;152;170;133;156;160;138;178;140 12:36:57 INFO - 2015-11-13 12:36:57,290 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;160;161;162;162;160;161;161 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;73;81;90;73;72;73;92;93;72 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;132;90;92;92;126;91;91;126 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;109;109;110;109;109;109 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;147;146;147;147;148;146 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;69;69;70;69;72;70;77;68;68 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;66;65;66;67;71;66;66;66;66 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;85;84;85;87;84;85;84;85 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;121;127;132;124;125;132;119;125;119 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;144;146;138;145;134;145;143;141;132 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;71;70;67;69;69;70;68;69;68 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,974 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:36:57 INFO - 2015-11-13 12:36:57,291 DEBUG : BROWSER_OUTPUT: __startTimestamp1447447017287__endTimestamp 12:36:57 INFO - 2015-11-13 12:36:57,292 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,295 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:36:57 INFO - 2015-11-13 12:36:57,295 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:36:57 INFO - 2015-11-13 12:36:57,295 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,295 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:4.07 (3.6%) stddev-sans-first:4.31 12:36:57 INFO - 2015-11-13 12:36:57,295 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 106.0 113.0 113.0 113.0 102.0 113.0 116.0 112.0 12:36:57 INFO - 2015-11-13 12:36:57,295 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,295 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.20 Median:156.00 stddev:16.05 (10.3%) stddev-sans-first:16.93 12:36:57 INFO - 2015-11-13 12:36:57,295 DEBUG : BROWSER_OUTPUT: Values: 156.0 129.0 152.0 170.0 133.0 156.0 160.0 138.0 178.0 140.0 12:36:57 INFO - 2015-11-13 12:36:57,295 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,295 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 160.0 161.0 162.0 162.0 160.0 161.0 161.0 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:78.00 stddev:8.88 (11.4%) stddev-sans-first:9.28 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 81.0 90.0 73.0 72.0 73.0 92.0 93.0 72.0 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.30 Median:91.00 stddev:17.82 (19.6%) stddev-sans-first:18.51 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 132.0 90.0 92.0 92.0 126.0 91.0 91.0 126.0 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 148.0 146.0 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:36:57 INFO - 2015-11-13 12:36:57,296 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 12:36:57 INFO - 2015-11-13 12:36:57,297 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,297 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.10 Median:69.50 stddev:2.69 (3.9%) stddev-sans-first:2.82 12:36:57 INFO - 2015-11-13 12:36:57,297 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 69.0 72.0 70.0 77.0 68.0 68.0 12:36:57 INFO - 2015-11-13 12:36:57,297 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,297 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.00 stddev:1.81 (2.7%) stddev-sans-first:1.74 12:36:57 INFO - 2015-11-13 12:36:57,297 DEBUG : BROWSER_OUTPUT: Values: 69.0 66.0 65.0 66.0 67.0 71.0 66.0 66.0 66.0 66.0 12:36:57 INFO - 2015-11-13 12:36:57,297 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,297 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:85.00 stddev:1.57 (1.8%) stddev-sans-first:1.12 12:36:57 INFO - 2015-11-13 12:36:57,297 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 85.0 84.0 85.0 87.0 84.0 85.0 84.0 85.0 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:126.00 stddev:4.88 (3.9%) stddev-sans-first:4.88 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: Values: 130.0 121.0 127.0 132.0 124.0 125.0 132.0 119.0 125.0 119.0 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.40 Median:144.50 stddev:5.08 (3.5%) stddev-sans-first:5.11 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: Values: 146.0 144.0 146.0 138.0 145.0 134.0 145.0 143.0 141.0 132.0 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.32 (1.9%) stddev-sans-first:1.22 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: Values: 67.0 71.0 70.0 67.0 69.0 69.0 70.0 68.0 69.0 68.0 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:36:57 INFO - 2015-11-13 12:36:57,298 DEBUG : BROWSER_OUTPUT: 12:36:58 INFO - 2015-11-13 12:36:58,179 INFO : Browser exited with error code: 0 12:36:58 INFO - 2015-11-13 12:36:58,230 INFO : Completed test kraken (00:01:00) 12:36:58 INFO - 2015-11-13 12:36:58,230 INFO : Starting test v8_7 12:36:58 INFO - 2015-11-13 12:36:58,230 DEBUG : operating with platform_type : linux_ 12:36:58 INFO - 2015-11-13 12:36:58,230 INFO : Initialising browser for v8_7 test... 12:36:58 INFO - 2015-11-13 12:36:58,236 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb3c2Y6/profile http://localhost:52493/getInfo.html 12:37:02 INFO - 2015-11-13 12:37:02,045 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:37:02 INFO - 2015-11-13 12:37:02,045 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:37:02 INFO - 2015-11-13 12:37:02,045 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:37:02 INFO - 2015-11-13 12:37:02,046 DEBUG : BROWSER_OUTPUT: __metrics 12:37:02 INFO - 2015-11-13 12:37:02,203 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:37:02 INFO - 2015-11-13 12:37:02,776 DEBUG : BROWSER_OUTPUT: console.error: 12:37:02 INFO - 2015-11-13 12:37:02,777 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 12:37:02 INFO - 2015-11-13 12:37:02,777 DEBUG : BROWSER_OUTPUT: Stack: 12:37:02 INFO - 2015-11-13 12:37:02,777 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 12:37:02 INFO - 2015-11-13 12:37:02,778 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 12:37:02 INFO - 2015-11-13 12:37:02,778 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 12:37:02 INFO - 2015-11-13 12:37:02,778 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 12:37:02 INFO - 2015-11-13 12:37:02,778 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 12:37:02 INFO - 2015-11-13 12:37:02,778 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 12:37:02 INFO - 2015-11-13 12:37:02,778 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:37:02 INFO - 2015-11-13 12:37:02,779 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 12:37:02 INFO - 2015-11-13 12:37:02,779 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 12:37:02 INFO - 2015-11-13 12:37:02,779 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-13 12:37:03,355 INFO : Browser initialized. 12:37:03 INFO - 2015-11-13 12:37:03,356 INFO : Running cycle 1/1 for v8_7 test... 12:37:03 INFO - 2015-11-13 12:37:03,356 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb3c2Y6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:37:15 INFO - 2015-11-13 12:37:15,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 141053952 12:37:15 INFO - 2015-11-13 12:37:15,262 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52493/tests/v8_7/run.html (next: http://localhost:52493/tests/v8_7/run.html) 12:37:36 INFO - 2015-11-13 12:37:36,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 440217600 12:37:36 INFO - 2015-11-13 12:37:36,958 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,958 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:36 INFO - 2015-11-13 12:37:36,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:36 INFO - 2015-11-13 12:37:36,959 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:36 INFO - 2015-11-13 12:37:36,959 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:36 INFO - 2015-11-13 12:37:36,959 DEBUG : BROWSER_OUTPUT: |0;Richards;169.80811682798438 12:37:36 INFO - 2015-11-13 12:37:36,959 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.6040061633282 12:37:36 INFO - 2015-11-13 12:37:36,959 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.12570781426956 12:37:36 INFO - 2015-11-13 12:37:36,959 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 12:37:36 INFO - 2015-11-13 12:37:36,960 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1976.2845849802372 12:37:36 INFO - 2015-11-13 12:37:36,960 DEBUG : BROWSER_OUTPUT: |5;Earley;807.1025020177563 12:37:36 INFO - 2015-11-13 12:37:36,960 DEBUG : BROWSER_OUTPUT: |6;Boyer;12370.37037037037 12:37:36 INFO - 2015-11-13 12:37:36,960 DEBUG : BROWSER_OUTPUT: |7;RegExp;26710.526315789473 12:37:36 INFO - 2015-11-13 12:37:36,960 DEBUG : BROWSER_OUTPUT: |8;Splay;599.2865636147443 12:37:36 INFO - 2015-11-13 12:37:36,960 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 12:37:36 INFO - 2015-11-13 12:37:36,960 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:36 INFO - 2015-11-13 12:37:36,961 DEBUG : BROWSER_OUTPUT: __startTimestamp1447447056952__endTimestamp 12:37:36 INFO - 2015-11-13 12:37:36,961 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,961 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:36 INFO - 2015-11-13 12:37:36,961 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:37:36 INFO - 2015-11-13 12:37:36,961 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,961 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:169.81 Median:169.81 stddev:0.00 (0.0%) 12:37:36 INFO - 2015-11-13 12:37:36,961 DEBUG : BROWSER_OUTPUT: Values: 169.8 12:37:36 INFO - 2015-11-13 12:37:36,962 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,962 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.60 Median:192.60 stddev:0.00 (0.0%) 12:37:36 INFO - 2015-11-13 12:37:36,962 DEBUG : BROWSER_OUTPUT: Values: 192.6 12:37:36 INFO - 2015-11-13 12:37:36,962 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,962 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.13 Median:283.13 stddev:0.00 (0.0%) 12:37:36 INFO - 2015-11-13 12:37:36,962 DEBUG : BROWSER_OUTPUT: Values: 283.1 12:37:36 INFO - 2015-11-13 12:37:36,962 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,962 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 12:37:36 INFO - 2015-11-13 12:37:36,962 DEBUG : BROWSER_OUTPUT: Values: 5065.7 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1976.28 Median:1976.28 stddev:0.00 (0.0%) 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: Values: 1976.3 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:807.10 Median:807.10 stddev:0.00 (0.0%) 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: Values: 807.1 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: Values: 12370.4 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26710.53 Median:26710.53 stddev:0.00 (0.0%) 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: Values: 26710.5 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:599.29 Median:599.29 stddev:0.00 (0.0%) 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: Values: 599.3 12:37:36 INFO - 2015-11-13 12:37:36,963 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-13 12:37:36,964 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 12:37:36 INFO - 2015-11-13 12:37:36,964 DEBUG : BROWSER_OUTPUT: Values: 4845.4 12:37:36 INFO - 2015-11-13 12:37:36,964 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:36 INFO - 2015-11-13 12:37:36,964 DEBUG : BROWSER_OUTPUT: 12:37:37 INFO - 2015-11-13 12:37:37,867 INFO : Browser exited with error code: 0 12:37:37 INFO - 2015-11-13 12:37:37,879 INFO : Completed test v8_7 (00:00:39) 12:37:37 INFO - 2015-11-13 12:37:37,965 INFO : Completed test suite (00:20:16) 12:37:37 INFO - 2015-11-13 12:37:37,965 DEBUG : Working with test: dromaeo_css 12:37:37 INFO - 2015-11-13 12:37:37,965 DEBUG : Generating results file: dromaeo_css 12:37:37 INFO - 2015-11-13 12:37:37,966 DEBUG : Working with test: kraken 12:37:37 INFO - 2015-11-13 12:37:37,967 DEBUG : Generating results file: kraken 12:37:37 INFO - 2015-11-13 12:37:37,967 INFO : javascript benchmark 12:37:37 INFO - 2015-11-13 12:37:37,967 DEBUG : Working with test: v8_7 12:37:37 INFO - 2015-11-13 12:37:37,967 DEBUG : Generating results file: v8_7 12:37:37 INFO - 2015-11-13 12:37:37,967 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:38 INFO - 2015-11-13 12:37:38,022 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 12:37:38 INFO - 2015-11-13 12:37:38,023 DEBUG : process_Request line: dromaeo_css 5987.82 graph.html#tests=[[72,131,35]] 12:37:38 INFO - 2015-11-13 12:37:38,023 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:38 INFO - 2015-11-13 12:37:38,054 DEBUG : process_Request line: kraken 1513.20 graph.html#tests=[[232,131,35]] 12:37:38 INFO - 2015-11-13 12:37:38,054 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:38 INFO - 2015-11-13 12:37:38,085 DEBUG : process_Request line: v8_7 19670.03 graph.html#tests=[[230,131,35]] 12:37:38 INFO - 2015-11-13 12:37:38,087 INFO : javascript benchmark 12:37:38 INFO - 2015-11-13 12:37:38,091 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [332.5228297393239, 332.95784195468184, 334.15213867313736, 334.6803802368738, 334.99497507537393, 9345.532723363822, 9689.854652180224, 10786.946065269682, 15183.468578599737, 15604.687906241883, 9966.501674916262, 10164.390136591792, 10303.330283531584, 10303.690889273334, 10478.895211047888, 4029.4761680981505, 4147.834086636531, 4166.375043743433, 4167.9788451829345, 4171.603697648734, 3133.0444214514564, 3213.0360891732503, 4126.112885729567, 4532.3881276027805, 4686.484486706459, 4604.6776725629215, 4625.1443482955765, 4628.8148474061, 4641.466231383383, 4647.69789963653, 4494.213512635292, 4571.542845715435, 4575.6568257380495, 4615.169269531483, 4628.143793398232, 3964.8215830287418, 3977.3636218204947, 3985.3822657488136, 3988.6210809973004, 3990.980045099785, 11537.884621153766, 11958.820617690742, 11965.641030769091, 12425.0, 12431.31627760482, 1640.4012535424483, 1659.3196789316323, 1674.3051633572054, 1691.6362981958814, 1781.4655603318952, 8737.694180703646, 8901.955490222572, 8930.553472326423, 9334.39326443779, 9527.237820974306, 1601.1513897634156, 1635.6156303268722, 1661.4018953176846, 1672.046933248049, 1677.0524653570694, 54012.45987540153, 54219.0, 54571.727141364434, 55239.72380138114, 55559.0, 6435.131257280207, 6499.675016249169, 6518.543701940914, 6539.967300163468, 6548.410643042149, 7485.625718714043, 7570.091589009354, 7571.848563028709, 7583.165851756303, 7585.810354741176, 5096.464871188546, 5150.716710580879, 5175.870603234949, 5195.7142357170715, 5203.412959047527, 5167.22491626259, 5170.715610641376, 5183.248428977777, 5199.870003249949, 5204.42751297357, 2935.9266018349713, 2979.6275465566805, 3012.051203870774, 3012.7891047626895, 3016.0, 1013.3210748798323, 1054.2620165883911, 1055.6094245129198, 1056.4823236614156, 1106.0985296983094, 392.22339767260985, 411.83114922881475, 415.3561978932703, 419.6999145610842, 441.31596026159326, 10228.693139205836, 10355.741106472398, 10408.077911214663, 10469.986733644293, 10883.18376121794, 384.9037740564859, 391.53602980468236, 417.6011908627254, 426.7524835595409, 427.4934202969491, 5710.7430165642645, 5712.143178523254, 5727.427257274323, 5872.794452194153, 5892.823215303548, 307024.0, 308367.0, 310743.0, 311050.0, 311230.0, 60023.0, 61925.0, 66437.6678116616, 70156.298437016, 70609.0, 457.3391449355649, 467.1218109953266, 467.42273292483753, 467.84327250370825, 469.9154152252559, 9743.45222132845, 10164.18686505063, 10186.592536298465, 10383.94808025955, 10620.575176992834, 30810.84594577013, 32038.83980580082, 32804.34391312113, 33408.0, 33563.83218083894, 42644.786776067165, 43594.56405435905, 44559.0, 44748.32877506905, 45354.31968520541, 6009.2188015557695, 6057.42454466825, 6172.290186628596, 6220.098085777447, 6220.595661282002, 11160.665180044612, 11244.437778111225, 11316.773664526829, 11369.0, 11442.199046066695, 9642.517874106126, 9862.556184971838, 9882.160016398686, 9892.0, 10076.445795481319, 9469.47917864524, 9574.95212523933, 9704.272179586418, 9930.304878658424, 10113.949430252802, 2397.700287464067, 7013.929860701328, 8134.796630084295, 9012.431457034714, 10299.176065914558, 5527.336719593674, 6079.088136779518, 6121.602095863755, 6142.938570614237, 6144.170536977451, 9283.39657922233, 9287.956649537091, 9447.574859131493, 9716.854247186156, 9847.803043939224], "dojo.html": [2642.550766369717, 2721.6461859958204, 2723.114987629021, 2733.6446261985925, 2743.369025124222, 4607.815687372509, 4612.538746125386, 4711.623070154388, 4731.0, 4742.264948932917, 4659.161350956835, 4726.243800991842, 4734.100520901026, 4743.075100355432, 4833.540813622709, 4319.71921825082, 4337.221739086975, 4338.587834155766, 4410.669199810027, 4454.48773391061, 4388.912221755579, 4392.12157568486, 4434.06884554244, 4462.687611867171, 4467.0842477292235, 4189.958100418988, 4228.386883901848, 4293.29160688486, 4310.3534469829465, 4333.674974376934, 4333.761643109628, 4377.627901628333, 4387.890302742425, 4408.6032257096695, 4418.1384629997165, 4182.728122672017, 4342.305231162999, 4350.369196466526, 4363.80362883671, 4400.537943515948, 4583.9083218335445, 4610.9308360374625, 4726.243800991859, 4740.478547359788, 4758.286257061434, 5057.797688092472, 5058.924116138261, 5060.139776238048, 5064.442911279756, 5098.923516147261, 4818.855434336975, 4933.901321973541, 5080.13637681595, 5085.313482679828, 5088.516590923857, 4650.51169627191, 4695.600873925755, 4725.480197178376, 4746.121967436001, 4757.5718185363485, 5203.115470370046, 5205.193195054772, 5217.739113044333, 5220.92168617471, 5271.077561426735, 4815.590674792612, 4919.335889654851, 4986.077575648516, 4989.476105008922, 5029.547340739351, 4979.203327467588, 5011.899762004739, 5055.8988820223385, 5069.873253168626, 5075.644704870698, 4986.152354099811, 5004.0, 5014.072396606566, 5016.423111342169, 5033.84898453047, 4818.734969576637, 4937.580305673986, 4979.253112033151, 4988.825391111293, 4990.5964870271255, 4087.693422993287, 4134.64855487287, 4153.273177193979, 4165.333546632524, 4182.790860456965, 3673.6142705016123, 3676.099355657881, 3690.095926498025, 3707.073231692077, 3724.366857634209, 4130.772807495617, 4351.956480435155, 4352.151330490524, 4366.235908715962, 4381.298992161239, 4983.0, 5013.523715247045, 5037.596992240612, 5135.229715542699, 5167.819126330635, 4372.912541749147, 4412.955870441255, 4418.491873434532, 4426.778661066934, 4465.866024019285, 4403.273459879084, 4541.9545804542195, 4551.294549344857, 4553.203189441834, 4609.654275929319, 4719.1741445247635, 4723.45680246776, 4735.147673418749, 4803.687760295569, 4807.375041244755, 5057.14028615129, 5062.392512898476, 5066.36670416198, 5073.923891141562, 5107.846764597068, 4789.616830653609, 4793.281007848851, 4795.040991801584, 4822.059698358787, 4844.539768721966, 4751.192297309535, 4846.466888642317, 4847.5394837490385, 4915.6313276505125, 5020.22186561069, 5012.398512178562, 5026.84919452417, 5034.0938631046765, 5036.043151801146, 5074.06129865976, 4871.732054737024, 4873.342098816614, 4878.121938051043, 4909.140900342497, 4914.459409464885, 4710.528947105262, 4797.928031079607, 4800.015996720594, 4861.4895435978715, 4967.726775027264, 4857.028594281229, 4905.1416002200185, 4906.754662266943, 4910.950890491193, 4938.629602779878, 4976.5023497649945, 5008.749562521786, 5022.146235139962, 5025.522575355335, 5067.797288108582, 4278.871633850989, 4651.813927443, 4699.553542413465, 4813.109574728686, 4820.204666230033], "mootools.html": [1462.0642788615294, 1625.520471460919, 1656.6769479951415, 1687.3082036365092, 1690.907000114994, 6040.214772079629, 6602.240742314623, 6711.36242057005, 6711.832204194891, 6722.462203023759, 6892.689828957697, 6983.0, 7020.929790702092, 7035.331643493872, 7037.296270372973, 2001.9499512512195, 2017.6166528359638, 2018.7476565429322, 2023.0896096756444, 2023.3929821053698, 1986.741723575933, 1990.870593411431, 2007.4680209744429, 2007.6285887110857, 2015.1234213117268, 1950.6488832010232, 1956.6380219659338, 1967.616314818611, 1974.5359840437486, 1974.9927536956184, 1984.5534754680154, 1995.0324092814974, 1996.3711430899366, 1999.1903279171886, 2002.7596688397339, 1961.7253584498183, 1962.0, 1971.5761111360982, 1998.7101870228735, 1999.8500112491477, 5936.1095835625, 6181.196444462236, 6900.7929762107215, 6918.965405172992, 6927.515073944826, 4153.210889930903, 4260.744355338689, 4270.017895883933, 4274.722143060691, 4288.228118938589, 2614.0981361430277, 2616.1105224223666, 2649.894004239828, 2657.0833062593374, 2740.6026126211586, 893.7408151636083, 897.9236764874994, 910.2399496420497, 918.1919910478736, 920.1442658327752, 9451.33840631156, 9484.14642682155, 9514.476703781289, 9539.47532885691, 9581.952090239574, 3940.7832569208967, 3966.4050392440786, 3992.461017762565, 3996.1008773025837, 4017.5379831319187, 8325.666973321, 8326.70856520019, 8330.708425205088, 8332.083470818205, 8356.122607126286, 4389.231884420214, 4389.363542286351, 4390.956090439055, 4395.912081758347, 4397.450318710161, 3911.1395492991496, 3944.546377166605, 3949.2101579684177, 3950.940735888964, 3953.2093581283857, 3132.9686703133134, 3150.952735708966, 3181.8886338978486, 3189.77671562993, 3190.680931906837, 1030.701096681969, 1032.318669678009, 1041.7603951091291, 1042.0881728487573, 1042.11940909931, 853.3514528958036, 869.6956065377068, 873.0222151190707, 873.6636394987976, 933.3046880074253, 6813.284605116491, 6865.725370985205, 6878.27778083304, 6882.03651488792, 6883.8967415488805, 946.8911075226299, 960.6301573894101, 1041.6927006533092, 1042.166266986408, 1061.2147011211648, 4979.502049795064, 5345.064613692666, 5365.946340536622, 5369.677819330853, 5374.247605335257, 7679.961600192075, 7680.270374314431, 7832.960835195788, 7909.485883417559, 7913.881291780628, 8256.1331060239, 8260.380471464665, 8350.24847763692, 8352.16478352172, 8368.0, 6610.0745895574655, 6721.563098398588, 6737.090492783412, 6764.898526522106, 6796.0, 6616.106825578678, 6659.667016649051, 6707.061011458302, 6713.227978782503, 6725.12573365479, 7434.2565743427385, 7550.471466997257, 7562.319391254813, 7634.580098094658, 7644.426667999811, 7829.765107046797, 7843.529388236724, 7843.607819609111, 7907.367410607023, 7955.920440795518, 5429.511343979061, 5506.889862202654, 5739.655620662774, 5755.97122014404, 5777.104548794776, 6939.548929319578, 6980.057692211486, 6986.091808064919, 6997.930020699931, 6999.6850141742725, 6391.96804015977, 6604.603723776589, 6632.403083722488, 6643.7674681385915, 6707.899381509379, 6345.809625711236, 6423.646699431576, 6438.356164383524, 6465.2564955030775, 6476.481881449567, 6433.131527243762, 6453.386928241809, 6469.902951455826, 6470.6441145737435, 6483.805485835433, 5529.142982837667, 5587.580931430078, 5599.468050535193, 6023.66869822164, 6085.908711369421, 5999.52003839683, 6014.518838492998, 6026.7287972040485, 6028.125921741411, 6051.0923361496125], "ext.html": [543.7906406033677, 550.9917351239731, 552.2654869024195, 554.2379228560729, 565.1889538512232, 27491.0, 37534.436983445274, 38329.425058624074, 38360.232795344076, 38400.42399364012, 40233.396499052535, 40722.59277407225, 40782.59217407825, 40867.79566102173, 40872.59127408725, 6940.9305906941045, 7075.257098004713, 8001.479903806234, 8208.05607355156, 8211.917880821175, 10341.638042668508, 10561.207909406825, 10613.363198208093, 10615.416152111631, 10619.946900265526, 10192.847107293397, 10293.0, 10298.12465940396, 10299.433531155784, 10313.587456501731, 7145.821354466154, 7332.853342933112, 10176.236782241325, 10241.180705543538, 10534.420606866619, 10032.398056116583, 10186.38881667095, 10198.541065652063, 10203.6428724995, 10210.234232432524, 37011.4448283276, 37596.24807503862, 37678.811605941795, 37718.62281377206, 37719.245615087544, 2909.5199292116777, 2920.751736102434, 2993.491106511898, 3442.569678790151, 3550.8757193498363, 26111.08611198618, 28163.718362816315, 28640.713592864013, 28813.711862881522, 28918.566221506695, 3060.8775648974015, 3125.3280544683003, 3130.201798541357, 3168.3980043791607, 3233.919152021195, 221098.0, 224388.0, 225561.0, 226040.0, 226829.86585067134, 46867.76566117216, 48000.27999580009, 57580.71209643925, 58254.12618810721, 59297.70351148216, 56114.43885561174, 56579.71710141423, 56742.71628641913, 56776.71611641916, 56808.715956419954, 13790.172589644653, 13925.0, 13951.023428359917, 13953.581392558239, 13966.511172108927, 10482.528286227138, 10593.947030264799, 10598.0, 10598.682039538826, 10652.36085834837, 20029.399118026482, 20507.0, 20615.0, 20658.0, 20701.0, 8188.795280117925, 8419.747407577783, 8452.830943381221, 8495.66017359311, 8550.957245213734, 783.7727059152896, 818.7502811642387, 891.4294851295176, 916.9862452063225, 945.7399215215734, 26049.869750651127, 26398.6040209397, 26485.735142648326, 26768.732312677013, 26786.330341741614, 915.2677857713802, 951.3150531617224, 986.363795351994, 997.4015590645555, 1115.1079136690614, 13582.524611638546, 13697.657558561115, 13825.10136841102, 13897.0, 13902.721945561032, 255069.0, 258512.0, 259096.0, 259599.0, 259806.0, 45080.77459612681, 45606.77196614062, 45651.315230271575, 45691.40080097181, 45712.542874571496, 1057.5769692123058, 1065.4140222877386, 1066.898644628759, 1171.3323405658693, 1320.5774152271374, 23834.284971450885, 30002.69997299999, 31101.222469438446, 31199.220019498785, 31324.0, 35441.64558354383, 42946.57053429426, 43234.56765432305, 43361.3495797557, 43474.0, 175199.0, 320656.0, 324050.0, 325070.0, 325437.0, 38669.806650966566, 39165.216695666495, 39547.0, 39594.40608390819, 39596.604033959295, 41731.58268417277, 42108.789456052524, 42428.363574547024, 42672.359914601926, 43102.137957240055, 35009.29981400409, 35389.0, 36054.0, 36317.81841090778, 38139.0, 34221.82889085539, 34650.0, 34936.30127397489, 34959.825200873835, 35489.0, 33765.32469350648, 34325.0, 34715.826420867736, 34772.65227347694, 34790.0, 30481.695183048774, 31295.687043129277, 31599.36801263916, 31741.04776856698, 31770.205744856565, 24111.156109536783, 24151.51696966086, 24324.756752432248, 24668.50662986766, 24679.87660061688], "prototype.html": [285.66149113300736, 290.58736594036463, 291.18468288791377, 297.1664481130431, 298.11014122843306, 5382.62321637485, 5442.700651464168, 5447.509724124828, 5469.0, 5475.644083134598, 5400.729963501819, 5423.810166644168, 5425.2675888755, 5433.891322173554, 5443.891122177554, 4117.608827161415, 4154.3976123462235, 4156.085661154541, 4164.12553363794, 4175.540690524055, 3933.547642021161, 4051.615096565836, 4053.1893621275717, 4145.3574695922025, 4169.562195969425, 4112.0, 4129.967508122969, 4136.400221967813, 4138.8965275868195, 4141.316682747343, 3890.7665540067687, 3976.1053762903116, 4118.732282401635, 4132.194222126702, 4139.834406623761, 3541.592716837571, 3605.801680907549, 3612.6206748291315, 3612.9277414451826, 3624.4382120771324, 5202.947970520284, 5214.426413094557, 5220.973895130538, 5226.451222621608, 5236.7905283788605, 4772.093302272592, 4778.641601879873, 4778.80884764609, 4786.593139583139, 4793.400824896888, 5490.423505531901, 5682.943170568283, 5698.2592263005545, 5708.086706127, 5713.171590119409, 3833.0, 3872.206197729459, 3872.457855900176, 3874.5737968823405, 3875.9031024224337, 5889.676067816268, 5973.551983601247, 5974.462298393122, 5989.101634754778, 6020.5785595008365, 3922.0, 3926.1166237596885, 3927.0, 3929.332013557645, 3931.272714547818, 3903.355946268834, 4016.8393264269685, 4017.979910100431, 4027.637512623878, 4031.9395209071886, 4691.272852707836, 4691.929621055687, 4699.154152252628, 4702.0, 4705.223638099744, 5700.714964251771, 5702.971485142548, 5744.224529688522, 5744.368119506851, 5749.0, 1393.7351903138372, 1422.317287701909, 1422.381264150098, 1423.843377228504, 1424.3803945283835, 919.2829592917535, 925.6390007896925, 931.7856892914532, 934.3646320501988, 939.7180845746249, 5024.196128619476, 5032.0, 5032.672876263031, 5037.370328708911, 5044.772985215674, 5944.167816505693, 5952.10718392236, 5954.0, 5955.0, 5956.16613674086, 5004.524570165829, 5008.474110218374, 5014.548690617789, 5014.648974571745, 5025.6482046256415, 3132.9060128195733, 3180.220845892725, 3204.967950320467, 3213.6304325002925, 3218.2758879251983, 5589.5807814413265, 5604.607677462538, 5604.8038318658655, 5609.439056094439, 5615.522680572197, 6092.482139018233, 6095.969520152371, 6103.481204097613, 6106.053561697944, 6106.786262480792, 5581.386047534768, 5607.719614019201, 5609.49514543693, 5610.07433773431, 5621.887562248814, 5783.450572195635, 6015.759369625166, 6017.939820601913, 6023.096535519707, 6026.427489388501, 5851.795187168429, 5856.092305692625, 5859.472647461749, 5862.501687356623, 5863.648181109147, 5669.914951275651, 5686.203931449518, 5687.829365119053, 5690.971545142248, 5693.971530142323, 3827.808609569455, 3924.0974575848286, 3964.960350396459, 3969.6030396960073, 3977.980110099431, 5939.940600593939, 5945.613535120204, 5949.19685842423, 5949.345571986992, 5949.702514874326, 5707.914381284201, 5714.171445140514, 5714.20001199824, 5714.999875021771, 5716.342620598518, 5595.328560572757, 5719.2279042328755, 5726.112452569859, 5726.312842458931, 5736.340320863154, 5673.432656734293, 5677.687727175045, 5678.488935995781, 5680.289963754531, 5682.573806964577, 5569.777208911761, 5712.343080545625, 5770.432157689787, 5823.068309070529, 5826.184334193132, 5551.084071128219, 5661.264035675335, 5688.317401911797, 5695.430456954271, 5706.3152421709665], "yui.html": [636.8789929913316, 759.4342215049788, 768.5849641193755, 770.8304173081922, 783.9176886426925, 11509.712257193574, 11839.348835814028, 11839.46722397492, 11865.584704535342, 11869.287842729442, 11709.121815863802, 12766.0, 12922.483100675961, 12931.547395841148, 12932.935335323311, 600.3066458240717, 608.3126067543692, 762.8016715653943, 777.5140537164273, 778.622368151446, 762.211111499598, 769.1885061260368, 773.9651715672808, 774.1561697749452, 775.2209029924918, 806.9354451643854, 811.119934870666, 812.4394168024045, 812.553095797312, 812.6302532347768, 620.7392894984117, 627.9026750853625, 791.0981481111537, 806.7902345390182, 807.9394045446586, 586.2671660424469, 586.633354153654, 586.8327526654883, 586.9559783016248, 587.1398401342012, 11671.649850504498, 11751.294922304603, 11758.941205294004, 11774.352410617412, 11791.764164716658, 8912.55437228136, 8952.597133129026, 9155.176034156957, 9256.583453744597, 9814.263930205192, 8608.784780380478, 8767.956160219159, 8786.86819697705, 8894.377393582452, 9423.528823558863, 2831.688514263429, 2851.1446566030318, 2862.7852911031546, 2882.164172390025, 2925.9612837442614, 36861.81569092164, 36933.26133477315, 37192.0, 37281.06797330089, 37284.81357593222, 6668.299828518033, 6714.0, 6736.7642132525125, 6736.932630673728, 6778.559393639496, 9877.357971731959, 9938.850917236246, 9952.054554817281, 9956.601735930626, 9962.302638815214, 5601.915971260434, 5661.915071273934, 5692.800751973661, 5739.0, 5749.9425005750245, 3474.7567670263343, 3502.0894567412656, 3561.94657080144, 3595.2449985502813, 3623.9456408153897, 2409.0484258717706, 2426.454047839222, 2435.671184390085, 2438.597631390801, 2446.681931348913, 373.3745975491042, 381.03217826720373, 383.58189573365166, 388.11509757752367, 388.46391979068704, 561.8370672505009, 566.7647926110618, 571.2602180176681, 594.4501336264025, 595.0687174571781, 7771.0, 7782.64978075988, 7825.843483130306, 7917.3270272026375, 8040.8793868092025, 532.9546988506021, 567.7133047810829, 585.2362666719971, 592.7836339735966, 647.757091090841, 3626.4560315952817, 3628.8911332660064, 3644.0525463379713, 3662.6520480554304, 3721.7580857244734, 51411.48588514142, 51573.0, 51875.0, 51946.22080668793, 51988.48011519836, 45818.541814581426, 46165.07669846584, 46266.0, 46273.537264627594, 46283.07433851372, 38782.224355512735, 39054.609453905665, 39467.60532394697, 39829.80085099556, 41465.0, 7601.3918886490055, 7793.688252469838, 8054.436189466681, 8089.959550202211, 8151.551664658264, 31510.684893150774, 31785.0, 32610.0, 32768.83615582002, 33564.496532551544, 42036.3694544576, 42212.36681449842, 42324.0, 42478.362824557036, 42623.57376426196, 6822.181338239245, 7002.3697867192195, 7107.786766397016, 7126.073610430611, 7139.21468638439, 10933.343999360064, 10996.395198263852, 11135.0, 11231.887681123411, 11239.887601123884, 10749.441331007116, 10800.0, 10829.729256768644, 10913.454327283764, 11017.779644407226, 9811.215102791903, 10295.249807532588, 10480.63317783874, 10521.631742888962, 10708.30396024256, 10400.895991040295, 10797.0, 10998.725031874266, 11101.666949991513, 11105.666829995112, 9205.723828285161, 9344.532773361441, 9484.02629965462, 9543.761405964906, 9851.359661622258, 8661.566921654017, 9018.684346047858, 9186.448813071238, 9246.722598322061, 9257.537123143951]}, "summary": {"lowerIsBetter": false, "suite": 5987.820246071633, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6076.104854712462, "unit": "ms", "value": 6076.104854712462}, "dojo.html": {"lowerIsBetter": false, "filtered": 4623.954810554226, "unit": "ms", "value": 4623.954810554226}, "mootools.html": {"lowerIsBetter": false, "filtered": 4026.093211590207, "unit": "ms", "value": 4026.093211590207}, "ext.html": {"lowerIsBetter": false, "filtered": 17771.10998384972, "unit": "ms", "value": 17771.10998384972}, "prototype.html": {"lowerIsBetter": false, "filtered": 4248.127149483582, "unit": "ms", "value": 4248.127149483582}, "yui.html": {"lowerIsBetter": false, "filtered": 5396.753444210518, "unit": "ms", "value": 5396.753444210518}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-006"}, "testrun": {"date": 1447445841, "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": "20151113071449", "branch": "Mozilla-Inbound-Non-PGO", "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 162.0, 162.0, 160.0, 161.0, 162.0, 162.0, 160.0, 161.0, 161.0], "ai-astar": [111.0, 112.0, 106.0, 113.0, 113.0, 113.0, 102.0, 113.0, 116.0, 112.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "audio-beat-detection": [156.0, 129.0, 152.0, 170.0, 133.0, 156.0, 160.0, 138.0, 178.0, 140.0], "json-stringify-tinderbox": [69.0, 66.0, 65.0, 66.0, 67.0, 71.0, 66.0, 66.0, 66.0, 66.0], "stanford-crypto-pbkdf2": [146.0, 144.0, 146.0, 138.0, 145.0, 134.0, 145.0, 143.0, 141.0, 132.0], "json-parse-financial": [69.0, 69.0, 69.0, 70.0, 69.0, 72.0, 70.0, 77.0, 68.0, 68.0], "stanford-crypto-sha256-iterative": [67.0, 71.0, 70.0, 67.0, 69.0, 69.0, 70.0, 68.0, 69.0, 68.0], "audio-fft": [75.0, 73.0, 81.0, 90.0, 73.0, 72.0, 73.0, 92.0, 93.0, 72.0], "imaging-darkroom": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0], "stanford-crypto-ccm": [130.0, 121.0, 127.0, 132.0, 124.0, 125.0, 132.0, 119.0, 125.0, 119.0], "audio-oscillator": [92.0, 91.0, 132.0, 90.0, 92.0, 92.0, 126.0, 91.0, 91.0, 126.0], "stanford-crypto-aes": [81.0, 83.0, 85.0, 84.0, 85.0, 87.0, 84.0, 85.0, 84.0, 85.0], "imaging-desaturate": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1513.1999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 79.4, "unit": "ms", "value": 79.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 141.4, "unit": "ms", "value": 141.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 151.2, "unit": "ms", "value": 151.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 125.4, "unit": "ms", "value": 125.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.7, "unit": "ms", "value": 146.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 70.1, "unit": "ms", "value": 70.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 102.3, "unit": "ms", "value": 102.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 111.1, "unit": "ms", "value": 111.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.3, "unit": "ms", "value": 161.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 68.8, "unit": "ms", "value": 68.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.8, "unit": "ms", "value": 66.8}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.3, "unit": "ms", "value": 84.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.0, "unit": "ms", "value": 95.0}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-006"}, "testrun": {"date": 1447445841, "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": "20151113071449", "branch": "Mozilla-Inbound-Non-PGO", "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6"}}, {"talos_counters": {}, "results": {"DeltaBlue": [192.6040061633282], "Encrypt": [283.12570781426956], "NavierStokes": [4845.410628019324], "Decrypt": [5065.656565656565], "Splay": [599.2865636147443], "Richards": [169.80811682798438], "RegExp": [26710.526315789473], "Earley": [807.1025020177563], "Boyer": [12370.37037037037], "RayTrace": [1976.2845849802372]}, "summary": {"lowerIsBetter": false, "suite": 19670.03256465504, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 343.2846559999999, "unit": "score", "value": 343.2846559999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 940.1512919999999, "unit": "score", "value": 940.1512919999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.26919242273203, "unit": "score", "value": 306.26919242273203}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.54619940179463, "unit": "score", "value": 52.54619940179463}, "Splay": {"lowerIsBetter": false, "filtered": 135.98002182539685, "unit": "score", "value": 135.98002182539685}, "RegExp": {"lowerIsBetter": false, "filtered": 34.105842364532016, "unit": "score", "value": 34.105842364532016}, "Richards": {"lowerIsBetter": false, "filtered": 207.8934780000001, "unit": "score", "value": 207.8934780000001}, "Earley": {"lowerIsBetter": false, "filtered": 825.7476570000002, "unit": "score", "value": 825.7476570000002}, "Boyer": {"lowerIsBetter": false, "filtered": 53.87575149700595, "unit": "score", "value": 53.87575149700595}, "RayTrace": {"lowerIsBetter": false, "filtered": 374.434434, "unit": "score", "value": 374.434434}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-006"}, "testrun": {"date": 1447445841, "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": "20151113071449", "branch": "Mozilla-Inbound-Non-PGO", "revision": "d1029ba11d5c64c455412a58a2a77d14511286d6"}}] 12:37:38 INFO - RETURN: dromaeo_css: 5987.82 12:37:38 INFO - RETURN: kraken: 1513.20 12:37:38 INFO - RETURN: v8_7: 19670.03 12:37:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19670.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1513.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "5987.82"}}} 12:37:38 INFO - Return code: 0 12:37:38 INFO - # TBPL SUCCESS # 12:37:38 INFO - Running post-action listener: _resource_record_post_action 12:37:38 INFO - Running post-run listener: _resource_record_post_run 12:37:39 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 506830848; Read time: 0; Write time: 557208 12:37:39 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 221954048; Read time: 0; Write time: 331036 12:37:39 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 278962176; Read time: 0; Write time: 171788 12:37:39 INFO - Running post-run listener: _upload_blobber_files 12:37:39 INFO - Blob upload gear active. 12:37:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:37:39 INFO - Copying logs to upload dir... 12:37:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1294.572791 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2015-11-13 12:37:38.866468) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 12:37:38.869565) ========= 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=801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010035 build_url: 'https://queue.taskcluster.net/v1/task/OOG17jUCTP6c4jwOJuo1-g/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-13 12:37:38.920540) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:37:38.920908) ========= 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=801756c90a5e5cfe63934219000001c7-1447443817.561190-786910794 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 12:37:38.971262) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 12:37:38.971658) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 12:37:38.972006) ========= ========= Total master_lag: 0.26 =========