builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1447813295.17 results: success (0) buildid: 20151117173134 builduid: e8c46542fe0a4558b3dba57b25c90d98 revision: 84d1c56d6983f1acb9f09bf29c2b45b9183e944b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.175301) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.175718) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.176017) ========= 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=fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006473 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.204906) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.205194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.228126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.228378) ========= 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=fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.281282) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.281603) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.281989) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.282264) ========= 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=fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 18:21:35-- 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% 222M=0s 2015-11-17 18:21:35 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102799 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.397345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.397641) ========= 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=fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019760 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.446520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.446838) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 84d1c56d6983f1acb9f09bf29c2b45b9183e944b --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 84d1c56d6983f1acb9f09bf29c2b45b9183e944b --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=fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 18:21:35,579 truncating revision to first 12 chars 2015-11-17 18:21:35,580 Setting DEBUG logging. 2015-11-17 18:21:35,580 attempt 1/10 2015-11-17 18:21:35,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/84d1c56d6983?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 18:21:35,816 unpacking tar archive at: mozilla-inbound-84d1c56d6983/testing/mozharness/ program finished with exit code 0 elapsedTime=0.484694 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.944397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.944713) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.953458) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.953728) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:21:35.954133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-17 18:21:35.954422) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:21:36 INFO - MultiFileLogger online at 20151117 18:21:36 in /builds/slave/test 18:21:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 18:21:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:21:36 INFO - {'append_to_log': False, 18:21:36 INFO - 'base_work_dir': '/builds/slave/test', 18:21:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 18:21:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:21:36 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 18:21:36 INFO - 'buildbot_json_path': 'buildprops.json', 18:21:36 INFO - 'config_files': ('talos/linux_config.py',), 18:21:36 INFO - 'default_actions': ('clobber', 18:21:36 INFO - 'read-buildbot-config', 18:21:36 INFO - 'download-and-extract', 18:21:36 INFO - 'populate-webroot', 18:21:36 INFO - 'create-virtualenv', 18:21:36 INFO - 'install', 18:21:36 INFO - 'run-tests'), 18:21:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:21:36 INFO - 'download_minidump_stackwalk': True, 18:21:36 INFO - 'download_symbols': 'ondemand', 18:21:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:21:36 INFO - 'tooltool.py': '/tools/tooltool.py', 18:21:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:21:36 INFO - '/tools/misc-python/virtualenv.py')}, 18:21:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:21:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:21:36 INFO - 'installer_path': 'installer.exe', 18:21:36 INFO - 'log_level': 'info', 18:21:36 INFO - 'log_name': 'talos', 18:21:36 INFO - 'log_to_console': True, 18:21:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:21:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:21:36 INFO - 'opt_config_files': (), 18:21:36 INFO - 'pip_index': False, 18:21:36 INFO - 'sps_profile': False, 18:21:36 INFO - 'sps_profile_interval': 0, 18:21:36 INFO - 'suite': 'dromaeojs-e10s', 18:21:36 INFO - 'system_bits': '64', 18:21:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:21:36 INFO - 'title': 'talos-linux64-ix-046', 18:21:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:21:36 INFO - 'use_talos_json': True, 18:21:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:21:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:21:36 INFO - 'work_dir': 'build'} 18:21:36 INFO - ##### 18:21:36 INFO - ##### Running clobber step. 18:21:36 INFO - ##### 18:21:36 INFO - Running pre-action listener: _resource_record_pre_action 18:21:36 INFO - Running main action method: clobber 18:21:36 INFO - rmtree: /builds/slave/test/build 18:21:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:21:37 INFO - Running post-action listener: _resource_record_post_action 18:21:37 INFO - ##### 18:21:37 INFO - ##### Running read-buildbot-config step. 18:21:37 INFO - ##### 18:21:37 INFO - Running pre-action listener: _resource_record_pre_action 18:21:37 INFO - Running main action method: read_buildbot_config 18:21:37 INFO - Using buildbot properties: 18:21:37 INFO - { 18:21:37 INFO - "properties": { 18:21:37 INFO - "buildnumber": 1109, 18:21:37 INFO - "product": "firefox", 18:21:37 INFO - "script_repo_revision": "production", 18:21:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:21:37 INFO - "repository": "", 18:21:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs-e10s", 18:21:37 INFO - "buildid": "20151117173134", 18:21:37 INFO - "slavename": "talos-linux64-ix-046", 18:21:37 INFO - "pgo_build": "False", 18:21:37 INFO - "basedir": "/builds/slave/test", 18:21:37 INFO - "project": "", 18:21:37 INFO - "platform": "ubuntu64_hw", 18:21:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:21:37 INFO - "slavebuilddir": "test", 18:21:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 18:21:37 INFO - "branch": "mozilla-inbound", 18:21:37 INFO - "repo_path": "integration/mozilla-inbound", 18:21:37 INFO - "stage_platform": "linux64", 18:21:37 INFO - "builduid": "e8c46542fe0a4558b3dba57b25c90d98", 18:21:37 INFO - "revision": "84d1c56d6983f1acb9f09bf29c2b45b9183e944b" 18:21:37 INFO - }, 18:21:37 INFO - "sourcestamp": { 18:21:37 INFO - "repository": "", 18:21:37 INFO - "hasPatch": false, 18:21:37 INFO - "project": "", 18:21:37 INFO - "branch": "mozilla-inbound-linux64-talos", 18:21:37 INFO - "changes": [ 18:21:37 INFO - { 18:21:37 INFO - "category": null, 18:21:37 INFO - "files": [ 18:21:37 INFO - { 18:21:37 INFO - "url": null, 18:21:37 INFO - "name": "https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:21:37 INFO - } 18:21:37 INFO - ], 18:21:37 INFO - "repository": "", 18:21:37 INFO - "rev": "84d1c56d6983f1acb9f09bf29c2b45b9183e944b", 18:21:37 INFO - "who": "tcole@mozilla.com", 18:21:37 INFO - "when": 1447813267, 18:21:37 INFO - "number": 6675386, 18:21:37 INFO - "comments": "Backout 02919b7d57d7 (Bug 1225233) for having regressed all the things.", 18:21:37 INFO - "project": "", 18:21:37 INFO - "at": "Tue 17 Nov 2015 18:21:07", 18:21:37 INFO - "branch": "mozilla-inbound-linux64-talos", 18:21:37 INFO - "revlink": "", 18:21:37 INFO - "properties": [ 18:21:37 INFO - [ 18:21:37 INFO - "buildid", 18:21:37 INFO - "20151117173134", 18:21:37 INFO - "Change" 18:21:37 INFO - ], 18:21:37 INFO - [ 18:21:37 INFO - "builduid", 18:21:37 INFO - "e8c46542fe0a4558b3dba57b25c90d98", 18:21:37 INFO - "Change" 18:21:37 INFO - ], 18:21:37 INFO - [ 18:21:37 INFO - "pgo_build", 18:21:37 INFO - "False", 18:21:37 INFO - "Change" 18:21:37 INFO - ] 18:21:37 INFO - ], 18:21:37 INFO - "revision": "84d1c56d6983f1acb9f09bf29c2b45b9183e944b" 18:21:37 INFO - } 18:21:37 INFO - ], 18:21:37 INFO - "revision": "84d1c56d6983f1acb9f09bf29c2b45b9183e944b" 18:21:37 INFO - } 18:21:37 INFO - } 18:21:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:21:37 INFO - Running post-action listener: _resource_record_post_action 18:21:37 INFO - ##### 18:21:37 INFO - ##### Running download-and-extract step. 18:21:37 INFO - ##### 18:21:37 INFO - Running pre-action listener: _resource_record_pre_action 18:21:37 INFO - Running main action method: download_and_extract 18:21:37 INFO - mkdir: /builds/slave/test/build/tests 18:21: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')]} 18:21:37 INFO - https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/test_packages.json 18:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/test_packages.json 18:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:21:40 INFO - Downloaded 1302 bytes. 18:21:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:21:40 INFO - Using the following test package requirements: 18:21:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:21:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:21:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:40 INFO - u'jsshell-linux-x86_64.zip'], 18:21:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:21:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:21:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:21:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:21:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:21:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:21:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:21:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:21:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:40 INFO - https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:21:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:21:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:21:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/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 18:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/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 18:21:43 INFO - Downloaded 21277830 bytes. 18:21:43 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 18:21:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:21:43 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 18:21:44 INFO - Return code: 0 18:21:44 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 18:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:44 INFO - https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:21:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:21:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:21:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/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 18:21:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/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 18:21:45 INFO - Downloaded 21277830 bytes. 18:21:45 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 18:21:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:21:45 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 18:21:46 INFO - Return code: 0 18:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:46 INFO - https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:21:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:21:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:21:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/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 18:21:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/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 18:21:47 INFO - Downloaded 11130997 bytes. 18:21:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:21:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:21:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:21:47 INFO - Return code: 0 18:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:47 INFO - https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:21:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:21:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:21:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/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 18:21:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DwJXblZcS7e5wQQnieUKcA/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 18:21:49 INFO - Downloaded 55663922 bytes. 18:21:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:21:49 INFO - mkdir: /builds/slave/test/properties 18:21:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:21:49 INFO - Writing to file /builds/slave/test/properties/build_url 18:21:49 INFO - Contents: 18:21:49 INFO - build_url:https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:21:49 INFO - Running post-action listener: _resource_record_post_action 18:21:49 INFO - Running post-action listener: set_extra_try_arguments 18:21:49 INFO - ##### 18:21:49 INFO - ##### Running populate-webroot step. 18:21:49 INFO - ##### 18:21:49 INFO - Running pre-action listener: _resource_record_pre_action 18:21:49 INFO - Running main action method: populate_webroot 18:21:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:21:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:21:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:21:49 INFO - '../fennec_ids.txt'], 18:21:49 INFO - 'tests': ['tcheck2']}, 18:21:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:21:49 INFO - '--tppagecycles', 18:21:49 INFO - '7'], 18:21:49 INFO - 'tests': ['tsvgm']}}, 18:21:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:21:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:21:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:21:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:21:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:21:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:21:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:49 INFO - 'talos_options': ['--e10s'], 18:21:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:49 INFO - 'tests': ['damp', 'tps']}, 18:21:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:49 INFO - 'talos_options': ['--e10s'], 18:21:49 INFO - 'tests': ['damp', 'tps']}, 18:21:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:21:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:21:49 INFO - 'other': {'tests': ['a11yr', 18:21:49 INFO - 'ts_paint', 18:21:49 INFO - 'tpaint', 18:21:49 INFO - 'sessionrestore', 18:21:49 INFO - 'sessionrestore_no_auto_restore']}, 18:21:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:21:49 INFO - 'tests': ['a11yr', 18:21:49 INFO - 'ts_paint', 18:21:49 INFO - 'tpaint', 18:21:49 INFO - 'sessionrestore', 18:21:49 INFO - 'sessionrestore_no_auto_restore']}, 18:21:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:21:49 INFO - 'tests': ['a11yr', 18:21:49 INFO - 'ts_paint', 18:21:49 INFO - 'tpaint', 18:21:49 INFO - 'sessionrestore', 18:21:49 INFO - 'sessionrestore_no_auto_restore']}, 18:21:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:21:49 INFO - 'tests': ['a11yr', 18:21:49 INFO - 'ts_paint', 18:21:49 INFO - 'tpaint', 18:21:49 INFO - 'sessionrestore', 18:21:49 INFO - 'sessionrestore_no_auto_restore']}, 18:21:49 INFO - 'other_l64': {'tests': ['a11yr', 18:21:49 INFO - 'ts_paint', 18:21:49 INFO - 'tpaint', 18:21:49 INFO - 'sessionrestore', 18:21:49 INFO - 'sessionrestore_no_auto_restore']}, 18:21:49 INFO - 'other_nol64': {'tests': ['a11yr', 18:21:49 INFO - 'ts_paint', 18:21:49 INFO - 'tpaint', 18:21:49 INFO - 'sessionrestore', 18:21:49 INFO - 'sessionrestore_no_auto_restore']}, 18:21:49 INFO - 'svgr': {'tests': ['tsvgx', 18:21:49 INFO - 'tsvgr_opacity', 18:21:49 INFO - 'tart', 18:21:49 INFO - 'tscrollx', 18:21:49 INFO - 'cart']}, 18:21:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:21:49 INFO - 'tests': ['tsvgx', 18:21:49 INFO - 'tsvgr_opacity', 18:21:49 INFO - 'tart', 18:21:49 INFO - 'tscrollx', 18:21:49 INFO - 'cart']}, 18:21:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:49 INFO - 'tests': ['tp5o']}, 18:21:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:49 INFO - 'talos_options': ['--e10s'], 18:21:49 INFO - 'tests': ['tp5o']}, 18:21:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:49 INFO - 'talos_options': ['--xperf_path', 18:21:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:49 INFO - 'tests': ['tp5n']}, 18:21:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:49 INFO - 'talos_options': ['--e10s', 18:21:49 INFO - '--xperf_path', 18:21:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:49 INFO - 'tests': ['tp5n']}}, 18:21:49 INFO - 'talos.zip': {'path': '', 18:21:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:21:49 INFO - Running post-action listener: _resource_record_post_action 18:21:49 INFO - ##### 18:21:49 INFO - ##### Running create-virtualenv step. 18:21:49 INFO - ##### 18:21:49 INFO - Running pre-action listener: _resource_record_pre_action 18:21:49 INFO - Running main action method: create_virtualenv 18:21:49 INFO - Creating virtualenv /builds/slave/test/build/venv 18:21:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:21:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:21:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:21:49 INFO - Using real prefix '/usr' 18:21:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:21:49 INFO - Installing distribute.............................................................................................................................................................................................done. 18:21:51 INFO - Installing pip.................done. 18:21:51 INFO - Return code: 0 18:21:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff305ccac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17966c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188db70>, '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 0x18dedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18df250>, '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': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', '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 18:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:21:51 INFO - Using env: {'DISPLAY': ':0', 18:21:51 INFO - 'HOME': '/home/cltbld', 18:21:51 INFO - 'LANG': 'en_US.UTF-8', 18:21:51 INFO - 'LANGUAGE': 'en_US:en', 18:21:51 INFO - 'LOGNAME': 'cltbld', 18:21:51 INFO - 'MAIL': '/var/mail/cltbld', 18:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:51 INFO - 'MOZ_NO_REMOTE': '1', 18:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:51 INFO - 'NO_EM_RESTART': '1', 18:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:51 INFO - 'PWD': '/builds/slave/test', 18:21:51 INFO - 'SHELL': '/bin/bash', 18:21:51 INFO - 'SHLVL': '1', 18:21:51 INFO - 'TERM': 'linux', 18:21:51 INFO - 'TMOUT': '86400', 18:21:51 INFO - 'USER': 'cltbld', 18:21:51 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', 18:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:51 INFO - '_': '/tools/buildbot/bin/python'} 18:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:52 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 18:21:52 INFO - Cleaning up... 18:21:52 INFO - Return code: 0 18:21:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff305ccac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17966c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188db70>, '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 0x18dedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18df250>, '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': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', '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 18:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:21:52 INFO - Using env: {'DISPLAY': ':0', 18:21:52 INFO - 'HOME': '/home/cltbld', 18:21:52 INFO - 'LANG': 'en_US.UTF-8', 18:21:52 INFO - 'LANGUAGE': 'en_US:en', 18:21:52 INFO - 'LOGNAME': 'cltbld', 18:21:52 INFO - 'MAIL': '/var/mail/cltbld', 18:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:52 INFO - 'MOZ_NO_REMOTE': '1', 18:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:52 INFO - 'NO_EM_RESTART': '1', 18:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:52 INFO - 'PWD': '/builds/slave/test', 18:21:52 INFO - 'SHELL': '/bin/bash', 18:21:52 INFO - 'SHLVL': '1', 18:21:52 INFO - 'TERM': 'linux', 18:21:52 INFO - 'TMOUT': '86400', 18:21:52 INFO - 'USER': 'cltbld', 18:21:52 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', 18:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:52 INFO - '_': '/tools/buildbot/bin/python'} 18:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:52 INFO - Downloading/unpacking psutil>=0.7.1 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:21:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:54 INFO - Installing collected packages: psutil 18:21:54 INFO - Running setup.py install for psutil 18:21:54 INFO - building 'psutil._psutil_linux' extension 18:21:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:21:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:21:54 INFO - building 'psutil._psutil_posix' extension 18:21:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:21:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:21:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:54 INFO - Successfully installed psutil 18:21:54 INFO - Cleaning up... 18:21:54 INFO - Return code: 0 18:21:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21: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')]} 18:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff305ccac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17966c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188db70>, '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 0x18dedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18df250>, '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': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', '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 18:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:21:54 INFO - Using env: {'DISPLAY': ':0', 18:21:54 INFO - 'HOME': '/home/cltbld', 18:21:54 INFO - 'LANG': 'en_US.UTF-8', 18:21:54 INFO - 'LANGUAGE': 'en_US:en', 18:21:54 INFO - 'LOGNAME': 'cltbld', 18:21:54 INFO - 'MAIL': '/var/mail/cltbld', 18:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:54 INFO - 'MOZ_NO_REMOTE': '1', 18:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:54 INFO - 'NO_EM_RESTART': '1', 18:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:54 INFO - 'PWD': '/builds/slave/test', 18:21:54 INFO - 'SHELL': '/bin/bash', 18:21:54 INFO - 'SHLVL': '1', 18:21:54 INFO - 'TERM': 'linux', 18:21:54 INFO - 'TMOUT': '86400', 18:21:54 INFO - 'USER': 'cltbld', 18:21:54 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', 18:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:54 INFO - '_': '/tools/buildbot/bin/python'} 18:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:21:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:21:56 INFO - Installing collected packages: mozsystemmonitor 18:21:56 INFO - Running setup.py install for mozsystemmonitor 18:21:56 INFO - Successfully installed mozsystemmonitor 18:21:56 INFO - Cleaning up... 18:21:56 INFO - Return code: 0 18:21:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff305ccac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17966c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188db70>, '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 0x18dedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18df250>, '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': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', '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 18:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:21:56 INFO - Using env: {'DISPLAY': ':0', 18:21:56 INFO - 'HOME': '/home/cltbld', 18:21:56 INFO - 'LANG': 'en_US.UTF-8', 18:21:56 INFO - 'LANGUAGE': 'en_US:en', 18:21:56 INFO - 'LOGNAME': 'cltbld', 18:21:56 INFO - 'MAIL': '/var/mail/cltbld', 18:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:56 INFO - 'MOZ_NO_REMOTE': '1', 18:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:56 INFO - 'NO_EM_RESTART': '1', 18:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:56 INFO - 'PWD': '/builds/slave/test', 18:21:56 INFO - 'SHELL': '/bin/bash', 18:21:56 INFO - 'SHLVL': '1', 18:21:56 INFO - 'TERM': 'linux', 18:21:56 INFO - 'TMOUT': '86400', 18:21:56 INFO - 'USER': 'cltbld', 18:21:56 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', 18:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:56 INFO - '_': '/tools/buildbot/bin/python'} 18:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:56 INFO - Downloading/unpacking blobuploader==1.2.4 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:58 INFO - Downloading blobuploader-1.2.4.tar.gz 18:21:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:21:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:21:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:21:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:59 INFO - Downloading docopt-0.6.1.tar.gz 18:21:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:21:59 INFO - Installing collected packages: blobuploader, requests, docopt 18:21:59 INFO - Running setup.py install for blobuploader 18:21:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:21:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:21:59 INFO - Running setup.py install for requests 18:21:59 INFO - Running setup.py install for docopt 18:21:59 INFO - Successfully installed blobuploader requests docopt 18:21:59 INFO - Cleaning up... 18:21:59 INFO - Return code: 0 18:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff305ccac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17966c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188db70>, '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 0x18dedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18df250>, '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': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', '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 18:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:21:59 INFO - Using env: {'DISPLAY': ':0', 18:21:59 INFO - 'HOME': '/home/cltbld', 18:21:59 INFO - 'LANG': 'en_US.UTF-8', 18:21:59 INFO - 'LANGUAGE': 'en_US:en', 18:21:59 INFO - 'LOGNAME': 'cltbld', 18:21:59 INFO - 'MAIL': '/var/mail/cltbld', 18:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:59 INFO - 'MOZ_NO_REMOTE': '1', 18:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:59 INFO - 'NO_EM_RESTART': '1', 18:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:59 INFO - 'PWD': '/builds/slave/test', 18:21:59 INFO - 'SHELL': '/bin/bash', 18:21:59 INFO - 'SHLVL': '1', 18:21:59 INFO - 'TERM': 'linux', 18:21:59 INFO - 'TMOUT': '86400', 18:21:59 INFO - 'USER': 'cltbld', 18:21:59 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', 18:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:59 INFO - '_': '/tools/buildbot/bin/python'} 18:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:22:00 INFO - Running setup.py (path:/tmp/pip-CeYyGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:22:00 INFO - Running setup.py (path:/tmp/pip-GspN8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:22:00 INFO - Running setup.py (path:/tmp/pip-vnFJkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:22:00 INFO - Running setup.py (path:/tmp/pip-HTS3nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:22:00 INFO - Running setup.py (path:/tmp/pip-iDvlFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:22:00 INFO - Running setup.py (path:/tmp/pip-VLGoX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:22:00 INFO - Running setup.py (path:/tmp/pip-FGhNKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:00 INFO - Running setup.py (path:/tmp/pip-bd7oFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:00 INFO - Running setup.py (path:/tmp/pip-syUeJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:00 INFO - Running setup.py (path:/tmp/pip-xbRmyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:00 INFO - Running setup.py (path:/tmp/pip-4LrzhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:00 INFO - Running setup.py (path:/tmp/pip-6_H95v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:00 INFO - Running setup.py (path:/tmp/pip-J87yym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:01 INFO - Running setup.py (path:/tmp/pip-HiOjoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:01 INFO - Running setup.py (path:/tmp/pip-VLs0br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:01 INFO - Running setup.py (path:/tmp/pip-wXEOjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:01 INFO - Running setup.py (path:/tmp/pip-yKGGiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:22:01 INFO - Running setup.py install for manifestparser 18:22:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:22:01 INFO - Running setup.py install for mozcrash 18:22:01 INFO - Running setup.py install for mozdebug 18:22:01 INFO - Running setup.py install for mozdevice 18:22:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:22:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:22:01 INFO - Running setup.py install for mozfile 18:22:01 INFO - Running setup.py install for mozhttpd 18:22:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:22:01 INFO - Running setup.py install for mozinfo 18:22:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:22:01 INFO - Running setup.py install for mozInstall 18:22:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:22:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:22:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:22:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:22:02 INFO - Running setup.py install for mozleak 18:22:02 INFO - Running setup.py install for mozlog 18:22:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:22:02 INFO - Running setup.py install for moznetwork 18:22:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:22:02 INFO - Running setup.py install for mozprocess 18:22:02 INFO - Running setup.py install for mozprofile 18:22:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:22:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:22:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:22:02 INFO - Running setup.py install for mozrunner 18:22:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:22:02 INFO - Running setup.py install for mozscreenshot 18:22:02 INFO - Running setup.py install for moztest 18:22:02 INFO - Running setup.py install for mozversion 18:22:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:22:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:22:03 INFO - Cleaning up... 18:22:03 INFO - Return code: 0 18:22:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ff305ccac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17966c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188db70>, '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 0x18dedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18df250>, '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': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', '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 18:22:03 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 18:22:03 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 18:22:03 INFO - Using env: {'DISPLAY': ':0', 18:22:03 INFO - 'HOME': '/home/cltbld', 18:22:03 INFO - 'LANG': 'en_US.UTF-8', 18:22:03 INFO - 'LANGUAGE': 'en_US:en', 18:22:03 INFO - 'LOGNAME': 'cltbld', 18:22:03 INFO - 'MAIL': '/var/mail/cltbld', 18:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:03 INFO - 'MOZ_NO_REMOTE': '1', 18:22:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:03 INFO - 'NO_EM_RESTART': '1', 18:22:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:03 INFO - 'PWD': '/builds/slave/test', 18:22:03 INFO - 'SHELL': '/bin/bash', 18:22:03 INFO - 'SHLVL': '1', 18:22:03 INFO - 'TERM': 'linux', 18:22:03 INFO - 'TMOUT': '86400', 18:22:03 INFO - 'USER': 'cltbld', 18:22:03 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', 18:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:03 INFO - '_': '/tools/buildbot/bin/python'} 18:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:22:03 INFO - Running setup.py (path:/tmp/pip-dM1Pwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:22:03 INFO - Running setup.py (path:/tmp/pip-tWyaIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:22:03 INFO - Running setup.py (path:/tmp/pip-4nV6FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:22:03 INFO - Running setup.py (path:/tmp/pip-3EvW5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:22:03 INFO - Running setup.py (path:/tmp/pip-yYJdFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:22:03 INFO - Running setup.py (path:/tmp/pip-9sBBj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:22:03 INFO - Running setup.py (path:/tmp/pip-60zKYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:03 INFO - Running setup.py (path:/tmp/pip-M9Tqhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:03 INFO - Running setup.py (path:/tmp/pip-lNKeAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:03 INFO - Running setup.py (path:/tmp/pip-mLffnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:03 INFO - Running setup.py (path:/tmp/pip-cH4hKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:04 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)) 18:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:04 INFO - Running setup.py (path:/tmp/pip-0FU0r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:04 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)) 18:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:04 INFO - Running setup.py (path:/tmp/pip-3X0c2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:04 INFO - Running setup.py (path:/tmp/pip-w1uf3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:04 INFO - Running setup.py (path:/tmp/pip-UaOmTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:04 INFO - Running setup.py (path:/tmp/pip-WcGcnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:22:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:04 INFO - Running setup.py (path:/tmp/pip-asGQou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:06 INFO - Downloading blessings-1.5.1.tar.gz 18:22:06 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 18:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:22:06 INFO - Installing collected packages: blessings 18:22:06 INFO - Running setup.py install for blessings 18:22:06 INFO - Successfully installed blessings 18:22:06 INFO - Cleaning up... 18:22:06 INFO - Return code: 0 18:22:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:06 INFO - Reading from file tmpfile_stdout 18:22:06 INFO - Current package versions: 18:22:06 INFO - argparse == 1.2.1 18:22:06 INFO - blessings == 1.5.1 18:22:06 INFO - blobuploader == 1.2.4 18:22:06 INFO - docopt == 0.6.1 18:22:06 INFO - manifestparser == 1.1 18:22:06 INFO - mozInstall == 1.12 18:22:06 INFO - mozcrash == 0.16 18:22:06 INFO - mozdebug == 0.1 18:22:06 INFO - mozdevice == 0.47 18:22:06 INFO - mozfile == 1.2 18:22:06 INFO - mozhttpd == 0.7 18:22:06 INFO - mozinfo == 0.9 18:22:06 INFO - mozleak == 0.1 18:22:06 INFO - mozlog == 3.0 18:22:06 INFO - moznetwork == 0.27 18:22:06 INFO - mozprocess == 0.22 18:22:06 INFO - mozprofile == 0.27 18:22:06 INFO - mozrunner == 6.11 18:22:06 INFO - mozscreenshot == 0.1 18:22:06 INFO - mozsystemmonitor == 0.0 18:22:06 INFO - moztest == 0.7 18:22:06 INFO - mozversion == 1.4 18:22:06 INFO - psutil == 3.1.1 18:22:06 INFO - requests == 1.2.3 18:22:06 INFO - wsgiref == 0.1.2 18:22:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff305ccac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17966c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1847900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188db70>, '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 0x18dedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18df250>, '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': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', '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 18:22:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:22:06 INFO - Using env: {'DISPLAY': ':0', 18:22:06 INFO - 'HOME': '/home/cltbld', 18:22:06 INFO - 'LANG': 'en_US.UTF-8', 18:22:06 INFO - 'LANGUAGE': 'en_US:en', 18:22:06 INFO - 'LOGNAME': 'cltbld', 18:22:06 INFO - 'MAIL': '/var/mail/cltbld', 18:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:06 INFO - 'MOZ_NO_REMOTE': '1', 18:22:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:06 INFO - 'NO_EM_RESTART': '1', 18:22:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:06 INFO - 'PWD': '/builds/slave/test', 18:22:06 INFO - 'SHELL': '/bin/bash', 18:22:06 INFO - 'SHLVL': '1', 18:22:06 INFO - 'TERM': 'linux', 18:22:06 INFO - 'TMOUT': '86400', 18:22:06 INFO - 'USER': 'cltbld', 18:22:06 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', 18:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:06 INFO - '_': '/tools/buildbot/bin/python'} 18:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:22:06 INFO - Cleaning up... 18:22:06 INFO - Return code: 0 18:22:06 INFO - Running post-action listener: _resource_record_post_action 18:22:06 INFO - Running post-action listener: _start_resource_monitoring 18:22:06 INFO - Starting resource monitoring. 18:22:06 INFO - ##### 18:22:06 INFO - ##### Running install step. 18:22:06 INFO - ##### 18:22:06 INFO - Running pre-action listener: _resource_record_pre_action 18:22:06 INFO - Running main action method: install 18:22:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:07 INFO - Reading from file tmpfile_stdout 18:22:07 INFO - Detecting whether we're running mozinstall >=1.0... 18:22:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:22:07 INFO - Reading from file tmpfile_stdout 18:22:07 INFO - Output received: 18:22:07 INFO - Usage: mozinstall [options] installer 18:22:07 INFO - Options: 18:22:07 INFO - -h, --help show this help message and exit 18:22:07 INFO - -d DEST, --destination=DEST 18:22:07 INFO - Directory to install application into. [default: 18:22:07 INFO - "/builds/slave/test"] 18:22:07 INFO - --app=APP Application being installed. [default: firefox] 18:22:07 INFO - mkdir: /builds/slave/test/build/application 18:22:07 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'] 18:22:07 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 18:22:21 INFO - Reading from file tmpfile_stdout 18:22:21 INFO - Output received: 18:22:21 INFO - /builds/slave/test/build/application/firefox/firefox 18:22:21 INFO - Running post-action listener: _resource_record_post_action 18:22:21 INFO - ##### 18:22:21 INFO - ##### Running run-tests step. 18:22:21 INFO - ##### 18:22:21 INFO - Running pre-action listener: _resource_record_pre_action 18:22:21 INFO - Running main action method: run_tests 18:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:22:21 INFO - Python 2.7.3 18:22:21 INFO - Return code: 0 18:22:21 INFO - grabbing minidump binary from tooltool 18:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188db70>, '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 0x18dedc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18df250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:22:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:22:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:22:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:22:21 INFO - Return code: 0 18:22:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:22:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:22:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:22:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:22:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] in /builds/slave/test/build 18:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost 18:22:21 INFO - Using env: {'DISPLAY': ':0', 18:22:21 INFO - 'HOME': '/home/cltbld', 18:22:21 INFO - 'LANG': 'en_US.UTF-8', 18:22:21 INFO - 'LANGUAGE': 'en_US:en', 18:22:21 INFO - 'LOGNAME': 'cltbld', 18:22:21 INFO - 'MAIL': '/var/mail/cltbld', 18:22:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:22:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:21 INFO - 'MOZ_NO_REMOTE': '1', 18:22:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:22:21 INFO - 'NO_EM_RESTART': '1', 18:22:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:21 INFO - 'PWD': '/builds/slave/test', 18:22:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:22:21 INFO - 'SHELL': '/bin/bash', 18:22:21 INFO - 'SHLVL': '1', 18:22:21 INFO - 'TERM': 'linux', 18:22:21 INFO - 'TMOUT': '86400', 18:22:21 INFO - 'USER': 'cltbld', 18:22:21 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888', 18:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:21 INFO - '_': '/tools/buildbot/bin/python'} 18:22:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] with output_timeout 3600 18:22:21 INFO - mozversion INFO | application_buildid: 20151117173134 18:22:21 INFO - mozversion INFO | application_changeset: 84d1c56d6983f1acb9f09bf29c2b45b9183e944b 18:22:21 INFO - mozversion INFO | application_display_name: Nightly 18:22:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:22:21 INFO - mozversion INFO | application_name: Firefox 18:22:21 INFO - mozversion INFO | application_remotingname: firefox 18:22:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:22:21 INFO - mozversion INFO | application_vendor: Mozilla 18:22:21 INFO - mozversion INFO | application_version: 45.0a1 18:22:21 INFO - mozversion INFO | platform_buildid: 20151117173134 18:22:21 INFO - mozversion INFO | platform_changeset: 84d1c56d6983f1acb9f09bf29c2b45b9183e944b 18:22:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:22:21 INFO - mozversion INFO | platform_version: 45.0a1 18:22:21 INFO - 2015-11-17 18:22:21,426 DEBUG : using testdate: 1447813341 18:22:21 INFO - 2015-11-17 18:22:21,426 DEBUG : actual date: 1447813341 18:22:21 INFO - 2015-11-17 18:22:21,436 INFO : starting webserver on 'localhost:54143' 18:22:21 INFO - 2015-11-17 18:22:21,437 INFO : Starting test suite talos-linux64-ix-046.e 18:22:21 INFO - 2015-11-17 18:22:21,437 INFO : Starting test dromaeo_css 18:22:21 INFO - 2015-11-17 18:22:21,437 DEBUG : operating with platform_type : linux_ 18:22:21 INFO - 2015-11-17 18:22:21,438 INFO : Initialising browser for dromaeo_css test... 18:22:21 INFO - 2015-11-17 18:22:21,449 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkeDhBc/profile http://localhost:54143/getInfo.html 18:22:27 INFO - 2015-11-17 18:22:27,510 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:22:27 INFO - 2015-11-17 18:22:27,510 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:22:27 INFO - 2015-11-17 18:22:27,510 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:22:27 INFO - 2015-11-17 18:22:27,510 DEBUG : BROWSER_OUTPUT: __metrics 18:22:28 INFO - 2015-11-17 18:22:28,602 INFO : Browser initialized. 18:22:28 INFO - 2015-11-17 18:22:28,603 INFO : Running cycle 1/1 for dromaeo_css test... 18:22:28 INFO - 2015-11-17 18:22:28,603 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkeDhBc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:22:40 INFO - 2015-11-17 18:22:40,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 141512704 18:22:40 INFO - 2015-11-17 18:22:40,604 DEBUG : BROWSER_OUTPUT: 18:23:30 INFO - 2015-11-17 18:23:30,259 DEBUG : BROWSER_OUTPUT: 1447813410257 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] 18:25:41 INFO - 2015-11-17 18:25:41,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54143/tests/dromaeo/cssquery-ext.html) 18:25:42 INFO - 2015-11-17 18:25:42,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 144306176 18:25:42 INFO - 2015-11-17 18:25:42,580 DEBUG : BROWSER_OUTPUT: 18:28:44 INFO - 2015-11-17 18:28:44,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/dromaeo/cssquery-ext.html (next: http://localhost:54143/tests/dromaeo/cssquery-jquery.html) 18:28:45 INFO - 2015-11-17 18:28:45,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 143368192 18:28:45 INFO - 2015-11-17 18:28:45,124 DEBUG : BROWSER_OUTPUT: 18:31:46 INFO - 2015-11-17 18:31:46,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54143/tests/dromaeo/cssquery-mootools.html) 18:31:47 INFO - 2015-11-17 18:31:47,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 143036416 18:31:47 INFO - 2015-11-17 18:31:47,497 DEBUG : BROWSER_OUTPUT: 18:34:49 INFO - 2015-11-17 18:34:49,232 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54143/tests/dromaeo/cssquery-prototype.html) 18:34:49 INFO - 2015-11-17 18:34:49,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 140845056 18:34:49 INFO - 2015-11-17 18:34:49,818 DEBUG : BROWSER_OUTPUT: 18:37:52 INFO - 2015-11-17 18:37:52,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54143/tests/dromaeo/cssquery-yui.html) 18:37:52 INFO - 2015-11-17 18:37:52,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 140079104 18:37:52 INFO - 2015-11-17 18:37:52,880 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-17 18:40:55,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/dromaeo/cssquery-yui.html (next: http://localhost:54143/tests/dromaeo/cssquery-dojo.html) 18:40:55 INFO - 2015-11-17 18:40:55,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 143396864 18:40:55 INFO - 2015-11-17 18:40:55,339 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-17 18:40:55,340 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:40:55 INFO - 2015-11-17 18:40:55,340 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:40:55 INFO - 2015-11-17 18:40:55,341 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:40:55 INFO - 2015-11-17 18:40:55,341 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:40:55 INFO - 2015-11-17 18:40:55,342 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2677.545965704241;2681.5039217744707;2718.4970780405624;2729.6587926509187;2740.60261262117;4600.056988317395;4650.13972415103;4682.08699303636;4706.223473126935;4760.309755085515;4679.8362057328;4702.929456058162;4723.338732577442;4788.928166077503;4791.089692958335;4343.19650864591;4372.73763574185;4373.343998400233;4384;4415.712978656393;4340.066885619591;4403.075354175627;4411.669124815636;4467.642588592905;4479.216137175998;4137.193247316774;4285.292926667096;4315.352697095429;4399.5160532341415;4421.248387774086;4429.357743127261;4443.311286750559;4445.288753799409;4445.755483448409;4459.754713490756;4145.398917157026;4422.09347083847;4423.60187583119;4459.866204013885;4466.3747075409465;4593.333966574862;4660.487346391928;4695.037517308943;4738.4550776660435;4769.42766867978;5107.565856902168;5189.455107213764;5205.7917683293;5211.2443695663915;5239.895202095975;4799;4910.90178196434;5214.765335559909;5234.555062819665;5240;4664.696794708333;4707.29390591414;4716.056788642285;4733.644976626767;4772.9284060739465;5213.478652134832;5216.347956505437;5238.397584277781;5240.842774716764;5344.679319240858;4756.072565849695;4919.483454237254;4923.212286034217;5053.567415028859;5066.290719299301;4962.280469331927;5027.648064635514;5049.596032317406;5059.696418214919;5071.0872043032605;5112.590992720573;5175.637705360588;5177.456367081478;5185.274061631375;5220.608454365938;4657.510961349078;4872.731999740048;5146.022255771391;5157.742112894415;5162.793488260428;4110.424540564323;4166.166766646683;4176.561461046607;4185.434966279574;4196.3705444183615;3747.3442147624055;3747.662710356081;3756.9248615027545;3768.2086761780333;3775.4336849472797;4213.431186789744;4344.891377715519;4355.629771469397;4406.735595864258;4439.866803995886;5191.377034755778;5256.763445644955;5265.0259701955265;5284.841454756363;5291.682499050069;4487.820487180476;4506.819727210875;4513.052259025641;4535.29702896045;4551.886202844956;4244.957550424456;4356.6950313477755;4490.146872094291;4584.977075114603;4614.930776038362;4877.6829506081995;4899.24061770419;4920.360353154067;4930.6795058321095;4953.851384458328;5193.298904647975;5199.246109314053;5206.8958620828125;5207.557357624492;5245.213218017328;4398.098389830013;4454.910901782011;4797.472278049342;4870.707757534559;4910.484399138182;4992.650514463952;5002.374703162105;5007.774650140679;5028.2960385546785;5051.191809310492;4783.234682450791;5074.238864170256;5091.66904151229;5101.132807422673;5121.283020377075;4827.155247831685;4858.95141048585;4876.707397556158;4892.975535122301;4960.181570040902;4909.993451342395;4954.157793175241;4956.281339205867;4964.726940018334;5011.724355160355;4847.054824309226;4855.1260773061185;4864.440589332272;4865.7323847188745;4869.196582563837;4730.7161570304515;4851.393575803025;4931.654784165074;5019.7490125494305;5046.596272298134;4879.853604391874;4881.219004959189;4883.121038213014;4884.63365247615;4907 18:40:55 INFO - 2015-11-17 18:40:55,344 DEBUG : BROWSER_OUTPUT: |1;ext.html;571.103367712691;575.0913556580603;575.6920047774439;585.7100735136107;595.3748564007791;36821;37425.06437339071;37481.81404580607;37609;37729.622703772955;40110.598894011055;40512.79743601278;40601.59398406015;40792.59207407925;40867.38698919518;7950.8807367889385;8107.756767296991;8158.592070396486;8164.183581641818;8177.4684645497855;7907.130215676271;7976.122626511079;8027.157148499411;8027.839443211133;8034.076081250672;7731.45879788415;7786.3770898328285;7804.882926756103;7811.296983271504;7831.099423566277;7891.60541972902;7962;7968.721094761684;7969.721059762938;7972.920270797275;7889.9211007890335;7933.563653999027;8030.678772849079;8043.11525732169;8053.315468185211;36723.265534689155;37134;37284;37514;37588.24823503542;2830.674472435655;2909.636295463067;2911.505044142501;3542.3092496963104;3632.7820330780237;27346.179614611592;27654.446911061867;28068.43863122726;28347.433051339063;28453;2833.7804143669755;2855.5431131018936;2909.6072030276064;2988.4023195361015;3040.407120611482;341817;346782;348916;349398;350763;38869.80565097213;39444.40833387501;39555.604443955766;56428.717856410454;56872;37138.814305928296;37327.62672373296;37396;37498.25003499969;37568.24863502714;11642.126840486997;11670.941645291889;11841.703957401134;11843.348615826213;11915.523379064914;8830.86753698695;8901.198892099743;8902.910970890338;8939.418937769024;8953.194212520904;13114.60656180297;13446.596602101758;13487.258200798855;13515;13569.457221711218;5464.453554644504;5533.916991245134;5595.916061259084;5618.943810561842;5707.4898937154185;799.8320352725992;864.2178828160525;900.3472482450302;903.6430609909049;1056.9577216911237;24920.87539562327;25050.624240636404;25085.623715643917;25131.62302565463;25132.874335628207;900.5857305639479;920.8020275640636;924.995375023134;987.1855719031828;1080.4813689429118;13110.147840390535;13311.866881331063;13394.263315517544;13394.464221431033;13412.530561430498;308484;311971;312408;315114;315130;45806.770966144955;46170;46346.768266158455;46594.30108548375;46811.76594117007;1094.8357746338113;1099.5052226498108;1108.5731993182521;1111.6942840718705;1116.2744216259334;24785.62821557642;24879.62680559829;24942.875285623457;24956.750432495443;25265.621015684414;38690.613093869826;39323.410148847215;39354.803225983684;39362.80318598503;39644.405333919436;245996;247425;247659;250257;250363;29018.854905725337;29523;42321.365179521716;43836.34245486256;44159.55840441555;38207.42688859725;38343.808280958416;38789.61210387973;39169.41245881257;39238.411423828096;33603.49594756032;33749;34519;34543;34712.65287347094;37509.43735844019;39801.20397591974;40002.59997400105;40032.48875770173;40433.797831010655;33142.834285828416;33233.169170770925;33337.66662333443;33533.16167095842;33692.32615347728;28816.279593010342;31026.379472410877;31353.37293254168;31483.212919677193;31586.842065789522;23858.449200801893;24018.87990560036;24068.27795166148;24206.273811785675;24422.755772442048 18:40:55 INFO - 2015-11-17 18:40:55,347 DEBUG : BROWSER_OUTPUT: |2;jquery.html;304.77142143392456;306.4223937877101;307.2472442515836;309.9907002789916;310.6629307201686;10922.453877306143;11193.048590869765;14620.34208460619;14998.550043498684;15213.84786152138;10517.842232366502;10554.683359499228;10754.623588174416;10801.945990270056;10825.891741082587;4004.1991601679633;4061.57353477885;4070.633642972132;4083.3874918762126;4097.098638299584;4018.4976877890263;4065.410515475254;4098.631123198911;4114.7119701620895;4123.917521649565;4003.1593365393155;4018.3369743992207;4356.085222103362;4449.822007119711;4466.3747075409465;4370.519242883281;4392.582704643054;4405.273129933557;4406.405135306724;4418.3593378960195;3793.468914351993;3807.162424266657;3886.067343837487;3905.882823515299;3906.9841841121515;9886.90113098867;9898.307118501707;11250.15623828208;11947.223430476992;12016.218945768496;1729.8702597305253;1735.4793561931497;1752.97370539442;1780.9376671816424;1793.8923664580036;9097.181253687133;9118;9240.353175277733;9361.672341468084;9385.108414700593;1579.2656414767189;1596.8642665373457;1605.8313877042976;1649;1650.4965985374456;46182.538174618494;46231.76884115558;46399.53600463986;47463.762681186716;48127.75936120297;6253.093301471352;6289.528285378524;6298.212723409574;6310.558260921692;6365.108884756138;7196.316349946746;7202.135743710788;7256.129264488295;7275.708971641075;7290.927090729025;4772.5227477252;4803.879903002383;4813.350197723333;4916.803327866917;4924.409070911442;4929.901401971941;4954.083494553519;4961.181405068195;4968;4972.950270497321;2973.8810447582287;2975.2561859535117;3002.084364268875;3005.1585556044342;3015.7285844273683;1061.2200032975757;1064.4571268653042;1073.2916275258292;1084.1651928015383;1119.9920071935323;341.83421040795196;347.30192313450146;348.84127721886483;349.62939284358663;375.09227669040985;8846.778830529289;9203.251382237353;9589.136977671904;9624.37441566296;9861.309708320492;370.6071564142018;375.73510674974625;377.7714482737959;381.94079917612817;399.6602887545563;5186.714730689773;5216.400113986864;5222.843314700565;5224.268602395668;5265.578753699695;470231;474864;475756;481901;489559;64055.6797216011;64777;65356.673216633615;65429;66575;404.28845232390614;404.5529689692847;405.47693475416384;407.8837531303564;408.24678468226074;8792.384533082623;8842.557872106241;8878.600462979051;8939.955300223457;9702.466364349746;27209;27996.72003279941;28668.42663146767;29009.7099029007;29200.561991569717;36370.27259454849;37475;38730.6126938727;38989.610103898594;40075.39886901757;6084.421979911901;6103.572749907641;6146.569740118328;6154.169187159855;6156.630602163885;10997.285176463503;11050.392228427192;11249.66251012471;11310.208285419942;11313.830292545454;8132.2680958711635;8455.365847561334;8635.395522313378;10003.449810260214;10082.949585252027;8505.574721263789;8805;8824.514651694219;9041.50271735061;9053.502057386644;8889.377743557889;9047.185753282236;9073.727788166365;9182.908170918472;9234.538273086453;5872.324682661378;5884.999550076412;5907.143464197753;5916.290045194432;5939.138824870456;8979.551022448983;8986;8995.505247211466;9124.908750912671;9309.906900930904 18:40:55 INFO - 2015-11-17 18:40:55,347 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1459.3724698379692;1662.3849175804953;1680.5714542791593;1714.34854755193;1731.5411415974766;5373.946260537398;5456.399796022434;5465.316835395575;5556.666600004002;5769.5672824538115;6434.935650643492;6646.401823835854;6687.665616719157;6732.730690772375;6759.1213142291435;1949.337225343383;1991.0343483410534;1993.491659626793;1996.6605677034865;1997.1711739628038;2003.5291706448972;2006.0972562346928;2011.1854698846917;2077.3456361246235;2079.116375540389;1979.5842872996689;2003.1987205117923;2007.2272175212502;2010.6079314533672;2010.979890201094;1995.900204989752;2005.82950449212;2016.9899150504227;2017.798220177985;2021.3632705697657;1996.8003199679915;2020.777714451409;2023.8785672859676;2024.757029156496;2042.5710600773707;6741.59550426976;6829.590224586541;6831.863362732767;6831.931680683179;6835.350641689031;3990.2418540477215;4049.250888585621;4061.2283666103344;4068.0236743181717;4068.2880495913096;2680.919572412831;2712.905048323299;2740.5889116632466;2808.340040090577;2808.3540785619216;839.9622017009189;841.4824882697159;855.7090589199639;873.3319010956624;883.355150739957;8956.910430895738;8980.685676001309;9010.098990101003;9035.954820225857;9071.410358326688;3613.7831730096277;3622.4566315052953;3636.1455058061333;3661.3043521730788;3713.925721485555;7856.960715196387;7857.096433910059;7857.096433910059;7871.134175240719;7877.527348359117;4101.8974525637095;4129.525104612948;4133.648639865645;4137.648299894482;4142.378643203544;3001.2046807596003;3052.3437460946;3712.6472985066375;3744.4944932433773;3751.1372384351753;2999.610050693396;3037.3014206732573;3039.9544006839915;3316.2704205074847;3342.1143396999814;1039.2465462539749;1048.130052056791;1056.989430105689;1057.3497299161115;1061.0768631290825;860.1226748716274;937.3063932689761;968.5254225429629;1147.002108165901;1147.9081673466103;6328.303886572473;6381;6384.457321127663;6397.296297407282;6415.935840641627;1000.0799264676515;1005.3113617172261;1009.7828966772179;1025.220832167558;1031.2265800649513;5088.796448142107;5116.462771409023;5192.662476939063;5240.973795131076;5264.078786212397;7981.082175549886;8190.303824175012;8193.71322003727;8220.876686849702;8223.01323841143;7941.722039728582;8064.919350806417;8080.636371363303;8095;8110.107888132301;6332.905006424908;6361.809145725636;6374.713137908805;6377.808665740035;6413.679316034273;6200.441960223601;6202.4417802398;6266.68666566679;6482.935170648233;6499;7049.9647501762165;7056.8588628226125;7160.176579693193;7193.676284567103;7206.6396680164735;7149.571025738473;7210.531315464478;7238.131424229126;7254.238304977901;7279.490435669452;4955.752212389438;5120.052790233819;5850.180974663465;5935.525157987265;6011.098335249748;6442.162518872517;6509.218893732783;6511.055896895018;6557.049227861838;6584.275729669828;5948.5538584605465;5952.851178720393;6088.056351265561;6171.352008039271;6349.777757778455;5787.421257874179;5865.354810970704;5952.97023514897;5959.821205363846;5989.610675306091;5990.101484777319;6120.663363515049;6124.601900876429;6134.325224225421;6152.784652537319;5719.7426115824055;5744.741486633028;5780.450857168562;5782.5663075268685;5802.47777700009;5802.245708057925;5830.2420685310635;5843.386444423274;5844.736986835687;5870.7945221917025 18:40:55 INFO - 2015-11-17 18:40:55,348 DEBUG : BROWSER_OUTPUT: |4;prototype.html;261.5409955528049;267.2383706436656;270.09114330278607;276.3933166699096;277.5503684031869;5573.888522229553;5576.191452239423;5583.302087239095;5627.521660658849;5748.367679555246;5577.274954255951;5603.823197128608;5617.157426386044;5618.887622247563;5640.0693885508945;4016.554040545401;4111.71218014739;4132.855350062749;4135.834566617332;4143.067809742814;4121.5672354402805;4123.051698109437;4123.175364927011;4123.525794533622;4130.2359063573185;4047.8583249586272;4067.4712287402594;4075.8981025474304;4087.4277601135864;4093.97953010236;4069.8604390770633;4077.7553346799286;4081.9591804082024;4087.4481944937497;4092.202020605983;3368.2758206985372;3435.055359776057;3435.2270739083756;3435.879744208941;3440.17435815405;5314.229436731691;5372.7313634318125;5375.11310633745;5375.838724838261;5390.326209223847;4636.698614590041;4652.441706995149;4659.184642687516;4662.8368007119925;4663.860084197479;5866.9119963200155;5874.295084589834;5875.148103525008;5879.118132280149;5892.410758924116;3655.122770535079;3728.328900797855;3729.4219395993664;3733.309337772521;3743.3262012837677;6171.691415429211;6232.220972378453;6234.719437625317;6239.251289845248;6258.967270400379;3925.7644541327613;3934.780218132388;3949.644531992077;3951.723379363417;3956.485656864589;3990.4413382126527;3991.1618560102124;4006.859759908389;4008.9198216035516;4015.8795236142964;4686;4707.082118986833;4716.976415117902;4731.716097034189;4736.265878788793;5696.857578560569;5878.412158784087;5903.58674892762;5927.585069045125;5932.93207222704;1398.0423409964208;1410.5838777560439;1420.3537390487304;1421.9004669673232;1422.8719415252676;917.5412293853074;921.3826736086838;923.0354279777648;935.2190920581255;940.431039221275;5085.898282034339;5114.028334616411;5138.717370544581;5141.177411614124;5141.948580514147;6011.338752737195;6103.908441373383;6123.4488895999575;6201.255849298113;6215.533834962396;5154.845354639367;5190.558802501754;5191.428942816287;5191.428942816287;5196.532312091855;3313.1385839681857;3331.6501767314567;3343.966560334414;3347.8493467794005;3351.296227792191;5622.606417550732;5817.0983497557945;5826.300843898759;5830.183774271605;5835.766569337179;6356.936430635635;6387.808365749035;6397.808065758035;6404.263509696445;6405.839854003687;5798.333191682926;5807;5826.70866456684;5828.154917537018;5831.154482599914;6073.544484163617;6169.290531588746;6186.536009799193;6188.319284878749;6201.658908760061;6026.427489388501;6050.42520960508;6058.242719660043;6069.787557435468;6074.939250607437;5803.158542011469;5809.2738407699035;5817.854553636023;5822.5633077518505;5824;3938.409238614116;3948.684105271629;3956.2878681837547;3960.5841386653988;3969.503812023497;6071.817845464643;6213.844653883689;6218.347073557211;6228.190335256388;6228.657423841732;5961.970190149022;5963.970180149072;5966.940330596639;5969.582129251085;5972.34304226526;5909.497692696169;5952.5833191676165;5952.940470595238;5954.672493012753;5966.403359663999;5653.745581448927;5805.8548536286935;5806.187133801187;5809.970950145223;5814.360420353673;5993.670348130895;6002.189704389852;6014.398560143951;6018.217631708025;6020.8795824084145;5696.715164241688;5760.423957604374;5775.653460792366;5802.912956305574;5829.795957141479 18:40:55 INFO - 2015-11-17 18:40:55,350 DEBUG : BROWSER_OUTPUT: |5;yui.html;648.2674577727167;725.3616817200866;734.4895297768053;777.0054330457017;796.358931060496;10898.455077246126;11084.168687348441;11691.766164676701;11968.401579921012;11983.520659173622;12622.431990560446;12973;13092.149010314322;13096.41066152023;13111.147775394593;789.329070290253;809.9838003239961;810.6635746165334;810.7729835645999;811.9025716913978;793.4406243598249;804.9678012879477;807.0436532708759;807.2774866494484;808.3048578222753;846.8899043124416;846.9407141500097;848.2662496940134;853.0871966995318;857.5712143928037;843.451756358372;846.475185385059;849.3502470609989;849.5964416901984;850.4429598612887;616.9876602467971;618.6844709198341;620.2185246589285;620.8199622109582;621.8631900981777;11841.28952262867;12511.74976500474;12555.309457979807;12582.496700131984;12595.3072581008;11223.214374993753;11224.158188135922;11471.713207169887;11507.827382589268;12004.879951200464;9479.383840050376;9483.33616646835;9485.193758530464;9490;9562.521873906346;2975.9404811903855;2996.790224684273;2998.6551546572205;3027.8486075696346;3075.6463006754284;33855.6614433855;37734;37823.621763782285;38086.23827523462;38301.42547861784;6612.206535215709;6697.631630260285;6745.5952642841585;6937.098177237028;6987.720491180397;10364.326318789406;10460.68617941463;10462.895371046192;10484.475776211159;10491.94754026225;5643.068893632505;5665.065264231438;5671.432856714296;5749.88500229993;5763.827085187451;3554.1405088179545;3571.982140089283;3587.318409502186;3596.0829988352803;3676.6690997810324;2421.055788242587;2434.6469761884427;2456.9631455528183;2462.7537246275588;2464.4085419499193;381.6279127850379;394.0994826820701;395.6913607386243;397.3523157253658;401.56229709616656;524.8740302327413;596.8299034775068;597.9133025711247;610.28901329951;618.981430557084;8556.61495232716;8675.696350627697;8766.780830479289;8848.513331766686;9106.81786364269;630.8296759874808;632.5951391109694;640.166741104658;640.5260107520402;660.2506155513431;3395.405803984293;3723.94414083789;3755.3615885299564;3808.2954653388656;3810.447485114643;45457.77271113623;49254.261186082236;51847.74076129671;52209.2168617471;52345.47654523482;42152.156956860694;42656.14687706291;42902;43208.351874721906;43526;41870.58129418667;41955;42668.78665606714;43905;44925.77537112294;8192.75421737349;8304.501729896225;8680.522571258642;8681.305495560213;8700.56497175126;31463.528047078853;31486.685133148374;31768.841155794074;31826.204344891565;32006;36845.63154368529;37185.07037324089;37430.6256937438;42551.36172957346;42750.57249427466;7560.697572097055;7583.203763604963;7595.506292090997;7596.962015189889;7778.766637000673;11527.94236028848;11547.653570392902;11645.88354116448;11667.708307292385;11926.821097683714;10674.946625266824;10796.946015269874;11047.83428248593;11053.060489858452;11061.612843550438;9539.52302384864;10322.380657160595;10527.94736026315;10845.349279043283;11205.215634905479;10787.946060269649;10831.837522437327;10899.673009809718;10901.618443354444;10947.397893115955;9296.116868897443;9352.392094513834;9449.905500944902;9799.461029643153;9856.605735770776;9376.296777741833;9547.952260238655;9594.280428967715;9597.952010239904;9653.17947974402 18:40:55 INFO - 2015-11-17 18:40:55,350 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:40:55 INFO - 2015-11-17 18:40:55,350 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:40:55 INFO - 2015-11-17 18:40:55,350 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,310 18:40:55 INFO - 2015-11-17 18:40:55,350 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:40:55 INFO - 2015-11-17 18:40:55,350 DEBUG : BROWSER_OUTPUT: __startTimestamp1447814455339__endTimestamp 18:40:55 INFO - 2015-11-17 18:40:55,350 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-17 18:40:55,351 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:40:55 INFO - 2015-11-17 18:40:55,351 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:40:55 INFO - 2015-11-17 18:40:55,351 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-17 18:40:55,351 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4697.91 Median:4799.00 stddev:503.04 (10.5%) stddev-sans-first:478.96 18:40:55 INFO - 2015-11-17 18:40:55,352 DEBUG : BROWSER_OUTPUT: Values: 2677.5 2681.5 2718.5 2729.7 2740.6 4600.1 4650.1 4682.1 4706.2 4760.3 4679.8 4702.9 4723.3 4788.9 4791.1 4343.2 4372.7 4373.3 4384.0 4415.7 4340.1 4403.1 4411.7 4467.6 4479.2 4137.2 4285.3 4315.4 4399.5 4421.2 4429.4 4443.3 4445.3 4445.8 4459.8 4145.4 4422.1 4423.6 4459.9 4466.4 4593.3 4660.5 4695.0 4738.5 4769.4 5107.6 5189.5 5205.8 5211.2 5239.9 4799.0 4910.9 5214.8 5234.6 5240.0 4664.7 4707.3 4716.1 4733.6 4772.9 5213.5 5216.3 5238.4 5240.8 5344.7 4756.1 4919.5 4923.2 5053.6 5066.3 4962.3 5027.6 5049.6 5059.7 5071.1 5112.6 5175.6 5177.5 5185.3 5220.6 4657.5 4872.7 5146.0 5157.7 5162.8 4110.4 4166.2 4176.6 4185.4 4196.4 3747.3 3747.7 3756.9 3768.2 3775.4 4213.4 4344.9 4355.6 4406.7 4439.9 5191.4 5256.8 5265.0 5284.8 5291.7 4487.8 4506.8 4513.1 4535.3 4551.9 4245.0 4356.7 4490.1 4585.0 4614.9 4877.7 4899.2 4920.4 4930.7 4953.9 5193.3 5199.2 5206.9 5207.6 5245.2 4398.1 4454.9 4797.5 4870.7 4910.5 4992.7 5002.4 5007.8 5028.3 5051.2 4783.2 5074.2 5091.7 5101.1 5121.3 4827.2 4859.0 4876.7 4893.0 4960.2 4910.0 4954.2 4956.3 4964.7 5011.7 4847.1 4855.1 4864.4 4865.7 4869.2 4730.7 4851.4 4931.7 5019.7 5046.6 4879.9 4881.2 4883.1 4884.6 4907.0 18:40:55 INFO - 2015-11-17 18:40:55,352 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-17 18:40:55,352 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44781.98 Median:37410.53 stddev:80342.52 (214.8%) stddev-sans-first:80499.33 18:40:55 INFO - 2015-11-17 18:40:55,352 DEBUG : BROWSER_OUTPUT: Values: 571.1 575.1 575.7 585.7 595.4 36821.0 37425.1 37481.8 37609.0 37729.6 40110.6 40512.8 40601.6 40792.6 40867.4 7950.9 8107.8 8158.6 8164.2 8177.5 7907.1 7976.1 8027.2 8027.8 8034.1 7731.5 7786.4 7804.9 7811.3 7831.1 7891.6 7962.0 7968.7 7969.7 7972.9 7889.9 7933.6 8030.7 8043.1 8053.3 36723.3 37134.0 37284.0 37514.0 37588.2 2830.7 2909.6 2911.5 3542.3 3632.8 27346.2 27654.4 28068.4 28347.4 28453.0 2833.8 2855.5 2909.6 2988.4 3040.4 341817.0 346782.0 348916.0 349398.0 350763.0 38869.8 39444.4 39555.6 56428.7 56872.0 37138.8 37327.6 37396.0 37498.3 37568.2 11642.1 11670.9 11841.7 11843.3 11915.5 8830.9 8901.2 8902.9 8939.4 8953.2 13114.6 13446.6 13487.3 13515.0 13569.5 5464.5 5533.9 5595.9 5618.9 5707.5 799.8 864.2 900.3 903.6 1057.0 24920.9 25050.6 25085.6 25131.6 25132.9 900.6 920.8 925.0 987.2 1080.5 13110.1 13311.9 13394.3 13394.5 13412.5 308484.0 311971.0 312408.0 315114.0 315130.0 45806.8 46170.0 46346.8 46594.3 46811.8 1094.8 1099.5 1108.6 1111.7 1116.3 24785.6 24879.6 24942.9 24956.8 25265.6 38690.6 39323.4 39354.8 39362.8 39644.4 245996.0 247425.0 247659.0 250257.0 250363.0 29018.9 29523.0 42321.4 43836.3 44159.6 38207.4 38343.8 38789.6 39169.4 39238.4 33603.5 33749.0 34519.0 34543.0 34712.7 37509.4 39801.2 40002.6 40032.5 40433.8 33142.8 33233.2 33337.7 33533.2 33692.3 28816.3 31026.4 31353.4 31483.2 31586.8 23858.4 24018.9 24068.3 24206.3 24422.8 18:40:55 INFO - 2015-11-17 18:40:55,352 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-17 18:40:55,352 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23264.74 Median:4405.84 stddev:78336.06 (1778.0%) stddev-sans-first:78536.84 18:40:55 INFO - 2015-11-17 18:40:55,353 DEBUG : BROWSER_OUTPUT: Values: 304.8 306.4 307.2 310.0 310.7 10922.5 11193.0 14620.3 14998.6 15213.8 10517.8 10554.7 10754.6 10801.9 10825.9 4004.2 4061.6 4070.6 4083.4 4097.1 4018.5 4065.4 4098.6 4114.7 4123.9 4003.2 4018.3 4356.1 4449.8 4466.4 4370.5 4392.6 4405.3 4406.4 4418.4 3793.5 3807.2 3886.1 3905.9 3907.0 9886.9 9898.3 11250.2 11947.2 12016.2 1729.9 1735.5 1753.0 1780.9 1793.9 9097.2 9118.0 9240.4 9361.7 9385.1 1579.3 1596.9 1605.8 1649.0 1650.5 46182.5 46231.8 46399.5 47463.8 48127.8 6253.1 6289.5 6298.2 6310.6 6365.1 7196.3 7202.1 7256.1 7275.7 7290.9 4772.5 4803.9 4813.4 4916.8 4924.4 4929.9 4954.1 4961.2 4968.0 4973.0 2973.9 2975.3 3002.1 3005.2 3015.7 1061.2 1064.5 1073.3 1084.2 1120.0 341.8 347.3 348.8 349.6 375.1 8846.8 9203.3 9589.1 9624.4 9861.3 370.6 375.7 377.8 381.9 399.7 5186.7 5216.4 5222.8 5224.3 5265.6 470231.0 474864.0 475756.0 481901.0 489559.0 64055.7 64777.0 65356.7 65429.0 66575.0 404.3 404.6 405.5 407.9 408.2 8792.4 8842.6 8878.6 8940.0 9702.5 27209.0 27996.7 28668.4 29009.7 29200.6 36370.3 37475.0 38730.6 38989.6 40075.4 6084.4 6103.6 6146.6 6154.2 6156.6 10997.3 11050.4 11249.7 11310.2 11313.8 8132.3 8455.4 8635.4 10003.4 10082.9 8505.6 8805.0 8824.5 9041.5 9053.5 8889.4 9047.2 9073.7 9182.9 9234.5 5872.3 5885.0 5907.1 5916.3 5939.1 8979.6 8986.0 8995.5 9124.9 9309.9 18:40:55 INFO - 2015-11-17 18:40:55,353 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-17 18:40:55,353 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4704.09 Median:5816.36 stddev:2389.19 (41.1%) stddev-sans-first:2383.45 18:40:55 INFO - 2015-11-17 18:40:55,353 DEBUG : BROWSER_OUTPUT: Values: 1459.4 1662.4 1680.6 1714.3 1731.5 5373.9 5456.4 5465.3 5556.7 5769.6 6434.9 6646.4 6687.7 6732.7 6759.1 1949.3 1991.0 1993.5 1996.7 1997.2 2003.5 2006.1 2011.2 2077.3 2079.1 1979.6 2003.2 2007.2 2010.6 2011.0 1995.9 2005.8 2017.0 2017.8 2021.4 1996.8 2020.8 2023.9 2024.8 2042.6 6741.6 6829.6 6831.9 6831.9 6835.4 3990.2 4049.3 4061.2 4068.0 4068.3 2680.9 2712.9 2740.6 2808.3 2808.4 840.0 841.5 855.7 873.3 883.4 8956.9 8980.7 9010.1 9036.0 9071.4 3613.8 3622.5 3636.1 3661.3 3713.9 7857.0 7857.1 7857.1 7871.1 7877.5 4101.9 4129.5 4133.6 4137.6 4142.4 3001.2 3052.3 3712.6 3744.5 3751.1 2999.6 3037.3 3040.0 3316.3 3342.1 1039.2 1048.1 1057.0 1057.3 1061.1 860.1 937.3 968.5 1147.0 1147.9 6328.3 6381.0 6384.5 6397.3 6415.9 1000.1 1005.3 1009.8 1025.2 1031.2 5088.8 5116.5 5192.7 5241.0 5264.1 7981.1 8190.3 8193.7 8220.9 8223.0 7941.7 8064.9 8080.6 8095.0 8110.1 6332.9 6361.8 6374.7 6377.8 6413.7 6200.4 6202.4 6266.7 6482.9 6499.0 7050.0 7056.9 7160.2 7193.7 7206.6 7149.6 7210.5 7238.1 7254.2 7279.5 4955.8 5120.1 5850.2 5935.5 6011.1 6442.2 6509.2 6511.1 6557.0 6584.3 5948.6 5952.9 6088.1 6171.4 6349.8 5787.4 5865.4 5953.0 5959.8 5989.6 5990.1 6120.7 6124.6 6134.3 6152.8 5719.7 5744.7 5780.5 5782.6 5802.5 5802.2 5830.2 5843.4 5844.7 5870.8 18:40:55 INFO - 2015-11-17 18:40:55,353 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-17 18:40:55,354 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4818.37 Median:5618.02 stddev:1507.06 (26.8%) stddev-sans-first:1471.96 18:40:55 INFO - 2015-11-17 18:40:55,354 DEBUG : BROWSER_OUTPUT: Values: 261.5 267.2 270.1 276.4 277.6 5573.9 5576.2 5583.3 5627.5 5748.4 5577.3 5603.8 5617.2 5618.9 5640.1 4016.6 4111.7 4132.9 4135.8 4143.1 4121.6 4123.1 4123.2 4123.5 4130.2 4047.9 4067.5 4075.9 4087.4 4094.0 4069.9 4077.8 4082.0 4087.4 4092.2 3368.3 3435.1 3435.2 3435.9 3440.2 5314.2 5372.7 5375.1 5375.8 5390.3 4636.7 4652.4 4659.2 4662.8 4663.9 5866.9 5874.3 5875.1 5879.1 5892.4 3655.1 3728.3 3729.4 3733.3 3743.3 6171.7 6232.2 6234.7 6239.3 6259.0 3925.8 3934.8 3949.6 3951.7 3956.5 3990.4 3991.2 4006.9 4008.9 4015.9 4686.0 4707.1 4717.0 4731.7 4736.3 5696.9 5878.4 5903.6 5927.6 5932.9 1398.0 1410.6 1420.4 1421.9 1422.9 917.5 921.4 923.0 935.2 940.4 5085.9 5114.0 5138.7 5141.2 5141.9 6011.3 6103.9 6123.4 6201.3 6215.5 5154.8 5190.6 5191.4 5191.4 5196.5 3313.1 3331.7 3344.0 3347.8 3351.3 5622.6 5817.1 5826.3 5830.2 5835.8 6356.9 6387.8 6397.8 6404.3 6405.8 5798.3 5807.0 5826.7 5828.2 5831.2 6073.5 6169.3 6186.5 6188.3 6201.7 6026.4 6050.4 6058.2 6069.8 6074.9 5803.2 5809.3 5817.9 5822.6 5824.0 3938.4 3948.7 3956.3 3960.6 3969.5 6071.8 6213.8 6218.3 6228.2 6228.7 5962.0 5964.0 5966.9 5969.6 5972.3 5909.5 5952.6 5952.9 5954.7 5966.4 5653.7 5805.9 5806.2 5810.0 5814.4 5993.7 6002.2 6014.4 6018.2 6020.9 5696.7 5760.4 5775.7 5802.9 5829.8 18:40:55 INFO - 2015-11-17 18:40:55,354 DEBUG : BROWSER_OUTPUT: 18:40:55 INFO - 2015-11-17 18:40:55,354 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12007.97 Median:43367.18 stddev:13747.61 (31.7%) stddev-sans-first:13759.70 18:40:55 INFO - 2015-11-17 18:40:55,355 DEBUG : BROWSER_OUTPUT: Values: 648.3 725.4 734.5 777.0 796.4 10898.5 11084.2 11691.8 11968.4 11983.5 12622.4 12973.0 13092.1 13096.4 13111.1 789.3 810.0 810.7 810.8 811.9 793.4 805.0 807.0 807.3 808.3 846.9 846.9 848.3 853.1 857.6 843.5 846.5 849.4 849.6 850.4 617.0 618.7 620.2 620.8 621.9 11841.3 12511.7 12555.3 12582.5 12595.3 11223.2 11224.2 11471.7 11507.8 12004.9 9479.4 9483.3 9485.2 9490.0 9562.5 2975.9 2996.8 2998.7 3027.8 3075.6 33855.7 37734.0 37823.6 38086.2 38301.4 6612.2 6697.6 6745.6 6937.1 6987.7 10364.3 10460.7 10462.9 10484.5 10491.9 5643.1 5665.1 5671.4 5749.9 5763.8 3554.1 3572.0 3587.3 3596.1 3676.7 2421.1 2434.6 2457.0 2462.8 2464.4 381.6 394.1 395.7 397.4 401.6 524.9 596.8 597.9 610.3 619.0 8556.6 8675.7 8766.8 8848.5 9106.8 630.8 632.6 640.2 640.5 660.3 3395.4 3723.9 3755.4 3808.3 3810.4 45457.8 49254.3 51847.7 52209.2 52345.5 42152.2 42656.1 42902.0 43208.4 43526.0 41870.6 41955.0 42668.8 43905.0 44925.8 8192.8 8304.5 8680.5 8681.3 8700.6 31463.5 31486.7 31768.8 31826.2 32006.0 36845.6 37185.1 37430.6 42551.4 42750.6 7560.7 7583.2 7595.5 7597.0 7778.8 11527.9 11547.7 11645.9 11667.7 11926.8 10674.9 10796.9 11047.8 11053.1 11061.6 9539.5 10322.4 10527.9 10845.3 11205.2 10787.9 10831.8 10899.7 10901.6 10947.4 9296.1 9352.4 9449.9 9799.5 9856.6 9376.3 9548.0 9594.3 9598.0 9653.2 18:40:55 INFO - 2015-11-17 18:40:55,355 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:40:55 INFO - 2015-11-17 18:40:55,355 DEBUG : BROWSER_OUTPUT: 18:40:56 INFO - 2015-11-17 18:40:56,066 INFO : Browser exited with error code: 0 18:40:56 INFO - 2015-11-17 18:40:56,085 INFO : Completed test dromaeo_css (00:18:34) 18:40:56 INFO - 2015-11-17 18:40:56,085 INFO : Starting test kraken 18:40:56 INFO - 2015-11-17 18:40:56,085 DEBUG : operating with platform_type : linux_ 18:40:56 INFO - 2015-11-17 18:40:56,085 INFO : Initialising browser for kraken test... 18:40:56 INFO - 2015-11-17 18:40:56,091 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Eeu7M/profile http://localhost:54143/getInfo.html 18:41:00 INFO - 2015-11-17 18:41:00,574 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:41:00 INFO - 2015-11-17 18:41:00,574 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:41:00 INFO - 2015-11-17 18:41:00,574 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:41:00 INFO - 2015-11-17 18:41:00,574 DEBUG : BROWSER_OUTPUT: __metrics 18:41:01 INFO - 2015-11-17 18:41:01,654 INFO : Browser initialized. 18:41:01 INFO - 2015-11-17 18:41:01,655 INFO : Running cycle 1/1 for kraken test... 18:41:01 INFO - 2015-11-17 18:41:01,655 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Eeu7M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:41:13 INFO - 2015-11-17 18:41:13,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 141983744 18:41:13 INFO - 2015-11-17 18:41:13,676 DEBUG : BROWSER_OUTPUT: 18:41:16 INFO - 2015-11-17 18:41:16,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54143/tests/kraken/driver.html?testName=audio-beat-detection) 18:41:16 INFO - 2015-11-17 18:41:16,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 140460032 18:41:16 INFO - 2015-11-17 18:41:16,895 DEBUG : BROWSER_OUTPUT: 18:41:19 INFO - 2015-11-17 18:41:19,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54143/tests/kraken/driver.html?testName=audio-dft) 18:41:20 INFO - 2015-11-17 18:41:20,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 140574720 18:41:20 INFO - 2015-11-17 18:41:20,234 DEBUG : BROWSER_OUTPUT: 18:41:23 INFO - 2015-11-17 18:41:23,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54143/tests/kraken/driver.html?testName=audio-fft) 18:41:23 INFO - 2015-11-17 18:41:23,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 136097792 18:41:23 INFO - 2015-11-17 18:41:23,765 DEBUG : BROWSER_OUTPUT: 18:41:25 INFO - 2015-11-17 18:41:25,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54143/tests/kraken/driver.html?testName=audio-oscillator) 18:41:26 INFO - 2015-11-17 18:41:26,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 136351744 18:41:26 INFO - 2015-11-17 18:41:26,449 DEBUG : BROWSER_OUTPUT: 18:41:28 INFO - 2015-11-17 18:41:28,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:41:29 INFO - 2015-11-17 18:41:29,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 138412032 18:41:29 INFO - 2015-11-17 18:41:29,286 DEBUG : BROWSER_OUTPUT: 18:41:32 INFO - 2015-11-17 18:41:32,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54143/tests/kraken/driver.html?testName=imaging-darkroom) 18:41:32 INFO - 2015-11-17 18:41:32,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 137383936 18:41:32 INFO - 2015-11-17 18:41:32,904 DEBUG : BROWSER_OUTPUT: 18:41:36 INFO - 2015-11-17 18:41:36,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54143/tests/kraken/driver.html?testName=imaging-desaturate) 18:41:36 INFO - 2015-11-17 18:41:36,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 136314880 18:41:36 INFO - 2015-11-17 18:41:36,994 DEBUG : BROWSER_OUTPUT: 18:41:39 INFO - 2015-11-17 18:41:39,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54143/tests/kraken/driver.html?testName=json-parse-financial) 18:41:40 INFO - 2015-11-17 18:41:40,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 137179136 18:41:40 INFO - 2015-11-17 18:41:40,474 DEBUG : BROWSER_OUTPUT: 18:41:42 INFO - 2015-11-17 18:41:42,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:41:42 INFO - 2015-11-17 18:41:42,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 139132928 18:41:42 INFO - 2015-11-17 18:41:42,856 DEBUG : BROWSER_OUTPUT: 18:41:44 INFO - 2015-11-17 18:41:44,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54143/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:41:45 INFO - 2015-11-17 18:41:45,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 138711040 18:41:45 INFO - 2015-11-17 18:41:45,414 DEBUG : BROWSER_OUTPUT: 18:41:47 INFO - 2015-11-17 18:41:47,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:41:48 INFO - 2015-11-17 18:41:48,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 140451840 18:41:48 INFO - 2015-11-17 18:41:48,188 DEBUG : BROWSER_OUTPUT: 18:41:50 INFO - 2015-11-17 18:41:50,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:41:51 INFO - 2015-11-17 18:41:51,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 138285056 18:41:51 INFO - 2015-11-17 18:41:51,371 DEBUG : BROWSER_OUTPUT: 18:41:54 INFO - 2015-11-17 18:41:54,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:41:54 INFO - 2015-11-17 18:41:54,702 DEBUG : BROWSER_OUTPUT: RSS: Main: 139702272 18:41:54 INFO - 2015-11-17 18:41:54,702 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,476 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54143/tests/kraken/driver.html?testName=ai-astar) 18:41:56 INFO - 2015-11-17 18:41:56,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 139669504 18:41:56 INFO - 2015-11-17 18:41:56,726 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,728 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:41:56 INFO - 2015-11-17 18:41:56,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:41:56 INFO - 2015-11-17 18:41:56,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:41:56 INFO - 2015-11-17 18:41:56,728 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:41:56 INFO - 2015-11-17 18:41:56,728 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;109;116;114;116;125;114;113;117;114 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;131;151;165;132;152;161;140;172;134 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;163;164;163;162;166;164;162;166;164 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;73;74;149;74;73;74;74;153 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;133;91;96;91;129;92;91;128 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;109;110;110;110;110;111;110;109 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;149;149;150;152;150;150;152;150;150 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;98;96;96;96;96;96;96;96 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;78;76;75;76;77;78;80;74;74 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;71;70;69;71;70;69;70;70 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;84;84;84;83;85;85;85;85 18:41:56 INFO - 2015-11-17 18:41:56,729 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;124;125;131;125;131;127;136;120;124 18:41:56 INFO - 2015-11-17 18:41:56,730 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;158;153;157;155;151;159;167;157;144 18:41:56 INFO - 2015-11-17 18:41:56,730 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;72;73;71;71;75;70;71;70 18:41:56 INFO - 2015-11-17 18:41:56,730 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:41:56 INFO - 2015-11-17 18:41:56,730 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:41:56 INFO - 2015-11-17 18:41:56,730 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,754 18:41:56 INFO - 2015-11-17 18:41:56,730 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:41:56 INFO - 2015-11-17 18:41:56,730 DEBUG : BROWSER_OUTPUT: __startTimestamp1447814516727__endTimestamp 18:41:56 INFO - 2015-11-17 18:41:56,730 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,738 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:41:56 INFO - 2015-11-17 18:41:56,738 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:41:56 INFO - 2015-11-17 18:41:56,738 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,738 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.30 Median:115.50 stddev:4.06 (3.5%) stddev-sans-first:4.30 18:41:56 INFO - 2015-11-17 18:41:56,738 DEBUG : BROWSER_OUTPUT: Values: 115.0 109.0 116.0 114.0 116.0 125.0 114.0 113.0 117.0 114.0 18:41:56 INFO - 2015-11-17 18:41:56,738 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,739 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.80 Median:151.50 stddev:14.38 (9.5%) stddev-sans-first:15.25 18:41:56 INFO - 2015-11-17 18:41:56,739 DEBUG : BROWSER_OUTPUT: Values: 150.0 131.0 151.0 165.0 132.0 152.0 161.0 140.0 172.0 134.0 18:41:56 INFO - 2015-11-17 18:41:56,739 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,739 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.42 (0.9%) stddev-sans-first:1.48 18:41:56 INFO - 2015-11-17 18:41:56,739 DEBUG : BROWSER_OUTPUT: Values: 163.0 163.0 164.0 163.0 162.0 166.0 164.0 162.0 166.0 164.0 18:41:56 INFO - 2015-11-17 18:41:56,739 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,739 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.00 Median:73.50 stddev:32.69 (44.5%) stddev-sans-first:34.16 18:41:56 INFO - 2015-11-17 18:41:56,739 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 74.0 149.0 74.0 73.0 74.0 74.0 153.0 18:41:56 INFO - 2015-11-17 18:41:56,740 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,740 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.70 Median:91.50 stddev:18.25 (19.9%) stddev-sans-first:18.94 18:41:56 INFO - 2015-11-17 18:41:56,740 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 133.0 91.0 96.0 91.0 129.0 92.0 91.0 128.0 18:41:56 INFO - 2015-11-17 18:41:56,740 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,740 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 18:41:56 INFO - 2015-11-17 18:41:56,740 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 109.0 110.0 110.0 110.0 110.0 111.0 110.0 109.0 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 149.0 150.0 152.0 150.0 150.0 152.0 150.0 150.0 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:76.30 Median:76.50 stddev:1.95 (2.5%) stddev-sans-first:2.01 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: Values: 75.0 78.0 76.0 75.0 76.0 77.0 78.0 80.0 74.0 74.0 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,741 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 71.0 70.0 69.0 71.0 70.0 69.0 70.0 70.0 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 84.0 84.0 84.0 83.0 85.0 85.0 85.0 85.0 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:128.00 stddev:4.61 (3.6%) stddev-sans-first:4.85 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: Values: 129.0 124.0 125.0 131.0 125.0 131.0 127.0 136.0 120.0 124.0 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:157.00 stddev:6.80 (4.3%) stddev-sans-first:6.26 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: Values: 145.0 158.0 153.0 157.0 155.0 151.0 159.0 167.0 157.0 144.0 18:41:56 INFO - 2015-11-17 18:41:56,742 DEBUG : BROWSER_OUTPUT: 18:41:56 INFO - 2015-11-17 18:41:56,743 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:1.58 (2.2%) stddev-sans-first:1.59 18:41:56 INFO - 2015-11-17 18:41:56,743 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 72.0 73.0 71.0 71.0 75.0 70.0 71.0 70.0 18:41:56 INFO - 2015-11-17 18:41:56,743 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:41:56 INFO - 2015-11-17 18:41:56,743 DEBUG : BROWSER_OUTPUT: 18:41:57 INFO - 2015-11-17 18:41:57,702 INFO : Browser exited with error code: 0 18:41:57 INFO - 2015-11-17 18:41:57,751 INFO : Completed test kraken (00:01:01) 18:41:57 INFO - 2015-11-17 18:41:57,751 INFO : Starting test v8_7 18:41:57 INFO - 2015-11-17 18:41:57,751 DEBUG : operating with platform_type : linux_ 18:41:57 INFO - 2015-11-17 18:41:57,751 INFO : Initialising browser for v8_7 test... 18:41:57 INFO - 2015-11-17 18:41:57,758 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwagj3w/profile http://localhost:54143/getInfo.html 18:42:02 INFO - 2015-11-17 18:42:02,357 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:42:02 INFO - 2015-11-17 18:42:02,357 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:42:02 INFO - 2015-11-17 18:42:02,357 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:42:02 INFO - 2015-11-17 18:42:02,357 DEBUG : BROWSER_OUTPUT: __metrics 18:42:03 INFO - 2015-11-17 18:42:03,426 INFO : Browser initialized. 18:42:03 INFO - 2015-11-17 18:42:03,427 INFO : Running cycle 1/1 for v8_7 test... 18:42:03 INFO - 2015-11-17 18:42:03,427 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwagj3w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:42:15 INFO - 2015-11-17 18:42:15,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 142090240 18:42:15 INFO - 2015-11-17 18:42:15,424 DEBUG : BROWSER_OUTPUT: 18:42:36 INFO - 2015-11-17 18:42:36,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54143/tests/v8_7/run.html (next: http://localhost:54143/tests/v8_7/run.html) 18:42:37 INFO - 2015-11-17 18:42:37,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 138498048 18:42:37 INFO - 2015-11-17 18:42:37,138 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,139 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:42:37 INFO - 2015-11-17 18:42:37,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:42:37 INFO - 2015-11-17 18:42:37,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:42:37 INFO - 2015-11-17 18:42:37,139 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:42:37 INFO - 2015-11-17 18:42:37,139 DEBUG : BROWSER_OUTPUT: |0;Richards;165.15276630883568 18:42:37 INFO - 2015-11-17 18:42:37,140 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.78933383943823 18:42:37 INFO - 2015-11-17 18:42:37,140 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 18:42:37 INFO - 2015-11-17 18:42:37,140 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 18:42:37 INFO - 2015-11-17 18:42:37,140 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1081.081081081081 18:42:37 INFO - 2015-11-17 18:42:37,140 DEBUG : BROWSER_OUTPUT: |5;Earley;716.3323782234957 18:42:37 INFO - 2015-11-17 18:42:37,140 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 18:42:37 INFO - 2015-11-17 18:42:37,140 DEBUG : BROWSER_OUTPUT: |7;RegExp;25948.71794871795 18:42:37 INFO - 2015-11-17 18:42:37,140 DEBUG : BROWSER_OUTPUT: |8;Splay;602.6331538001197 18:42:37 INFO - 2015-11-17 18:42:37,141 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 18:42:37 INFO - 2015-11-17 18:42:37,141 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:42:37 INFO - 2015-11-17 18:42:37,141 DEBUG : BROWSER_OUTPUT: __startTimestamp1447814557138__endTimestamp 18:42:37 INFO - 2015-11-17 18:42:37,141 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,142 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:42:37 INFO - 2015-11-17 18:42:37,142 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:42:37 INFO - 2015-11-17 18:42:37,142 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,142 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.15 Median:165.15 stddev:0.00 (0.0%) 18:42:37 INFO - 2015-11-17 18:42:37,142 DEBUG : BROWSER_OUTPUT: Values: 165.2 18:42:37 INFO - 2015-11-17 18:42:37,142 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,142 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.79 Median:189.79 stddev:0.00 (0.0%) 18:42:37 INFO - 2015-11-17 18:42:37,143 DEBUG : BROWSER_OUTPUT: Values: 189.8 18:42:37 INFO - 2015-11-17 18:42:37,143 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,143 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 18:42:37 INFO - 2015-11-17 18:42:37,143 DEBUG : BROWSER_OUTPUT: Values: 280.0 18:42:37 INFO - 2015-11-17 18:42:37,143 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,143 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 18:42:37 INFO - 2015-11-17 18:42:37,143 DEBUG : BROWSER_OUTPUT: Values: 5040.2 18:42:37 INFO - 2015-11-17 18:42:37,143 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,143 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1081.08 Median:1081.08 stddev:0.00 (0.0%) 18:42:37 INFO - 2015-11-17 18:42:37,144 DEBUG : BROWSER_OUTPUT: Values: 1081.1 18:42:37 INFO - 2015-11-17 18:42:37,144 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,144 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:716.33 Median:716.33 stddev:0.00 (0.0%) 18:42:37 INFO - 2015-11-17 18:42:37,144 DEBUG : BROWSER_OUTPUT: Values: 716.3 18:42:37 INFO - 2015-11-17 18:42:37,144 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,144 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 18:42:37 INFO - 2015-11-17 18:42:37,144 DEBUG : BROWSER_OUTPUT: Values: 12195.1 18:42:37 INFO - 2015-11-17 18:42:37,144 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,144 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 18:42:37 INFO - 2015-11-17 18:42:37,144 DEBUG : BROWSER_OUTPUT: Values: 25948.7 18:42:37 INFO - 2015-11-17 18:42:37,145 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,145 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.63 Median:602.63 stddev:0.00 (0.0%) 18:42:37 INFO - 2015-11-17 18:42:37,145 DEBUG : BROWSER_OUTPUT: Values: 602.6 18:42:37 INFO - 2015-11-17 18:42:37,145 DEBUG : BROWSER_OUTPUT: 18:42:37 INFO - 2015-11-17 18:42:37,145 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 18:42:37 INFO - 2015-11-17 18:42:37,145 DEBUG : BROWSER_OUTPUT: Values: 4830.9 18:42:37 INFO - 2015-11-17 18:42:37,145 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:42:37 INFO - 2015-11-17 18:42:37,145 DEBUG : BROWSER_OUTPUT: 18:42:38 INFO - 2015-11-17 18:42:38,098 INFO : Browser exited with error code: 0 18:42:38 INFO - 2015-11-17 18:42:38,115 INFO : Completed test v8_7 (00:00:40) 18:42:38 INFO - 2015-11-17 18:42:38,602 INFO : Completed test suite (00:20:17) 18:42:38 INFO - 2015-11-17 18:42:38,603 DEBUG : Working with test: dromaeo_css 18:42:38 INFO - 2015-11-17 18:42:38,603 DEBUG : Generating results file: dromaeo_css 18:42:38 INFO - 2015-11-17 18:42:38,604 DEBUG : Working with test: kraken 18:42:38 INFO - 2015-11-17 18:42:38,604 DEBUG : Generating results file: kraken 18:42:38 INFO - 2015-11-17 18:42:38,604 INFO : javascript benchmark 18:42:38 INFO - 2015-11-17 18:42:38,604 DEBUG : Working with test: v8_7 18:42:38 INFO - 2015-11-17 18:42:38,605 DEBUG : Generating results file: v8_7 18:42:38 INFO - 2015-11-17 18:42:38,605 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:42:38 INFO - 2015-11-17 18:42:38,652 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,43]] 18:42:38 INFO - 2015-11-17 18:42:38,652 DEBUG : process_Request line: dromaeo_css 5917.16 graph.html#tests=[[72,131,43]] 18:42:38 INFO - 2015-11-17 18:42:38,652 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:42:38 INFO - 2015-11-17 18:42:38,689 DEBUG : process_Request line: kraken 1560.80 graph.html#tests=[[232,131,43]] 18:42:38 INFO - 2015-11-17 18:42:38,689 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:42:38 INFO - 2015-11-17 18:42:38,724 DEBUG : process_Request line: v8_7 21358.10 graph.html#tests=[[230,131,43]] 18:42:38 INFO - 2015-11-17 18:42:38,725 INFO : javascript benchmark 18:42:38 INFO - 2015-11-17 18:42:38,728 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2677.545965704241, 2681.5039217744707, 2718.4970780405624, 2729.6587926509187, 2740.60261262117, 4600.056988317395, 4650.13972415103, 4682.08699303636, 4706.223473126935, 4760.309755085515, 4679.8362057328, 4702.929456058162, 4723.338732577442, 4788.928166077503, 4791.089692958335, 4343.19650864591, 4372.73763574185, 4373.343998400233, 4384.0, 4415.712978656393, 4340.066885619591, 4403.075354175627, 4411.669124815636, 4467.642588592905, 4479.216137175998, 4137.193247316774, 4285.292926667096, 4315.352697095429, 4399.5160532341415, 4421.248387774086, 4429.357743127261, 4443.311286750559, 4445.288753799409, 4445.755483448409, 4459.754713490756, 4145.398917157026, 4422.09347083847, 4423.60187583119, 4459.866204013885, 4466.3747075409465, 4593.333966574862, 4660.487346391928, 4695.037517308943, 4738.4550776660435, 4769.42766867978, 5107.565856902168, 5189.455107213764, 5205.7917683293, 5211.2443695663915, 5239.895202095975, 4799.0, 4910.90178196434, 5214.765335559909, 5234.555062819665, 5240.0, 4664.696794708333, 4707.29390591414, 4716.056788642285, 4733.644976626767, 4772.9284060739465, 5213.478652134832, 5216.347956505437, 5238.397584277781, 5240.842774716764, 5344.679319240858, 4756.072565849695, 4919.483454237254, 4923.212286034217, 5053.567415028859, 5066.290719299301, 4962.280469331927, 5027.648064635514, 5049.596032317406, 5059.696418214919, 5071.0872043032605, 5112.590992720573, 5175.637705360588, 5177.456367081478, 5185.274061631375, 5220.608454365938, 4657.510961349078, 4872.731999740048, 5146.022255771391, 5157.742112894415, 5162.793488260428, 4110.424540564323, 4166.166766646683, 4176.561461046607, 4185.434966279574, 4196.3705444183615, 3747.3442147624055, 3747.662710356081, 3756.9248615027545, 3768.2086761780333, 3775.4336849472797, 4213.431186789744, 4344.891377715519, 4355.629771469397, 4406.735595864258, 4439.866803995886, 5191.377034755778, 5256.763445644955, 5265.0259701955265, 5284.841454756363, 5291.682499050069, 4487.820487180476, 4506.819727210875, 4513.052259025641, 4535.29702896045, 4551.886202844956, 4244.957550424456, 4356.6950313477755, 4490.146872094291, 4584.977075114603, 4614.930776038362, 4877.6829506081995, 4899.24061770419, 4920.360353154067, 4930.6795058321095, 4953.851384458328, 5193.298904647975, 5199.246109314053, 5206.8958620828125, 5207.557357624492, 5245.213218017328, 4398.098389830013, 4454.910901782011, 4797.472278049342, 4870.707757534559, 4910.484399138182, 4992.650514463952, 5002.374703162105, 5007.774650140679, 5028.2960385546785, 5051.191809310492, 4783.234682450791, 5074.238864170256, 5091.66904151229, 5101.132807422673, 5121.283020377075, 4827.155247831685, 4858.95141048585, 4876.707397556158, 4892.975535122301, 4960.181570040902, 4909.993451342395, 4954.157793175241, 4956.281339205867, 4964.726940018334, 5011.724355160355, 4847.054824309226, 4855.1260773061185, 4864.440589332272, 4865.7323847188745, 4869.196582563837, 4730.7161570304515, 4851.393575803025, 4931.654784165074, 5019.7490125494305, 5046.596272298134, 4879.853604391874, 4881.219004959189, 4883.121038213014, 4884.63365247615, 4907.0], "unit": "ms", "name": "dojo.html", "value": 4666.486869322032}, {"lowerIsBetter": false, "replicates": [571.103367712691, 575.0913556580603, 575.6920047774439, 585.7100735136107, 595.3748564007791, 36821.0, 37425.06437339071, 37481.81404580607, 37609.0, 37729.622703772955, 40110.598894011055, 40512.79743601278, 40601.59398406015, 40792.59207407925, 40867.38698919518, 7950.8807367889385, 8107.756767296991, 8158.592070396486, 8164.183581641818, 8177.4684645497855, 7907.130215676271, 7976.122626511079, 8027.157148499411, 8027.839443211133, 8034.076081250672, 7731.45879788415, 7786.3770898328285, 7804.882926756103, 7811.296983271504, 7831.099423566277, 7891.60541972902, 7962.0, 7968.721094761684, 7969.721059762938, 7972.920270797275, 7889.9211007890335, 7933.563653999027, 8030.678772849079, 8043.11525732169, 8053.315468185211, 36723.265534689155, 37134.0, 37284.0, 37514.0, 37588.24823503542, 2830.674472435655, 2909.636295463067, 2911.505044142501, 3542.3092496963104, 3632.7820330780237, 27346.179614611592, 27654.446911061867, 28068.43863122726, 28347.433051339063, 28453.0, 2833.7804143669755, 2855.5431131018936, 2909.6072030276064, 2988.4023195361015, 3040.407120611482, 341817.0, 346782.0, 348916.0, 349398.0, 350763.0, 38869.80565097213, 39444.40833387501, 39555.604443955766, 56428.717856410454, 56872.0, 37138.814305928296, 37327.62672373296, 37396.0, 37498.25003499969, 37568.24863502714, 11642.126840486997, 11670.941645291889, 11841.703957401134, 11843.348615826213, 11915.523379064914, 8830.86753698695, 8901.198892099743, 8902.910970890338, 8939.418937769024, 8953.194212520904, 13114.60656180297, 13446.596602101758, 13487.258200798855, 13515.0, 13569.457221711218, 5464.453554644504, 5533.916991245134, 5595.916061259084, 5618.943810561842, 5707.4898937154185, 799.8320352725992, 864.2178828160525, 900.3472482450302, 903.6430609909049, 1056.9577216911237, 24920.87539562327, 25050.624240636404, 25085.623715643917, 25131.62302565463, 25132.874335628207, 900.5857305639479, 920.8020275640636, 924.995375023134, 987.1855719031828, 1080.4813689429118, 13110.147840390535, 13311.866881331063, 13394.263315517544, 13394.464221431033, 13412.530561430498, 308484.0, 311971.0, 312408.0, 315114.0, 315130.0, 45806.770966144955, 46170.0, 46346.768266158455, 46594.30108548375, 46811.76594117007, 1094.8357746338113, 1099.5052226498108, 1108.5731993182521, 1111.6942840718705, 1116.2744216259334, 24785.62821557642, 24879.62680559829, 24942.875285623457, 24956.750432495443, 25265.621015684414, 38690.613093869826, 39323.410148847215, 39354.803225983684, 39362.80318598503, 39644.405333919436, 245996.0, 247425.0, 247659.0, 250257.0, 250363.0, 29018.854905725337, 29523.0, 42321.365179521716, 43836.34245486256, 44159.55840441555, 38207.42688859725, 38343.808280958416, 38789.61210387973, 39169.41245881257, 39238.411423828096, 33603.49594756032, 33749.0, 34519.0, 34543.0, 34712.65287347094, 37509.43735844019, 39801.20397591974, 40002.59997400105, 40032.48875770173, 40433.797831010655, 33142.834285828416, 33233.169170770925, 33337.66662333443, 33533.16167095842, 33692.32615347728, 28816.279593010342, 31026.379472410877, 31353.37293254168, 31483.212919677193, 31586.842065789522, 23858.449200801893, 24018.87990560036, 24068.27795166148, 24206.273811785675, 24422.755772442048], "unit": "ms", "name": "ext.html", "value": 16532.7695107878}, {"lowerIsBetter": false, "replicates": [304.77142143392456, 306.4223937877101, 307.2472442515836, 309.9907002789916, 310.6629307201686, 10922.453877306143, 11193.048590869765, 14620.34208460619, 14998.550043498684, 15213.84786152138, 10517.842232366502, 10554.683359499228, 10754.623588174416, 10801.945990270056, 10825.891741082587, 4004.1991601679633, 4061.57353477885, 4070.633642972132, 4083.3874918762126, 4097.098638299584, 4018.4976877890263, 4065.410515475254, 4098.631123198911, 4114.7119701620895, 4123.917521649565, 4003.1593365393155, 4018.3369743992207, 4356.085222103362, 4449.822007119711, 4466.3747075409465, 4370.519242883281, 4392.582704643054, 4405.273129933557, 4406.405135306724, 4418.3593378960195, 3793.468914351993, 3807.162424266657, 3886.067343837487, 3905.882823515299, 3906.9841841121515, 9886.90113098867, 9898.307118501707, 11250.15623828208, 11947.223430476992, 12016.218945768496, 1729.8702597305253, 1735.4793561931497, 1752.97370539442, 1780.9376671816424, 1793.8923664580036, 9097.181253687133, 9118.0, 9240.353175277733, 9361.672341468084, 9385.108414700593, 1579.2656414767189, 1596.8642665373457, 1605.8313877042976, 1649.0, 1650.4965985374456, 46182.538174618494, 46231.76884115558, 46399.53600463986, 47463.762681186716, 48127.75936120297, 6253.093301471352, 6289.528285378524, 6298.212723409574, 6310.558260921692, 6365.108884756138, 7196.316349946746, 7202.135743710788, 7256.129264488295, 7275.708971641075, 7290.927090729025, 4772.5227477252, 4803.879903002383, 4813.350197723333, 4916.803327866917, 4924.409070911442, 4929.901401971941, 4954.083494553519, 4961.181405068195, 4968.0, 4972.950270497321, 2973.8810447582287, 2975.2561859535117, 3002.084364268875, 3005.1585556044342, 3015.7285844273683, 1061.2200032975757, 1064.4571268653042, 1073.2916275258292, 1084.1651928015383, 1119.9920071935323, 341.83421040795196, 347.30192313450146, 348.84127721886483, 349.62939284358663, 375.09227669040985, 8846.778830529289, 9203.251382237353, 9589.136977671904, 9624.37441566296, 9861.309708320492, 370.6071564142018, 375.73510674974625, 377.7714482737959, 381.94079917612817, 399.6602887545563, 5186.714730689773, 5216.400113986864, 5222.843314700565, 5224.268602395668, 5265.578753699695, 470231.0, 474864.0, 475756.0, 481901.0, 489559.0, 64055.6797216011, 64777.0, 65356.673216633615, 65429.0, 66575.0, 404.28845232390614, 404.5529689692847, 405.47693475416384, 407.8837531303564, 408.24678468226074, 8792.384533082623, 8842.557872106241, 8878.600462979051, 8939.955300223457, 9702.466364349746, 27209.0, 27996.72003279941, 28668.42663146767, 29009.7099029007, 29200.561991569717, 36370.27259454849, 37475.0, 38730.6126938727, 38989.610103898594, 40075.39886901757, 6084.421979911901, 6103.572749907641, 6146.569740118328, 6154.169187159855, 6156.630602163885, 10997.285176463503, 11050.392228427192, 11249.66251012471, 11310.208285419942, 11313.830292545454, 8132.2680958711635, 8455.365847561334, 8635.395522313378, 10003.449810260214, 10082.949585252027, 8505.574721263789, 8805.0, 8824.514651694219, 9041.50271735061, 9053.502057386644, 8889.377743557889, 9047.185753282236, 9073.727788166365, 9182.908170918472, 9234.538273086453, 5872.324682661378, 5884.999550076412, 5907.143464197753, 5916.290045194432, 5939.138824870456, 8979.551022448983, 8986.0, 8995.505247211466, 9124.908750912671, 9309.906900930904], "unit": "ms", "name": "jquery.html", "value": 5901.217037146033}, {"lowerIsBetter": false, "replicates": [1459.3724698379692, 1662.3849175804953, 1680.5714542791593, 1714.34854755193, 1731.5411415974766, 5373.946260537398, 5456.399796022434, 5465.316835395575, 5556.666600004002, 5769.5672824538115, 6434.935650643492, 6646.401823835854, 6687.665616719157, 6732.730690772375, 6759.1213142291435, 1949.337225343383, 1991.0343483410534, 1993.491659626793, 1996.6605677034865, 1997.1711739628038, 2003.5291706448972, 2006.0972562346928, 2011.1854698846917, 2077.3456361246235, 2079.116375540389, 1979.5842872996689, 2003.1987205117923, 2007.2272175212502, 2010.6079314533672, 2010.979890201094, 1995.900204989752, 2005.82950449212, 2016.9899150504227, 2017.798220177985, 2021.3632705697657, 1996.8003199679915, 2020.777714451409, 2023.8785672859676, 2024.757029156496, 2042.5710600773707, 6741.59550426976, 6829.590224586541, 6831.863362732767, 6831.931680683179, 6835.350641689031, 3990.2418540477215, 4049.250888585621, 4061.2283666103344, 4068.0236743181717, 4068.2880495913096, 2680.919572412831, 2712.905048323299, 2740.5889116632466, 2808.340040090577, 2808.3540785619216, 839.9622017009189, 841.4824882697159, 855.7090589199639, 873.3319010956624, 883.355150739957, 8956.910430895738, 8980.685676001309, 9010.098990101003, 9035.954820225857, 9071.410358326688, 3613.7831730096277, 3622.4566315052953, 3636.1455058061333, 3661.3043521730788, 3713.925721485555, 7856.960715196387, 7857.096433910059, 7857.096433910059, 7871.134175240719, 7877.527348359117, 4101.8974525637095, 4129.525104612948, 4133.648639865645, 4137.648299894482, 4142.378643203544, 3001.2046807596003, 3052.3437460946, 3712.6472985066375, 3744.4944932433773, 3751.1372384351753, 2999.610050693396, 3037.3014206732573, 3039.9544006839915, 3316.2704205074847, 3342.1143396999814, 1039.2465462539749, 1048.130052056791, 1056.989430105689, 1057.3497299161115, 1061.0768631290825, 860.1226748716274, 937.3063932689761, 968.5254225429629, 1147.002108165901, 1147.9081673466103, 6328.303886572473, 6381.0, 6384.457321127663, 6397.296297407282, 6415.935840641627, 1000.0799264676515, 1005.3113617172261, 1009.7828966772179, 1025.220832167558, 1031.2265800649513, 5088.796448142107, 5116.462771409023, 5192.662476939063, 5240.973795131076, 5264.078786212397, 7981.082175549886, 8190.303824175012, 8193.71322003727, 8220.876686849702, 8223.01323841143, 7941.722039728582, 8064.919350806417, 8080.636371363303, 8095.0, 8110.107888132301, 6332.905006424908, 6361.809145725636, 6374.713137908805, 6377.808665740035, 6413.679316034273, 6200.441960223601, 6202.4417802398, 6266.68666566679, 6482.935170648233, 6499.0, 7049.9647501762165, 7056.8588628226125, 7160.176579693193, 7193.676284567103, 7206.6396680164735, 7149.571025738473, 7210.531315464478, 7238.131424229126, 7254.238304977901, 7279.490435669452, 4955.752212389438, 5120.052790233819, 5850.180974663465, 5935.525157987265, 6011.098335249748, 6442.162518872517, 6509.218893732783, 6511.055896895018, 6557.049227861838, 6584.275729669828, 5948.5538584605465, 5952.851178720393, 6088.056351265561, 6171.352008039271, 6349.777757778455, 5787.421257874179, 5865.354810970704, 5952.97023514897, 5959.821205363846, 5989.610675306091, 5990.101484777319, 6120.663363515049, 6124.601900876429, 6134.325224225421, 6152.784652537319, 5719.7426115824055, 5744.741486633028, 5780.450857168562, 5782.5663075268685, 5802.47777700009, 5802.245708057925, 5830.2420685310635, 5843.386444423274, 5844.736986835687, 5870.7945221917025], "unit": "ms", "name": "mootools.html", "value": 3905.143371731584}, {"lowerIsBetter": false, "replicates": [261.5409955528049, 267.2383706436656, 270.09114330278607, 276.3933166699096, 277.5503684031869, 5573.888522229553, 5576.191452239423, 5583.302087239095, 5627.521660658849, 5748.367679555246, 5577.274954255951, 5603.823197128608, 5617.157426386044, 5618.887622247563, 5640.0693885508945, 4016.554040545401, 4111.71218014739, 4132.855350062749, 4135.834566617332, 4143.067809742814, 4121.5672354402805, 4123.051698109437, 4123.175364927011, 4123.525794533622, 4130.2359063573185, 4047.8583249586272, 4067.4712287402594, 4075.8981025474304, 4087.4277601135864, 4093.97953010236, 4069.8604390770633, 4077.7553346799286, 4081.9591804082024, 4087.4481944937497, 4092.202020605983, 3368.2758206985372, 3435.055359776057, 3435.2270739083756, 3435.879744208941, 3440.17435815405, 5314.229436731691, 5372.7313634318125, 5375.11310633745, 5375.838724838261, 5390.326209223847, 4636.698614590041, 4652.441706995149, 4659.184642687516, 4662.8368007119925, 4663.860084197479, 5866.9119963200155, 5874.295084589834, 5875.148103525008, 5879.118132280149, 5892.410758924116, 3655.122770535079, 3728.328900797855, 3729.4219395993664, 3733.309337772521, 3743.3262012837677, 6171.691415429211, 6232.220972378453, 6234.719437625317, 6239.251289845248, 6258.967270400379, 3925.7644541327613, 3934.780218132388, 3949.644531992077, 3951.723379363417, 3956.485656864589, 3990.4413382126527, 3991.1618560102124, 4006.859759908389, 4008.9198216035516, 4015.8795236142964, 4686.0, 4707.082118986833, 4716.976415117902, 4731.716097034189, 4736.265878788793, 5696.857578560569, 5878.412158784087, 5903.58674892762, 5927.585069045125, 5932.93207222704, 1398.0423409964208, 1410.5838777560439, 1420.3537390487304, 1421.9004669673232, 1422.8719415252676, 917.5412293853074, 921.3826736086838, 923.0354279777648, 935.2190920581255, 940.431039221275, 5085.898282034339, 5114.028334616411, 5138.717370544581, 5141.177411614124, 5141.948580514147, 6011.338752737195, 6103.908441373383, 6123.4488895999575, 6201.255849298113, 6215.533834962396, 5154.845354639367, 5190.558802501754, 5191.428942816287, 5191.428942816287, 5196.532312091855, 3313.1385839681857, 3331.6501767314567, 3343.966560334414, 3347.8493467794005, 3351.296227792191, 5622.606417550732, 5817.0983497557945, 5826.300843898759, 5830.183774271605, 5835.766569337179, 6356.936430635635, 6387.808365749035, 6397.808065758035, 6404.263509696445, 6405.839854003687, 5798.333191682926, 5807.0, 5826.70866456684, 5828.154917537018, 5831.154482599914, 6073.544484163617, 6169.290531588746, 6186.536009799193, 6188.319284878749, 6201.658908760061, 6026.427489388501, 6050.42520960508, 6058.242719660043, 6069.787557435468, 6074.939250607437, 5803.158542011469, 5809.2738407699035, 5817.854553636023, 5822.5633077518505, 5824.0, 3938.409238614116, 3948.684105271629, 3956.2878681837547, 3960.5841386653988, 3969.503812023497, 6071.817845464643, 6213.844653883689, 6218.347073557211, 6228.190335256388, 6228.657423841732, 5961.970190149022, 5963.970180149072, 5966.940330596639, 5969.582129251085, 5972.34304226526, 5909.497692696169, 5952.5833191676165, 5952.940470595238, 5954.672493012753, 5966.403359663999, 5653.745581448927, 5805.8548536286935, 5806.187133801187, 5809.970950145223, 5814.360420353673, 5993.670348130895, 6002.189704389852, 6014.398560143951, 6018.217631708025, 6020.8795824084145, 5696.715164241688, 5760.423957604374, 5775.653460792366, 5802.912956305574, 5829.795957141479], "unit": "ms", "name": "prototype.html", "value": 4313.138890818737}, {"lowerIsBetter": false, "replicates": [648.2674577727167, 725.3616817200866, 734.4895297768053, 777.0054330457017, 796.358931060496, 10898.455077246126, 11084.168687348441, 11691.766164676701, 11968.401579921012, 11983.520659173622, 12622.431990560446, 12973.0, 13092.149010314322, 13096.41066152023, 13111.147775394593, 789.329070290253, 809.9838003239961, 810.6635746165334, 810.7729835645999, 811.9025716913978, 793.4406243598249, 804.9678012879477, 807.0436532708759, 807.2774866494484, 808.3048578222753, 846.8899043124416, 846.9407141500097, 848.2662496940134, 853.0871966995318, 857.5712143928037, 843.451756358372, 846.475185385059, 849.3502470609989, 849.5964416901984, 850.4429598612887, 616.9876602467971, 618.6844709198341, 620.2185246589285, 620.8199622109582, 621.8631900981777, 11841.28952262867, 12511.74976500474, 12555.309457979807, 12582.496700131984, 12595.3072581008, 11223.214374993753, 11224.158188135922, 11471.713207169887, 11507.827382589268, 12004.879951200464, 9479.383840050376, 9483.33616646835, 9485.193758530464, 9490.0, 9562.521873906346, 2975.9404811903855, 2996.790224684273, 2998.6551546572205, 3027.8486075696346, 3075.6463006754284, 33855.6614433855, 37734.0, 37823.621763782285, 38086.23827523462, 38301.42547861784, 6612.206535215709, 6697.631630260285, 6745.5952642841585, 6937.098177237028, 6987.720491180397, 10364.326318789406, 10460.68617941463, 10462.895371046192, 10484.475776211159, 10491.94754026225, 5643.068893632505, 5665.065264231438, 5671.432856714296, 5749.88500229993, 5763.827085187451, 3554.1405088179545, 3571.982140089283, 3587.318409502186, 3596.0829988352803, 3676.6690997810324, 2421.055788242587, 2434.6469761884427, 2456.9631455528183, 2462.7537246275588, 2464.4085419499193, 381.6279127850379, 394.0994826820701, 395.6913607386243, 397.3523157253658, 401.56229709616656, 524.8740302327413, 596.8299034775068, 597.9133025711247, 610.28901329951, 618.981430557084, 8556.61495232716, 8675.696350627697, 8766.780830479289, 8848.513331766686, 9106.81786364269, 630.8296759874808, 632.5951391109694, 640.166741104658, 640.5260107520402, 660.2506155513431, 3395.405803984293, 3723.94414083789, 3755.3615885299564, 3808.2954653388656, 3810.447485114643, 45457.77271113623, 49254.261186082236, 51847.74076129671, 52209.2168617471, 52345.47654523482, 42152.156956860694, 42656.14687706291, 42902.0, 43208.351874721906, 43526.0, 41870.58129418667, 41955.0, 42668.78665606714, 43905.0, 44925.77537112294, 8192.75421737349, 8304.501729896225, 8680.522571258642, 8681.305495560213, 8700.56497175126, 31463.528047078853, 31486.685133148374, 31768.841155794074, 31826.204344891565, 32006.0, 36845.63154368529, 37185.07037324089, 37430.6256937438, 42551.36172957346, 42750.57249427466, 7560.697572097055, 7583.203763604963, 7595.506292090997, 7596.962015189889, 7778.766637000673, 11527.94236028848, 11547.653570392902, 11645.88354116448, 11667.708307292385, 11926.821097683714, 10674.946625266824, 10796.946015269874, 11047.83428248593, 11053.060489858452, 11061.612843550438, 9539.52302384864, 10322.380657160595, 10527.94736026315, 10845.349279043283, 11205.215634905479, 10787.946060269649, 10831.837522437327, 10899.673009809718, 10901.618443354444, 10947.397893115955, 9296.116868897443, 9352.392094513834, 9449.905500944902, 9799.461029643153, 9856.605735770776, 9376.296777741833, 9547.952260238655, 9594.280428967715, 9597.952010239904, 9653.17947974402], "unit": "ms", "name": "yui.html", "value": 5596.654505840437}], "name": "dromaeo_css", "value": 5917.156224410385}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 116.0, 114.0, 116.0, 125.0, 114.0, 113.0, 117.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 115.3}, {"lowerIsBetter": true, "replicates": [150.0, 131.0, 151.0, 165.0, 132.0, 152.0, 161.0, 140.0, 172.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 164.0, 163.0, 162.0, 166.0, 164.0, 162.0, 166.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 74.0, 149.0, 74.0, 73.0, 74.0, 74.0, 153.0], "unit": "ms", "name": "audio-fft", "value": 89.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 133.0, 91.0, 96.0, 91.0, 129.0, 92.0, 91.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 103.7}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 149.0, 150.0, 152.0, 150.0, 150.0, 152.0, 150.0, 150.0], "unit": "ms", "name": "imaging-darkroom", "value": 150.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [75.0, 78.0, 76.0, 75.0, 76.0, 77.0, 78.0, 80.0, 74.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 76.3}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 70.0, 69.0, 71.0, 70.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 84.0, 84.0, 83.0, 85.0, 85.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [129.0, 124.0, 125.0, 131.0, 125.0, 131.0, 127.0, 136.0, 120.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [145.0, 158.0, 153.0, 157.0, 155.0, 151.0, 159.0, 167.0, 157.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 154.6}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 72.0, 73.0, 71.0, 71.0, 75.0, 70.0, 71.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.4}], "name": "kraken", "value": 1560.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.15276630883568], "unit": "score", "name": "Richards", "value": 213.75361000000004}, {"lowerIsBetter": false, "replicates": [189.78933383943823], "unit": "score", "name": "DeltaBlue", "value": 348.37574199999995}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1081.081081081081], "unit": "score", "name": "RayTrace", "value": 684.4898250000002}, {"lowerIsBetter": false, "replicates": [716.3323782234957], "unit": "score", "name": "Earley", "value": 930.3823479999999}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25948.71794871795], "unit": "score", "name": "RegExp", "value": 35.107129446640336}, {"lowerIsBetter": false, "replicates": [602.6331538001197], "unit": "score", "name": "Splay", "value": 135.22488679245282}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21358.10218638557}]} 18:42:38 INFO - RETURN: dromaeo_css: 5917.16 18:42:38 INFO - RETURN: kraken: 1560.80 18:42:38 INFO - RETURN: v8_7: 21358.10 18:42:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,43]]", "result": "21358.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,43]]", "result": "1560.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,43]]", "result": "5917.16"}}} 18:42:38 INFO - Return code: 0 18:42:38 INFO - # TBPL SUCCESS # 18:42:38 INFO - Running post-action listener: _resource_record_post_action 18:42:38 INFO - Running post-run listener: _resource_record_post_run 18:42:39 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519241728; Read time: 276; Write time: 458268 18:42:39 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 85417984; Read time: 0; Write time: 70872 18:42:39 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 352169984; Read time: 0; Write time: 278156 18:42:39 INFO - Running post-run listener: _upload_blobber_files 18:42:39 INFO - Blob upload gear active. 18:42:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:42:39 INFO - Copying logs to upload dir... 18:42:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.881165 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-17 18:42:39.864177) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:42:39.868204) ========= 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=fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009095 build_url: 'https://queue.taskcluster.net/v1/task/DwJXblZcS7e5wQQnieUKcA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:42:39.922881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:42:39.923231) ========= 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=fce1c2174958ee92775f70ae000001a3-1447811703.730500-1793450888 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:42:39.972584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 18:42:39.972920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 18:42:39.973252) ========= ========= Total master_lag: 0.24 =========