builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1447923529.15 results: success (0) buildid: 20151119001840 builduid: 7f55421e2d2c45c0a4e6450014dd16a6 revision: 6b34afb1a471b35f9c24945eb2ae094b77952526 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.153088) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.153679) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.154112) ========= 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=70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009159 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.223574) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.224031) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.292825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.293234) ========= 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=70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004687 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.354994) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.355395) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.355911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.356381) ========= 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=70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 00:58:49-- 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% 226M=0s 2015-11-19 00:58:49 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.346894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.719649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.720394) ========= 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=70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017404 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.770951) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.771290) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6b34afb1a471b35f9c24945eb2ae094b77952526 --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 6b34afb1a471b35f9c24945eb2ae094b77952526 --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=70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 00:58:49,977 truncating revision to first 12 chars 2015-11-19 00:58:49,977 Setting DEBUG logging. 2015-11-19 00:58:49,978 attempt 1/10 2015-11-19 00:58:49,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6b34afb1a471?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 00:58:50,234 unpacking tar archive at: mozilla-inbound-6b34afb1a471/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:50.348387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:50.348662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:50.358803) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:50.359063) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:50.359614) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-19 00:58:50.359933) ========= /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=70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:58:50 INFO - MultiFileLogger online at 20151119 00:58:50 in /builds/slave/test 00:58:50 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 00:58:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:58:50 INFO - {'append_to_log': False, 00:58:50 INFO - 'base_work_dir': '/builds/slave/test', 00:58:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 00:58:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:58:50 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 00:58:50 INFO - 'buildbot_json_path': 'buildprops.json', 00:58:50 INFO - 'config_files': ('talos/linux_config.py',), 00:58:50 INFO - 'default_actions': ('clobber', 00:58:50 INFO - 'read-buildbot-config', 00:58:50 INFO - 'download-and-extract', 00:58:50 INFO - 'populate-webroot', 00:58:50 INFO - 'create-virtualenv', 00:58:50 INFO - 'install', 00:58:50 INFO - 'run-tests'), 00:58:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:58:50 INFO - 'download_minidump_stackwalk': True, 00:58:50 INFO - 'download_symbols': 'ondemand', 00:58:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:58:50 INFO - 'tooltool.py': '/tools/tooltool.py', 00:58:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:58:50 INFO - '/tools/misc-python/virtualenv.py')}, 00:58:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:58:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:58:50 INFO - 'installer_path': 'installer.exe', 00:58:50 INFO - 'log_level': 'info', 00:58:50 INFO - 'log_name': 'talos', 00:58:50 INFO - 'log_to_console': True, 00:58:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:58:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:58:50 INFO - 'opt_config_files': (), 00:58:50 INFO - 'pip_index': False, 00:58:50 INFO - 'sps_profile': False, 00:58:50 INFO - 'sps_profile_interval': 0, 00:58:50 INFO - 'suite': 'dromaeojs', 00:58:50 INFO - 'system_bits': '64', 00:58:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:58:50 INFO - 'title': 'talos-linux64-ix-015', 00:58:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:58:50 INFO - 'use_talos_json': True, 00:58:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:58:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:58:50 INFO - 'work_dir': 'build'} 00:58:50 INFO - ##### 00:58:50 INFO - ##### Running clobber step. 00:58:50 INFO - ##### 00:58:50 INFO - Running pre-action listener: _resource_record_pre_action 00:58:50 INFO - Running main action method: clobber 00:58:50 INFO - rmtree: /builds/slave/test/build 00:58:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:58:51 INFO - Running post-action listener: _resource_record_post_action 00:58:51 INFO - ##### 00:58:51 INFO - ##### Running read-buildbot-config step. 00:58:51 INFO - ##### 00:58:51 INFO - Running pre-action listener: _resource_record_pre_action 00:58:51 INFO - Running main action method: read_buildbot_config 00:58:51 INFO - Using buildbot properties: 00:58:51 INFO - { 00:58:51 INFO - "properties": { 00:58:51 INFO - "buildnumber": 2898, 00:58:51 INFO - "product": "firefox", 00:58:51 INFO - "script_repo_revision": "production", 00:58:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:58:51 INFO - "repository": "", 00:58:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 00:58:51 INFO - "buildid": "20151119001840", 00:58:51 INFO - "slavename": "talos-linux64-ix-015", 00:58:51 INFO - "pgo_build": "False", 00:58:51 INFO - "basedir": "/builds/slave/test", 00:58:51 INFO - "project": "", 00:58:51 INFO - "platform": "ubuntu64_hw", 00:58:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:58:51 INFO - "slavebuilddir": "test", 00:58:51 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 00:58:51 INFO - "branch": "mozilla-inbound", 00:58:51 INFO - "repo_path": "integration/mozilla-inbound", 00:58:51 INFO - "stage_platform": "linux64", 00:58:51 INFO - "builduid": "7f55421e2d2c45c0a4e6450014dd16a6", 00:58:51 INFO - "revision": "6b34afb1a471b35f9c24945eb2ae094b77952526" 00:58:51 INFO - }, 00:58:51 INFO - "sourcestamp": { 00:58:51 INFO - "repository": "", 00:58:51 INFO - "hasPatch": false, 00:58:51 INFO - "project": "", 00:58:51 INFO - "branch": "mozilla-inbound-linux64-talos", 00:58:51 INFO - "changes": [ 00:58:51 INFO - { 00:58:51 INFO - "category": null, 00:58:51 INFO - "files": [ 00:58:51 INFO - { 00:58:51 INFO - "url": null, 00:58:51 INFO - "name": "https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:58:51 INFO - } 00:58:51 INFO - ], 00:58:51 INFO - "repository": "", 00:58:51 INFO - "rev": "6b34afb1a471b35f9c24945eb2ae094b77952526", 00:58:51 INFO - "who": "lhansen@mozilla.com", 00:58:51 INFO - "when": 1447923470, 00:58:51 INFO - "number": 6681540, 00:58:51 INFO - "comments": "Bug 1214152 - early check that shell is executable. r=terrence", 00:58:51 INFO - "project": "", 00:58:51 INFO - "at": "Thu 19 Nov 2015 00:57:50", 00:58:51 INFO - "branch": "mozilla-inbound-linux64-talos", 00:58:51 INFO - "revlink": "", 00:58:51 INFO - "properties": [ 00:58:51 INFO - [ 00:58:51 INFO - "buildid", 00:58:51 INFO - "20151119001840", 00:58:51 INFO - "Change" 00:58:51 INFO - ], 00:58:51 INFO - [ 00:58:51 INFO - "builduid", 00:58:51 INFO - "7f55421e2d2c45c0a4e6450014dd16a6", 00:58:51 INFO - "Change" 00:58:51 INFO - ], 00:58:51 INFO - [ 00:58:51 INFO - "pgo_build", 00:58:51 INFO - "False", 00:58:51 INFO - "Change" 00:58:51 INFO - ] 00:58:51 INFO - ], 00:58:51 INFO - "revision": "6b34afb1a471b35f9c24945eb2ae094b77952526" 00:58:51 INFO - } 00:58:51 INFO - ], 00:58:51 INFO - "revision": "6b34afb1a471b35f9c24945eb2ae094b77952526" 00:58:51 INFO - } 00:58:51 INFO - } 00:58:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:58:51 INFO - Running post-action listener: _resource_record_post_action 00:58:51 INFO - ##### 00:58:51 INFO - ##### Running download-and-extract step. 00:58:51 INFO - ##### 00:58:51 INFO - Running pre-action listener: _resource_record_pre_action 00:58:51 INFO - Running main action method: download_and_extract 00:58:51 INFO - mkdir: /builds/slave/test/build/tests 00:58: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')]} 00:58:51 INFO - https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:58:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/test_packages.json 00:58:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/test_packages.json 00:58:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:59:11 INFO - Downloaded 1302 bytes. 00:59:11 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:59:11 INFO - Using the following test package requirements: 00:59:11 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:59:11 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:59:11 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:11 INFO - u'jsshell-linux-x86_64.zip'], 00:59:11 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:59:11 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:59:11 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:59:11 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:59:11 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:59:11 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:59:11 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:59:11 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:11 INFO - https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:59:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/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 00:59:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/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 00:59:22 INFO - Downloaded 21322772 bytes. 00:59:22 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 00:59:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:22 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 00:59:24 INFO - Return code: 0 00:59:24 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 00:59:24 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')]} 00:59:24 INFO - https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:59:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/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 00:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/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 00:59:36 INFO - Downloaded 21322772 bytes. 00:59:36 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 00:59:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:36 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 00:59:37 INFO - Return code: 0 00:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:37 INFO - https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/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 00:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/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 00:59:39 INFO - Downloaded 11130997 bytes. 00:59:39 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 00:59:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:39 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 00:59:39 INFO - Return code: 0 00:59: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')]} 00:59:39 INFO - https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/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 00:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/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 00:59:46 INFO - Downloaded 55775041 bytes. 00:59:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:59:46 INFO - mkdir: /builds/slave/test/properties 00:59:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:59:46 INFO - Writing to file /builds/slave/test/properties/build_url 00:59:46 INFO - Contents: 00:59:46 INFO - build_url:https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:59:46 INFO - Running post-action listener: _resource_record_post_action 00:59:46 INFO - Running post-action listener: set_extra_try_arguments 00:59:46 INFO - ##### 00:59:46 INFO - ##### Running populate-webroot step. 00:59:46 INFO - ##### 00:59:46 INFO - Running pre-action listener: _resource_record_pre_action 00:59:46 INFO - Running main action method: populate_webroot 00:59:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:59:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:59:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:59:46 INFO - '../fennec_ids.txt'], 00:59:46 INFO - 'tests': ['tcheck2']}, 00:59:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:59:46 INFO - '--tppagecycles', 00:59:46 INFO - '7'], 00:59:46 INFO - 'tests': ['tsvgm']}}, 00:59:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:59:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:59:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:59:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:59:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:59:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:59:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:59:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:46 INFO - 'talos_options': ['--e10s'], 00:59:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:59:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:46 INFO - 'tests': ['damp', 'tps']}, 00:59:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:46 INFO - 'talos_options': ['--e10s'], 00:59:46 INFO - 'tests': ['damp', 'tps']}, 00:59:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:59:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:59:46 INFO - 'other': {'tests': ['a11yr', 00:59:46 INFO - 'ts_paint', 00:59:46 INFO - 'tpaint', 00:59:46 INFO - 'sessionrestore', 00:59:46 INFO - 'sessionrestore_no_auto_restore']}, 00:59:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:59:46 INFO - 'tests': ['a11yr', 00:59:46 INFO - 'ts_paint', 00:59:46 INFO - 'tpaint', 00:59:46 INFO - 'sessionrestore', 00:59:46 INFO - 'sessionrestore_no_auto_restore']}, 00:59:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:59:46 INFO - 'tests': ['a11yr', 00:59:46 INFO - 'ts_paint', 00:59:46 INFO - 'tpaint', 00:59:46 INFO - 'sessionrestore', 00:59:46 INFO - 'sessionrestore_no_auto_restore']}, 00:59:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:59:46 INFO - 'tests': ['a11yr', 00:59:46 INFO - 'ts_paint', 00:59:46 INFO - 'tpaint', 00:59:46 INFO - 'sessionrestore', 00:59:46 INFO - 'sessionrestore_no_auto_restore']}, 00:59:46 INFO - 'other_l64': {'tests': ['a11yr', 00:59:46 INFO - 'ts_paint', 00:59:46 INFO - 'tpaint', 00:59:46 INFO - 'sessionrestore', 00:59:46 INFO - 'sessionrestore_no_auto_restore']}, 00:59:46 INFO - 'other_nol64': {'tests': ['a11yr', 00:59:46 INFO - 'ts_paint', 00:59:46 INFO - 'tpaint', 00:59:46 INFO - 'sessionrestore', 00:59:46 INFO - 'sessionrestore_no_auto_restore']}, 00:59:46 INFO - 'svgr': {'tests': ['tsvgx', 00:59:46 INFO - 'tsvgr_opacity', 00:59:46 INFO - 'tart', 00:59:46 INFO - 'tscrollx', 00:59:46 INFO - 'cart']}, 00:59:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:59:46 INFO - 'tests': ['tsvgx', 00:59:46 INFO - 'tsvgr_opacity', 00:59:46 INFO - 'tart', 00:59:46 INFO - 'tscrollx', 00:59:46 INFO - 'cart']}, 00:59:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:46 INFO - 'tests': ['tp5o']}, 00:59:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:46 INFO - 'talos_options': ['--e10s'], 00:59:46 INFO - 'tests': ['tp5o']}, 00:59:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:46 INFO - 'talos_options': ['--xperf_path', 00:59:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:59:46 INFO - 'tests': ['tp5n']}, 00:59:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:59:46 INFO - 'talos_options': ['--e10s', 00:59:46 INFO - '--xperf_path', 00:59:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:59:46 INFO - 'tests': ['tp5n']}}, 00:59:46 INFO - 'talos.zip': {'path': '', 00:59:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:59:46 INFO - Running post-action listener: _resource_record_post_action 00:59:46 INFO - ##### 00:59:46 INFO - ##### Running create-virtualenv step. 00:59:46 INFO - ##### 00:59:46 INFO - Running pre-action listener: _resource_record_pre_action 00:59:46 INFO - Running main action method: create_virtualenv 00:59:46 INFO - Creating virtualenv /builds/slave/test/build/venv 00:59:46 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 00:59:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:59:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:59:47 INFO - Using real prefix '/usr' 00:59:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:59:47 INFO - Installing distribute.............................................................................................................................................................................................done. 00:59:49 INFO - Installing pip.................done. 00:59:49 INFO - Return code: 0 00:59:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:49 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 0x7f7f8a795c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a64b70>, '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 0x1ab5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6250>, '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': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', '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 00:59:49 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 00:59:49 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 00:59:49 INFO - Using env: {'DISPLAY': ':0', 00:59:49 INFO - 'HOME': '/home/cltbld', 00:59:49 INFO - 'LANG': 'en_US.UTF-8', 00:59:49 INFO - 'LANGUAGE': 'en_US:en', 00:59:49 INFO - 'LOGNAME': 'cltbld', 00:59:49 INFO - 'MAIL': '/var/mail/cltbld', 00:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:49 INFO - 'MOZ_NO_REMOTE': '1', 00:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:49 INFO - 'NO_EM_RESTART': '1', 00:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:49 INFO - 'PWD': '/builds/slave/test', 00:59:49 INFO - 'SHELL': '/bin/bash', 00:59:49 INFO - 'SHLVL': '1', 00:59:49 INFO - 'TERM': 'linux', 00:59:49 INFO - 'TMOUT': '86400', 00:59:49 INFO - 'USER': 'cltbld', 00:59:49 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', 00:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:49 INFO - '_': '/tools/buildbot/bin/python'} 00:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:49 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 00:59:49 INFO - Cleaning up... 00:59:49 INFO - Return code: 0 00:59:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:49 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 0x7f7f8a795c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a64b70>, '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 0x1ab5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6250>, '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': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', '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 00:59:49 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 00:59:49 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 00:59:49 INFO - Using env: {'DISPLAY': ':0', 00:59:49 INFO - 'HOME': '/home/cltbld', 00:59:49 INFO - 'LANG': 'en_US.UTF-8', 00:59:49 INFO - 'LANGUAGE': 'en_US:en', 00:59:49 INFO - 'LOGNAME': 'cltbld', 00:59:49 INFO - 'MAIL': '/var/mail/cltbld', 00:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:49 INFO - 'MOZ_NO_REMOTE': '1', 00:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:49 INFO - 'NO_EM_RESTART': '1', 00:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:49 INFO - 'PWD': '/builds/slave/test', 00:59:49 INFO - 'SHELL': '/bin/bash', 00:59:49 INFO - 'SHLVL': '1', 00:59:49 INFO - 'TERM': 'linux', 00:59:49 INFO - 'TMOUT': '86400', 00:59:49 INFO - 'USER': 'cltbld', 00:59:49 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', 00:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:49 INFO - '_': '/tools/buildbot/bin/python'} 00:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:49 INFO - Downloading/unpacking psutil>=0.7.1 00:59:49 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 00:59:49 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 00:59:49 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 00:59:49 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 00:59:49 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 00:59:49 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 00:59:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:59:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:59:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:59:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:59:51 INFO - Installing collected packages: psutil 00:59:51 INFO - Running setup.py install for psutil 00:59:51 INFO - building 'psutil._psutil_linux' extension 00:59:51 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 00:59:51 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 00:59:52 INFO - building 'psutil._psutil_posix' extension 00:59:52 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 00:59:52 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 00:59:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:59:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:59:52 INFO - Successfully installed psutil 00:59:52 INFO - Cleaning up... 00:59:52 INFO - Return code: 0 00:59:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:59: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')]} 00:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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')]} 00:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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', '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 0x7f7f8a795c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a64b70>, '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 0x1ab5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6250>, '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': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', '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 00:59: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:59: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 mozsystemmonitor==0.0.0 00:59:52 INFO - Using env: {'DISPLAY': ':0', 00:59:52 INFO - 'HOME': '/home/cltbld', 00:59:52 INFO - 'LANG': 'en_US.UTF-8', 00:59:52 INFO - 'LANGUAGE': 'en_US:en', 00:59:52 INFO - 'LOGNAME': 'cltbld', 00:59:52 INFO - 'MAIL': '/var/mail/cltbld', 00:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:52 INFO - 'MOZ_NO_REMOTE': '1', 00:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:52 INFO - 'NO_EM_RESTART': '1', 00:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:52 INFO - 'PWD': '/builds/slave/test', 00:59:52 INFO - 'SHELL': '/bin/bash', 00:59:52 INFO - 'SHLVL': '1', 00:59:52 INFO - 'TERM': 'linux', 00:59:52 INFO - 'TMOUT': '86400', 00:59:52 INFO - 'USER': 'cltbld', 00:59:52 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', 00:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:52 INFO - '_': '/tools/buildbot/bin/python'} 00:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:59:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:59:54 INFO - Installing collected packages: mozsystemmonitor 00:59:54 INFO - Running setup.py install for mozsystemmonitor 00:59:54 INFO - Successfully installed mozsystemmonitor 00:59:54 INFO - Cleaning up... 00:59:54 INFO - Return code: 0 00:59:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:59: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')]} 00:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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')]} 00:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59: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', '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 0x7f7f8a795c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a64b70>, '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 0x1ab5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6250>, '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': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', '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 00:59: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:59: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 blobuploader==1.2.4 00:59:54 INFO - Using env: {'DISPLAY': ':0', 00:59:54 INFO - 'HOME': '/home/cltbld', 00:59:54 INFO - 'LANG': 'en_US.UTF-8', 00:59:54 INFO - 'LANGUAGE': 'en_US:en', 00:59:54 INFO - 'LOGNAME': 'cltbld', 00:59:54 INFO - 'MAIL': '/var/mail/cltbld', 00:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:54 INFO - 'MOZ_NO_REMOTE': '1', 00:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:54 INFO - 'NO_EM_RESTART': '1', 00:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:54 INFO - 'PWD': '/builds/slave/test', 00:59:54 INFO - 'SHELL': '/bin/bash', 00:59:54 INFO - 'SHLVL': '1', 00:59:54 INFO - 'TERM': 'linux', 00:59:54 INFO - 'TMOUT': '86400', 00:59:54 INFO - 'USER': 'cltbld', 00:59:54 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', 00:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:54 INFO - '_': '/tools/buildbot/bin/python'} 00:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:54 INFO - Downloading/unpacking blobuploader==1.2.4 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59:56 INFO - Downloading blobuploader-1.2.4.tar.gz 00:59:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:59:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:59:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59: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 00:59:56 INFO - Downloading docopt-0.6.1.tar.gz 00:59:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:59:56 INFO - Installing collected packages: blobuploader, requests, docopt 00:59:56 INFO - Running setup.py install for blobuploader 00:59:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:59:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:59:57 INFO - Running setup.py install for requests 00:59:57 INFO - Running setup.py install for docopt 00:59:57 INFO - Successfully installed blobuploader requests docopt 00:59:57 INFO - Cleaning up... 00:59:57 INFO - Return code: 0 00:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:59:57 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')]} 00:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:57 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')]} 00:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:59:57 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 0x7f7f8a795c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a64b70>, '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 0x1ab5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6250>, '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': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', '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 00:59:57 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 00:59:57 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 00:59:57 INFO - Using env: {'DISPLAY': ':0', 00:59:57 INFO - 'HOME': '/home/cltbld', 00:59:57 INFO - 'LANG': 'en_US.UTF-8', 00:59:57 INFO - 'LANGUAGE': 'en_US:en', 00:59:57 INFO - 'LOGNAME': 'cltbld', 00:59:57 INFO - 'MAIL': '/var/mail/cltbld', 00:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:57 INFO - 'MOZ_NO_REMOTE': '1', 00:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:59:57 INFO - 'NO_EM_RESTART': '1', 00:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:57 INFO - 'PWD': '/builds/slave/test', 00:59:57 INFO - 'SHELL': '/bin/bash', 00:59:57 INFO - 'SHLVL': '1', 00:59:57 INFO - 'TERM': 'linux', 00:59:57 INFO - 'TMOUT': '86400', 00:59:57 INFO - 'USER': 'cltbld', 00:59:57 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', 00:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:57 INFO - '_': '/tools/buildbot/bin/python'} 00:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:59:57 INFO - Running setup.py (path:/tmp/pip-CF7xsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:59:57 INFO - Running setup.py (path:/tmp/pip-dSlXsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:59:57 INFO - Running setup.py (path:/tmp/pip-9da6wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:59:57 INFO - Running setup.py (path:/tmp/pip-UkA9kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:59:58 INFO - Running setup.py (path:/tmp/pip-G8IKrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:59:58 INFO - Running setup.py (path:/tmp/pip-BYXvXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:59:58 INFO - Running setup.py (path:/tmp/pip-rycEnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:59:58 INFO - Running setup.py (path:/tmp/pip-uGFdc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:59:58 INFO - Running setup.py (path:/tmp/pip-4Kg8Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:59:58 INFO - Running setup.py (path:/tmp/pip-DEP_2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:59:58 INFO - Running setup.py (path:/tmp/pip-ku9NoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:59:58 INFO - Running setup.py (path:/tmp/pip-yl9VYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:59:58 INFO - Running setup.py (path:/tmp/pip-RjCWie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:59:58 INFO - Running setup.py (path:/tmp/pip-ULR1Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:58 INFO - Running setup.py (path:/tmp/pip-bUkd64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:59:58 INFO - Running setup.py (path:/tmp/pip-QbqqoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:59:58 INFO - Running setup.py (path:/tmp/pip-aPKOBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:59:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:59:58 INFO - Running setup.py install for manifestparser 00:59:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:59:59 INFO - Running setup.py install for mozcrash 00:59:59 INFO - Running setup.py install for mozdebug 00:59:59 INFO - Running setup.py install for mozdevice 00:59:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:59:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:59:59 INFO - Running setup.py install for mozfile 00:59:59 INFO - Running setup.py install for mozhttpd 00:59:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:59:59 INFO - Running setup.py install for mozinfo 00:59:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:59:59 INFO - Running setup.py install for mozInstall 00:59:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:59:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:59:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:59:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:59:59 INFO - Running setup.py install for mozleak 00:59:59 INFO - Running setup.py install for mozlog 01:00:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:00:00 INFO - Running setup.py install for moznetwork 01:00:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:00:00 INFO - Running setup.py install for mozprocess 01:00:00 INFO - Running setup.py install for mozprofile 01:00:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:00:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:00:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:00:00 INFO - Running setup.py install for mozrunner 01:00:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:00:00 INFO - Running setup.py install for mozscreenshot 01:00:00 INFO - Running setup.py install for moztest 01:00:00 INFO - Running setup.py install for mozversion 01:00:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:00:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:00:00 INFO - Cleaning up... 01:00:00 INFO - Return code: 0 01:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:00 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 0x7f7f8a795c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a64b70>, '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 0x1ab5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6250>, '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': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', '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 01:00:00 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 01:00:00 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 01:00:00 INFO - Using env: {'DISPLAY': ':0', 01:00:00 INFO - 'HOME': '/home/cltbld', 01:00:00 INFO - 'LANG': 'en_US.UTF-8', 01:00:00 INFO - 'LANGUAGE': 'en_US:en', 01:00:00 INFO - 'LOGNAME': 'cltbld', 01:00:00 INFO - 'MAIL': '/var/mail/cltbld', 01:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:00 INFO - 'MOZ_NO_REMOTE': '1', 01:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:00 INFO - 'NO_EM_RESTART': '1', 01:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:00 INFO - 'PWD': '/builds/slave/test', 01:00:00 INFO - 'SHELL': '/bin/bash', 01:00:00 INFO - 'SHLVL': '1', 01:00:00 INFO - 'TERM': 'linux', 01:00:00 INFO - 'TMOUT': '86400', 01:00:00 INFO - 'USER': 'cltbld', 01:00:00 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', 01:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:00 INFO - '_': '/tools/buildbot/bin/python'} 01:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:01 INFO - Running setup.py (path:/tmp/pip-VHyJgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:01 INFO - Running setup.py (path:/tmp/pip-5nHYQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:01 INFO - Running setup.py (path:/tmp/pip-aiJFE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:01 INFO - Running setup.py (path:/tmp/pip-vxBsIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:01 INFO - Running setup.py (path:/tmp/pip-uf2Z_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:01 INFO - Running setup.py (path:/tmp/pip-3sHqOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:01 INFO - Running setup.py (path:/tmp/pip-VNNe29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:01 INFO - Running setup.py (path:/tmp/pip-hOXQ8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:01 INFO - Running setup.py (path:/tmp/pip-LdXuMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:01 INFO - Running setup.py (path:/tmp/pip-5mAvMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:01 INFO - Running setup.py (path:/tmp/pip-RUvRWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:01 INFO - Running setup.py (path:/tmp/pip-LIbwwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:01 INFO - Running setup.py (path:/tmp/pip-ioQOF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:01 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)) 01:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:01 INFO - Running setup.py (path:/tmp/pip-azqR9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:02 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)) 01:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:02 INFO - Running setup.py (path:/tmp/pip-kDXRWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:02 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)) 01:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:02 INFO - Running setup.py (path:/tmp/pip-L2YoHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:02 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)) 01:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:02 INFO - Running setup.py (path:/tmp/pip-YIojjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:02 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)) 01:00:02 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)) 01:00:02 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)) 01:00:02 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)) 01:00:02 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)) 01:00:02 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)) 01:00:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:00:02 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 01:00:02 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 01:00:02 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 01:00:02 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 01:00:02 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 01:00:02 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 01:00:04 INFO - Downloading blessings-1.5.1.tar.gz 01:00:04 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 01:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:00:04 INFO - Installing collected packages: blessings 01:00:04 INFO - Running setup.py install for blessings 01:00:04 INFO - Successfully installed blessings 01:00:04 INFO - Cleaning up... 01:00:04 INFO - Return code: 0 01:00:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:04 INFO - Reading from file tmpfile_stdout 01:00:04 INFO - Current package versions: 01:00:04 INFO - argparse == 1.2.1 01:00:04 INFO - blessings == 1.5.1 01:00:04 INFO - blobuploader == 1.2.4 01:00:04 INFO - docopt == 0.6.1 01:00:04 INFO - manifestparser == 1.1 01:00:04 INFO - mozInstall == 1.12 01:00:04 INFO - mozcrash == 0.16 01:00:04 INFO - mozdebug == 0.1 01:00:04 INFO - mozdevice == 0.47 01:00:04 INFO - mozfile == 1.2 01:00:04 INFO - mozhttpd == 0.7 01:00:04 INFO - mozinfo == 0.9 01:00:04 INFO - mozleak == 0.1 01:00:04 INFO - mozlog == 3.0 01:00:04 INFO - moznetwork == 0.27 01:00:04 INFO - mozprocess == 0.22 01:00:04 INFO - mozprofile == 0.27 01:00:04 INFO - mozrunner == 6.11 01:00:04 INFO - mozscreenshot == 0.1 01:00:04 INFO - mozsystemmonitor == 0.0 01:00:04 INFO - moztest == 0.7 01:00:04 INFO - mozversion == 1.4 01:00:04 INFO - psutil == 3.1.1 01:00:04 INFO - requests == 1.2.3 01:00:04 INFO - wsgiref == 0.1.2 01:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f7f8a795c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a1e900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a64b70>, '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 0x1ab5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6250>, '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': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', '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 01:00:04 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 01:00:04 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 01:00:04 INFO - Using env: {'DISPLAY': ':0', 01:00:04 INFO - 'HOME': '/home/cltbld', 01:00:04 INFO - 'LANG': 'en_US.UTF-8', 01:00:04 INFO - 'LANGUAGE': 'en_US:en', 01:00:04 INFO - 'LOGNAME': 'cltbld', 01:00:04 INFO - 'MAIL': '/var/mail/cltbld', 01:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:04 INFO - 'MOZ_NO_REMOTE': '1', 01:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:04 INFO - 'NO_EM_RESTART': '1', 01:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:04 INFO - 'PWD': '/builds/slave/test', 01:00:04 INFO - 'SHELL': '/bin/bash', 01:00:04 INFO - 'SHLVL': '1', 01:00:04 INFO - 'TERM': 'linux', 01:00:04 INFO - 'TMOUT': '86400', 01:00:04 INFO - 'USER': 'cltbld', 01:00:04 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', 01:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:04 INFO - '_': '/tools/buildbot/bin/python'} 01:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:04 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)) 01:00:04 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)) 01:00:04 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)) 01:00:04 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)) 01:00:04 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)) 01:00:04 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)) 01:00:04 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)) 01:00:04 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)) 01:00: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:00:04 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)) 01:00:04 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)) 01:00:04 INFO - Cleaning up... 01:00:04 INFO - Return code: 0 01:00:04 INFO - Running post-action listener: _resource_record_post_action 01:00:04 INFO - Running post-action listener: _start_resource_monitoring 01:00:04 INFO - Starting resource monitoring. 01:00:04 INFO - ##### 01:00:04 INFO - ##### Running install step. 01:00:04 INFO - ##### 01:00:04 INFO - Running pre-action listener: _resource_record_pre_action 01:00:04 INFO - Running main action method: install 01:00:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:05 INFO - Reading from file tmpfile_stdout 01:00:05 INFO - Detecting whether we're running mozinstall >=1.0... 01:00:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:00:05 INFO - Reading from file tmpfile_stdout 01:00:05 INFO - Output received: 01:00:05 INFO - Usage: mozinstall [options] installer 01:00:05 INFO - Options: 01:00:05 INFO - -h, --help show this help message and exit 01:00:05 INFO - -d DEST, --destination=DEST 01:00:05 INFO - Directory to install application into. [default: 01:00:05 INFO - "/builds/slave/test"] 01:00:05 INFO - --app=APP Application being installed. [default: firefox] 01:00:05 INFO - mkdir: /builds/slave/test/build/application 01:00:05 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'] 01:00:05 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 01:00:19 INFO - Reading from file tmpfile_stdout 01:00:19 INFO - Output received: 01:00:19 INFO - /builds/slave/test/build/application/firefox/firefox 01:00:19 INFO - Running post-action listener: _resource_record_post_action 01:00:19 INFO - ##### 01:00:19 INFO - ##### Running run-tests step. 01:00:19 INFO - ##### 01:00:19 INFO - Running pre-action listener: _resource_record_pre_action 01:00:19 INFO - Running main action method: run_tests 01:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:00:19 INFO - Python 2.7.3 01:00:19 INFO - Return code: 0 01:00:19 INFO - grabbing minidump binary from tooltool 01:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:19 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 0x1a64b70>, '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 0x1ab5dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ab6250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:00:19 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 01:00:19 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 01:00:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:00:19 INFO - Return code: 0 01:00:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:00:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:00:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:00:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:00:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:00:19 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/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test/build 01:00:19 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/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 01:00:19 INFO - Using env: {'DISPLAY': ':0', 01:00:19 INFO - 'HOME': '/home/cltbld', 01:00:19 INFO - 'LANG': 'en_US.UTF-8', 01:00:19 INFO - 'LANGUAGE': 'en_US:en', 01:00:19 INFO - 'LOGNAME': 'cltbld', 01:00:19 INFO - 'MAIL': '/var/mail/cltbld', 01:00:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:00:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:19 INFO - 'MOZ_NO_REMOTE': '1', 01:00:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:19 INFO - 'NO_EM_RESTART': '1', 01:00:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:19 INFO - 'PWD': '/builds/slave/test', 01:00:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:00:19 INFO - 'SHELL': '/bin/bash', 01:00:19 INFO - 'SHLVL': '1', 01:00:19 INFO - 'TERM': 'linux', 01:00:19 INFO - 'TMOUT': '86400', 01:00:19 INFO - 'USER': 'cltbld', 01:00:19 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930', 01:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:19 INFO - '_': '/tools/buildbot/bin/python'} 01:00:19 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/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 01:00:19 INFO - mozversion INFO | application_buildid: 20151119001840 01:00:19 INFO - mozversion INFO | application_changeset: 6b34afb1a471b35f9c24945eb2ae094b77952526 01:00:19 INFO - mozversion INFO | application_display_name: Nightly 01:00:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:00:19 INFO - mozversion INFO | application_name: Firefox 01:00:19 INFO - mozversion INFO | application_remotingname: firefox 01:00:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:00:19 INFO - mozversion INFO | application_vendor: Mozilla 01:00:19 INFO - mozversion INFO | application_version: 45.0a1 01:00:19 INFO - mozversion INFO | platform_buildid: 20151119001840 01:00:19 INFO - mozversion INFO | platform_changeset: 6b34afb1a471b35f9c24945eb2ae094b77952526 01:00:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:00:19 INFO - mozversion INFO | platform_version: 45.0a1 01:00:19 INFO - 2015-11-19 01:00:19,564 DEBUG : using testdate: 1447923619 01:00:19 INFO - 2015-11-19 01:00:19,565 DEBUG : actual date: 1447923619 01:00:19 INFO - 2015-11-19 01:00:19,667 INFO : starting webserver on 'localhost:38824' 01:00:19 INFO - 2015-11-19 01:00:19,668 INFO : Starting test suite talos-linux64-ix-015 01:00:19 INFO - 2015-11-19 01:00:19,668 INFO : Starting test dromaeo_css 01:00:19 INFO - 2015-11-19 01:00:19,668 DEBUG : operating with platform_type : linux_ 01:00:19 INFO - 2015-11-19 01:00:19,669 INFO : Initialising browser for dromaeo_css test... 01:00:19 INFO - 2015-11-19 01:00:19,683 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKvbQxe/profile http://localhost:38824/getInfo.html 01:00:24 INFO - 2015-11-19 01:00:24,970 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:00:24 INFO - 2015-11-19 01:00:24,970 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:00:24 INFO - 2015-11-19 01:00:24,970 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:00:24 INFO - 2015-11-19 01:00:24,971 DEBUG : BROWSER_OUTPUT: __metrics 01:00:25 INFO - 2015-11-19 01:00:25,092 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:00:26 INFO - 2015-11-19 01:00:26,453 INFO : Browser initialized. 01:00:26 INFO - 2015-11-19 01:00:26,453 INFO : Running cycle 1/1 for dromaeo_css test... 01:00:26 INFO - 2015-11-19 01:00:26,454 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKvbQxe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:00:38 INFO - 2015-11-19 01:00:38,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 141488128 01:00:38 INFO - 2015-11-19 01:00:38,335 DEBUG : BROWSER_OUTPUT: 01:01:29 INFO - 2015-11-19 01:01:29,840 DEBUG : BROWSER_OUTPUT: 1447923689836 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] 01:03:42 INFO - 2015-11-19 01:03:42,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38824/tests/dromaeo/cssquery-ext.html) 01:03:43 INFO - 2015-11-19 01:03:43,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 241586176 01:03:43 INFO - 2015-11-19 01:03:43,150 DEBUG : BROWSER_OUTPUT: 01:06:45 INFO - 2015-11-19 01:06:45,686 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-ext.html (next: http://localhost:38824/tests/dromaeo/cssquery-jquery.html) 01:06:46 INFO - 2015-11-19 01:06:46,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 219885568 01:06:46 INFO - 2015-11-19 01:06:46,255 DEBUG : BROWSER_OUTPUT: 01:09:48 INFO - 2015-11-19 01:09:48,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38824/tests/dromaeo/cssquery-mootools.html) 01:09:48 INFO - 2015-11-19 01:09:48,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 217755648 01:09:48 INFO - 2015-11-19 01:09:48,930 DEBUG : BROWSER_OUTPUT: 01:12:50 INFO - 2015-11-19 01:12:50,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38824/tests/dromaeo/cssquery-prototype.html) 01:12:51 INFO - 2015-11-19 01:12:51,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 204627968 01:12:51 INFO - 2015-11-19 01:12:51,411 DEBUG : BROWSER_OUTPUT: 01:15:54 INFO - 2015-11-19 01:15:54,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38824/tests/dromaeo/cssquery-yui.html) 01:15:54 INFO - 2015-11-19 01:15:54,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 204693504 01:15:54 INFO - 2015-11-19 01:15:54,829 DEBUG : BROWSER_OUTPUT: 01:18:57 INFO - 2015-11-19 01:18:57,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/dromaeo/cssquery-yui.html (next: http://localhost:38824/tests/dromaeo/cssquery-dojo.html) 01:18:57 INFO - 2015-11-19 01:18:57,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 249257984 01:18:57 INFO - 2015-11-19 01:18:57,670 DEBUG : BROWSER_OUTPUT: 01:18:57 INFO - 2015-11-19 01:18:57,671 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:18:57 INFO - 2015-11-19 01:18:57,671 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:18:57 INFO - 2015-11-19 01:18:57,671 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:18:57 INFO - 2015-11-19 01:18:57,671 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:18:57 INFO - 2015-11-19 01:18:57,672 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2630.6974697909736;2733.412316351986;2738.1648597177855;2753.655793025873;2763.474939761445;4565.748883811389;4666.859994200179;4750.501197374273;4787.281907713845;4789.137955168068;4655.534446555343;4698.177818881691;4706.223473126938;4769.523047695228;4777.8805529861775;4365.083332500179;4367.170237654851;4389.034412429261;4404.053128577355;4427.2695005324085;4218.599233072869;4395.384646149541;4405.074934263793;4457.353683715859;4488.887777805565;4296.935545966813;4330.783460826946;4377.058932329564;4381.474223093249;4425.468943726742;4393.8462153824785;4404.603585677304;4405.977970110129;4445.955540444586;4446.133004064209;4186.958130418688;4280.143971205771;4384.517703052662;4398.252297109499;4448.132614140244;4555;4584.908301833978;4662.184117779409;4683.063387322515;4695.248760198386;5056.721880296583;5056.797728090872;5069.315642388304;5071.036503064406;5108.64239503235;4924.950750492485;5088.643794934356;5092;5094.4650811664615;5106.64253502255;4699.953000469985;4701.788419521062;4719.150552900511;4720.952790472052;4724.385829842098;5297.761600727977;5310.044192045391;5341.145416733304;5351.464853514617;5356.625036247426;5077.289179514871;5091.389033315952;5095.719735414514;5101.770420331094;5138.845834624967;4898.510148985073;4960.776765045582;4996.7501624918605;5171.2501687255135;5183.274341592105;4985;5107.821226257063;5137.152369859006;5149.819756308511;5158.509941555546;4999.625028122832;5043.142665746758;5048.0913435581215;5049.040682270357;5088.72012039334;4052.250333688277;4203.222403855297;4207.957920420757;4212.87361379153;4250.978745106255;3615.493830863681;3666.2667466506805;3704.481372607837;3711.888643340704;3726.2174943261675;4458.08609235106;4460.397846290774;4469.7988590513505;4482.21561226784;4503.729776213438;4928.162212423897;5180.274761533388;5181.35233095863;5187.118189907725;5189.014087323397;4325.956740432618;4374.912501750011;4390.034192477649;4403.383526306319;4430.556944305608;4516.683832131719;4539.251023581072;4540.341650460665;4547.749873756975;4563.38394316763;4632.629389648888;4843.346148269939;4843.830465933675;4846.29728689338;4885.706857588556;5026.84919452417;5039.193729003342;5070.569001634754;5108.7445627717725;5173.456787037307;4825.565699087099;4829.154897892925;4836.056968891173;4837.395325584302;4867.805287788448;4841.878953026203;5008.874778130576;5037.546620804145;5041.0422019816115;5091.770870310919;5006.574441172541;5028.019536190408;5041.092603331289;5146.228065790161;5173.7671804769625;5013.874653133701;5016.448190698947;5020.648554601289;5027.371578552681;5067.87330316745;4768.690035147704;5001;5003.899922001612;5014.373203349582;5014.874628134326;4744.715317080986;4760.381150450419;4816.566509014206;4837.564619184291;4859.052484765578;5015.322931404359;5024.6231532634465;5025.271335656383;5027.371578552681;5027.7234752087525;4682.367880336247;4923.753812309298;4926;4927.162382395073;4965.329680493087 01:18:57 INFO - 2015-11-19 01:18:57,676 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.5963706131583;563.6618029182491;566.2864790364141;573.249043752684;578.3869098755317;28382.43235135296;34441.31117377654;34767.304653906904;34825.82587087067;34840.47739283913;40056.39915401271;40720.38919416211;40772.18455630886;40825.7958710206;40835.795821020925;7011.0885584873895;7130.2513236110235;7958.16439273878;8131.105578386373;8136.715214967478;9979.15177209938;10220.642277520288;10230.07929286364;10232.74418139545;10235.283530152892;10154.339967902062;10261.076503114718;10275.588976440933;10279.486025698723;10282.074613284803;7204.567725936435;7377.55734655917;9932.602695892156;10071.295009349311;10075.093241608218;9710;9861.063198996084;9864.112229899272;9871;9875.60497580096;34087.82956085228;34449.827750861084;34535.4819677705;34560.30879382423;34583.30833383343;3012.9849350753107;3539.0798392418155;3559.626239244868;3570.4465807799834;3668.52309199805;28215.57676634852;28273.57589636157;28440.431191376058;28440.573391399146;28474.288142796388;3035.2715348316246;3055.5874956880757;3214.1321843102464;3219.5170724391296;3223.62928263248;217946;218029;219316.9034154835;219692;219910;51598.22602660963;53290.20064699033;56641;57515;58424.123638144614;48574.75712621414;49072.754636227306;49126;49275.26087108696;49351.753241234284;12702.682432939066;12754.170978886343;12764.744705106032;12839.101262911694;12841.48634054646;9371.578278977462;9386.249100072115;9387.90612093884;9400.388974716621;9466.006069362618;19352;19534.804651953582;19564.576199165374;19570.119344629526;19678.508037299183;7666.540007599562;7831.6475758591005;7873.685052597946;7923.859009267863;7950.880736788837;819.6352623082671;833.2375876073446;840.2899549880341;844.2823599940002;877.88587483628;26397;26495;26696.19911402661;26736.59895101575;26813.731862681514;952.876126103616;966.0677446264248;1009.4952523738131;1049.3127001813825;1112.9888701113048;12413.75172496563;12494.125411221126;12528.874711252953;12606.495740170474;12688.111832171659;203052;205764;205932;206012;206223;41671.1665766683;41909.371359429635;41980.79009604932;42016.579834201875;42150.367744483854;1147.4090843215752;1171.2328424881716;1179.2747460312019;1179.9587014454453;1197.1619866093943;21133.6829947554;23453;24434.389140271636;26628.201153965412;27013.86493067522;37952.62047379491;38298.80850595729;38380.42429363618;38470.80764596159;38513.229735405694;175912;177451.11274443546;177707;177926;233955;23634.645480317464;28857.422851542433;29290.267743306587;29558.261043474085;29613;34480.482792757626;34692;35121.47317790184;35232.471512926815;35267;28663.713362866103;29066;32496.512552312208;32942.34115317728;32947.34105317928;31890.20274493156;32206.35587288288;32240.516392254605;32359;33460.832695837336;29741.5538766923;29870.701292986792;30006.399872002003;30073.24816879508;30211.09366719002;27281.863590682715;27438.314042149104;28116.297092572848;30129.849350753106;30434.543481847348;23005.309840704136;23540.7520614517;23915.641265381382;25082.498350033264;25334.36664083339 01:18:57 INFO - 2015-11-19 01:18:57,676 DEBUG : BROWSER_OUTPUT: |2;jquery.html;342.878278211235;344.3973047167457;345.8564695651305;347.2880594780702;350.4742885671493;12487.43806528706;12914.547990820323;14916.776248356284;15343.3095510702;16199.190040497986;14925.552233433014;15280.930334876535;15929;16188.35246590138;16198.83801161988;4918.139325618021;4920.384951881015;5037.722925239111;5038.899222015558;5039.622028347871;3587.157018100744;3680.907977300562;3682.171511409938;3688.151725103228;5072.213806859942;3678.337899178147;5592.273004509408;5791.536677065846;5793.304803423595;5797.3043234811885;5344.893102137936;5384.892302153955;5386.138217885159;5413.485718856722;5725.914111288334;4992.90014199714;5117.41149767774;5120.078385890538;5121.052605268;5121.206213036985;18853;19145;19382.321618743277;19388.22447102114;19523.121459534355;1886.6792645250341;1953.1113343428706;1977.6736838421643;1986.1955907857196;2028.5131568423471;12444.315562644051;12588.559400420942;12606.243625382414;12616.936915315457;12624.936875315656;1715.279582575309;1720.1485264794007;1720.3204734130074;1720.3720641965592;1801.261482792062;48929.75535122337;49940.50059499395;52888.735556322354;53732.19401708977;54567.45432545664;6583.604983700898;6688;6702.597844129368;6739.326067393319;6780.457563394916;7919.049714034238;7935.2064793520185;7935.801604959922;7945.602719863984;7948.483348582324;5029.29589857413;5035.597152227813;5049.772760225798;5054.332070416754;5123.077845987758;5054.115529782273;5059.62052846038;5065.8733531662;5072.112380333427;5103.923441148386;3025.7428118609723;3088.444080065565;3112.579801726738;3113.128324069264;3122.7970181938554;1009.9444530550743;1088.1675518228562;1112.3715100967927;1129.5312445335094;1154.3824054131167;422.2210022508467;425.5149129991812;454.6044940901437;457.7711144427786;480.43068963277926;10600.681979540626;10869.239153259196;10969;11411.201215914973;11617.302961822148;391.9333713268751;460.46585960286575;468.5104066250776;468.9882752931136;471.59442879123924;5918.082697181858;6072.605280656743;6079.665618390943;6135.32511423743;6466.579672321284;492253.23594258487;504044;515971;526486;530296;67533.66233168803;69121.65439172872;70572.2942770576;70911.64544177246;71067.64466177636;512.1523877981946;520.2118790033103;520.4483247757389;520.8958208358343;523.0611053159588;10547.103496202908;10622.25644204929;10685.839712404475;10855.891441085803;10877.238593298393;32879;33553.32893342071;34020;34171.82914085513;34453;43982.56017439913;44036.11927761491;44420;44641.33038004497;45240.32139517844;6039.124326972652;6132.938670613236;6148.877022459436;6151.0773383992755;6382.744690212339;11039.116870650168;11240.4379781009;11272.492737826653;11315.321080734853;11401.771964560829;9992.300538962494;10183.236257280882;10210.438425886647;10495.790084198426;10503.212259080752;9996.850047249443;10109.696709098738;10316.329438586468;10318.948405257926;10369.844452333373;8345.66617335324;8582.09887961755;9852.408855468695;10519.646385025231;10536.57853685844;6300.827170201936;6368.554201206057;6434.742610295536;6442.291347951816;6454.096426500199;10164.542595583069;10334.741631458974;10339.327943683937;10435.269531132748;10518.316309440168 01:18:57 INFO - 2015-11-19 01:18:57,679 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1427.0937954398953;1652.7272999955007;1669.9749503757446;1702.8297170282974;1712.1781544858463;6193.628382297065;6406.359364063597;7325.926740732598;7465.850682986337;7467.813304667386;7310.378617817492;7332.266773322665;7354.117505899286;7381.667824947876;7388.039554857861;2087.3842216546154;2100.9684854727193;2103.4320733401973;2104.642210824156;2105.536781907978;2107.420459373669;2132.051237199447;2163.939669561911;2178.8474806763534;2180.160638154306;2096.811286984171;2098.4858709616165;2114.873107613548;2129.350548082834;2130.541933484308;2111.7149184860077;2116.8941552922292;2121.7666056733747;2122.2996411184427;2123.617748805222;2059.104289634014;2063.772984971652;2078.0856423173905;2079.469735217525;2091.288961752996;6104.603200791934;7318.890216646754;7340.632968351614;7369.152547457057;7378.446616503784;3861.9227615447817;4372.191144638252;4469.642428605704;4480.462344518679;4485.282354823245;2808.340040090577;2882.596436498871;2944.1903476543907;2988.4321978823955;2989.5216765317446;905.4702998745742;910.7905181808155;930.2139691960283;930.2836815651978;948.2887834124407;10035.09684128432;10045.045720656526;10083.546240419199;10112.544935477921;10119.24105692076;4013.2776100301644;4034.23349563582;4076.898077548026;4077.796110194538;4132.33882578792;8571.571421428904;8599.441036332744;8616.353773467015;8630.654773809103;8638.870416943751;4272.33778764292;4300.548442413564;4305.7201281917205;4344.543822898613;4353.542877997828;3892.8637497687446;3893.377059670496;3895.2599006188734;3904.824282907219;3913.2369188008634;3457.3085382923014;3457.8098204598987;3473.94789078164;3504.281622267429;3507.631698671603;1104.9060829829555;1110.2339385823757;1112.1769890281296;1115.4422788605698;1120.4005856866538;1017.5370206555999;1032.1742605915238;1041.265907535186;1048.2295512798087;1049.0086867909752;6733.46132309414;6756.2568117507035;6763.425108865703;6780.288069752605;6792.76225332111;377.9640934111255;379.0221229228584;380.27937059272523;380.77724531149033;383.1417624521053;4990.201567749143;5128;5171.81898633546;5174.379074511083;5184.326037615161;7970.515774459584;8732.126787321216;8794.60424280896;8801.691940782042;8801.911980880237;8622.525761083201;8720.738377848675;8727.214550690342;8740.519271440005;8743.169398907094;6924.134483189601;6977.581345119309;7042.823929401806;7046.365827075485;7049.436045116378;6627.966860165669;6659.134312539339;6686.866262674816;6688.163979502562;6695.598264104169;7856.214378562327;7976.322012628992;8036;8075.717349892726;8092;8181.140980197231;8209.671613135646;8218.671253149807;8343.332533397435;8345.248927596545;6233.127362169209;6325.936740632535;6329.7151628175925;6333.081703152925;6333.20834895638;6802.795916122524;6823.761168359282;6849.794506164623;6865;6868;6357.586756860789;6424.775132870327;6461.935380646133;6556.18047744032;6589.077529145828;6414.358564143548;6475.287718350884;6512.185976752906;6536.379043990813;6564.376384243489;6543.1821022372205;6595.175603049619;6596.208454985241;6600.966995164993;6603.867922641424;5886.41135886425;6012.368701286302;6017.578769486269;6022.277326720821;6024.909626355696;6067.605605635619;6125.663088530174;6125.989211780185;6126.142340072304;6137.202163718866 01:18:57 INFO - 2015-11-19 01:18:57,680 DEBUG : BROWSER_OUTPUT: |4;prototype.html;312.8451416548809;323.86397712960553;324.6915430341175;325.77521510158005;330.61648487754195;5285.233641122035;5322.946770532299;5386.865328366793;5390.757415916283;5439.075357189277;5200.167973124301;5368.46315368463;5382.0043291991005;5387.326584176978;5392.595555333346;4198.118395137025;4200.495940487146;4205.747655140686;4211.978940105295;4213.431186789775;3937.2716047531153;4038.495188101487;4043.150938302945;4176.0603864130635;4196;4105.466289382376;4118.588141185887;4133.049398638315;4136.296829538986;4138.903190654479;4099.446574712406;4114.753114813091;4114.930118169283;4116.876493705194;4153.605407486284;3599.4420864766003;3614.5120408744747;3614.8554057837655;3618.7466877318598;3618.9276214475562;5071.7210553419545;5182.248573956793;5184.455632158607;5193.169092945111;5202.167653175474;4732.384789977281;4748.691335063209;4780.8525953771195;4784.617230621542;4787.305840653121;5581.832545023656;5652.349979752299;5654.858628534278;5655.943440565583;5660.066089095294;3722.8324725387424;3822.503074600284;3941.2117576484816;3981.203759248162;3998.660113890323;5937.812437512472;5945.781114871441;5947.672877991708;5950.1372301016545;5969.522438204933;4070.7354021988476;4089.3661482470266;4105.58944105587;4109.137081212979;4116.094459218967;4196.538380778112;4216.894577635584;4219.7046206765235;4227.471566054243;4229.725067870579;4679.415073115861;4757.26262429324;4795.040991801654;4800.35195248644;4800.4719480857775;5680.460356266148;5682.943170568324;5688.175214593861;5691.68695721731;5696.430356964271;1478.3051965576162;1482.3255418784427;1489.1883923261848;1490.07615278528;1490.2548725637182;992.2310209587628;1001.4041645221082;1004.638330201127;1025.7486915705551;1027.987432379106;4978.975105124524;4984;4991.126552853236;4992.076465853828;4994.175960966472;5859.033259512133;5869.090291004901;5877.794277200363;5878.588498805128;5880.794172203952;4970.65205435616;4982.725950072709;4982.800687972513;4984.800607975713;4999.725015124203;3069.3247485553143;3142.2929840786096;3167.129039514152;3173.7143657070974;3176.7299779519;5517.2551705520045;5542.251796007487;5552.639078459887;5553.722313884289;5556.277683901067;6044.123602077674;6047.8488037798525;6050.122732203806;6057.939420605826;6059.818205453844;5508.394076651645;5539.279893613804;5542.667439953616;5544.61187716856;5553.500184983371;5773.8556536086935;5958.731857066529;5965.582409231312;5967.1944287522365;5979.103134529855;5570.832875013756;5743.282089738783;5743.741531631003;5803.3616302207565;5854.853628659318;5417.674939503642;5526.557875370041;5533.833984980457;5539.113741801292;5587.497125258747;4062.2281766464275;4104.733192342488;4111.198316328288;4119.629233369011;4122.361034039729;5888.823335299948;5904.291485021825;5910.408959104056;5923.111533269872;5941.851453713692;5576.358718747234;5712.228849105318;5722.399148089391;5725.627834190765;5739.196512488338;5709.600327977002;5721.1990321354215;5721.456461636138;5724.542036637143;5728.770849165987;5567.415421380697;5602.991461536963;5605.915911261252;5607.859803504945;5616.1856530803625;5573.498385145356;5773.422657734193;5778.075507918713;5782.710864456676;5786.566007549535;5623.606347555632;5627.465390787868;5630.60585758993;5630.7466164023535;5634.211210430461 01:18:57 INFO - 2015-11-19 01:18:57,681 DEBUG : BROWSER_OUTPUT: |5;yui.html;768.9192634773349;773.3812949640286;778.5873487051863;783.2480818414322;788.4599049650986;11495.597654082108;13895.09681870679;13969.650758731037;14021.509247176351;14038.78941815871;12416.441260143292;12500.062495312864;12502.374881255946;12512.81230781539;12514.186577872455;600.6276108812542;608.2397003745318;764.8011517005577;777.6345117794627;778.5523324088643;768.8231706707461;777.1063277231201;781.2460975158971;782.538302401583;783.8275579372529;807.4307613132727;812.2446125103651;813.4631143445328;813.894193754814;815.2377527012233;628.4909223528933;637.3849235487777;806.1897792718339;819.4632515702225;842.6924172676929;608.1698481572665;613.0405914743412;613.1844646619985;613.4295105551835;613.5490414545305;11843.23019003762;11975.580854670045;11983.700407489796;11994.10044246685;12013.93993030038;11349.829752553718;11443.542258309657;11544.018758405546;11717.589884354007;11937.224080434744;9111.544422778901;9298.53507324631;9324;9336.906630933672;9489.38319009269;3232.095013396229;3242.1084201844446;3304.0913748719054;3337.8331083445732;3344.96655033449;42918.35622465666;42947.785261073805;43482.565174348165;43505;43559.78220108911;9316.767080823034;9578.425294482353;9594.280428967855;9707.6116955321;9778.706638800848;16736.581585460463;16751.497455076365;16759.078250696086;16763.748543771853;16768.161591920354;6423.068655044993;6432.324605916405;6504.869902602016;6568.211814582281;6620.768273110418;3571.142925697814;3603.6936860367164;3614.042278796121;3625.6918161956;3657.8902632921054;2603.4402603440353;2629.907953221628;2631.8026148038975;2634.4467661790854;2643.233462295951;409.25107054090944;411.61925219172747;412.7853516171574;413.09532124646927;420.1324265391956;478.45934094473023;484.791539637952;517.1898355754857;580.6283978253921;594.8602078511547;7194.532355396883;7250.2024777274455;7312.670929808171;7553;7594.202608726005;361.76485284565246;460.68567861973054;560.9775608975596;599.1551911804335;613.8741557980693;3681.245344704329;3729.6829769469355;3740;3744.2698673758355;3765.604611515806;47971.04057918822;48728;54613.72693136509;55043.72478137664;55045.44954550483;45627.77186114115;46268;47184.7640761794;47346.289805652945;48115.03769924582;43387.78306108449;43742.56257437448;43814.56185438169;44273;44720.55279447229;7945.960270198843;7977.521348719096;8127;8330.416870818985;8605.483670979762;34018.82990585031;34274.65725342715;36622.63377366299;37282.25435491329;37944;45288;45556.77221613871;46043.3093503591;46905.29642055304;47177.764111179225;10255.134037448788;10296.845547316647;10329.328593641389;10508.264421490423;10829.133669306279;9943.30396872212;10370.42962637032;11269.267497612629;11623.941880290544;11625.302481851117;10058.446785426871;10132;10265.692029238837;11023.559057637605;11396.829047564128;10044.997682843481;10693.732656683645;10703.571857125628;10747.408892510986;11178.217524773188;7821.726239581587;9947.303688741718;10496.422696751446;10566.788664226826;10729.731756705833;8755.51844648525;8821.426607270507;9075.863862042206;9113.863292050757;9268.675596354366;8334.791630209293;8741.300695944436;8774.429662071945;9041.81916361656;9042.728718138467 01:18:57 INFO - 2015-11-19 01:18:57,681 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:18:57 INFO - 2015-11-19 01:18:57,681 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:18:57 INFO - 2015-11-19 01:18:57,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 01:18:57 INFO - 2015-11-19 01:18:57,681 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:18:57 INFO - 2015-11-19 01:18:57,682 DEBUG : BROWSER_OUTPUT: __startTimestamp1447924737669__endTimestamp 01:18:57 INFO - 2015-11-19 01:18:57,682 DEBUG : BROWSER_OUTPUT: 01:18:57 INFO - 2015-11-19 01:18:57,682 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:18:57 INFO - 2015-11-19 01:18:57,682 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:18:57 INFO - 2015-11-19 01:18:57,682 DEBUG : BROWSER_OUTPUT: 01:18:57 INFO - 2015-11-19 01:18:57,683 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4699.91 Median:4829.15 stddev:499.29 (10.3%) stddev-sans-first:473.70 01:18:57 INFO - 2015-11-19 01:18:57,683 DEBUG : BROWSER_OUTPUT: Values: 2630.7 2733.4 2738.2 2753.7 2763.5 4565.7 4666.9 4750.5 4787.3 4789.1 4655.5 4698.2 4706.2 4769.5 4777.9 4365.1 4367.2 4389.0 4404.1 4427.3 4218.6 4395.4 4405.1 4457.4 4488.9 4296.9 4330.8 4377.1 4381.5 4425.5 4393.8 4404.6 4406.0 4446.0 4446.1 4187.0 4280.1 4384.5 4398.3 4448.1 4555.0 4584.9 4662.2 4683.1 4695.2 5056.7 5056.8 5069.3 5071.0 5108.6 4925.0 5088.6 5092.0 5094.5 5106.6 4700.0 4701.8 4719.2 4721.0 4724.4 5297.8 5310.0 5341.1 5351.5 5356.6 5077.3 5091.4 5095.7 5101.8 5138.8 4898.5 4960.8 4996.8 5171.3 5183.3 4985.0 5107.8 5137.2 5149.8 5158.5 4999.6 5043.1 5048.1 5049.0 5088.7 4052.3 4203.2 4208.0 4212.9 4251.0 3615.5 3666.3 3704.5 3711.9 3726.2 4458.1 4460.4 4469.8 4482.2 4503.7 4928.2 5180.3 5181.4 5187.1 5189.0 4326.0 4374.9 4390.0 4403.4 4430.6 4516.7 4539.3 4540.3 4547.7 4563.4 4632.6 4843.3 4843.8 4846.3 4885.7 5026.8 5039.2 5070.6 5108.7 5173.5 4825.6 4829.2 4836.1 4837.4 4867.8 4841.9 5008.9 5037.5 5041.0 5091.8 5006.6 5028.0 5041.1 5146.2 5173.8 5013.9 5016.4 5020.6 5027.4 5067.9 4768.7 5001.0 5003.9 5014.4 5014.9 4744.7 4760.4 4816.6 4837.6 4859.1 5015.3 5024.6 5025.3 5027.4 5027.7 4682.4 4923.8 4926.0 4927.2 4965.3 01:18:57 INFO - 2015-11-19 01:18:57,683 DEBUG : BROWSER_OUTPUT: 01:18:57 INFO - 2015-11-19 01:18:57,683 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36520.27 Median:17552.17 stddev:53036.75 (302.2%) stddev-sans-first:53116.80 01:18:57 INFO - 2015-11-19 01:18:57,683 DEBUG : BROWSER_OUTPUT: Values: 560.6 563.7 566.3 573.2 578.4 28382.4 34441.3 34767.3 34825.8 34840.5 40056.4 40720.4 40772.2 40825.8 40835.8 7011.1 7130.3 7958.2 8131.1 8136.7 9979.2 10220.6 10230.1 10232.7 10235.3 10154.3 10261.1 10275.6 10279.5 10282.1 7204.6 7377.6 9932.6 10071.3 10075.1 9710.0 9861.1 9864.1 9871.0 9875.6 34087.8 34449.8 34535.5 34560.3 34583.3 3013.0 3539.1 3559.6 3570.4 3668.5 28215.6 28273.6 28440.4 28440.6 28474.3 3035.3 3055.6 3214.1 3219.5 3223.6 217946.0 218029.0 219316.9 219692.0 219910.0 51598.2 53290.2 56641.0 57515.0 58424.1 48574.8 49072.8 49126.0 49275.3 49351.8 12702.7 12754.2 12764.7 12839.1 12841.5 9371.6 9386.2 9387.9 9400.4 9466.0 19352.0 19534.8 19564.6 19570.1 19678.5 7666.5 7831.6 7873.7 7923.9 7950.9 819.6 833.2 840.3 844.3 877.9 26397.0 26495.0 26696.2 26736.6 26813.7 952.9 966.1 1009.5 1049.3 1113.0 12413.8 12494.1 12528.9 12606.5 12688.1 203052.0 205764.0 205932.0 206012.0 206223.0 41671.2 41909.4 41980.8 42016.6 42150.4 1147.4 1171.2 1179.3 1180.0 1197.2 21133.7 23453.0 24434.4 26628.2 27013.9 37952.6 38298.8 38380.4 38470.8 38513.2 175912.0 177451.1 177707.0 177926.0 233955.0 23634.6 28857.4 29290.3 29558.3 29613.0 34480.5 34692.0 35121.5 35232.5 35267.0 28663.7 29066.0 32496.5 32942.3 32947.3 31890.2 32206.4 32240.5 32359.0 33460.8 29741.6 29870.7 30006.4 30073.2 30211.1 27281.9 27438.3 28116.3 30129.8 30434.5 23005.3 23540.8 23915.6 25082.5 25334.4 01:18:57 INFO - 2015-11-19 01:18:57,683 DEBUG : BROWSER_OUTPUT: 01:18:57 INFO - 2015-11-19 01:18:57,684 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25757.87 Median:44530.67 stddev:84099.78 (188.9%) stddev-sans-first:84314.04 01:18:57 INFO - 2015-11-19 01:18:57,684 DEBUG : BROWSER_OUTPUT: Values: 342.9 344.4 345.9 347.3 350.5 12487.4 12914.5 14916.8 15343.3 16199.2 14925.6 15280.9 15929.0 16188.4 16198.8 4918.1 4920.4 5037.7 5038.9 5039.6 3587.2 3680.9 3682.2 3688.2 5072.2 3678.3 5592.3 5791.5 5793.3 5797.3 5344.9 5384.9 5386.1 5413.5 5725.9 4992.9 5117.4 5120.1 5121.1 5121.2 18853.0 19145.0 19382.3 19388.2 19523.1 1886.7 1953.1 1977.7 1986.2 2028.5 12444.3 12588.6 12606.2 12616.9 12624.9 1715.3 1720.1 1720.3 1720.4 1801.3 48929.8 49940.5 52888.7 53732.2 54567.5 6583.6 6688.0 6702.6 6739.3 6780.5 7919.0 7935.2 7935.8 7945.6 7948.5 5029.3 5035.6 5049.8 5054.3 5123.1 5054.1 5059.6 5065.9 5072.1 5103.9 3025.7 3088.4 3112.6 3113.1 3122.8 1009.9 1088.2 1112.4 1129.5 1154.4 422.2 425.5 454.6 457.8 480.4 10600.7 10869.2 10969.0 11411.2 11617.3 391.9 460.5 468.5 469.0 471.6 5918.1 6072.6 6079.7 6135.3 6466.6 492253.2 504044.0 515971.0 526486.0 530296.0 67533.7 69121.7 70572.3 70911.6 71067.6 512.2 520.2 520.4 520.9 523.1 10547.1 10622.3 10685.8 10855.9 10877.2 32879.0 33553.3 34020.0 34171.8 34453.0 43982.6 44036.1 44420.0 44641.3 45240.3 6039.1 6132.9 6148.9 6151.1 6382.7 11039.1 11240.4 11272.5 11315.3 11401.8 9992.3 10183.2 10210.4 10495.8 10503.2 9996.9 10109.7 10316.3 10318.9 10369.8 8345.7 8582.1 9852.4 10519.6 10536.6 6300.8 6368.6 6434.7 6442.3 6454.1 10164.5 10334.7 10339.3 10435.3 10518.3 01:18:57 INFO - 2015-11-19 01:18:57,684 DEBUG : BROWSER_OUTPUT: 01:18:57 INFO - 2015-11-19 01:18:57,684 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5077.41 Median:6086.10 stddev:2671.37 (43.9%) stddev-sans-first:2664.77 01:18:57 INFO - 2015-11-19 01:18:57,685 DEBUG : BROWSER_OUTPUT: Values: 1427.1 1652.7 1670.0 1702.8 1712.2 6193.6 6406.4 7325.9 7465.9 7467.8 7310.4 7332.3 7354.1 7381.7 7388.0 2087.4 2101.0 2103.4 2104.6 2105.5 2107.4 2132.1 2163.9 2178.8 2180.2 2096.8 2098.5 2114.9 2129.4 2130.5 2111.7 2116.9 2121.8 2122.3 2123.6 2059.1 2063.8 2078.1 2079.5 2091.3 6104.6 7318.9 7340.6 7369.2 7378.4 3861.9 4372.2 4469.6 4480.5 4485.3 2808.3 2882.6 2944.2 2988.4 2989.5 905.5 910.8 930.2 930.3 948.3 10035.1 10045.0 10083.5 10112.5 10119.2 4013.3 4034.2 4076.9 4077.8 4132.3 8571.6 8599.4 8616.4 8630.7 8638.9 4272.3 4300.5 4305.7 4344.5 4353.5 3892.9 3893.4 3895.3 3904.8 3913.2 3457.3 3457.8 3473.9 3504.3 3507.6 1104.9 1110.2 1112.2 1115.4 1120.4 1017.5 1032.2 1041.3 1048.2 1049.0 6733.5 6756.3 6763.4 6780.3 6792.8 378.0 379.0 380.3 380.8 383.1 4990.2 5128.0 5171.8 5174.4 5184.3 7970.5 8732.1 8794.6 8801.7 8801.9 8622.5 8720.7 8727.2 8740.5 8743.2 6924.1 6977.6 7042.8 7046.4 7049.4 6628.0 6659.1 6686.9 6688.2 6695.6 7856.2 7976.3 8036.0 8075.7 8092.0 8181.1 8209.7 8218.7 8343.3 8345.2 6233.1 6325.9 6329.7 6333.1 6333.2 6802.8 6823.8 6849.8 6865.0 6868.0 6357.6 6424.8 6461.9 6556.2 6589.1 6414.4 6475.3 6512.2 6536.4 6564.4 6543.2 6595.2 6596.2 6601.0 6603.9 5886.4 6012.4 6017.6 6022.3 6024.9 6067.6 6125.7 6126.0 6126.1 6137.2 01:18:57 INFO - 2015-11-19 01:18:57,685 DEBUG : BROWSER_OUTPUT: 01:18:57 INFO - 2015-11-19 01:18:57,685 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4710.67 Median:5304.09 stddev:1383.03 (26.1%) stddev-sans-first:1346.95 01:18:57 INFO - 2015-11-19 01:18:57,685 DEBUG : BROWSER_OUTPUT: Values: 312.8 323.9 324.7 325.8 330.6 5285.2 5322.9 5386.9 5390.8 5439.1 5200.2 5368.5 5382.0 5387.3 5392.6 4198.1 4200.5 4205.7 4212.0 4213.4 3937.3 4038.5 4043.2 4176.1 4196.0 4105.5 4118.6 4133.0 4136.3 4138.9 4099.4 4114.8 4114.9 4116.9 4153.6 3599.4 3614.5 3614.9 3618.7 3618.9 5071.7 5182.2 5184.5 5193.2 5202.2 4732.4 4748.7 4780.9 4784.6 4787.3 5581.8 5652.3 5654.9 5655.9 5660.1 3722.8 3822.5 3941.2 3981.2 3998.7 5937.8 5945.8 5947.7 5950.1 5969.5 4070.7 4089.4 4105.6 4109.1 4116.1 4196.5 4216.9 4219.7 4227.5 4229.7 4679.4 4757.3 4795.0 4800.4 4800.5 5680.5 5682.9 5688.2 5691.7 5696.4 1478.3 1482.3 1489.2 1490.1 1490.3 992.2 1001.4 1004.6 1025.7 1028.0 4979.0 4984.0 4991.1 4992.1 4994.2 5859.0 5869.1 5877.8 5878.6 5880.8 4970.7 4982.7 4982.8 4984.8 4999.7 3069.3 3142.3 3167.1 3173.7 3176.7 5517.3 5542.3 5552.6 5553.7 5556.3 6044.1 6047.8 6050.1 6057.9 6059.8 5508.4 5539.3 5542.7 5544.6 5553.5 5773.9 5958.7 5965.6 5967.2 5979.1 5570.8 5743.3 5743.7 5803.4 5854.9 5417.7 5526.6 5533.8 5539.1 5587.5 4062.2 4104.7 4111.2 4119.6 4122.4 5888.8 5904.3 5910.4 5923.1 5941.9 5576.4 5712.2 5722.4 5725.6 5739.2 5709.6 5721.2 5721.5 5724.5 5728.8 5567.4 5603.0 5605.9 5607.9 5616.2 5573.5 5773.4 5778.1 5782.7 5786.6 5623.6 5627.5 5630.6 5630.7 5634.2 01:18:57 INFO - 2015-11-19 01:18:57,685 DEBUG : BROWSER_OUTPUT: 01:18:57 INFO - 2015-11-19 01:18:57,685 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12930.51 Median:23044.23 stddev:15108.69 (65.6%) stddev-sans-first:15123.47 01:18:57 INFO - 2015-11-19 01:18:57,685 DEBUG : BROWSER_OUTPUT: Values: 768.9 773.4 778.6 783.2 788.5 11495.6 13895.1 13969.7 14021.5 14038.8 12416.4 12500.1 12502.4 12512.8 12514.2 600.6 608.2 764.8 777.6 778.6 768.8 777.1 781.2 782.5 783.8 807.4 812.2 813.5 813.9 815.2 628.5 637.4 806.2 819.5 842.7 608.2 613.0 613.2 613.4 613.5 11843.2 11975.6 11983.7 11994.1 12013.9 11349.8 11443.5 11544.0 11717.6 11937.2 9111.5 9298.5 9324.0 9336.9 9489.4 3232.1 3242.1 3304.1 3337.8 3345.0 42918.4 42947.8 43482.6 43505.0 43559.8 9316.8 9578.4 9594.3 9707.6 9778.7 16736.6 16751.5 16759.1 16763.7 16768.2 6423.1 6432.3 6504.9 6568.2 6620.8 3571.1 3603.7 3614.0 3625.7 3657.9 2603.4 2629.9 2631.8 2634.4 2643.2 409.3 411.6 412.8 413.1 420.1 478.5 484.8 517.2 580.6 594.9 7194.5 7250.2 7312.7 7553.0 7594.2 361.8 460.7 561.0 599.2 613.9 3681.2 3729.7 3740.0 3744.3 3765.6 47971.0 48728.0 54613.7 55043.7 55045.4 45627.8 46268.0 47184.8 47346.3 48115.0 43387.8 43742.6 43814.6 44273.0 44720.6 7946.0 7977.5 8127.0 8330.4 8605.5 34018.8 34274.7 36622.6 37282.3 37944.0 45288.0 45556.8 46043.3 46905.3 47177.8 10255.1 10296.8 10329.3 10508.3 10829.1 9943.3 10370.4 11269.3 11623.9 11625.3 10058.4 10132.0 10265.7 11023.6 11396.8 10045.0 10693.7 10703.6 10747.4 11178.2 7821.7 9947.3 10496.4 10566.8 10729.7 8755.5 8821.4 9075.9 9113.9 9268.7 8334.8 8741.3 8774.4 9041.8 9042.7 01:18:57 INFO - 2015-11-19 01:18:57,686 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:18:57 INFO - 2015-11-19 01:18:57,686 DEBUG : BROWSER_OUTPUT: 01:18:58 INFO - 2015-11-19 01:18:58,357 INFO : Browser exited with error code: 0 01:18:58 INFO - 2015-11-19 01:18:58,383 INFO : Completed test dromaeo_css (00:18:38) 01:18:58 INFO - 2015-11-19 01:18:58,383 INFO : Starting test kraken 01:18:58 INFO - 2015-11-19 01:18:58,383 DEBUG : operating with platform_type : linux_ 01:18:58 INFO - 2015-11-19 01:18:58,383 INFO : Initialising browser for kraken test... 01:18:58 INFO - 2015-11-19 01:18:58,389 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpARPArH/profile http://localhost:38824/getInfo.html 01:19:02 INFO - 2015-11-19 01:19:02,712 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:19:02 INFO - 2015-11-19 01:19:02,712 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:19:02 INFO - 2015-11-19 01:19:02,712 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:19:02 INFO - 2015-11-19 01:19:02,712 DEBUG : BROWSER_OUTPUT: __metrics 01:19:02 INFO - 2015-11-19 01:19:02,855 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:19:04 INFO - 2015-11-19 01:19:04,160 INFO : Browser initialized. 01:19:04 INFO - 2015-11-19 01:19:04,161 INFO : Running cycle 1/1 for kraken test... 01:19:04 INFO - 2015-11-19 01:19:04,161 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpARPArH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:19:16 INFO - 2015-11-19 01:19:16,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 141619200 01:19:16 INFO - 2015-11-19 01:19:16,051 DEBUG : BROWSER_OUTPUT: 01:19:18 INFO - 2015-11-19 01:19:18,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-beat-detection) 01:19:19 INFO - 2015-11-19 01:19:19,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 177356800 01:19:19 INFO - 2015-11-19 01:19:19,273 DEBUG : BROWSER_OUTPUT: 01:19:22 INFO - 2015-11-19 01:19:22,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-dft) 01:19:22 INFO - 2015-11-19 01:19:22,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 167403520 01:19:22 INFO - 2015-11-19 01:19:22,585 DEBUG : BROWSER_OUTPUT: 01:19:25 INFO - 2015-11-19 01:19:25,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-fft) 01:19:26 INFO - 2015-11-19 01:19:26,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 151339008 01:19:26 INFO - 2015-11-19 01:19:26,170 DEBUG : BROWSER_OUTPUT: 01:19:28 INFO - 2015-11-19 01:19:28,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38824/tests/kraken/driver.html?testName=audio-oscillator) 01:19:28 INFO - 2015-11-19 01:19:28,773 DEBUG : BROWSER_OUTPUT: RSS: Main: 155353088 01:19:28 INFO - 2015-11-19 01:19:28,773 DEBUG : BROWSER_OUTPUT: 01:19:30 INFO - 2015-11-19 01:19:30,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38824/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:19:31 INFO - 2015-11-19 01:19:31,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 155140096 01:19:31 INFO - 2015-11-19 01:19:31,547 DEBUG : BROWSER_OUTPUT: 01:19:34 INFO - 2015-11-19 01:19:34,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38824/tests/kraken/driver.html?testName=imaging-darkroom) 01:19:35 INFO - 2015-11-19 01:19:35,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 156319744 01:19:35 INFO - 2015-11-19 01:19:35,084 DEBUG : BROWSER_OUTPUT: 01:19:38 INFO - 2015-11-19 01:19:38,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38824/tests/kraken/driver.html?testName=imaging-desaturate) 01:19:39 INFO - 2015-11-19 01:19:39,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 156577792 01:19:39 INFO - 2015-11-19 01:19:39,074 DEBUG : BROWSER_OUTPUT: 01:19:41 INFO - 2015-11-19 01:19:41,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38824/tests/kraken/driver.html?testName=json-parse-financial) 01:19:42 INFO - 2015-11-19 01:19:42,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 157417472 01:19:42 INFO - 2015-11-19 01:19:42,534 DEBUG : BROWSER_OUTPUT: 01:19:44 INFO - 2015-11-19 01:19:44,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38824/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:19:44 INFO - 2015-11-19 01:19:44,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 164794368 01:19:44 INFO - 2015-11-19 01:19:44,873 DEBUG : BROWSER_OUTPUT: 01:19:46 INFO - 2015-11-19 01:19:46,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:19:47 INFO - 2015-11-19 01:19:47,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 166297600 01:19:47 INFO - 2015-11-19 01:19:47,370 DEBUG : BROWSER_OUTPUT: 01:19:49 INFO - 2015-11-19 01:19:49,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:19:50 INFO - 2015-11-19 01:19:50,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 172826624 01:19:50 INFO - 2015-11-19 01:19:50,044 DEBUG : BROWSER_OUTPUT: 01:19:52 INFO - 2015-11-19 01:19:52,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:19:53 INFO - 2015-11-19 01:19:53,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 179707904 01:19:53 INFO - 2015-11-19 01:19:53,161 DEBUG : BROWSER_OUTPUT: 01:19:55 INFO - 2015-11-19 01:19:55,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:19:56 INFO - 2015-11-19 01:19:56,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 177766400 01:19:56 INFO - 2015-11-19 01:19:56,363 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38824/tests/kraken/driver.html?testName=ai-astar) 01:19:58 INFO - 2015-11-19 01:19:58,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 237596672 01:19:58 INFO - 2015-11-19 01:19:58,378 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,382 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:19:58 INFO - 2015-11-19 01:19:58,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:19:58 INFO - 2015-11-19 01:19:58,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:19:58 INFO - 2015-11-19 01:19:58,382 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:19:58 INFO - 2015-11-19 01:19:58,382 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;105;112;112;112;102;115;116;112 01:19:58 INFO - 2015-11-19 01:19:58,383 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;151;166;135;154;157;137;176;135 01:19:58 INFO - 2015-11-19 01:19:58,383 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;160;160;161;163;163;163;162 01:19:58 INFO - 2015-11-19 01:19:58,383 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;82;92;73;75;73;102;92;74 01:19:58 INFO - 2015-11-19 01:19:58,383 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;129;91;92;90;124;91;90;123 01:19:58 INFO - 2015-11-19 01:19:58,383 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;110;110;110;110;109 01:19:58 INFO - 2015-11-19 01:19:58,383 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;146;146;146;148;147;147 01:19:58 INFO - 2015-11-19 01:19:58,383 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;95;96;96;95;95 01:19:58 INFO - 2015-11-19 01:19:58,383 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;71;71;72;72;69;71;80;70;71 01:19:58 INFO - 2015-11-19 01:19:58,384 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;68;68;69;69;69 01:19:58 INFO - 2015-11-19 01:19:58,384 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;82;82;83;85;83;82;83;82 01:19:58 INFO - 2015-11-19 01:19:58,384 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;125;121;119;126;122;132;123;129;128 01:19:58 INFO - 2015-11-19 01:19:58,384 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;145;148;163;152;137;159;138;149;144 01:19:58 INFO - 2015-11-19 01:19:58,384 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;73;70;70;70;69;70;68 01:19:58 INFO - 2015-11-19 01:19:58,384 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:19:58 INFO - 2015-11-19 01:19:58,384 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:19:58 INFO - 2015-11-19 01:19:58,384 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,980 01:19:58 INFO - 2015-11-19 01:19:58,385 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:19:58 INFO - 2015-11-19 01:19:58,385 DEBUG : BROWSER_OUTPUT: __startTimestamp1447924798380__endTimestamp 01:19:58 INFO - 2015-11-19 01:19:58,385 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,392 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:4.36 (3.9%) stddev-sans-first:4.62 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 105.0 112.0 112.0 112.0 102.0 115.0 116.0 112.0 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.70 Median:155.00 stddev:15.10 (9.7%) stddev-sans-first:15.84 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 151.0 166.0 135.0 154.0 157.0 137.0 176.0 135.0 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.34 (0.8%) stddev-sans-first:1.41 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 160.0 160.0 161.0 163.0 163.0 163.0 162.0 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:74.50 stddev:10.76 (14.4%) stddev-sans-first:11.03 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 82.0 92.0 73.0 75.0 73.0 102.0 92.0 74.0 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.20 Median:91.00 stddev:16.73 (18.4%) stddev-sans-first:17.33 01:19:58 INFO - 2015-11-19 01:19:58,393 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 129.0 91.0 92.0 90.0 124.0 91.0 90.0 123.0 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 146.0 146.0 146.0 148.0 147.0 147.0 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.70 Median:71.00 stddev:3.06 (4.3%) stddev-sans-first:3.18 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 72.0 72.0 69.0 71.0 80.0 70.0 71.0 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 01:19:58 INFO - 2015-11-19 01:19:58,394 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 68.0 68.0 69.0 69.0 69.0 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 82.0 82.0 83.0 85.0 83.0 82.0 83.0 82.0 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:125.50 stddev:4.38 (3.5%) stddev-sans-first:4.18 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: Values: 119.0 125.0 121.0 119.0 126.0 122.0 132.0 123.0 129.0 128.0 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:148.50 stddev:8.33 (5.6%) stddev-sans-first:8.72 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: Values: 144.0 145.0 148.0 163.0 152.0 137.0 159.0 138.0 149.0 144.0 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.43 (2.0%) stddev-sans-first:1.50 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 73.0 70.0 70.0 70.0 69.0 70.0 68.0 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:19:58 INFO - 2015-11-19 01:19:58,395 DEBUG : BROWSER_OUTPUT: 01:19:59 INFO - 2015-11-19 01:19:59,285 INFO : Browser exited with error code: 0 01:19:59 INFO - 2015-11-19 01:19:59,338 INFO : Completed test kraken (00:01:00) 01:19:59 INFO - 2015-11-19 01:19:59,338 INFO : Starting test v8_7 01:19:59 INFO - 2015-11-19 01:19:59,339 DEBUG : operating with platform_type : linux_ 01:19:59 INFO - 2015-11-19 01:19:59,339 INFO : Initialising browser for v8_7 test... 01:19:59 INFO - 2015-11-19 01:19:59,345 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJYBimC/profile http://localhost:38824/getInfo.html 01:20:03 INFO - 2015-11-19 01:20:03,451 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:20:03 INFO - 2015-11-19 01:20:03,451 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:20:03 INFO - 2015-11-19 01:20:03,451 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:20:03 INFO - 2015-11-19 01:20:03,452 DEBUG : BROWSER_OUTPUT: __metrics 01:20:03 INFO - 2015-11-19 01:20:03,596 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:20:05 INFO - 2015-11-19 01:20:05,014 INFO : Browser initialized. 01:20:05 INFO - 2015-11-19 01:20:05,015 INFO : Running cycle 1/1 for v8_7 test... 01:20:05 INFO - 2015-11-19 01:20:05,015 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJYBimC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:20:16 INFO - 2015-11-19 01:20:16,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 141676544 01:20:16 INFO - 2015-11-19 01:20:16,988 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:38824/tests/v8_7/run.html (next: http://localhost:38824/tests/v8_7/run.html) 01:20:38 INFO - 2015-11-19 01:20:38,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 444702720 01:20:38 INFO - 2015-11-19 01:20:38,617 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,617 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:20:38 INFO - 2015-11-19 01:20:38,618 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:20:38 INFO - 2015-11-19 01:20:38,618 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:20:38 INFO - 2015-11-19 01:20:38,618 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:20:38 INFO - 2015-11-19 01:20:38,618 DEBUG : BROWSER_OUTPUT: |0;Richards;162.52234682268812 01:20:38 INFO - 2015-11-19 01:20:38,618 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.68104274487254 01:20:38 INFO - 2015-11-19 01:20:38,618 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 01:20:38 INFO - 2015-11-19 01:20:38,618 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 01:20:38 INFO - 2015-11-19 01:20:38,619 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1990.0596421471173 01:20:38 INFO - 2015-11-19 01:20:38,619 DEBUG : BROWSER_OUTPUT: |5;Earley;790.5138339920949 01:20:38 INFO - 2015-11-19 01:20:38,619 DEBUG : BROWSER_OUTPUT: |6;Boyer;12444.444444444445 01:20:38 INFO - 2015-11-19 01:20:38,619 DEBUG : BROWSER_OUTPUT: |7;RegExp;26684.21052631579 01:20:38 INFO - 2015-11-19 01:20:38,619 DEBUG : BROWSER_OUTPUT: |8;Splay;619.1950464396285 01:20:38 INFO - 2015-11-19 01:20:38,619 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 01:20:38 INFO - 2015-11-19 01:20:38,619 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:20:38 INFO - 2015-11-19 01:20:38,620 DEBUG : BROWSER_OUTPUT: __startTimestamp1447924838610__endTimestamp 01:20:38 INFO - 2015-11-19 01:20:38,620 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,620 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:20:38 INFO - 2015-11-19 01:20:38,620 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:20:38 INFO - 2015-11-19 01:20:38,620 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,620 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.52 Median:162.52 stddev:0.00 (0.0%) 01:20:38 INFO - 2015-11-19 01:20:38,620 DEBUG : BROWSER_OUTPUT: Values: 162.5 01:20:38 INFO - 2015-11-19 01:20:38,620 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,621 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.68 Median:191.68 stddev:0.00 (0.0%) 01:20:38 INFO - 2015-11-19 01:20:38,621 DEBUG : BROWSER_OUTPUT: Values: 191.7 01:20:38 INFO - 2015-11-19 01:20:38,621 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,621 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 01:20:38 INFO - 2015-11-19 01:20:38,621 DEBUG : BROWSER_OUTPUT: Values: 279.6 01:20:38 INFO - 2015-11-19 01:20:38,621 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,621 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 01:20:38 INFO - 2015-11-19 01:20:38,622 DEBUG : BROWSER_OUTPUT: Values: 5035.2 01:20:38 INFO - 2015-11-19 01:20:38,622 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,622 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 01:20:38 INFO - 2015-11-19 01:20:38,622 DEBUG : BROWSER_OUTPUT: Values: 1990.1 01:20:38 INFO - 2015-11-19 01:20:38,622 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,622 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 01:20:38 INFO - 2015-11-19 01:20:38,622 DEBUG : BROWSER_OUTPUT: Values: 790.5 01:20:38 INFO - 2015-11-19 01:20:38,622 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,623 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 01:20:38 INFO - 2015-11-19 01:20:38,623 DEBUG : BROWSER_OUTPUT: Values: 12444.4 01:20:38 INFO - 2015-11-19 01:20:38,623 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,623 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26684.21 Median:26684.21 stddev:0.00 (0.0%) 01:20:38 INFO - 2015-11-19 01:20:38,623 DEBUG : BROWSER_OUTPUT: Values: 26684.2 01:20:38 INFO - 2015-11-19 01:20:38,623 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,623 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.20 Median:619.20 stddev:0.00 (0.0%) 01:20:38 INFO - 2015-11-19 01:20:38,624 DEBUG : BROWSER_OUTPUT: Values: 619.2 01:20:38 INFO - 2015-11-19 01:20:38,624 DEBUG : BROWSER_OUTPUT: 01:20:38 INFO - 2015-11-19 01:20:38,624 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 01:20:38 INFO - 2015-11-19 01:20:38,624 DEBUG : BROWSER_OUTPUT: Values: 4845.4 01:20:38 INFO - 2015-11-19 01:20:38,624 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:20:38 INFO - 2015-11-19 01:20:38,624 DEBUG : BROWSER_OUTPUT: 01:20:39 INFO - 2015-11-19 01:20:39,525 INFO : Browser exited with error code: 0 01:20:39 INFO - 2015-11-19 01:20:39,542 INFO : Completed test v8_7 (00:00:40) 01:20:39 INFO - 2015-11-19 01:20:39,659 INFO : Completed test suite (00:20:19) 01:20:39 INFO - 2015-11-19 01:20:39,659 DEBUG : Working with test: dromaeo_css 01:20:39 INFO - 2015-11-19 01:20:39,659 DEBUG : Generating results file: dromaeo_css 01:20:39 INFO - 2015-11-19 01:20:39,660 DEBUG : Working with test: kraken 01:20:39 INFO - 2015-11-19 01:20:39,660 DEBUG : Generating results file: kraken 01:20:39 INFO - 2015-11-19 01:20:39,660 INFO : javascript benchmark 01:20:39 INFO - 2015-11-19 01:20:39,661 DEBUG : Working with test: v8_7 01:20:39 INFO - 2015-11-19 01:20:39,661 DEBUG : Generating results file: v8_7 01:20:39 INFO - 2015-11-19 01:20:39,661 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:20:39 INFO - 2015-11-19 01:20:39,706 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 01:20:39 INFO - 2015-11-19 01:20:39,706 DEBUG : process_Request line: dromaeo_css 6118.75 graph.html#tests=[[72,131,35]] 01:20:39 INFO - 2015-11-19 01:20:39,706 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:20:39 INFO - 2015-11-19 01:20:39,734 DEBUG : process_Request line: kraken 1520.70 graph.html#tests=[[232,131,35]] 01:20:39 INFO - 2015-11-19 01:20:39,734 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:20:39 INFO - 2015-11-19 01:20:39,760 DEBUG : process_Request line: v8_7 19755.63 graph.html#tests=[[230,131,35]] 01:20:39 INFO - 2015-11-19 01:20:39,762 INFO : javascript benchmark 01:20:39 INFO - 2015-11-19 01:20:39,765 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2630.6974697909736, 2733.412316351986, 2738.1648597177855, 2753.655793025873, 2763.474939761445, 4565.748883811389, 4666.859994200179, 4750.501197374273, 4787.281907713845, 4789.137955168068, 4655.534446555343, 4698.177818881691, 4706.223473126938, 4769.523047695228, 4777.8805529861775, 4365.083332500179, 4367.170237654851, 4389.034412429261, 4404.053128577355, 4427.2695005324085, 4218.599233072869, 4395.384646149541, 4405.074934263793, 4457.353683715859, 4488.887777805565, 4296.935545966813, 4330.783460826946, 4377.058932329564, 4381.474223093249, 4425.468943726742, 4393.8462153824785, 4404.603585677304, 4405.977970110129, 4445.955540444586, 4446.133004064209, 4186.958130418688, 4280.143971205771, 4384.517703052662, 4398.252297109499, 4448.132614140244, 4555.0, 4584.908301833978, 4662.184117779409, 4683.063387322515, 4695.248760198386, 5056.721880296583, 5056.797728090872, 5069.315642388304, 5071.036503064406, 5108.64239503235, 4924.950750492485, 5088.643794934356, 5092.0, 5094.4650811664615, 5106.64253502255, 4699.953000469985, 4701.788419521062, 4719.150552900511, 4720.952790472052, 4724.385829842098, 5297.761600727977, 5310.044192045391, 5341.145416733304, 5351.464853514617, 5356.625036247426, 5077.289179514871, 5091.389033315952, 5095.719735414514, 5101.770420331094, 5138.845834624967, 4898.510148985073, 4960.776765045582, 4996.7501624918605, 5171.2501687255135, 5183.274341592105, 4985.0, 5107.821226257063, 5137.152369859006, 5149.819756308511, 5158.509941555546, 4999.625028122832, 5043.142665746758, 5048.0913435581215, 5049.040682270357, 5088.72012039334, 4052.250333688277, 4203.222403855297, 4207.957920420757, 4212.87361379153, 4250.978745106255, 3615.493830863681, 3666.2667466506805, 3704.481372607837, 3711.888643340704, 3726.2174943261675, 4458.08609235106, 4460.397846290774, 4469.7988590513505, 4482.21561226784, 4503.729776213438, 4928.162212423897, 5180.274761533388, 5181.35233095863, 5187.118189907725, 5189.014087323397, 4325.956740432618, 4374.912501750011, 4390.034192477649, 4403.383526306319, 4430.556944305608, 4516.683832131719, 4539.251023581072, 4540.341650460665, 4547.749873756975, 4563.38394316763, 4632.629389648888, 4843.346148269939, 4843.830465933675, 4846.29728689338, 4885.706857588556, 5026.84919452417, 5039.193729003342, 5070.569001634754, 5108.7445627717725, 5173.456787037307, 4825.565699087099, 4829.154897892925, 4836.056968891173, 4837.395325584302, 4867.805287788448, 4841.878953026203, 5008.874778130576, 5037.546620804145, 5041.0422019816115, 5091.770870310919, 5006.574441172541, 5028.019536190408, 5041.092603331289, 5146.228065790161, 5173.7671804769625, 5013.874653133701, 5016.448190698947, 5020.648554601289, 5027.371578552681, 5067.87330316745, 4768.690035147704, 5001.0, 5003.899922001612, 5014.373203349582, 5014.874628134326, 4744.715317080986, 4760.381150450419, 4816.566509014206, 4837.564619184291, 4859.052484765578, 5015.322931404359, 5024.6231532634465, 5025.271335656383, 5027.371578552681, 5027.7234752087525, 4682.367880336247, 4923.753812309298, 4926.0, 4927.162382395073, 4965.329680493087], "unit": "ms", "name": "dojo.html", "value": 4668.477628496929}, {"lowerIsBetter": false, "replicates": [560.5963706131583, 563.6618029182491, 566.2864790364141, 573.249043752684, 578.3869098755317, 28382.43235135296, 34441.31117377654, 34767.304653906904, 34825.82587087067, 34840.47739283913, 40056.39915401271, 40720.38919416211, 40772.18455630886, 40825.7958710206, 40835.795821020925, 7011.0885584873895, 7130.2513236110235, 7958.16439273878, 8131.105578386373, 8136.715214967478, 9979.15177209938, 10220.642277520288, 10230.07929286364, 10232.74418139545, 10235.283530152892, 10154.339967902062, 10261.076503114718, 10275.588976440933, 10279.486025698723, 10282.074613284803, 7204.567725936435, 7377.55734655917, 9932.602695892156, 10071.295009349311, 10075.093241608218, 9710.0, 9861.063198996084, 9864.112229899272, 9871.0, 9875.60497580096, 34087.82956085228, 34449.827750861084, 34535.4819677705, 34560.30879382423, 34583.30833383343, 3012.9849350753107, 3539.0798392418155, 3559.626239244868, 3570.4465807799834, 3668.52309199805, 28215.57676634852, 28273.57589636157, 28440.431191376058, 28440.573391399146, 28474.288142796388, 3035.2715348316246, 3055.5874956880757, 3214.1321843102464, 3219.5170724391296, 3223.62928263248, 217946.0, 218029.0, 219316.9034154835, 219692.0, 219910.0, 51598.22602660963, 53290.20064699033, 56641.0, 57515.0, 58424.123638144614, 48574.75712621414, 49072.754636227306, 49126.0, 49275.26087108696, 49351.753241234284, 12702.682432939066, 12754.170978886343, 12764.744705106032, 12839.101262911694, 12841.48634054646, 9371.578278977462, 9386.249100072115, 9387.90612093884, 9400.388974716621, 9466.006069362618, 19352.0, 19534.804651953582, 19564.576199165374, 19570.119344629526, 19678.508037299183, 7666.540007599562, 7831.6475758591005, 7873.685052597946, 7923.859009267863, 7950.880736788837, 819.6352623082671, 833.2375876073446, 840.2899549880341, 844.2823599940002, 877.88587483628, 26397.0, 26495.0, 26696.19911402661, 26736.59895101575, 26813.731862681514, 952.876126103616, 966.0677446264248, 1009.4952523738131, 1049.3127001813825, 1112.9888701113048, 12413.75172496563, 12494.125411221126, 12528.874711252953, 12606.495740170474, 12688.111832171659, 203052.0, 205764.0, 205932.0, 206012.0, 206223.0, 41671.1665766683, 41909.371359429635, 41980.79009604932, 42016.579834201875, 42150.367744483854, 1147.4090843215752, 1171.2328424881716, 1179.2747460312019, 1179.9587014454453, 1197.1619866093943, 21133.6829947554, 23453.0, 24434.389140271636, 26628.201153965412, 27013.86493067522, 37952.62047379491, 38298.80850595729, 38380.42429363618, 38470.80764596159, 38513.229735405694, 175912.0, 177451.11274443546, 177707.0, 177926.0, 233955.0, 23634.645480317464, 28857.422851542433, 29290.267743306587, 29558.261043474085, 29613.0, 34480.482792757626, 34692.0, 35121.47317790184, 35232.471512926815, 35267.0, 28663.713362866103, 29066.0, 32496.512552312208, 32942.34115317728, 32947.34105317928, 31890.20274493156, 32206.35587288288, 32240.516392254605, 32359.0, 33460.832695837336, 29741.5538766923, 29870.701292986792, 30006.399872002003, 30073.24816879508, 30211.09366719002, 27281.863590682715, 27438.314042149104, 28116.297092572848, 30129.849350753106, 30434.543481847348, 23005.309840704136, 23540.7520614517, 23915.641265381382, 25082.498350033264, 25334.36664083339], "unit": "ms", "name": "ext.html", "value": 16506.417951431933}, {"lowerIsBetter": false, "replicates": [342.878278211235, 344.3973047167457, 345.8564695651305, 347.2880594780702, 350.4742885671493, 12487.43806528706, 12914.547990820323, 14916.776248356284, 15343.3095510702, 16199.190040497986, 14925.552233433014, 15280.930334876535, 15929.0, 16188.35246590138, 16198.83801161988, 4918.139325618021, 4920.384951881015, 5037.722925239111, 5038.899222015558, 5039.622028347871, 3587.157018100744, 3680.907977300562, 3682.171511409938, 3688.151725103228, 5072.213806859942, 3678.337899178147, 5592.273004509408, 5791.536677065846, 5793.304803423595, 5797.3043234811885, 5344.893102137936, 5384.892302153955, 5386.138217885159, 5413.485718856722, 5725.914111288334, 4992.90014199714, 5117.41149767774, 5120.078385890538, 5121.052605268, 5121.206213036985, 18853.0, 19145.0, 19382.321618743277, 19388.22447102114, 19523.121459534355, 1886.6792645250341, 1953.1113343428706, 1977.6736838421643, 1986.1955907857196, 2028.5131568423471, 12444.315562644051, 12588.559400420942, 12606.243625382414, 12616.936915315457, 12624.936875315656, 1715.279582575309, 1720.1485264794007, 1720.3204734130074, 1720.3720641965592, 1801.261482792062, 48929.75535122337, 49940.50059499395, 52888.735556322354, 53732.19401708977, 54567.45432545664, 6583.604983700898, 6688.0, 6702.597844129368, 6739.326067393319, 6780.457563394916, 7919.049714034238, 7935.2064793520185, 7935.801604959922, 7945.602719863984, 7948.483348582324, 5029.29589857413, 5035.597152227813, 5049.772760225798, 5054.332070416754, 5123.077845987758, 5054.115529782273, 5059.62052846038, 5065.8733531662, 5072.112380333427, 5103.923441148386, 3025.7428118609723, 3088.444080065565, 3112.579801726738, 3113.128324069264, 3122.7970181938554, 1009.9444530550743, 1088.1675518228562, 1112.3715100967927, 1129.5312445335094, 1154.3824054131167, 422.2210022508467, 425.5149129991812, 454.6044940901437, 457.7711144427786, 480.43068963277926, 10600.681979540626, 10869.239153259196, 10969.0, 11411.201215914973, 11617.302961822148, 391.9333713268751, 460.46585960286575, 468.5104066250776, 468.9882752931136, 471.59442879123924, 5918.082697181858, 6072.605280656743, 6079.665618390943, 6135.32511423743, 6466.579672321284, 492253.23594258487, 504044.0, 515971.0, 526486.0, 530296.0, 67533.66233168803, 69121.65439172872, 70572.2942770576, 70911.64544177246, 71067.64466177636, 512.1523877981946, 520.2118790033103, 520.4483247757389, 520.8958208358343, 523.0611053159588, 10547.103496202908, 10622.25644204929, 10685.839712404475, 10855.891441085803, 10877.238593298393, 32879.0, 33553.32893342071, 34020.0, 34171.82914085513, 34453.0, 43982.56017439913, 44036.11927761491, 44420.0, 44641.33038004497, 45240.32139517844, 6039.124326972652, 6132.938670613236, 6148.877022459436, 6151.0773383992755, 6382.744690212339, 11039.116870650168, 11240.4379781009, 11272.492737826653, 11315.321080734853, 11401.771964560829, 9992.300538962494, 10183.236257280882, 10210.438425886647, 10495.790084198426, 10503.212259080752, 9996.850047249443, 10109.696709098738, 10316.329438586468, 10318.948405257926, 10369.844452333373, 8345.66617335324, 8582.09887961755, 9852.408855468695, 10519.646385025231, 10536.57853685844, 6300.827170201936, 6368.554201206057, 6434.742610295536, 6442.291347951816, 6454.096426500199, 10164.542595583069, 10334.741631458974, 10339.327943683937, 10435.269531132748, 10518.316309440168], "unit": "ms", "name": "jquery.html", "value": 6788.221583744528}, {"lowerIsBetter": false, "replicates": [1427.0937954398953, 1652.7272999955007, 1669.9749503757446, 1702.8297170282974, 1712.1781544858463, 6193.628382297065, 6406.359364063597, 7325.926740732598, 7465.850682986337, 7467.813304667386, 7310.378617817492, 7332.266773322665, 7354.117505899286, 7381.667824947876, 7388.039554857861, 2087.3842216546154, 2100.9684854727193, 2103.4320733401973, 2104.642210824156, 2105.536781907978, 2107.420459373669, 2132.051237199447, 2163.939669561911, 2178.8474806763534, 2180.160638154306, 2096.811286984171, 2098.4858709616165, 2114.873107613548, 2129.350548082834, 2130.541933484308, 2111.7149184860077, 2116.8941552922292, 2121.7666056733747, 2122.2996411184427, 2123.617748805222, 2059.104289634014, 2063.772984971652, 2078.0856423173905, 2079.469735217525, 2091.288961752996, 6104.603200791934, 7318.890216646754, 7340.632968351614, 7369.152547457057, 7378.446616503784, 3861.9227615447817, 4372.191144638252, 4469.642428605704, 4480.462344518679, 4485.282354823245, 2808.340040090577, 2882.596436498871, 2944.1903476543907, 2988.4321978823955, 2989.5216765317446, 905.4702998745742, 910.7905181808155, 930.2139691960283, 930.2836815651978, 948.2887834124407, 10035.09684128432, 10045.045720656526, 10083.546240419199, 10112.544935477921, 10119.24105692076, 4013.2776100301644, 4034.23349563582, 4076.898077548026, 4077.796110194538, 4132.33882578792, 8571.571421428904, 8599.441036332744, 8616.353773467015, 8630.654773809103, 8638.870416943751, 4272.33778764292, 4300.548442413564, 4305.7201281917205, 4344.543822898613, 4353.542877997828, 3892.8637497687446, 3893.377059670496, 3895.2599006188734, 3904.824282907219, 3913.2369188008634, 3457.3085382923014, 3457.8098204598987, 3473.94789078164, 3504.281622267429, 3507.631698671603, 1104.9060829829555, 1110.2339385823757, 1112.1769890281296, 1115.4422788605698, 1120.4005856866538, 1017.5370206555999, 1032.1742605915238, 1041.265907535186, 1048.2295512798087, 1049.0086867909752, 6733.46132309414, 6756.2568117507035, 6763.425108865703, 6780.288069752605, 6792.76225332111, 377.9640934111255, 379.0221229228584, 380.27937059272523, 380.77724531149033, 383.1417624521053, 4990.201567749143, 5128.0, 5171.81898633546, 5174.379074511083, 5184.326037615161, 7970.515774459584, 8732.126787321216, 8794.60424280896, 8801.691940782042, 8801.911980880237, 8622.525761083201, 8720.738377848675, 8727.214550690342, 8740.519271440005, 8743.169398907094, 6924.134483189601, 6977.581345119309, 7042.823929401806, 7046.365827075485, 7049.436045116378, 6627.966860165669, 6659.134312539339, 6686.866262674816, 6688.163979502562, 6695.598264104169, 7856.214378562327, 7976.322012628992, 8036.0, 8075.717349892726, 8092.0, 8181.140980197231, 8209.671613135646, 8218.671253149807, 8343.332533397435, 8345.248927596545, 6233.127362169209, 6325.936740632535, 6329.7151628175925, 6333.081703152925, 6333.20834895638, 6802.795916122524, 6823.761168359282, 6849.794506164623, 6865.0, 6868.0, 6357.586756860789, 6424.775132870327, 6461.935380646133, 6556.18047744032, 6589.077529145828, 6414.358564143548, 6475.287718350884, 6512.185976752906, 6536.379043990813, 6564.376384243489, 6543.1821022372205, 6595.175603049619, 6596.208454985241, 6600.966995164993, 6603.867922641424, 5886.41135886425, 6012.368701286302, 6017.578769486269, 6022.277326720821, 6024.909626355696, 6067.605605635619, 6125.663088530174, 6125.989211780185, 6126.142340072304, 6137.202163718866], "unit": "ms", "name": "mootools.html", "value": 4077.6779057047083}, {"lowerIsBetter": false, "replicates": [312.8451416548809, 323.86397712960553, 324.6915430341175, 325.77521510158005, 330.61648487754195, 5285.233641122035, 5322.946770532299, 5386.865328366793, 5390.757415916283, 5439.075357189277, 5200.167973124301, 5368.46315368463, 5382.0043291991005, 5387.326584176978, 5392.595555333346, 4198.118395137025, 4200.495940487146, 4205.747655140686, 4211.978940105295, 4213.431186789775, 3937.2716047531153, 4038.495188101487, 4043.150938302945, 4176.0603864130635, 4196.0, 4105.466289382376, 4118.588141185887, 4133.049398638315, 4136.296829538986, 4138.903190654479, 4099.446574712406, 4114.753114813091, 4114.930118169283, 4116.876493705194, 4153.605407486284, 3599.4420864766003, 3614.5120408744747, 3614.8554057837655, 3618.7466877318598, 3618.9276214475562, 5071.7210553419545, 5182.248573956793, 5184.455632158607, 5193.169092945111, 5202.167653175474, 4732.384789977281, 4748.691335063209, 4780.8525953771195, 4784.617230621542, 4787.305840653121, 5581.832545023656, 5652.349979752299, 5654.858628534278, 5655.943440565583, 5660.066089095294, 3722.8324725387424, 3822.503074600284, 3941.2117576484816, 3981.203759248162, 3998.660113890323, 5937.812437512472, 5945.781114871441, 5947.672877991708, 5950.1372301016545, 5969.522438204933, 4070.7354021988476, 4089.3661482470266, 4105.58944105587, 4109.137081212979, 4116.094459218967, 4196.538380778112, 4216.894577635584, 4219.7046206765235, 4227.471566054243, 4229.725067870579, 4679.415073115861, 4757.26262429324, 4795.040991801654, 4800.35195248644, 4800.4719480857775, 5680.460356266148, 5682.943170568324, 5688.175214593861, 5691.68695721731, 5696.430356964271, 1478.3051965576162, 1482.3255418784427, 1489.1883923261848, 1490.07615278528, 1490.2548725637182, 992.2310209587628, 1001.4041645221082, 1004.638330201127, 1025.7486915705551, 1027.987432379106, 4978.975105124524, 4984.0, 4991.126552853236, 4992.076465853828, 4994.175960966472, 5859.033259512133, 5869.090291004901, 5877.794277200363, 5878.588498805128, 5880.794172203952, 4970.65205435616, 4982.725950072709, 4982.800687972513, 4984.800607975713, 4999.725015124203, 3069.3247485553143, 3142.2929840786096, 3167.129039514152, 3173.7143657070974, 3176.7299779519, 5517.2551705520045, 5542.251796007487, 5552.639078459887, 5553.722313884289, 5556.277683901067, 6044.123602077674, 6047.8488037798525, 6050.122732203806, 6057.939420605826, 6059.818205453844, 5508.394076651645, 5539.279893613804, 5542.667439953616, 5544.61187716856, 5553.500184983371, 5773.8556536086935, 5958.731857066529, 5965.582409231312, 5967.1944287522365, 5979.103134529855, 5570.832875013756, 5743.282089738783, 5743.741531631003, 5803.3616302207565, 5854.853628659318, 5417.674939503642, 5526.557875370041, 5533.833984980457, 5539.113741801292, 5587.497125258747, 4062.2281766464275, 4104.733192342488, 4111.198316328288, 4119.629233369011, 4122.361034039729, 5888.823335299948, 5904.291485021825, 5910.408959104056, 5923.111533269872, 5941.851453713692, 5576.358718747234, 5712.228849105318, 5722.399148089391, 5725.627834190765, 5739.196512488338, 5709.600327977002, 5721.1990321354215, 5721.456461636138, 5724.542036637143, 5728.770849165987, 5567.415421380697, 5602.991461536963, 5605.915911261252, 5607.859803504945, 5616.1856530803625, 5573.498385145356, 5773.422657734193, 5778.075507918713, 5782.710864456676, 5786.566007549535, 5623.606347555632, 5627.465390787868, 5630.60585758993, 5630.7466164023535, 5634.211210430461], "unit": "ms", "name": "prototype.html", "value": 4273.30258433399}, {"lowerIsBetter": false, "replicates": [768.9192634773349, 773.3812949640286, 778.5873487051863, 783.2480818414322, 788.4599049650986, 11495.597654082108, 13895.09681870679, 13969.650758731037, 14021.509247176351, 14038.78941815871, 12416.441260143292, 12500.062495312864, 12502.374881255946, 12512.81230781539, 12514.186577872455, 600.6276108812542, 608.2397003745318, 764.8011517005577, 777.6345117794627, 778.5523324088643, 768.8231706707461, 777.1063277231201, 781.2460975158971, 782.538302401583, 783.8275579372529, 807.4307613132727, 812.2446125103651, 813.4631143445328, 813.894193754814, 815.2377527012233, 628.4909223528933, 637.3849235487777, 806.1897792718339, 819.4632515702225, 842.6924172676929, 608.1698481572665, 613.0405914743412, 613.1844646619985, 613.4295105551835, 613.5490414545305, 11843.23019003762, 11975.580854670045, 11983.700407489796, 11994.10044246685, 12013.93993030038, 11349.829752553718, 11443.542258309657, 11544.018758405546, 11717.589884354007, 11937.224080434744, 9111.544422778901, 9298.53507324631, 9324.0, 9336.906630933672, 9489.38319009269, 3232.095013396229, 3242.1084201844446, 3304.0913748719054, 3337.8331083445732, 3344.96655033449, 42918.35622465666, 42947.785261073805, 43482.565174348165, 43505.0, 43559.78220108911, 9316.767080823034, 9578.425294482353, 9594.280428967855, 9707.6116955321, 9778.706638800848, 16736.581585460463, 16751.497455076365, 16759.078250696086, 16763.748543771853, 16768.161591920354, 6423.068655044993, 6432.324605916405, 6504.869902602016, 6568.211814582281, 6620.768273110418, 3571.142925697814, 3603.6936860367164, 3614.042278796121, 3625.6918161956, 3657.8902632921054, 2603.4402603440353, 2629.907953221628, 2631.8026148038975, 2634.4467661790854, 2643.233462295951, 409.25107054090944, 411.61925219172747, 412.7853516171574, 413.09532124646927, 420.1324265391956, 478.45934094473023, 484.791539637952, 517.1898355754857, 580.6283978253921, 594.8602078511547, 7194.532355396883, 7250.2024777274455, 7312.670929808171, 7553.0, 7594.202608726005, 361.76485284565246, 460.68567861973054, 560.9775608975596, 599.1551911804335, 613.8741557980693, 3681.245344704329, 3729.6829769469355, 3740.0, 3744.2698673758355, 3765.604611515806, 47971.04057918822, 48728.0, 54613.72693136509, 55043.72478137664, 55045.44954550483, 45627.77186114115, 46268.0, 47184.7640761794, 47346.289805652945, 48115.03769924582, 43387.78306108449, 43742.56257437448, 43814.56185438169, 44273.0, 44720.55279447229, 7945.960270198843, 7977.521348719096, 8127.0, 8330.416870818985, 8605.483670979762, 34018.82990585031, 34274.65725342715, 36622.63377366299, 37282.25435491329, 37944.0, 45288.0, 45556.77221613871, 46043.3093503591, 46905.29642055304, 47177.764111179225, 10255.134037448788, 10296.845547316647, 10329.328593641389, 10508.264421490423, 10829.133669306279, 9943.30396872212, 10370.42962637032, 11269.267497612629, 11623.941880290544, 11625.302481851117, 10058.446785426871, 10132.0, 10265.692029238837, 11023.559057637605, 11396.829047564128, 10044.997682843481, 10693.732656683645, 10703.571857125628, 10747.408892510986, 11178.217524773188, 7821.726239581587, 9947.303688741718, 10496.422696751446, 10566.788664226826, 10729.731756705833, 8755.51844648525, 8821.426607270507, 9075.863862042206, 9113.863292050757, 9268.675596354366, 8334.791630209293, 8741.300695944436, 8774.429662071945, 9041.81916361656, 9042.728718138467], "unit": "ms", "name": "yui.html", "value": 5756.7093946690775}], "name": "dromaeo_css", "value": 6118.7494326664355}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 105.0, 112.0, 112.0, 112.0, 102.0, 115.0, 116.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [156.0, 130.0, 151.0, 166.0, 135.0, 154.0, 157.0, 137.0, 176.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 163.0, 163.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 82.0, 92.0, 73.0, 75.0, 73.0, 102.0, 92.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 129.0, 91.0, 92.0, 90.0, 124.0, 91.0, 90.0, 123.0], "unit": "ms", "name": "audio-oscillator", "value": 101.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 72.0, 72.0, 69.0, 71.0, 80.0, 70.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 71.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 82.0, 82.0, 83.0, 85.0, 83.0, 82.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [119.0, 125.0, 121.0, 119.0, 126.0, 122.0, 132.0, 123.0, 129.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [144.0, 145.0, 148.0, 163.0, 152.0, 137.0, 159.0, 138.0, 149.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 73.0, 70.0, 70.0, 70.0, 69.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1520.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.52234682268812], "unit": "score", "name": "Richards", "value": 217.21320600000004}, {"lowerIsBetter": false, "replicates": [191.68104274487254], "unit": "score", "name": "DeltaBlue", "value": 344.937606}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [26684.21052631579], "unit": "score", "name": "RegExp", "value": 34.13947731755427}, {"lowerIsBetter": false, "replicates": [619.1950464396285], "unit": "score", "name": "Splay", "value": 131.60796499999995}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19755.627946461263}]} 01:20:39 INFO - RETURN: dromaeo_css: 6118.75 01:20:39 INFO - RETURN: kraken: 1520.70 01:20:39 INFO - RETURN: v8_7: 19755.63 01:20:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19755.63"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1520.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "6118.75"}}} 01:20:39 INFO - Return code: 0 01:20:39 INFO - # TBPL SUCCESS # 01:20:39 INFO - Running post-action listener: _resource_record_post_action 01:20:39 INFO - Running post-run listener: _resource_record_post_run 01:20:40 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 8192; Write bytes: 496386048; Read time: 24; Write time: 402580 01:20:40 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 159293440; Read time: 0; Write time: 188948 01:20:40 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 336904192; Read time: 0; Write time: 213584 01:20:40 INFO - Running post-run listener: _upload_blobber_files 01:20:40 INFO - Blob upload gear active. 01:20:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:20:40 INFO - Copying logs to upload dir... 01:20:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1310.459752 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-19 01:20:40.838208) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 01:20:40.842217) ========= 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=70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009953 build_url: 'https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 01:20:40.892730) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 01:20:40.893067) ========= 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=70a720fcaf18edea6683c2dc000001ad-1447914601.890151-1253437930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004709 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 01:20:40.942638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 01:20:40.942960) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 01:20:40.943232) ========= ========= Total master_lag: 0.28 =========