builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1447923529.0 results: success (0) buildid: 20151119001840 builduid: 7f55421e2d2c45c0a4e6450014dd16a6 revision: 6b34afb1a471b35f9c24945eb2ae094b77952526 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:48.995695) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:48.996071) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:48.996352) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009275 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.058818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.059118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.213065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.213531) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004613 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.272052) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.272444) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.272947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.273340) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 00:58:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.8M=0.001s 2015-11-19 00:58:50 (20.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.454157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.454468) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017567 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:49.507712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 00:58:49.508073) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6b34afb1a471b35f9c24945eb2ae094b77952526 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6b34afb1a471b35f9c24945eb2ae094b77952526 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 00:58:50,290 truncating revision to first 12 chars 2015-11-19 00:58:50,290 Setting DEBUG logging. 2015-11-19 00:58:50,291 attempt 1/10 2015-11-19 00:58:50,291 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6b34afb1a471?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 00:58:51,608 unpacking tar archive at: mozilla-inbound-6b34afb1a471/testing/mozharness/ program finished with exit code 0 elapsedTime=1.601017 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-19 00:58:51.123008) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:51.123344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:51.132628) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:51.132901) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 00:58:51.133283) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 9 secs) (at 2015-11-19 00:58:51.133575) ========= /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=cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:58:51 INFO - MultiFileLogger online at 20151119 00:58:51 in /builds/slave/test 00:58:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 00:58:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:58:51 INFO - {'append_to_log': False, 00:58:51 INFO - 'base_work_dir': '/builds/slave/test', 00:58:51 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 00:58:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:58:51 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 00:58:51 INFO - 'buildbot_json_path': 'buildprops.json', 00:58:51 INFO - 'config_files': ('talos/linux_config.py',), 00:58:51 INFO - 'default_actions': ('clobber', 00:58:51 INFO - 'read-buildbot-config', 00:58:51 INFO - 'download-and-extract', 00:58:51 INFO - 'populate-webroot', 00:58:51 INFO - 'create-virtualenv', 00:58:51 INFO - 'install', 00:58:51 INFO - 'run-tests'), 00:58:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:58:51 INFO - 'download_minidump_stackwalk': True, 00:58:51 INFO - 'download_symbols': 'ondemand', 00:58:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:58:51 INFO - 'tooltool.py': '/tools/tooltool.py', 00:58:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:58:51 INFO - '/tools/misc-python/virtualenv.py')}, 00:58:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:58:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:58:51 INFO - 'installer_path': 'installer.exe', 00:58:51 INFO - 'log_level': 'info', 00:58:52 INFO - 'log_name': 'talos', 00:58:52 INFO - 'log_to_console': True, 00:58:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:58:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:58:52 INFO - 'opt_config_files': (), 00:58:52 INFO - 'pip_index': False, 00:58:52 INFO - 'sps_profile': False, 00:58:52 INFO - 'sps_profile_interval': 0, 00:58:52 INFO - 'suite': 'dromaeojs-e10s', 00:58:52 INFO - 'system_bits': '64', 00:58:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:58:52 INFO - 'title': 'talos-linux64-ix-005', 00:58:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:58:52 INFO - 'use_talos_json': True, 00:58:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:58:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:58:52 INFO - 'work_dir': 'build'} 00:58:52 INFO - ##### 00:58:52 INFO - ##### Running clobber step. 00:58:52 INFO - ##### 00:58:52 INFO - Running pre-action listener: _resource_record_pre_action 00:58:52 INFO - Running main action method: clobber 00:58:52 INFO - rmtree: /builds/slave/test/build 00:58:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:58:52 INFO - Running post-action listener: _resource_record_post_action 00:58:52 INFO - ##### 00:58:52 INFO - ##### Running read-buildbot-config step. 00:58:52 INFO - ##### 00:58:52 INFO - Running pre-action listener: _resource_record_pre_action 00:58:52 INFO - Running main action method: read_buildbot_config 00:58:52 INFO - Using buildbot properties: 00:58:52 INFO - { 00:58:52 INFO - "properties": { 00:58:52 INFO - "buildnumber": 1126, 00:58:52 INFO - "product": "firefox", 00:58:52 INFO - "script_repo_revision": "production", 00:58:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 00:58:52 INFO - "repository": "", 00:58:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs-e10s", 00:58:52 INFO - "buildid": "20151119001840", 00:58:52 INFO - "slavename": "talos-linux64-ix-005", 00:58:52 INFO - "pgo_build": "False", 00:58:52 INFO - "basedir": "/builds/slave/test", 00:58:52 INFO - "project": "", 00:58:52 INFO - "platform": "ubuntu64_hw", 00:58:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:58:52 INFO - "slavebuilddir": "test", 00:58:52 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 00:58:52 INFO - "branch": "mozilla-inbound", 00:58:52 INFO - "repo_path": "integration/mozilla-inbound", 00:58:52 INFO - "stage_platform": "linux64", 00:58:52 INFO - "builduid": "7f55421e2d2c45c0a4e6450014dd16a6", 00:58:52 INFO - "revision": "6b34afb1a471b35f9c24945eb2ae094b77952526" 00:58:52 INFO - }, 00:58:52 INFO - "sourcestamp": { 00:58:52 INFO - "repository": "", 00:58:52 INFO - "hasPatch": false, 00:58:52 INFO - "project": "", 00:58:52 INFO - "branch": "mozilla-inbound-linux64-talos", 00:58:52 INFO - "changes": [ 00:58:52 INFO - { 00:58:52 INFO - "category": null, 00:58:52 INFO - "files": [ 00:58:52 INFO - { 00:58:52 INFO - "url": null, 00:58:52 INFO - "name": "https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:58:52 INFO - } 00:58:52 INFO - ], 00:58:52 INFO - "repository": "", 00:58:52 INFO - "rev": "6b34afb1a471b35f9c24945eb2ae094b77952526", 00:58:52 INFO - "who": "lhansen@mozilla.com", 00:58:52 INFO - "when": 1447923470, 00:58:52 INFO - "number": 6681540, 00:58:52 INFO - "comments": "Bug 1214152 - early check that shell is executable. r=terrence", 00:58:52 INFO - "project": "", 00:58:52 INFO - "at": "Thu 19 Nov 2015 00:57:50", 00:58:52 INFO - "branch": "mozilla-inbound-linux64-talos", 00:58:52 INFO - "revlink": "", 00:58:52 INFO - "properties": [ 00:58:52 INFO - [ 00:58:52 INFO - "buildid", 00:58:52 INFO - "20151119001840", 00:58:52 INFO - "Change" 00:58:52 INFO - ], 00:58:52 INFO - [ 00:58:52 INFO - "builduid", 00:58:52 INFO - "7f55421e2d2c45c0a4e6450014dd16a6", 00:58:52 INFO - "Change" 00:58:52 INFO - ], 00:58:52 INFO - [ 00:58:52 INFO - "pgo_build", 00:58:52 INFO - "False", 00:58:52 INFO - "Change" 00:58:52 INFO - ] 00:58:52 INFO - ], 00:58:52 INFO - "revision": "6b34afb1a471b35f9c24945eb2ae094b77952526" 00:58:52 INFO - } 00:58:52 INFO - ], 00:58:52 INFO - "revision": "6b34afb1a471b35f9c24945eb2ae094b77952526" 00:58:52 INFO - } 00:58:52 INFO - } 00:58:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:58:52 INFO - Running post-action listener: _resource_record_post_action 00:58:52 INFO - ##### 00:58:52 INFO - ##### Running download-and-extract step. 00:58:52 INFO - ##### 00:58:52 INFO - Running pre-action listener: _resource_record_pre_action 00:58:52 INFO - Running main action method: download_and_extract 00:58:52 INFO - mkdir: /builds/slave/test/build/tests 00:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:58:52 INFO - https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:58:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/test_packages.json 00:58:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/test_packages.json 00:58:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:59:04 INFO - Downloaded 1302 bytes. 00:59:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:59:04 INFO - Using the following test package requirements: 00:59:04 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:59:04 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:59:04 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:04 INFO - u'jsshell-linux-x86_64.zip'], 00:59:04 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:59:04 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:59:04 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:59:04 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:59:04 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:59:04 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:59:04 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:59:04 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:59:04 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:04 INFO - https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:59:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:59:05 INFO - Downloaded 21322772 bytes. 00:59:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 00:59:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:59:06 INFO - Return code: 0 00:59:06 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:59: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')]} 00:59:06 INFO - https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:59:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:59:33 INFO - Downloaded 21322772 bytes. 00:59:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 00:59:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:59:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:59:34 INFO - Return code: 0 00:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:34 INFO - https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:59:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:59:56 INFO - Downloaded 11130997 bytes. 00:59:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 00:59:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:59:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 00:59:57 INFO - Return code: 0 00:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:59:57 INFO - https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:59:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:59:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:59:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:59:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:00:12 INFO - Downloaded 55775041 bytes. 01:00:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:00:12 INFO - mkdir: /builds/slave/test/properties 01:00:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:00:12 INFO - Writing to file /builds/slave/test/properties/build_url 01:00:12 INFO - Contents: 01:00:12 INFO - build_url:https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:00:12 INFO - Running post-action listener: _resource_record_post_action 01:00:12 INFO - Running post-action listener: set_extra_try_arguments 01:00:12 INFO - ##### 01:00:12 INFO - ##### Running populate-webroot step. 01:00:12 INFO - ##### 01:00:12 INFO - Running pre-action listener: _resource_record_pre_action 01:00:12 INFO - Running main action method: populate_webroot 01:00:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:00:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:00:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:00:12 INFO - '../fennec_ids.txt'], 01:00:12 INFO - 'tests': ['tcheck2']}, 01:00:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:00:12 INFO - '--tppagecycles', 01:00:12 INFO - '7'], 01:00:12 INFO - 'tests': ['tsvgm']}}, 01:00:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:00:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:00:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:00:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:00:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:00:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:00:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:12 INFO - 'talos_options': ['--e10s'], 01:00:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:00:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:12 INFO - 'tests': ['damp', 'tps']}, 01:00:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:12 INFO - 'talos_options': ['--e10s'], 01:00:12 INFO - 'tests': ['damp', 'tps']}, 01:00:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:00:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:00:12 INFO - 'other': {'tests': ['a11yr', 01:00:12 INFO - 'ts_paint', 01:00:12 INFO - 'tpaint', 01:00:12 INFO - 'sessionrestore', 01:00:12 INFO - 'sessionrestore_no_auto_restore']}, 01:00:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:00:12 INFO - 'tests': ['a11yr', 01:00:12 INFO - 'ts_paint', 01:00:12 INFO - 'tpaint', 01:00:12 INFO - 'sessionrestore', 01:00:12 INFO - 'sessionrestore_no_auto_restore']}, 01:00:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:00:12 INFO - 'tests': ['a11yr', 01:00:12 INFO - 'ts_paint', 01:00:12 INFO - 'tpaint', 01:00:12 INFO - 'sessionrestore', 01:00:12 INFO - 'sessionrestore_no_auto_restore']}, 01:00:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:00:12 INFO - 'tests': ['a11yr', 01:00:12 INFO - 'ts_paint', 01:00:12 INFO - 'tpaint', 01:00:12 INFO - 'sessionrestore', 01:00:12 INFO - 'sessionrestore_no_auto_restore']}, 01:00:12 INFO - 'other_l64': {'tests': ['a11yr', 01:00:12 INFO - 'ts_paint', 01:00:12 INFO - 'tpaint', 01:00:12 INFO - 'sessionrestore', 01:00:12 INFO - 'sessionrestore_no_auto_restore']}, 01:00:12 INFO - 'other_nol64': {'tests': ['a11yr', 01:00:12 INFO - 'ts_paint', 01:00:12 INFO - 'tpaint', 01:00:12 INFO - 'sessionrestore', 01:00:12 INFO - 'sessionrestore_no_auto_restore']}, 01:00:12 INFO - 'svgr': {'tests': ['tsvgx', 01:00:12 INFO - 'tsvgr_opacity', 01:00:12 INFO - 'tart', 01:00:12 INFO - 'tscrollx', 01:00:12 INFO - 'cart']}, 01:00:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:00:12 INFO - 'tests': ['tsvgx', 01:00:12 INFO - 'tsvgr_opacity', 01:00:12 INFO - 'tart', 01:00:12 INFO - 'tscrollx', 01:00:12 INFO - 'cart']}, 01:00:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:12 INFO - 'tests': ['tp5o']}, 01:00:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:12 INFO - 'talos_options': ['--e10s'], 01:00:12 INFO - 'tests': ['tp5o']}, 01:00:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:12 INFO - 'talos_options': ['--xperf_path', 01:00:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:12 INFO - 'tests': ['tp5n']}, 01:00:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:00:12 INFO - 'talos_options': ['--e10s', 01:00:12 INFO - '--xperf_path', 01:00:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:00:12 INFO - 'tests': ['tp5n']}}, 01:00:12 INFO - 'talos.zip': {'path': '', 01:00:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:00:12 INFO - Running post-action listener: _resource_record_post_action 01:00:12 INFO - ##### 01:00:12 INFO - ##### Running create-virtualenv step. 01:00:12 INFO - ##### 01:00:12 INFO - Running pre-action listener: _resource_record_pre_action 01:00:12 INFO - Running main action method: create_virtualenv 01:00:12 INFO - Creating virtualenv /builds/slave/test/build/venv 01:00:12 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 01:00:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:00:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:00:13 INFO - Using real prefix '/usr' 01:00:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:00:13 INFO - Installing distribute.............................................................................................................................................................................................done. 01:00:15 INFO - Installing pip.................done. 01:00:15 INFO - Return code: 0 01:00:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:15 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 0x7f124ee89c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bab70>, '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 0x250bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250c250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:00:15 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 01:00:15 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 01:00:15 INFO - Using env: {'DISPLAY': ':0', 01:00:15 INFO - 'HOME': '/home/cltbld', 01:00:15 INFO - 'LANG': 'en_US.UTF-8', 01:00:15 INFO - 'LANGUAGE': 'en_US:en', 01:00:15 INFO - 'LOGNAME': 'cltbld', 01:00:15 INFO - 'MAIL': '/var/mail/cltbld', 01:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:15 INFO - 'MOZ_NO_REMOTE': '1', 01:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:15 INFO - 'NO_EM_RESTART': '1', 01:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:15 INFO - 'PWD': '/builds/slave/test', 01:00:15 INFO - 'SHELL': '/bin/bash', 01:00:15 INFO - 'SHLVL': '1', 01:00:15 INFO - 'TERM': 'linux', 01:00:15 INFO - 'TMOUT': '86400', 01:00:15 INFO - 'USER': 'cltbld', 01:00:15 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 01:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:15 INFO - '_': '/tools/buildbot/bin/python'} 01:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:15 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 01:00:15 INFO - Cleaning up... 01:00:15 INFO - Return code: 0 01:00:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:15 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 0x7f124ee89c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bab70>, '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 0x250bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250c250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:00:15 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 01:00:15 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 01:00:15 INFO - Using env: {'DISPLAY': ':0', 01:00:15 INFO - 'HOME': '/home/cltbld', 01:00:15 INFO - 'LANG': 'en_US.UTF-8', 01:00:15 INFO - 'LANGUAGE': 'en_US:en', 01:00:15 INFO - 'LOGNAME': 'cltbld', 01:00:15 INFO - 'MAIL': '/var/mail/cltbld', 01:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:15 INFO - 'MOZ_NO_REMOTE': '1', 01:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:15 INFO - 'NO_EM_RESTART': '1', 01:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:15 INFO - 'PWD': '/builds/slave/test', 01:00:15 INFO - 'SHELL': '/bin/bash', 01:00:15 INFO - 'SHLVL': '1', 01:00:15 INFO - 'TERM': 'linux', 01:00:15 INFO - 'TMOUT': '86400', 01:00:15 INFO - 'USER': 'cltbld', 01:00:15 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 01:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:15 INFO - '_': '/tools/buildbot/bin/python'} 01:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:15 INFO - Downloading/unpacking psutil>=0.7.1 01:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:00:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:00:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:00:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:00:17 INFO - Installing collected packages: psutil 01:00:17 INFO - Running setup.py install for psutil 01:00:17 INFO - building 'psutil._psutil_linux' extension 01:00:17 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 01:00:17 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 01:00:18 INFO - building 'psutil._psutil_posix' extension 01:00:18 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 01:00:18 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 01:00:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:00:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:00:18 INFO - Successfully installed psutil 01:00:18 INFO - Cleaning up... 01:00:18 INFO - Return code: 0 01:00:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:18 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 0x7f124ee89c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bab70>, '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 0x250bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250c250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:00:18 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 01:00:18 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 01:00:18 INFO - Using env: {'DISPLAY': ':0', 01:00:18 INFO - 'HOME': '/home/cltbld', 01:00:18 INFO - 'LANG': 'en_US.UTF-8', 01:00:18 INFO - 'LANGUAGE': 'en_US:en', 01:00:18 INFO - 'LOGNAME': 'cltbld', 01:00:18 INFO - 'MAIL': '/var/mail/cltbld', 01:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:18 INFO - 'MOZ_NO_REMOTE': '1', 01:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:18 INFO - 'NO_EM_RESTART': '1', 01:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:18 INFO - 'PWD': '/builds/slave/test', 01:00:18 INFO - 'SHELL': '/bin/bash', 01:00:18 INFO - 'SHLVL': '1', 01:00:18 INFO - 'TERM': 'linux', 01:00:18 INFO - 'TMOUT': '86400', 01:00:18 INFO - 'USER': 'cltbld', 01:00:18 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 01:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:18 INFO - '_': '/tools/buildbot/bin/python'} 01:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:00:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:00:20 INFO - Installing collected packages: mozsystemmonitor 01:00:20 INFO - Running setup.py install for mozsystemmonitor 01:00:20 INFO - Successfully installed mozsystemmonitor 01:00:20 INFO - Cleaning up... 01:00:20 INFO - Return code: 0 01:00:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f124ee89c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bab70>, '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 0x250bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250c250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:00:20 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 01:00:20 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 01:00:20 INFO - Using env: {'DISPLAY': ':0', 01:00:20 INFO - 'HOME': '/home/cltbld', 01:00:20 INFO - 'LANG': 'en_US.UTF-8', 01:00:20 INFO - 'LANGUAGE': 'en_US:en', 01:00:20 INFO - 'LOGNAME': 'cltbld', 01:00:20 INFO - 'MAIL': '/var/mail/cltbld', 01:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:20 INFO - 'MOZ_NO_REMOTE': '1', 01:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:20 INFO - 'NO_EM_RESTART': '1', 01:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:20 INFO - 'PWD': '/builds/slave/test', 01:00:20 INFO - 'SHELL': '/bin/bash', 01:00:20 INFO - 'SHLVL': '1', 01:00:20 INFO - 'TERM': 'linux', 01:00:20 INFO - 'TMOUT': '86400', 01:00:20 INFO - 'USER': 'cltbld', 01:00:20 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 01:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:20 INFO - '_': '/tools/buildbot/bin/python'} 01:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:20 INFO - Downloading/unpacking blobuploader==1.2.4 01:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:22 INFO - Downloading blobuploader-1.2.4.tar.gz 01:00:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:00:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:00:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:22 INFO - Downloading docopt-0.6.1.tar.gz 01:00:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:00:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:00:22 INFO - Installing collected packages: blobuploader, requests, docopt 01:00:22 INFO - Running setup.py install for blobuploader 01:00:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:00:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:00:23 INFO - Running setup.py install for requests 01:00:23 INFO - Running setup.py install for docopt 01:00:23 INFO - Successfully installed blobuploader requests docopt 01:00:23 INFO - Cleaning up... 01:00:23 INFO - Return code: 0 01:00:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:23 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 0x7f124ee89c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bab70>, '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 0x250bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250c250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:00:23 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 01:00:23 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 01:00:23 INFO - Using env: {'DISPLAY': ':0', 01:00:23 INFO - 'HOME': '/home/cltbld', 01:00:23 INFO - 'LANG': 'en_US.UTF-8', 01:00:23 INFO - 'LANGUAGE': 'en_US:en', 01:00:23 INFO - 'LOGNAME': 'cltbld', 01:00:23 INFO - 'MAIL': '/var/mail/cltbld', 01:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:23 INFO - 'MOZ_NO_REMOTE': '1', 01:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:23 INFO - 'NO_EM_RESTART': '1', 01:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:23 INFO - 'PWD': '/builds/slave/test', 01:00:23 INFO - 'SHELL': '/bin/bash', 01:00:23 INFO - 'SHLVL': '1', 01:00:23 INFO - 'TERM': 'linux', 01:00:23 INFO - 'TMOUT': '86400', 01:00:23 INFO - 'USER': 'cltbld', 01:00:23 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 01:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:23 INFO - '_': '/tools/buildbot/bin/python'} 01:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:23 INFO - Running setup.py (path:/tmp/pip-5bgd3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:23 INFO - Running setup.py (path:/tmp/pip-Vqosn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:23 INFO - Running setup.py (path:/tmp/pip-0xmKA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:23 INFO - Running setup.py (path:/tmp/pip-LRRb9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:24 INFO - Running setup.py (path:/tmp/pip-12_Qub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:24 INFO - Running setup.py (path:/tmp/pip-k_w4lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:24 INFO - Running setup.py (path:/tmp/pip-ZAAoXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:24 INFO - Running setup.py (path:/tmp/pip-C1mfhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:24 INFO - Running setup.py (path:/tmp/pip-JCZHel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:24 INFO - Running setup.py (path:/tmp/pip-cVmr7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:24 INFO - Running setup.py (path:/tmp/pip-my0u4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:24 INFO - Running setup.py (path:/tmp/pip-wcaIcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:24 INFO - Running setup.py (path:/tmp/pip-BmxBiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:24 INFO - Running setup.py (path:/tmp/pip-OtJGT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:24 INFO - Running setup.py (path:/tmp/pip-NVL8_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:24 INFO - Running setup.py (path:/tmp/pip-NySFZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:24 INFO - Running setup.py (path:/tmp/pip-CFnFWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:00:24 INFO - Running setup.py install for manifestparser 01:00:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:00:25 INFO - Running setup.py install for mozcrash 01:00:25 INFO - Running setup.py install for mozdebug 01:00:25 INFO - Running setup.py install for mozdevice 01:00:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:00:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:00:25 INFO - Running setup.py install for mozfile 01:00:25 INFO - Running setup.py install for mozhttpd 01:00:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:00:25 INFO - Running setup.py install for mozinfo 01:00:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:00:25 INFO - Running setup.py install for mozInstall 01:00:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:00:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:00:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:00:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:00:25 INFO - Running setup.py install for mozleak 01:00:25 INFO - Running setup.py install for mozlog 01:00:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:00:26 INFO - Running setup.py install for moznetwork 01:00:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:00:26 INFO - Running setup.py install for mozprocess 01:00:26 INFO - Running setup.py install for mozprofile 01:00:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:00:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:00:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:00:26 INFO - Running setup.py install for mozrunner 01:00:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:00:26 INFO - Running setup.py install for mozscreenshot 01:00:26 INFO - Running setup.py install for moztest 01:00:26 INFO - Running setup.py install for mozversion 01:00:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:00:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:00:26 INFO - Cleaning up... 01:00:26 INFO - Return code: 0 01:00:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:26 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 0x7f124ee89c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bab70>, '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 0x250bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250c250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:00:26 INFO - Using env: {'DISPLAY': ':0', 01:00:26 INFO - 'HOME': '/home/cltbld', 01:00:26 INFO - 'LANG': 'en_US.UTF-8', 01:00:26 INFO - 'LANGUAGE': 'en_US:en', 01:00:26 INFO - 'LOGNAME': 'cltbld', 01:00:26 INFO - 'MAIL': '/var/mail/cltbld', 01:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:26 INFO - 'MOZ_NO_REMOTE': '1', 01:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:26 INFO - 'NO_EM_RESTART': '1', 01:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:26 INFO - 'PWD': '/builds/slave/test', 01:00:26 INFO - 'SHELL': '/bin/bash', 01:00:26 INFO - 'SHLVL': '1', 01:00:26 INFO - 'TERM': 'linux', 01:00:26 INFO - 'TMOUT': '86400', 01:00:26 INFO - 'USER': 'cltbld', 01:00:26 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 01:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:26 INFO - '_': '/tools/buildbot/bin/python'} 01:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:00:27 INFO - Running setup.py (path:/tmp/pip-K6sCO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:00:27 INFO - Running setup.py (path:/tmp/pip-4QQj2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:00:27 INFO - Running setup.py (path:/tmp/pip-YH2xwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:00:27 INFO - Running setup.py (path:/tmp/pip-duGyH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:00:27 INFO - Running setup.py (path:/tmp/pip-dL1cGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:00:27 INFO - Running setup.py (path:/tmp/pip-f5DyDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:00:27 INFO - Running setup.py (path:/tmp/pip-v8PHea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:00:27 INFO - Running setup.py (path:/tmp/pip-KBnHEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:00:27 INFO - Running setup.py (path:/tmp/pip-11B_eF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:00:27 INFO - Running setup.py (path:/tmp/pip-el8GKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:00:27 INFO - Running setup.py (path:/tmp/pip-4Rsfic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:00:27 INFO - Running setup.py (path:/tmp/pip-rXtpBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:00:27 INFO - Running setup.py (path:/tmp/pip-gIGG0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:00:27 INFO - Running setup.py (path:/tmp/pip-ZKeDrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:28 INFO - Running setup.py (path:/tmp/pip-MOdQo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:00:28 INFO - Running setup.py (path:/tmp/pip-KWDM2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:00:28 INFO - Running setup.py (path:/tmp/pip-hRKWl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:00:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:00:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:00:29 INFO - Downloading blessings-1.5.1.tar.gz 01:00:29 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 01:00:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:00:29 INFO - Installing collected packages: blessings 01:00:29 INFO - Running setup.py install for blessings 01:00:30 INFO - Successfully installed blessings 01:00:30 INFO - Cleaning up... 01:00:30 INFO - Return code: 0 01:00:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:30 INFO - Reading from file tmpfile_stdout 01:00:30 INFO - Current package versions: 01:00:30 INFO - argparse == 1.2.1 01:00:30 INFO - blessings == 1.5.1 01:00:30 INFO - blobuploader == 1.2.4 01:00:30 INFO - docopt == 0.6.1 01:00:30 INFO - manifestparser == 1.1 01:00:30 INFO - mozInstall == 1.12 01:00:30 INFO - mozcrash == 0.16 01:00:30 INFO - mozdebug == 0.1 01:00:30 INFO - mozdevice == 0.47 01:00:30 INFO - mozfile == 1.2 01:00:30 INFO - mozhttpd == 0.7 01:00:30 INFO - mozinfo == 0.9 01:00:30 INFO - mozleak == 0.1 01:00:30 INFO - mozlog == 3.0 01:00:30 INFO - moznetwork == 0.27 01:00:30 INFO - mozprocess == 0.22 01:00:30 INFO - mozprofile == 0.27 01:00:30 INFO - mozrunner == 6.11 01:00:30 INFO - mozscreenshot == 0.1 01:00:30 INFO - mozsystemmonitor == 0.0 01:00:30 INFO - moztest == 0.7 01:00:30 INFO - mozversion == 1.4 01:00:30 INFO - psutil == 3.1.1 01:00:30 INFO - requests == 1.2.3 01:00:30 INFO - wsgiref == 0.1.2 01:00:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:00:30 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 0x7f124ee89c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2474900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24bab70>, '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 0x250bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250c250>, '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': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:00:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:00:30 INFO - Using env: {'DISPLAY': ':0', 01:00:30 INFO - 'HOME': '/home/cltbld', 01:00:30 INFO - 'LANG': 'en_US.UTF-8', 01:00:30 INFO - 'LANGUAGE': 'en_US:en', 01:00:30 INFO - 'LOGNAME': 'cltbld', 01:00:30 INFO - 'MAIL': '/var/mail/cltbld', 01:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:30 INFO - 'MOZ_NO_REMOTE': '1', 01:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:30 INFO - 'NO_EM_RESTART': '1', 01:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:30 INFO - 'PWD': '/builds/slave/test', 01:00:30 INFO - 'SHELL': '/bin/bash', 01:00:30 INFO - 'SHLVL': '1', 01:00:30 INFO - 'TERM': 'linux', 01:00:30 INFO - 'TMOUT': '86400', 01:00:30 INFO - 'USER': 'cltbld', 01:00:30 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 01:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:30 INFO - '_': '/tools/buildbot/bin/python'} 01:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:00:30 INFO - Cleaning up... 01:00:30 INFO - Return code: 0 01:00:30 INFO - Running post-action listener: _resource_record_post_action 01:00:30 INFO - Running post-action listener: _start_resource_monitoring 01:00:30 INFO - Starting resource monitoring. 01:00:30 INFO - ##### 01:00:30 INFO - ##### Running install step. 01:00:30 INFO - ##### 01:00:30 INFO - Running pre-action listener: _resource_record_pre_action 01:00:30 INFO - Running main action method: install 01:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:00:30 INFO - Reading from file tmpfile_stdout 01:00:30 INFO - Detecting whether we're running mozinstall >=1.0... 01:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:00:30 INFO - Reading from file tmpfile_stdout 01:00:30 INFO - Output received: 01:00:30 INFO - Usage: mozinstall [options] installer 01:00:30 INFO - Options: 01:00:30 INFO - -h, --help show this help message and exit 01:00:30 INFO - -d DEST, --destination=DEST 01:00:30 INFO - Directory to install application into. [default: 01:00:30 INFO - "/builds/slave/test"] 01:00:30 INFO - --app=APP Application being installed. [default: firefox] 01:00:30 INFO - mkdir: /builds/slave/test/build/application 01:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:00:44 INFO - Reading from file tmpfile_stdout 01:00:44 INFO - Output received: 01:00:44 INFO - /builds/slave/test/build/application/firefox/firefox 01:00:44 INFO - Running post-action listener: _resource_record_post_action 01:00:44 INFO - ##### 01:00:44 INFO - ##### Running run-tests step. 01:00:44 INFO - ##### 01:00:44 INFO - Running pre-action listener: _resource_record_pre_action 01:00:44 INFO - Running main action method: run_tests 01:00:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:00:44 INFO - Python 2.7.3 01:00:44 INFO - Return code: 0 01:00:44 INFO - grabbing minidump binary from tooltool 01:00: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')]} 01:00:44 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 0x24bab70>, '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 0x250bdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x250c250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:00:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:00:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:00:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:00:45 INFO - Return code: 0 01:00:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:00:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:00:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:00:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:00:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:00:45 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/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost'] in /builds/slave/test/build 01:00:45 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/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost 01:00:45 INFO - Using env: {'DISPLAY': ':0', 01:00:45 INFO - 'HOME': '/home/cltbld', 01:00:45 INFO - 'LANG': 'en_US.UTF-8', 01:00:45 INFO - 'LANGUAGE': 'en_US:en', 01:00:45 INFO - 'LOGNAME': 'cltbld', 01:00:45 INFO - 'MAIL': '/var/mail/cltbld', 01:00:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:00:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:00:45 INFO - 'MOZ_NO_REMOTE': '1', 01:00:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:00:45 INFO - 'NO_EM_RESTART': '1', 01:00:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:00:45 INFO - 'PWD': '/builds/slave/test', 01:00:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:00:45 INFO - 'SHELL': '/bin/bash', 01:00:45 INFO - 'SHLVL': '1', 01:00:45 INFO - 'TERM': 'linux', 01:00:45 INFO - 'TMOUT': '86400', 01:00:45 INFO - 'USER': 'cltbld', 01:00:45 INFO - 'XDG_SESSION_COOKIE': 'cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056', 01:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:00:45 INFO - '_': '/tools/buildbot/bin/python'} 01:00:45 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/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost'] with output_timeout 3600 01:00:45 INFO - mozversion INFO | application_buildid: 20151119001840 01:00:45 INFO - mozversion INFO | application_changeset: 6b34afb1a471b35f9c24945eb2ae094b77952526 01:00:45 INFO - mozversion INFO | application_display_name: Nightly 01:00:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:00:45 INFO - mozversion INFO | application_name: Firefox 01:00:45 INFO - mozversion INFO | application_remotingname: firefox 01:00:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:00:45 INFO - mozversion INFO | application_vendor: Mozilla 01:00:45 INFO - mozversion INFO | application_version: 45.0a1 01:00:45 INFO - mozversion INFO | platform_buildid: 20151119001840 01:00:45 INFO - mozversion INFO | platform_changeset: 6b34afb1a471b35f9c24945eb2ae094b77952526 01:00:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:00:45 INFO - mozversion INFO | platform_version: 45.0a1 01:00:45 INFO - 2015-11-19 01:00:45,243 DEBUG : using testdate: 1447923645 01:00:45 INFO - 2015-11-19 01:00:45,243 DEBUG : actual date: 1447923645 01:00:45 INFO - 2015-11-19 01:00:45,257 INFO : starting webserver on 'localhost:55859' 01:00:45 INFO - 2015-11-19 01:00:45,258 INFO : Starting test suite talos-linux64-ix-005.e 01:00:45 INFO - 2015-11-19 01:00:45,258 INFO : Starting test dromaeo_css 01:00:45 INFO - 2015-11-19 01:00:45,259 DEBUG : operating with platform_type : linux_ 01:00:45 INFO - 2015-11-19 01:00:45,259 INFO : Initialising browser for dromaeo_css test... 01:00:45 INFO - 2015-11-19 01:00:45,276 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK73yr0/profile http://localhost:55859/getInfo.html 01:00:49 INFO - 2015-11-19 01:00:49,600 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:00:49 INFO - 2015-11-19 01:00:49,600 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:00:49 INFO - 2015-11-19 01:00:49,600 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:00:49 INFO - 2015-11-19 01:00:49,600 DEBUG : BROWSER_OUTPUT: __metrics 01:00:50 INFO - 2015-11-19 01:00:50,625 INFO : Browser initialized. 01:00:50 INFO - 2015-11-19 01:00:50,626 INFO : Running cycle 1/1 for dromaeo_css test... 01:00:50 INFO - 2015-11-19 01:00:50,626 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK73yr0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:01:02 INFO - 2015-11-19 01:01:02,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 141410304 01:01:02 INFO - 2015-11-19 01:01:02,583 DEBUG : BROWSER_OUTPUT: 01:01:52 INFO - 2015-11-19 01:01:52,224 DEBUG : BROWSER_OUTPUT: 1447923712222 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:04:03 INFO - 2015-11-19 01:04:03,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55859/tests/dromaeo/cssquery-ext.html) 01:04:05 INFO - 2015-11-19 01:04:05,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 143822848 01:04:05 INFO - 2015-11-19 01:04:05,017 DEBUG : BROWSER_OUTPUT: 01:07:07 INFO - 2015-11-19 01:07:07,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/dromaeo/cssquery-ext.html (next: http://localhost:55859/tests/dromaeo/cssquery-jquery.html) 01:07:07 INFO - 2015-11-19 01:07:07,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 141983744 01:07:07 INFO - 2015-11-19 01:07:07,674 DEBUG : BROWSER_OUTPUT: 01:10:09 INFO - 2015-11-19 01:10:09,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55859/tests/dromaeo/cssquery-mootools.html) 01:10:10 INFO - 2015-11-19 01:10:10,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 142282752 01:10:10 INFO - 2015-11-19 01:10:10,033 DEBUG : BROWSER_OUTPUT: 01:13:11 INFO - 2015-11-19 01:13:11,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55859/tests/dromaeo/cssquery-prototype.html) 01:13:12 INFO - 2015-11-19 01:13:12,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 141004800 01:13:12 INFO - 2015-11-19 01:13:12,389 DEBUG : BROWSER_OUTPUT: 01:16:14 INFO - 2015-11-19 01:16:14,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55859/tests/dromaeo/cssquery-yui.html) 01:16:15 INFO - 2015-11-19 01:16:15,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 141848576 01:16:15 INFO - 2015-11-19 01:16:15,488 DEBUG : BROWSER_OUTPUT: 01:19:17 INFO - 2015-11-19 01:19:17,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/dromaeo/cssquery-yui.html (next: http://localhost:55859/tests/dromaeo/cssquery-dojo.html) 01:19:18 INFO - 2015-11-19 01:19:18,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 144584704 01:19:18 INFO - 2015-11-19 01:19:18,197 DEBUG : BROWSER_OUTPUT: 01:19:18 INFO - 2015-11-19 01:19:18,197 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:19:18 INFO - 2015-11-19 01:19:18,197 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:19:18 INFO - 2015-11-19 01:19:18,197 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:19:18 INFO - 2015-11-19 01:19:18,197 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:19:18 INFO - 2015-11-19 01:19:18,201 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2667.173176315342;2697.4874773792967;2741.9725802741978;2755.035737491878;2755.4351357971605;4636.51316611756;4792.9041419171635;4804.159272127376;4824.083424149414;4834.299026641143;4741.312509686093;4771;4778.020505796312;4779.832705855296;4783.665143439961;4302.935455968163;4356.128774245164;4363.498197707273;4457.91084178317;4517.254652982254;418.3680757651971;4502.842400515982;4511.684182107254;4533.523979982087;4534.546545345472;4396.120775844828;4416.646668266531;4485.080558485535;4489.2592722201125;4533.229351010336;4470.9105817883465;4484.282514797616;4484.910301793979;4494.07871386365;4531;4220.556841531657;4443.888902777424;4447.822087116511;4461.24158892989;4485.506594274627;4603.884902877421;4623.8150473981;4651.88370290742;4685.976570117162;4698.600618947394;5180.456052114511;5218.347706536683;5221.086309895753;5224.373075230997;5226.947730522722;4974.204127339608;5067.695938243717;5213.661112027706;5244.475552444763;5245.291885595434;4656.790444429975;4673.088747694235;4679.017406344706;4715.151272770934;4754.643401744848;5211.1662134059125;5239.607029472805;5248.3701955765555;5250.317458730341;5255.211718242218;4896.265560165933;4977.352944117241;5017.9247311290355;5039.143345631252;5078;5160.535551800281;5176.068307704574;5177.197534382177;5180.922286165711;5230.320058392384;5111.642185047085;5124.7950081996305;5143.048536020848;5144.279800827887;5173.0688476074665;4894.975525122351;4981.053599816023;5004.4995500450395;5104.642675012788;5122.359705036871;4245.1085272093205;4246.4691913510815;4270.12462445198;4283.20760659279;4304.332828411601;3720.776753394805;3722.571904230994;3734.7198960078103;3748.793816340073;3758.567764707039;4252.659787217015;4432.534583868712;4436.423264975532;4436.578525040116;4490.57339552742;5082.822101226439;5138.527468246306;5159.226116082543;5160.458151894072;5197.818076367309;4476.127155204704;4510.639148868083;4513.097380523843;4528.184926713223;4549.567791059844;4333.8699839004885;4447.08834688888;4456.955430445654;4566.109608626286;4616.561426664462;4764.404449443819;4824.228123500293;4834.492378300228;4864.562189402829;4876.609871210366;5118.8976220476125;5155.381354237516;5167.870803229949;5171.689698618095;5227.294315267391;4669.48635650085;4799.208130658402;4867.026594681007;4896.314515967696;4918.680285781413;4902.166631672696;5054.2671312660195;5062.696238225718;5076.984603079325;5103.92344114846;5139.640225184351;5160.380754309357;5160.638755287094;5187.014467251211;5211.687298762086;4800.3759511263315;4920.434150072644;4924.679895806761;4990.226514890198;5011.498850114959;5000.449950505369;5021.573166280907;5023.2214006829;5038.949610503848;5040.84877453677;4900.975495122501;4926.704397736147;4943.456219815889;4945.455999839943;4968.776405061709;4878.804847806048;4949.331840201527;4961.404631444249;5025.974870125626;5119.129747942784;4917.655764096622;4925.876853078558;4936.950630493649;4944.3572335596145;4980.651354405301 01:19:18 INFO - 2015-11-19 01:19:18,201 DEBUG : BROWSER_OUTPUT: |1;ext.html;535.5795700375205;537.094994933537;554.7808615596842;570.1049352516549;571.7712914834066;36843.263134737324;37702.81148594257;37709.81145094274;37718.24563508728;37884.43173352402;40278.79860600693;40737.38893916586;40758.59241407585;40763.18473630526;40814.18371632566;7939.285464308211;8081.515109093444;8085.676572937075;8086.595670216495;8103.797405064891;7928.365730741556;8006.239407256301;8009.639566219534;8010.198980101973;8010.799730006738;7958.761237162895;7966.800829979239;8043.638036288381;8048.637811298506;8081.2322829331415;7908.762737117896;8010;8021.759347219593;8099.55452450115;8109.675612975474;7849.254320839568;7983.441159118864;8015.47899386538;8046.155153708834;8056.637451314647;37792.24415511702;38558.80720596407;38703.612963870284;38709;38733.806330968444;3061.280599059219;3077.5537547055774;3390.2033022239752;3449.862005519801;3799.772013679188;28563.85718071417;29174.076514209475;29216.26959326034;29299;29924.85037574798;3100.829454380008;3127.53087036944;3145.9528107078413;3152.6374466936136;3232.4828027515487;222221;222863;223511;224124;224289;38419.61580384216;38717.806410967765;55792.44207557872;56131;56146.71926640341;37237.2072094594;37252.813735931144;37435.62564374322;37504.62495375066;37735;12863.935680321538;13086.934565327303;13098.2141071536;13114.934425327812;13143.277119758313;10247.795044099077;10367.874585709911;10374.066334029974;10391.792164156826;10407.5836966522;13049.28228947398;13463.52877649297;13536.05247632676;13539.781419672277;13611.11527750693;5422.972885135628;5467.58993075513;5491.121420572689;5523.143912693539;5551.3893471718075;841.3984001439001;875.7241468937265;894.8031433084711;896.3994123936978;1011.7622358745689;26361.209163725118;26467.205983820517;30265;31073.68926310708;32105.51841722376;966.1015255812163;982.2240430060173;1029.5933106422922;1124.1175677093606;1135.2734250079955;13800.447982080605;14248.145111293356;14334.641633959234;15479.303431345392;16226.756598651029;339265;345606;345717;345881;346027;48764.51235487671;49320.50679493159;49321.753391233535;49362.259566106535;49472.75263623659;1148.4831825678311;1178.7701398227434;1185.4369174641977;1194.4505527457293;1209.12338554549;27797.51332149162;27847.443051139267;28354.85822570874;28422.57366139551;28736.71263287424;39010.6098939007;39294;39358.40962385509;39390;39502.40746388749;257196;258990;260171;260343;260579;29386.265343366587;29594;30041.399172016874;30094.84952575223;30113.69886301109;39469.80265098656;40123;40159.3976090353;40300.596994029685;40518;33830;33941.60220609495;34613;34795.30409391849;35063.47404788879;33833.83083084569;34264.828675856465;34532.482012769324;34568.82715586406;34597.30805383928;38671.22657546889;38742.22515549617;39198.804005979786;39445.80277098596;39594;30704.385912282076;30990.535141972436;31046.68953310438;31364;31505.52741708922;24042.87978560166;24320.270391888273;24544.263672089866;24727.50544989054;24777.87611061933 01:19:18 INFO - 2015-11-19 01:19:18,204 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.9384063948168;344.96722811332916;346.9677708816272;348.53644652612024;349.4897449723403;12579.559715409963;13104;14990.700185996273;15377.308021139048;17460.03969781663;15084.6983060339;15210.543683689479;15430.922845385785;15566.610834729137;15575.92212038941;4965.7020578765205;4974.7015179089185;5039.622028347871;5073.898522029557;5076.619253555979;4548.363229147905;4661.044485880403;4671.626269898417;4683.48481667018;4973.726445045521;4462.286034234523;4578.130155270488;4596.264597664374;4617.515160908107;4742.4309082910095;4708.176069187895;4757.64317676174;4758.690685105475;4770.236762118045;4784.162771515006;4115.73247738896;4119.588041195886;4127.050778321003;4127.690423218271;4186.790660466995;12463.314517701523;12464.750704985849;12981.675458113528;13013.804792928113;13019.804702929463;1744.310997156129;1746.1705689797373;1761.8150094240048;1801.7837859456818;1824.4617837737899;9508.381955172892;9553.761155971088;9698.466584337859;9752.21982241419;9755.658551950648;1603.3185895994272;1624.236608793865;1628.2184551415387;1650.4058538925976;1655.1558705060386;50228;51146.232806507935;51258.7437062816;51719.99999999962;52164.21753673698;6544.901826472606;6591.901121483182;6697;6710.698018589175;6725.730970761115;7761.340286075634;7821.1396746359;7822;7862.685492580233;7884.4086693497065;5147.510986456281;5157.484251574812;5173.974130129325;5175.767090480862;5192.9740351298005;4954.900901982012;4985;5056.974715126401;5224.373075230997;5244.921326180111;3026.1829306087234;3032.120685001369;3094.6131733533307;3115.1589070950718;3122.6252849658185;1091.2688498705727;1096.7937957931263;1097.6871591596516;1101.9889801102047;1135.9772804544027;404.3611094470729;406.24235800232356;430.6167510915288;447.84773177119285;457.7985686298018;9520.904790952001;9687.32188746781;9952.303338766362;9956.651517196864;10167;420.7454490033547;421.15978622648015;430.1053808079188;433.3845938766959;437.19556016929005;4270.48754149504;5512.91730624041;5574.163875418639;5575.804846830422;5582.553395728332;312417;313589;313596;313726;316849;56104;60023;60374.69812650997;66877;67078.32921670818;507.0416912036254;513.5711680746543;516.2746341390277;518.1243698150114;522.1984254169907;9968.451735154636;10516.316439431412;10592.364458132537;10634.09610183143;10637.308574942605;29263.7073629261;29495.557566636948;29647.703522964493;30207.69792302049;30897.691023089483;35462;36923;37021;38019.23961520809;38956.80521597374;6182.598131121463;6450.41946224842;6465.903011454926;6467.644279564669;6504.284528701744;10823.296485728402;11299.887001129884;11422.885771142182;11491.023263022737;11824.46789894474;9721.513924303616;9833.901660983298;9900.504974751379;10076.244281678757;10232.079112879877;9810.75473113178;9959.103680668775;10099.798004040025;10100.696979090639;10102.242331824995;10284.434356110485;10319.587216511256;10326.328788628714;10360.119389851947;10376.533056012346;6343.777967771106;6397.488200943821;6488.091667166506;6490.740370385321;6493.090967264492;10450;10451.477426128511;10474.581016759244;10625.149988000787;10657.733556661145 01:19:18 INFO - 2015-11-19 01:19:18,206 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1482.4959513765332;1686.8060173080096;1715.9656806863863;1723.3881971899975;1725.3788636091012;7211.819704507383;7408.296211859878;7476.775696729093;7507.699692012313;7532.661030253638;7511.586862722548;7559.546427214357;7606.277403646659;7608.277213664693;7626.19924907885;1940.6215787921396;1969.1532640964379;1975.4764987278384;1975.6345076160885;1983.186893373717;2119.109973811003;2136.0174319812904;2145.710329105574;2180.716506854115;2181.149351752818;1888.9244430222843;1913.1868955693774;1921.8750781199246;2094.2984100326407;2118.3115487466634;2090.550531635698;2116.9788302117013;2117.76704562498;2117.798809113132;2122.872627642331;2091.6862470629376;2140.4327853118934;2144.0994782191515;2154.8060674539365;2160.211522794169;7304.707811687526;7376.7786966391095;7399.889001664979;7422.2577742225885;7467.141278752904;4296.763677997709;4333.978330108329;4396.1427521633295;4398.318260669601;4400.911981760379;2882.3082460209607;2893.8263704177816;2941.0588611644284;2941.5293553031624;2943;840.6175190288404;892.9776755581097;898.2006014646969;1771.5925337172393;1795.5690634247687;9779.657711980046;9841.50792460374;9868.555914983843;9901.801963960752;9970.90029099707;3744.6817020553012;3771.0949372150485;3816.694664426839;3819.4079917612817;3923.843046278117;7503.437242206747;7556.65995030225;7566.167721550625;7566.886496702554;7576.7348142814735;4231.534531201565;4240.830366785356;4245.12974840157;4247.51153617338;4265.296226122655;3910.4720862683744;3910.530736311661;3915.256101340736;3923.5291764988383;3933.901652458654;3199.2961548459302;3210.502372132323;3217.6621454746914;3229.3864165808423;3259.6088469383353;958.0898146760605;964.3442459127721;967.4437198610827;978.4520668425704;984.0651381187901;697.5988806436319;763.0957315581054;775.5889378629336;808.0303635637259;855.4995327733221;6680.5991640501725;6736.1916570010935;6745.190577130677;6746.797596072126;6750.35871592198;626.0765371077715;635.1489004733587;638.8370965403792;650.4796163069525;770.2567022822891;5042.596592272609;5084.33903592538;5086.796528138833;5123.129068058439;5124.871878203;8621.741347759576;8704.78238044054;8776.912230877737;8799;8965.50689712072;8724.389292749447;8737.694180703646;8745.693900713444;8818.33862460318;8825.161609647073;6840.452763778985;6936.0636314096955;7006.894896576556;7010.894836577456;7052.259512751088;6304.243490781136;6384.680765961776;6399.072134540373;6407.8718425630295;6432.517561182836;7404.777856664308;7742.845143097219;7758.7672369829;7768.378529717722;7819.139894611474;7885.842283154419;7925.207479252029;8050.194980502137;8134.145914678874;8205.79485512867;6698.866022679616;6721.529492935448;6724.260331363448;6751.088603038527;6753.3246675332075;6627.867442651216;6631.237407697983;6644.60132392058;6659.300773418721;6695.665216739241;6436.0989461476365;6558.376954189344;6604.3725846044545;6628.072069910313;6703.028060931235;5730.111832665943;6268.373162683695;6313.05304204373;6336.144620476177;6359.8092057238355;6372.872542549216;6373.521985850987;6393.680315984089;6410.711517981609;6421.839454013687;5938.940610593839;5998.25021872266;6022.36765139654;6037.728302226498;6046.879062418639;6078.54410919174;6120.54095942815;6120.816375508742;6120.908186377297;6121.418465245794 01:19:18 INFO - 2015-11-19 01:19:18,206 DEBUG : BROWSER_OUTPUT: |4;prototype.html;318.3457993822693;319.4951975878113;325.82405501029444;326.2073162215816;328.579418344519;5507.862303442411;5568.972155139229;5599.35607405148;5608.186812912125;5650.152477128433;5505.614606977513;5558.610897237195;5561.388247292794;5572.86067848304;5574.916376254349;4158.5009798824185;4278.828846846122;4287.678424118188;4294.935575966363;4301.032267739764;4239.215745087154;4249.936250956238;4252.893677658052;4258.701890867641;4267.679924005696;4226.239276930151;4235.470566179228;4239.512456067561;4239.512456067561;4243.809028593705;4227.070044590185;4230.957690423103;4232.640225580829;4233.640140588053;4247.745135291892;3696.7781933083834;3707.9988403131274;3708.0915175782106;3709.647583479592;3711.888643340704;5221.634485586011;5340.519353258225;5341.813036543703;5343.118385466432;5350.812721554766;4833.2266837306215;4855.538723821267;4871.050145221683;4872.8538143855385;4874.098291816025;5836.212111364996;5852.707364631794;5860.648361098348;5862.20860183874;5863.091220860773;3922.980385098056;4013.2174226025936;4016.357382818764;4016.6184212499766;4018.1160144768105;6051.788187413464;6169.845753856144;6175.7529698811995;6175.783847565313;6178.320384757673;4080.265552200573;4087.3868919662286;4090.406891000788;4094.303968325392;4110.0752330725345;4155.1897380010605;4159.022629682022;4161.542230354658;4169.187008533368;4169.2703776838935;4799.28010798383;4808.134535783593;4810.687305325143;4812;4820.903581928342;5633.521150702236;5858.414158584107;5862.824115276549;5865.35481097079;5865.73604187804;1474.4102359056249;1506.7363211437955;1507.3518387093654;1508.0499285450096;1510.358097808427;988.2686811759246;992.692265397729;994.7314225159312;1001.9949900250452;1020.1685626214611;5134.409542902614;5156.535911767884;5162.5611822994715;5180.844574662766;5181.948180518222;5931.656995486758;6054.364291749391;6135.662538560333;6146.262448506208;6155.784547540815;5155.74221288934;5173.198154286091;5173.948260517422;5185.481451854785;5205.687658740488;3254.2677897473354;3297.5713157289397;3314.6022477302877;3317.8506967186536;3320.4853247746155;5579.079451890392;5734.741936612862;5757.827265182052;5767.394423585547;5784.305883293948;6266.216722909637;6295.96852015737;6309.274433440213;6318.241810982711;6330.746770129235;5756.280464941966;5762.394948530427;5765.376753577112;5773.797917072882;5794.855128621818;5964.880702385841;6090;6133.938660613337;6135.754569817157;6145.66198859067;6005.129256257906;6008.5493587981955;6010.188624535632;6013.6692481913915;6013.759449622141;5754.309482862083;5757.942420575908;5764.654120752768;5775.047117225611;5790.594658373873;4158.812853421543;4198.412222288943;4202.117555313418;4203.76879271643;4212.073343864345;5972.34304226526;6148.16999705052;6155.415235552616;6160.045192995093;6161.784337548164;5913.6747478887355;5918.822435326947;5924.4667979882015;5926.7925622603;5929.762809487572;5877.441643043904;5900.055991041413;5933.495652869382;5935.703214839327;5937.020391635332;5602.52378547828;5738.856528586819;5771;5776.942230577809;5777.768889244383;5933.389308704156;5934.258217722785;5954.940450595612;5974;5978.312494063239;5624.465675760796;5798.884022319615;5800.651960882361;5809.2738407699035;5816.127580862735 01:19:18 INFO - 2015-11-19 01:19:18,207 DEBUG : BROWSER_OUTPUT: |5;yui.html;621.8569728962341;630.4357599948047;691.5332150798216;736.4439847914826;771.1286246541409;11130.944345278273;11250.66248012561;11307.434628268595;11327.943360283207;11380.601678941239;12578.308193049379;12815.102942793985;12816.23102613844;12831.42258598363;12835.614931552045;605.3885575568663;607.9300880398766;763.9159692433827;780.4848799792138;782.5500337306072;754.2645920227789;768.170375993928;773.3812949640266;773.4817672159638;774.4965772248028;794.8291117409756;803.7508372404544;805.9838803223961;805.995970020152;806.330745481252;798.0343784021342;802.6468353924255;804.3364224514798;805.0781854776307;807.858624740668;584.7865529081897;587.5622661117452;591.3967752892027;592.5318997991582;593.9287285525721;11698.47356868943;11723.824142637868;11757;11795.764084718343;11801.940990294994;9273.258139348904;9526.380785249006;9688.660896868576;9972.351797133164;9972.650957216463;8945.507997060158;9068.138526839939;9305.860412093823;9698.51507424626;10418.426986515738;2785.5960885671466;2829.6038554602374;2851.6435445569305;2882.8126171798767;2927.238917881345;35459.29081418383;35496.64503354985;35734.285314293826;36277.274454511025;36311.4553281701;6601.438877695449;6989.580625162506;7030.894536581955;7043.36609705129;7057.541259818198;10969.177311701655;11064.778704425866;11074.889251107386;11077.72305692348;11100.333979961066;5351.411344752074;5455.1544510600925;5486.451354864562;5568.9443105568425;5707.286589176353;3434.9828250858586;3507.473878918183;3514.086337552255;3529.2764983178386;3566.8038257896064;2435.1233555919853;2473.7773600376054;2477.764612361823;2482.1808803094937;2486.788622967068;384.34085543293384;386.6906474820189;388.93388124018986;396.23526593674484;396.2431755347273;429.2573847244285;451.4853067503049;458.7522737721593;471.73347058911605;513.2327170879558;7784.571848548271;7936.960315198503;7972.920270797334;8017.759467215993;8122.268995790408;535.7749745107064;536.1207619504016;539.7450926595602;557.4648337595872;578.0375674501992;3614.801185934746;3736.75711078779;3800.467934489174;3868.129670824042;3898.8830335089992;51752.74123629358;54397.72801136048;55538.72230638821;55755.721221394444;55818.44181558213;45298.54701453009;46260.53739462562;46438.30342544865;46489.767551162025;46824;42722.14555708931;42843.35734963978;42844.57155428468;42869.356104730825;43840.561594383646;7748.612569371621;7756.806079848049;7785.766427007199;7988.480748751313;8133.552654604054;33365.16587085342;33685.83157084199;34164.31671366509;34339.4849077269;34449.138771529906;40113.799431002655;42196.36705449482;42516.57483425126;43348;43504;7058.61177635235;7205.315495027964;7298.854022919406;7325.963370183115;7333.945819779917;11065.004149626573;11276.492557834754;11384.089272857986;11517.769644606893;11720.70698232551;10323.741906452398;10400.167986561208;10583.153347732008;10868.184886133413;10938.398388088732;10130.898691012995;10299.433531155859;10616.150707943192;10632;10651.946740266249;10537.73655658584;10869.858664840394;10949.726256843323;10998.230123891251;11080.390578517936;9305.395149315273;9547.33168678186;9560.665376711782;9756.658516951873;9940;8975.910240897769;9122.315826313186;9149.908500914906;9190.632374705205;9192.678256261266 01:19:18 INFO - 2015-11-19 01:19:18,207 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:19:18 INFO - 2015-11-19 01:19:18,207 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:19:18 INFO - 2015-11-19 01:19:18,207 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,295 01:19:18 INFO - 2015-11-19 01:19:18,207 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:19:18 INFO - 2015-11-19 01:19:18,208 DEBUG : BROWSER_OUTPUT: __startTimestamp1447924758195__endTimestamp 01:19:18 INFO - 2015-11-19 01:19:18,208 DEBUG : BROWSER_OUTPUT: 01:19:18 INFO - 2015-11-19 01:19:18,208 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:19:18 INFO - 2015-11-19 01:19:18,208 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:19:18 INFO - 2015-11-19 01:19:18,208 DEBUG : BROWSER_OUTPUT: 01:19:18 INFO - 2015-11-19 01:19:18,208 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4711.16 Median:4867.03 stddev:599.47 (12.3%) stddev-sans-first:579.46 01:19:18 INFO - 2015-11-19 01:19:18,208 DEBUG : BROWSER_OUTPUT: Values: 2667.2 2697.5 2742.0 2755.0 2755.4 4636.5 4792.9 4804.2 4824.1 4834.3 4741.3 4771.0 4778.0 4779.8 4783.7 4302.9 4356.1 4363.5 4457.9 4517.3 418.4 4502.8 4511.7 4533.5 4534.5 4396.1 4416.6 4485.1 4489.3 4533.2 4470.9 4484.3 4484.9 4494.1 4531.0 4220.6 4443.9 4447.8 4461.2 4485.5 4603.9 4623.8 4651.9 4686.0 4698.6 5180.5 5218.3 5221.1 5224.4 5226.9 4974.2 5067.7 5213.7 5244.5 5245.3 4656.8 4673.1 4679.0 4715.2 4754.6 5211.2 5239.6 5248.4 5250.3 5255.2 4896.3 4977.4 5017.9 5039.1 5078.0 5160.5 5176.1 5177.2 5180.9 5230.3 5111.6 5124.8 5143.0 5144.3 5173.1 4895.0 4981.1 5004.5 5104.6 5122.4 4245.1 4246.5 4270.1 4283.2 4304.3 3720.8 3722.6 3734.7 3748.8 3758.6 4252.7 4432.5 4436.4 4436.6 4490.6 5082.8 5138.5 5159.2 5160.5 5197.8 4476.1 4510.6 4513.1 4528.2 4549.6 4333.9 4447.1 4457.0 4566.1 4616.6 4764.4 4824.2 4834.5 4864.6 4876.6 5118.9 5155.4 5167.9 5171.7 5227.3 4669.5 4799.2 4867.0 4896.3 4918.7 4902.2 5054.3 5062.7 5077.0 5103.9 5139.6 5160.4 5160.6 5187.0 5211.7 4800.4 4920.4 4924.7 4990.2 5011.5 5000.4 5021.6 5023.2 5038.9 5040.8 4901.0 4926.7 4943.5 4945.5 4968.8 4878.8 4949.3 4961.4 5026.0 5119.1 4917.7 4925.9 4937.0 4944.4 4980.7 01:19:18 INFO - 2015-11-19 01:19:18,208 DEBUG : BROWSER_OUTPUT: 01:19:18 INFO - 2015-11-19 01:19:18,209 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42967.07 Median:34704.15 stddev:73497.45 (211.8%) stddev-sans-first:73634.58 01:19:18 INFO - 2015-11-19 01:19:18,210 DEBUG : BROWSER_OUTPUT: Values: 535.6 537.1 554.8 570.1 571.8 36843.3 37702.8 37709.8 37718.2 37884.4 40278.8 40737.4 40758.6 40763.2 40814.2 7939.3 8081.5 8085.7 8086.6 8103.8 7928.4 8006.2 8009.6 8010.2 8010.8 7958.8 7966.8 8043.6 8048.6 8081.2 7908.8 8010.0 8021.8 8099.6 8109.7 7849.3 7983.4 8015.5 8046.2 8056.6 37792.2 38558.8 38703.6 38709.0 38733.8 3061.3 3077.6 3390.2 3449.9 3799.8 28563.9 29174.1 29216.3 29299.0 29924.9 3100.8 3127.5 3146.0 3152.6 3232.5 222221.0 222863.0 223511.0 224124.0 224289.0 38419.6 38717.8 55792.4 56131.0 56146.7 37237.2 37252.8 37435.6 37504.6 37735.0 12863.9 13086.9 13098.2 13114.9 13143.3 10247.8 10367.9 10374.1 10391.8 10407.6 13049.3 13463.5 13536.1 13539.8 13611.1 5423.0 5467.6 5491.1 5523.1 5551.4 841.4 875.7 894.8 896.4 1011.8 26361.2 26467.2 30265.0 31073.7 32105.5 966.1 982.2 1029.6 1124.1 1135.3 13800.4 14248.1 14334.6 15479.3 16226.8 339265.0 345606.0 345717.0 345881.0 346027.0 48764.5 49320.5 49321.8 49362.3 49472.8 1148.5 1178.8 1185.4 1194.5 1209.1 27797.5 27847.4 28354.9 28422.6 28736.7 39010.6 39294.0 39358.4 39390.0 39502.4 257196.0 258990.0 260171.0 260343.0 260579.0 29386.3 29594.0 30041.4 30094.8 30113.7 39469.8 40123.0 40159.4 40300.6 40518.0 33830.0 33941.6 34613.0 34795.3 35063.5 33833.8 34264.8 34532.5 34568.8 34597.3 38671.2 38742.2 39198.8 39445.8 39594.0 30704.4 30990.5 31046.7 31364.0 31505.5 24042.9 24320.3 24544.3 24727.5 24777.9 01:19:18 INFO - 2015-11-19 01:19:18,210 DEBUG : BROWSER_OUTPUT: 01:19:18 INFO - 2015-11-19 01:19:18,210 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:19308.31 Median:430.36 stddev:51743.73 (12023.3%) stddev-sans-first:51869.27 01:19:18 INFO - 2015-11-19 01:19:18,212 DEBUG : BROWSER_OUTPUT: Values: 332.9 345.0 347.0 348.5 349.5 12579.6 13104.0 14990.7 15377.3 17460.0 15084.7 15210.5 15430.9 15566.6 15575.9 4965.7 4974.7 5039.6 5073.9 5076.6 4548.4 4661.0 4671.6 4683.5 4973.7 4462.3 4578.1 4596.3 4617.5 4742.4 4708.2 4757.6 4758.7 4770.2 4784.2 4115.7 4119.6 4127.1 4127.7 4186.8 12463.3 12464.8 12981.7 13013.8 13019.8 1744.3 1746.2 1761.8 1801.8 1824.5 9508.4 9553.8 9698.5 9752.2 9755.7 1603.3 1624.2 1628.2 1650.4 1655.2 50228.0 51146.2 51258.7 51720.0 52164.2 6544.9 6591.9 6697.0 6710.7 6725.7 7761.3 7821.1 7822.0 7862.7 7884.4 5147.5 5157.5 5174.0 5175.8 5193.0 4954.9 4985.0 5057.0 5224.4 5244.9 3026.2 3032.1 3094.6 3115.2 3122.6 1091.3 1096.8 1097.7 1102.0 1136.0 404.4 406.2 430.6 447.8 457.8 9520.9 9687.3 9952.3 9956.7 10167.0 420.7 421.2 430.1 433.4 437.2 4270.5 5512.9 5574.2 5575.8 5582.6 312417.0 313589.0 313596.0 313726.0 316849.0 56104.0 60023.0 60374.7 66877.0 67078.3 507.0 513.6 516.3 518.1 522.2 9968.5 10516.3 10592.4 10634.1 10637.3 29263.7 29495.6 29647.7 30207.7 30897.7 35462.0 36923.0 37021.0 38019.2 38956.8 6182.6 6450.4 6465.9 6467.6 6504.3 10823.3 11299.9 11422.9 11491.0 11824.5 9721.5 9833.9 9900.5 10076.2 10232.1 9810.8 9959.1 10099.8 10100.7 10102.2 10284.4 10319.6 10326.3 10360.1 10376.5 6343.8 6397.5 6488.1 6490.7 6493.1 10450.0 10451.5 10474.6 10625.1 10657.7 01:19:18 INFO - 2015-11-19 01:19:18,212 DEBUG : BROWSER_OUTPUT: 01:19:18 INFO - 2015-11-19 01:19:18,212 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5031.87 Median:6403.47 stddev:2635.09 (41.2%) stddev-sans-first:2628.98 01:19:18 INFO - 2015-11-19 01:19:18,214 DEBUG : BROWSER_OUTPUT: Values: 1482.5 1686.8 1716.0 1723.4 1725.4 7211.8 7408.3 7476.8 7507.7 7532.7 7511.6 7559.5 7606.3 7608.3 7626.2 1940.6 1969.2 1975.5 1975.6 1983.2 2119.1 2136.0 2145.7 2180.7 2181.1 1888.9 1913.2 1921.9 2094.3 2118.3 2090.6 2117.0 2117.8 2117.8 2122.9 2091.7 2140.4 2144.1 2154.8 2160.2 7304.7 7376.8 7399.9 7422.3 7467.1 4296.8 4334.0 4396.1 4398.3 4400.9 2882.3 2893.8 2941.1 2941.5 2943.0 840.6 893.0 898.2 1771.6 1795.6 9779.7 9841.5 9868.6 9901.8 9970.9 3744.7 3771.1 3816.7 3819.4 3923.8 7503.4 7556.7 7566.2 7566.9 7576.7 4231.5 4240.8 4245.1 4247.5 4265.3 3910.5 3910.5 3915.3 3923.5 3933.9 3199.3 3210.5 3217.7 3229.4 3259.6 958.1 964.3 967.4 978.5 984.1 697.6 763.1 775.6 808.0 855.5 6680.6 6736.2 6745.2 6746.8 6750.4 626.1 635.1 638.8 650.5 770.3 5042.6 5084.3 5086.8 5123.1 5124.9 8621.7 8704.8 8776.9 8799.0 8965.5 8724.4 8737.7 8745.7 8818.3 8825.2 6840.5 6936.1 7006.9 7010.9 7052.3 6304.2 6384.7 6399.1 6407.9 6432.5 7404.8 7742.8 7758.8 7768.4 7819.1 7885.8 7925.2 8050.2 8134.1 8205.8 6698.9 6721.5 6724.3 6751.1 6753.3 6627.9 6631.2 6644.6 6659.3 6695.7 6436.1 6558.4 6604.4 6628.1 6703.0 5730.1 6268.4 6313.1 6336.1 6359.8 6372.9 6373.5 6393.7 6410.7 6421.8 5938.9 5998.3 6022.4 6037.7 6046.9 6078.5 6120.5 6120.8 6120.9 6121.4 01:19:18 INFO - 2015-11-19 01:19:18,214 DEBUG : BROWSER_OUTPUT: 01:19:18 INFO - 2015-11-19 01:19:18,214 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4853.91 Median:5565.18 stddev:1445.34 (26.0%) stddev-sans-first:1408.73 01:19:18 INFO - 2015-11-19 01:19:18,215 DEBUG : BROWSER_OUTPUT: Values: 318.3 319.5 325.8 326.2 328.6 5507.9 5569.0 5599.4 5608.2 5650.2 5505.6 5558.6 5561.4 5572.9 5574.9 4158.5 4278.8 4287.7 4294.9 4301.0 4239.2 4249.9 4252.9 4258.7 4267.7 4226.2 4235.5 4239.5 4239.5 4243.8 4227.1 4231.0 4232.6 4233.6 4247.7 3696.8 3708.0 3708.1 3709.6 3711.9 5221.6 5340.5 5341.8 5343.1 5350.8 4833.2 4855.5 4871.1 4872.9 4874.1 5836.2 5852.7 5860.6 5862.2 5863.1 3923.0 4013.2 4016.4 4016.6 4018.1 6051.8 6169.8 6175.8 6175.8 6178.3 4080.3 4087.4 4090.4 4094.3 4110.1 4155.2 4159.0 4161.5 4169.2 4169.3 4799.3 4808.1 4810.7 4812.0 4820.9 5633.5 5858.4 5862.8 5865.4 5865.7 1474.4 1506.7 1507.4 1508.0 1510.4 988.3 992.7 994.7 1002.0 1020.2 5134.4 5156.5 5162.6 5180.8 5181.9 5931.7 6054.4 6135.7 6146.3 6155.8 5155.7 5173.2 5173.9 5185.5 5205.7 3254.3 3297.6 3314.6 3317.9 3320.5 5579.1 5734.7 5757.8 5767.4 5784.3 6266.2 6296.0 6309.3 6318.2 6330.7 5756.3 5762.4 5765.4 5773.8 5794.9 5964.9 6090.0 6133.9 6135.8 6145.7 6005.1 6008.5 6010.2 6013.7 6013.8 5754.3 5757.9 5764.7 5775.0 5790.6 4158.8 4198.4 4202.1 4203.8 4212.1 5972.3 6148.2 6155.4 6160.0 6161.8 5913.7 5918.8 5924.5 5926.8 5929.8 5877.4 5900.1 5933.5 5935.7 5937.0 5602.5 5738.9 5771.0 5776.9 5777.8 5933.4 5934.3 5954.9 5974.0 5978.3 5624.5 5798.9 5800.7 5809.3 5816.1 01:19:18 INFO - 2015-11-19 01:19:18,215 DEBUG : BROWSER_OUTPUT: 01:19:18 INFO - 2015-11-19 01:19:18,216 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12173.12 Median:46349.42 stddev:14537.24 (31.4%) stddev-sans-first:14552.14 01:19:18 INFO - 2015-11-19 01:19:18,217 DEBUG : BROWSER_OUTPUT: Values: 621.9 630.4 691.5 736.4 771.1 11130.9 11250.7 11307.4 11327.9 11380.6 12578.3 12815.1 12816.2 12831.4 12835.6 605.4 607.9 763.9 780.5 782.6 754.3 768.2 773.4 773.5 774.5 794.8 803.8 806.0 806.0 806.3 798.0 802.6 804.3 805.1 807.9 584.8 587.6 591.4 592.5 593.9 11698.5 11723.8 11757.0 11795.8 11801.9 9273.3 9526.4 9688.7 9972.4 9972.7 8945.5 9068.1 9305.9 9698.5 10418.4 2785.6 2829.6 2851.6 2882.8 2927.2 35459.3 35496.6 35734.3 36277.3 36311.5 6601.4 6989.6 7030.9 7043.4 7057.5 10969.2 11064.8 11074.9 11077.7 11100.3 5351.4 5455.2 5486.5 5568.9 5707.3 3435.0 3507.5 3514.1 3529.3 3566.8 2435.1 2473.8 2477.8 2482.2 2486.8 384.3 386.7 388.9 396.2 396.2 429.3 451.5 458.8 471.7 513.2 7784.6 7937.0 7972.9 8017.8 8122.3 535.8 536.1 539.7 557.5 578.0 3614.8 3736.8 3800.5 3868.1 3898.9 51752.7 54397.7 55538.7 55755.7 55818.4 45298.5 46260.5 46438.3 46489.8 46824.0 42722.1 42843.4 42844.6 42869.4 43840.6 7748.6 7756.8 7785.8 7988.5 8133.6 33365.2 33685.8 34164.3 34339.5 34449.1 40113.8 42196.4 42516.6 43348.0 43504.0 7058.6 7205.3 7298.9 7326.0 7333.9 11065.0 11276.5 11384.1 11517.8 11720.7 10323.7 10400.2 10583.2 10868.2 10938.4 10130.9 10299.4 10616.2 10632.0 10651.9 10537.7 10869.9 10949.7 10998.2 11080.4 9305.4 9547.3 9560.7 9756.7 9940.0 8975.9 9122.3 9149.9 9190.6 9192.7 01:19:18 INFO - 2015-11-19 01:19:18,217 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:19:18 INFO - 2015-11-19 01:19:18,217 DEBUG : BROWSER_OUTPUT: 01:19:18 INFO - 2015-11-19 01:19:18,913 INFO : Browser exited with error code: 0 01:19:18 INFO - 2015-11-19 01:19:18,932 INFO : Completed test dromaeo_css (00:18:33) 01:19:18 INFO - 2015-11-19 01:19:18,932 INFO : Starting test kraken 01:19:18 INFO - 2015-11-19 01:19:18,932 DEBUG : operating with platform_type : linux_ 01:19:18 INFO - 2015-11-19 01:19:18,932 INFO : Initialising browser for kraken test... 01:19:18 INFO - 2015-11-19 01:19:18,938 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkIXsOj/profile http://localhost:55859/getInfo.html 01:19:23 INFO - 2015-11-19 01:19:23,025 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:19:23 INFO - 2015-11-19 01:19:23,025 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:19:23 INFO - 2015-11-19 01:19:23,026 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:19:23 INFO - 2015-11-19 01:19:23,026 DEBUG : BROWSER_OUTPUT: __metrics 01:19:24 INFO - 2015-11-19 01:19:24,033 INFO : Browser initialized. 01:19:24 INFO - 2015-11-19 01:19:24,034 INFO : Running cycle 1/1 for kraken test... 01:19:24 INFO - 2015-11-19 01:19:24,034 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkIXsOj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:19:35 INFO - 2015-11-19 01:19:35,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 141488128 01:19:35 INFO - 2015-11-19 01:19:35,988 DEBUG : BROWSER_OUTPUT: 01:19:38 INFO - 2015-11-19 01:19:38,574 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55859/tests/kraken/driver.html?testName=audio-beat-detection) 01:19:39 INFO - 2015-11-19 01:19:39,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 141307904 01:19:39 INFO - 2015-11-19 01:19:39,196 DEBUG : BROWSER_OUTPUT: 01:19:41 INFO - 2015-11-19 01:19:41,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55859/tests/kraken/driver.html?testName=audio-dft) 01:19:42 INFO - 2015-11-19 01:19:42,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 141795328 01:19:42 INFO - 2015-11-19 01:19:42,587 DEBUG : BROWSER_OUTPUT: 01:19:45 INFO - 2015-11-19 01:19:45,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55859/tests/kraken/driver.html?testName=audio-fft) 01:19:46 INFO - 2015-11-19 01:19:46,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 135970816 01:19:46 INFO - 2015-11-19 01:19:46,132 DEBUG : BROWSER_OUTPUT: 01:19:48 INFO - 2015-11-19 01:19:48,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55859/tests/kraken/driver.html?testName=audio-oscillator) 01:19:48 INFO - 2015-11-19 01:19:48,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 136654848 01:19:48 INFO - 2015-11-19 01:19:48,775 DEBUG : BROWSER_OUTPUT: 01:19:50 INFO - 2015-11-19 01:19:50,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55859/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:19:51 INFO - 2015-11-19 01:19:51,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 137068544 01:19:51 INFO - 2015-11-19 01:19:51,588 DEBUG : BROWSER_OUTPUT: 01:19:54 INFO - 2015-11-19 01:19:54,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55859/tests/kraken/driver.html?testName=imaging-darkroom) 01:19:55 INFO - 2015-11-19 01:19:55,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 137715712 01:19:55 INFO - 2015-11-19 01:19:55,275 DEBUG : BROWSER_OUTPUT: 01:19:58 INFO - 2015-11-19 01:19:58,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55859/tests/kraken/driver.html?testName=imaging-desaturate) 01:19:59 INFO - 2015-11-19 01:19:59,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 136376320 01:19:59 INFO - 2015-11-19 01:19:59,372 DEBUG : BROWSER_OUTPUT: 01:20:02 INFO - 2015-11-19 01:20:02,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55859/tests/kraken/driver.html?testName=json-parse-financial) 01:20:02 INFO - 2015-11-19 01:20:02,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 137654272 01:20:02 INFO - 2015-11-19 01:20:02,869 DEBUG : BROWSER_OUTPUT: 01:20:04 INFO - 2015-11-19 01:20:04,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55859/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:20:05 INFO - 2015-11-19 01:20:05,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 139333632 01:20:05 INFO - 2015-11-19 01:20:05,233 DEBUG : BROWSER_OUTPUT: 01:20:07 INFO - 2015-11-19 01:20:07,164 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55859/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:20:07 INFO - 2015-11-19 01:20:07,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 139403264 01:20:07 INFO - 2015-11-19 01:20:07,770 DEBUG : BROWSER_OUTPUT: 01:20:09 INFO - 2015-11-19 01:20:09,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55859/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:20:10 INFO - 2015-11-19 01:20:10,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 139800576 01:20:10 INFO - 2015-11-19 01:20:10,537 DEBUG : BROWSER_OUTPUT: 01:20:13 INFO - 2015-11-19 01:20:13,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:20:13 INFO - 2015-11-19 01:20:13,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 139538432 01:20:13 INFO - 2015-11-19 01:20:13,731 DEBUG : BROWSER_OUTPUT: 01:20:16 INFO - 2015-11-19 01:20:16,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:20:16 INFO - 2015-11-19 01:20:16,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 139603968 01:20:16 INFO - 2015-11-19 01:20:16,960 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55859/tests/kraken/driver.html?testName=ai-astar) 01:20:18 INFO - 2015-11-19 01:20:18,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 140406784 01:20:18 INFO - 2015-11-19 01:20:18,976 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,979 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:20:18 INFO - 2015-11-19 01:20:18,979 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:20:18 INFO - 2015-11-19 01:20:18,980 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:20:18 INFO - 2015-11-19 01:20:18,980 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:20:18 INFO - 2015-11-19 01:20:18,980 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;107;114;113;116;126;114;115;114;113 01:20:18 INFO - 2015-11-19 01:20:18,980 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;161;131;168;176;134;158;157;150;164;142 01:20:18 INFO - 2015-11-19 01:20:18,981 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;165;164;165;168;167;163;165;167 01:20:18 INFO - 2015-11-19 01:20:18,981 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;73;146;72;73;72;73;151;73 01:20:18 INFO - 2015-11-19 01:20:18,981 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;138;91;91;92;126;91;92;132 01:20:18 INFO - 2015-11-19 01:20:18,981 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;109;111;110;110;110;111 01:20:18 INFO - 2015-11-19 01:20:18,982 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;150;147;148;147;148;148;149;148;147 01:20:18 INFO - 2015-11-19 01:20:18,982 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;96;96;97;97;97 01:20:18 INFO - 2015-11-19 01:20:18,982 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;73;77;74;73;73;79;73;74 01:20:18 INFO - 2015-11-19 01:20:18,982 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;71;69;68;70;69;69;69;70 01:20:18 INFO - 2015-11-19 01:20:18,982 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;83;82;83;83;83;84;84;84;92 01:20:18 INFO - 2015-11-19 01:20:18,983 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;120;135;134;120;123;123;126;135;125 01:20:18 INFO - 2015-11-19 01:20:18,983 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;161;154;135;154;137;146;143;148;147 01:20:18 INFO - 2015-11-19 01:20:18,983 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;70;71;73;70;70;70;71;70 01:20:18 INFO - 2015-11-19 01:20:18,983 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:20:18 INFO - 2015-11-19 01:20:18,984 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:20:18 INFO - 2015-11-19 01:20:18,984 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,810 01:20:18 INFO - 2015-11-19 01:20:18,984 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:20:18 INFO - 2015-11-19 01:20:18,984 DEBUG : BROWSER_OUTPUT: __startTimestamp1447924818978__endTimestamp 01:20:18 INFO - 2015-11-19 01:20:18,985 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,992 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:20:18 INFO - 2015-11-19 01:20:18,992 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:20:18 INFO - 2015-11-19 01:20:18,992 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,993 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.70 Median:114.50 stddev:4.67 (4.1%) stddev-sans-first:4.95 01:20:18 INFO - 2015-11-19 01:20:18,993 DEBUG : BROWSER_OUTPUT: Values: 115.0 107.0 114.0 113.0 116.0 126.0 114.0 115.0 114.0 113.0 01:20:18 INFO - 2015-11-19 01:20:18,993 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,993 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:154.10 Median:159.50 stddev:14.69 (9.2%) stddev-sans-first:15.37 01:20:18 INFO - 2015-11-19 01:20:18,993 DEBUG : BROWSER_OUTPUT: Values: 161.0 131.0 168.0 176.0 134.0 158.0 157.0 150.0 164.0 142.0 01:20:18 INFO - 2015-11-19 01:20:18,993 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,993 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:1.62 (1.0%) stddev-sans-first:1.66 01:20:18 INFO - 2015-11-19 01:20:18,993 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 165.0 164.0 165.0 168.0 167.0 163.0 165.0 167.0 01:20:18 INFO - 2015-11-19 01:20:18,993 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,994 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.00 Median:73.00 stddev:31.91 (43.7%) stddev-sans-first:33.44 01:20:18 INFO - 2015-11-19 01:20:18,994 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 73.0 146.0 72.0 73.0 72.0 73.0 151.0 73.0 01:20:18 INFO - 2015-11-19 01:20:18,994 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,994 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.70 Median:91.50 stddev:19.74 (21.6%) stddev-sans-first:20.48 01:20:18 INFO - 2015-11-19 01:20:18,994 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 138.0 91.0 91.0 92.0 126.0 91.0 92.0 132.0 01:20:18 INFO - 2015-11-19 01:20:18,994 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,994 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 01:20:18 INFO - 2015-11-19 01:20:18,994 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 109.0 111.0 110.0 110.0 110.0 111.0 01:20:18 INFO - 2015-11-19 01:20:18,994 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,995 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 01:20:18 INFO - 2015-11-19 01:20:18,995 DEBUG : BROWSER_OUTPUT: Values: 148.0 150.0 147.0 148.0 147.0 148.0 148.0 149.0 148.0 147.0 01:20:18 INFO - 2015-11-19 01:20:18,995 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,995 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:20:18 INFO - 2015-11-19 01:20:18,995 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 97.0 97.0 01:20:18 INFO - 2015-11-19 01:20:18,995 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,995 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.30 Median:74.00 stddev:2.06 (2.8%) stddev-sans-first:2.18 01:20:18 INFO - 2015-11-19 01:20:18,995 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 73.0 77.0 74.0 73.0 73.0 79.0 73.0 74.0 01:20:18 INFO - 2015-11-19 01:20:18,995 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,995 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.87 01:20:18 INFO - 2015-11-19 01:20:18,996 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 71.0 69.0 68.0 70.0 69.0 69.0 69.0 70.0 01:20:18 INFO - 2015-11-19 01:20:18,996 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,996 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:3.54 (4.2%) stddev-sans-first:2.99 01:20:18 INFO - 2015-11-19 01:20:18,996 DEBUG : BROWSER_OUTPUT: Values: 91.0 83.0 82.0 83.0 83.0 83.0 84.0 84.0 84.0 92.0 01:20:18 INFO - 2015-11-19 01:20:18,996 DEBUG : BROWSER_OUTPUT: 01:20:18 INFO - 2015-11-19 01:20:18,996 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:125.50 stddev:5.91 (4.7%) stddev-sans-first:6.24 01:20:18 INFO - 2015-11-19 01:20:18,996 DEBUG : BROWSER_OUTPUT: Values: 125.0 120.0 135.0 134.0 120.0 123.0 123.0 126.0 135.0 125.0 01:20:19 INFO - 2015-11-19 01:20:18,996 DEBUG : BROWSER_OUTPUT: 01:20:19 INFO - 2015-11-19 01:20:18,996 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:147.50 stddev:8.90 (6.0%) stddev-sans-first:8.33 01:20:19 INFO - 2015-11-19 01:20:18,997 DEBUG : BROWSER_OUTPUT: Values: 134.0 161.0 154.0 135.0 154.0 137.0 146.0 143.0 148.0 147.0 01:20:19 INFO - 2015-11-19 01:20:18,997 DEBUG : BROWSER_OUTPUT: 01:20:19 INFO - 2015-11-19 01:20:18,997 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.50 stddev:1.06 (1.5%) stddev-sans-first:1.09 01:20:19 INFO - 2015-11-19 01:20:18,997 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 70.0 71.0 73.0 70.0 70.0 70.0 71.0 70.0 01:20:19 INFO - 2015-11-19 01:20:18,997 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:20:19 INFO - 2015-11-19 01:20:18,997 DEBUG : BROWSER_OUTPUT: 01:20:19 INFO - 2015-11-19 01:20:19,969 INFO : Browser exited with error code: 0 01:20:20 INFO - 2015-11-19 01:20:20,023 INFO : Completed test kraken (00:01:01) 01:20:20 INFO - 2015-11-19 01:20:20,023 INFO : Starting test v8_7 01:20:20 INFO - 2015-11-19 01:20:20,023 DEBUG : operating with platform_type : linux_ 01:20:20 INFO - 2015-11-19 01:20:20,023 INFO : Initialising browser for v8_7 test... 01:20:20 INFO - 2015-11-19 01:20:20,029 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppqqOvc/profile http://localhost:55859/getInfo.html 01:20:24 INFO - 2015-11-19 01:20:24,088 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:20:24 INFO - 2015-11-19 01:20:24,088 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:20:24 INFO - 2015-11-19 01:20:24,088 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:20:24 INFO - 2015-11-19 01:20:24,088 DEBUG : BROWSER_OUTPUT: __metrics 01:20:25 INFO - 2015-11-19 01:20:25,133 INFO : Browser initialized. 01:20:25 INFO - 2015-11-19 01:20:25,134 INFO : Running cycle 1/1 for v8_7 test... 01:20:25 INFO - 2015-11-19 01:20:25,134 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppqqOvc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:20:37 INFO - 2015-11-19 01:20:37,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 141299712 01:20:37 INFO - 2015-11-19 01:20:37,088 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55859/tests/v8_7/run.html (next: http://localhost:55859/tests/v8_7/run.html) 01:20:58 INFO - 2015-11-19 01:20:58,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 138186752 01:20:58 INFO - 2015-11-19 01:20:58,859 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,861 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:20:58 INFO - 2015-11-19 01:20:58,861 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:20:58 INFO - 2015-11-19 01:20:58,861 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:20:58 INFO - 2015-11-19 01:20:58,861 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:20:58 INFO - 2015-11-19 01:20:58,861 DEBUG : BROWSER_OUTPUT: |0;Richards;163.15875346712352 01:20:58 INFO - 2015-11-19 01:20:58,861 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.0949742021785 01:20:58 INFO - 2015-11-19 01:20:58,862 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 01:20:58 INFO - 2015-11-19 01:20:58,862 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 01:20:58 INFO - 2015-11-19 01:20:58,862 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1064.9627263045793 01:20:58 INFO - 2015-11-19 01:20:58,862 DEBUG : BROWSER_OUTPUT: |5;Earley;713.2667617689016 01:20:58 INFO - 2015-11-19 01:20:58,862 DEBUG : BROWSER_OUTPUT: |6;Boyer;12419.753086419752 01:20:58 INFO - 2015-11-19 01:20:58,862 DEBUG : BROWSER_OUTPUT: |7;RegExp;25846.153846153848 01:20:58 INFO - 2015-11-19 01:20:58,862 DEBUG : BROWSER_OUTPUT: |8;Splay;607.7248038624019 01:20:58 INFO - 2015-11-19 01:20:58,862 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 01:20:58 INFO - 2015-11-19 01:20:58,863 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:20:58 INFO - 2015-11-19 01:20:58,863 DEBUG : BROWSER_OUTPUT: __startTimestamp1447924858860__endTimestamp 01:20:58 INFO - 2015-11-19 01:20:58,863 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,863 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:20:58 INFO - 2015-11-19 01:20:58,863 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:20:58 INFO - 2015-11-19 01:20:58,864 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,864 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.16 Median:163.16 stddev:0.00 (0.0%) 01:20:58 INFO - 2015-11-19 01:20:58,864 DEBUG : BROWSER_OUTPUT: Values: 163.2 01:20:58 INFO - 2015-11-19 01:20:58,864 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,864 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.09 Median:191.09 stddev:0.00 (0.0%) 01:20:58 INFO - 2015-11-19 01:20:58,865 DEBUG : BROWSER_OUTPUT: Values: 191.1 01:20:58 INFO - 2015-11-19 01:20:58,865 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,866 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 01:20:58 INFO - 2015-11-19 01:20:58,866 DEBUG : BROWSER_OUTPUT: Values: 279.4 01:20:58 INFO - 2015-11-19 01:20:58,866 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,867 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 01:20:58 INFO - 2015-11-19 01:20:58,867 DEBUG : BROWSER_OUTPUT: Values: 5040.2 01:20:58 INFO - 2015-11-19 01:20:58,867 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,867 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1064.96 Median:1064.96 stddev:0.00 (0.0%) 01:20:58 INFO - 2015-11-19 01:20:58,867 DEBUG : BROWSER_OUTPUT: Values: 1065.0 01:20:58 INFO - 2015-11-19 01:20:58,867 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,867 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:713.27 Median:713.27 stddev:0.00 (0.0%) 01:20:58 INFO - 2015-11-19 01:20:58,867 DEBUG : BROWSER_OUTPUT: Values: 713.3 01:20:58 INFO - 2015-11-19 01:20:58,868 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,868 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 01:20:58 INFO - 2015-11-19 01:20:58,868 DEBUG : BROWSER_OUTPUT: Values: 12419.8 01:20:58 INFO - 2015-11-19 01:20:58,868 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,868 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25846.15 Median:25846.15 stddev:0.00 (0.0%) 01:20:58 INFO - 2015-11-19 01:20:58,868 DEBUG : BROWSER_OUTPUT: Values: 25846.2 01:20:58 INFO - 2015-11-19 01:20:58,868 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,869 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.72 Median:607.72 stddev:0.00 (0.0%) 01:20:58 INFO - 2015-11-19 01:20:58,869 DEBUG : BROWSER_OUTPUT: Values: 607.7 01:20:58 INFO - 2015-11-19 01:20:58,869 DEBUG : BROWSER_OUTPUT: 01:20:58 INFO - 2015-11-19 01:20:58,869 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 01:20:58 INFO - 2015-11-19 01:20:58,869 DEBUG : BROWSER_OUTPUT: Values: 4850.2 01:20:58 INFO - 2015-11-19 01:20:58,869 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:20:58 INFO - 2015-11-19 01:20:58,869 DEBUG : BROWSER_OUTPUT: 01:20:59 INFO - 2015-11-19 01:20:59,817 INFO : Browser exited with error code: 0 01:20:59 INFO - 2015-11-19 01:20:59,834 INFO : Completed test v8_7 (00:00:39) 01:20:59 INFO - 2015-11-19 01:20:59,835 INFO : Completed test suite (00:20:14) 01:20:59 INFO - 2015-11-19 01:20:59,836 DEBUG : Working with test: dromaeo_css 01:20:59 INFO - 2015-11-19 01:20:59,836 DEBUG : Generating results file: dromaeo_css 01:20:59 INFO - 2015-11-19 01:20:59,836 DEBUG : Working with test: kraken 01:20:59 INFO - 2015-11-19 01:20:59,836 DEBUG : Generating results file: kraken 01:20:59 INFO - 2015-11-19 01:20:59,836 INFO : javascript benchmark 01:20:59 INFO - 2015-11-19 01:20:59,836 DEBUG : Working with test: v8_7 01:20:59 INFO - 2015-11-19 01:20:59,837 DEBUG : Generating results file: v8_7 01:20:59 INFO - 2015-11-19 01:20:59,837 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:20:59 INFO - 2015-11-19 01:20:59,890 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,43]] 01:20:59 INFO - 2015-11-19 01:20:59,890 DEBUG : process_Request line: dromaeo_css 6042.96 graph.html#tests=[[72,131,43]] 01:20:59 INFO - 2015-11-19 01:20:59,890 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:20:59 INFO - 2015-11-19 01:20:59,919 DEBUG : process_Request line: kraken 1551.90 graph.html#tests=[[232,131,43]] 01:20:59 INFO - 2015-11-19 01:20:59,919 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:20:59 INFO - 2015-11-19 01:20:59,963 DEBUG : process_Request line: v8_7 21358.30 graph.html#tests=[[230,131,43]] 01:20:59 INFO - 2015-11-19 01:20:59,964 INFO : javascript benchmark 01:21:00 INFO - 2015-11-19 01:20:59,968 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2667.173176315342, 2697.4874773792967, 2741.9725802741978, 2755.035737491878, 2755.4351357971605, 4636.51316611756, 4792.9041419171635, 4804.159272127376, 4824.083424149414, 4834.299026641143, 4741.312509686093, 4771.0, 4778.020505796312, 4779.832705855296, 4783.665143439961, 4302.935455968163, 4356.128774245164, 4363.498197707273, 4457.91084178317, 4517.254652982254, 418.3680757651971, 4502.842400515982, 4511.684182107254, 4533.523979982087, 4534.546545345472, 4396.120775844828, 4416.646668266531, 4485.080558485535, 4489.2592722201125, 4533.229351010336, 4470.9105817883465, 4484.282514797616, 4484.910301793979, 4494.07871386365, 4531.0, 4220.556841531657, 4443.888902777424, 4447.822087116511, 4461.24158892989, 4485.506594274627, 4603.884902877421, 4623.8150473981, 4651.88370290742, 4685.976570117162, 4698.600618947394, 5180.456052114511, 5218.347706536683, 5221.086309895753, 5224.373075230997, 5226.947730522722, 4974.204127339608, 5067.695938243717, 5213.661112027706, 5244.475552444763, 5245.291885595434, 4656.790444429975, 4673.088747694235, 4679.017406344706, 4715.151272770934, 4754.643401744848, 5211.1662134059125, 5239.607029472805, 5248.3701955765555, 5250.317458730341, 5255.211718242218, 4896.265560165933, 4977.352944117241, 5017.9247311290355, 5039.143345631252, 5078.0, 5160.535551800281, 5176.068307704574, 5177.197534382177, 5180.922286165711, 5230.320058392384, 5111.642185047085, 5124.7950081996305, 5143.048536020848, 5144.279800827887, 5173.0688476074665, 4894.975525122351, 4981.053599816023, 5004.4995500450395, 5104.642675012788, 5122.359705036871, 4245.1085272093205, 4246.4691913510815, 4270.12462445198, 4283.20760659279, 4304.332828411601, 3720.776753394805, 3722.571904230994, 3734.7198960078103, 3748.793816340073, 3758.567764707039, 4252.659787217015, 4432.534583868712, 4436.423264975532, 4436.578525040116, 4490.57339552742, 5082.822101226439, 5138.527468246306, 5159.226116082543, 5160.458151894072, 5197.818076367309, 4476.127155204704, 4510.639148868083, 4513.097380523843, 4528.184926713223, 4549.567791059844, 4333.8699839004885, 4447.08834688888, 4456.955430445654, 4566.109608626286, 4616.561426664462, 4764.404449443819, 4824.228123500293, 4834.492378300228, 4864.562189402829, 4876.609871210366, 5118.8976220476125, 5155.381354237516, 5167.870803229949, 5171.689698618095, 5227.294315267391, 4669.48635650085, 4799.208130658402, 4867.026594681007, 4896.314515967696, 4918.680285781413, 4902.166631672696, 5054.2671312660195, 5062.696238225718, 5076.984603079325, 5103.92344114846, 5139.640225184351, 5160.380754309357, 5160.638755287094, 5187.014467251211, 5211.687298762086, 4800.3759511263315, 4920.434150072644, 4924.679895806761, 4990.226514890198, 5011.498850114959, 5000.449950505369, 5021.573166280907, 5023.2214006829, 5038.949610503848, 5040.84877453677, 4900.975495122501, 4926.704397736147, 4943.456219815889, 4945.455999839943, 4968.776405061709, 4878.804847806048, 4949.331840201527, 4961.404631444249, 5025.974870125626, 5119.129747942784, 4917.655764096622, 4925.876853078558, 4936.950630493649, 4944.3572335596145, 4980.651354405301], "unit": "ms", "name": "dojo.html", "value": 4676.341532731391}, {"lowerIsBetter": false, "replicates": [535.5795700375205, 537.094994933537, 554.7808615596842, 570.1049352516549, 571.7712914834066, 36843.263134737324, 37702.81148594257, 37709.81145094274, 37718.24563508728, 37884.43173352402, 40278.79860600693, 40737.38893916586, 40758.59241407585, 40763.18473630526, 40814.18371632566, 7939.285464308211, 8081.515109093444, 8085.676572937075, 8086.595670216495, 8103.797405064891, 7928.365730741556, 8006.239407256301, 8009.639566219534, 8010.198980101973, 8010.799730006738, 7958.761237162895, 7966.800829979239, 8043.638036288381, 8048.637811298506, 8081.2322829331415, 7908.762737117896, 8010.0, 8021.759347219593, 8099.55452450115, 8109.675612975474, 7849.254320839568, 7983.441159118864, 8015.47899386538, 8046.155153708834, 8056.637451314647, 37792.24415511702, 38558.80720596407, 38703.612963870284, 38709.0, 38733.806330968444, 3061.280599059219, 3077.5537547055774, 3390.2033022239752, 3449.862005519801, 3799.772013679188, 28563.85718071417, 29174.076514209475, 29216.26959326034, 29299.0, 29924.85037574798, 3100.829454380008, 3127.53087036944, 3145.9528107078413, 3152.6374466936136, 3232.4828027515487, 222221.0, 222863.0, 223511.0, 224124.0, 224289.0, 38419.61580384216, 38717.806410967765, 55792.44207557872, 56131.0, 56146.71926640341, 37237.2072094594, 37252.813735931144, 37435.62564374322, 37504.62495375066, 37735.0, 12863.935680321538, 13086.934565327303, 13098.2141071536, 13114.934425327812, 13143.277119758313, 10247.795044099077, 10367.874585709911, 10374.066334029974, 10391.792164156826, 10407.5836966522, 13049.28228947398, 13463.52877649297, 13536.05247632676, 13539.781419672277, 13611.11527750693, 5422.972885135628, 5467.58993075513, 5491.121420572689, 5523.143912693539, 5551.3893471718075, 841.3984001439001, 875.7241468937265, 894.8031433084711, 896.3994123936978, 1011.7622358745689, 26361.209163725118, 26467.205983820517, 30265.0, 31073.68926310708, 32105.51841722376, 966.1015255812163, 982.2240430060173, 1029.5933106422922, 1124.1175677093606, 1135.2734250079955, 13800.447982080605, 14248.145111293356, 14334.641633959234, 15479.303431345392, 16226.756598651029, 339265.0, 345606.0, 345717.0, 345881.0, 346027.0, 48764.51235487671, 49320.50679493159, 49321.753391233535, 49362.259566106535, 49472.75263623659, 1148.4831825678311, 1178.7701398227434, 1185.4369174641977, 1194.4505527457293, 1209.12338554549, 27797.51332149162, 27847.443051139267, 28354.85822570874, 28422.57366139551, 28736.71263287424, 39010.6098939007, 39294.0, 39358.40962385509, 39390.0, 39502.40746388749, 257196.0, 258990.0, 260171.0, 260343.0, 260579.0, 29386.265343366587, 29594.0, 30041.399172016874, 30094.84952575223, 30113.69886301109, 39469.80265098656, 40123.0, 40159.3976090353, 40300.596994029685, 40518.0, 33830.0, 33941.60220609495, 34613.0, 34795.30409391849, 35063.47404788879, 33833.83083084569, 34264.828675856465, 34532.482012769324, 34568.82715586406, 34597.30805383928, 38671.22657546889, 38742.22515549617, 39198.804005979786, 39445.80277098596, 39594.0, 30704.385912282076, 30990.535141972436, 31046.68953310438, 31364.0, 31505.52741708922, 24042.87978560166, 24320.270391888273, 24544.263672089866, 24727.50544989054, 24777.87611061933], "unit": "ms", "name": "ext.html", "value": 16830.134203129506}, {"lowerIsBetter": false, "replicates": [332.9384063948168, 344.96722811332916, 346.9677708816272, 348.53644652612024, 349.4897449723403, 12579.559715409963, 13104.0, 14990.700185996273, 15377.308021139048, 17460.03969781663, 15084.6983060339, 15210.543683689479, 15430.922845385785, 15566.610834729137, 15575.92212038941, 4965.7020578765205, 4974.7015179089185, 5039.622028347871, 5073.898522029557, 5076.619253555979, 4548.363229147905, 4661.044485880403, 4671.626269898417, 4683.48481667018, 4973.726445045521, 4462.286034234523, 4578.130155270488, 4596.264597664374, 4617.515160908107, 4742.4309082910095, 4708.176069187895, 4757.64317676174, 4758.690685105475, 4770.236762118045, 4784.162771515006, 4115.73247738896, 4119.588041195886, 4127.050778321003, 4127.690423218271, 4186.790660466995, 12463.314517701523, 12464.750704985849, 12981.675458113528, 13013.804792928113, 13019.804702929463, 1744.310997156129, 1746.1705689797373, 1761.8150094240048, 1801.7837859456818, 1824.4617837737899, 9508.381955172892, 9553.761155971088, 9698.466584337859, 9752.21982241419, 9755.658551950648, 1603.3185895994272, 1624.236608793865, 1628.2184551415387, 1650.4058538925976, 1655.1558705060386, 50228.0, 51146.232806507935, 51258.7437062816, 51719.99999999962, 52164.21753673698, 6544.901826472606, 6591.901121483182, 6697.0, 6710.698018589175, 6725.730970761115, 7761.340286075634, 7821.1396746359, 7822.0, 7862.685492580233, 7884.4086693497065, 5147.510986456281, 5157.484251574812, 5173.974130129325, 5175.767090480862, 5192.9740351298005, 4954.900901982012, 4985.0, 5056.974715126401, 5224.373075230997, 5244.921326180111, 3026.1829306087234, 3032.120685001369, 3094.6131733533307, 3115.1589070950718, 3122.6252849658185, 1091.2688498705727, 1096.7937957931263, 1097.6871591596516, 1101.9889801102047, 1135.9772804544027, 404.3611094470729, 406.24235800232356, 430.6167510915288, 447.84773177119285, 457.7985686298018, 9520.904790952001, 9687.32188746781, 9952.303338766362, 9956.651517196864, 10167.0, 420.7454490033547, 421.15978622648015, 430.1053808079188, 433.3845938766959, 437.19556016929005, 4270.48754149504, 5512.91730624041, 5574.163875418639, 5575.804846830422, 5582.553395728332, 312417.0, 313589.0, 313596.0, 313726.0, 316849.0, 56104.0, 60023.0, 60374.69812650997, 66877.0, 67078.32921670818, 507.0416912036254, 513.5711680746543, 516.2746341390277, 518.1243698150114, 522.1984254169907, 9968.451735154636, 10516.316439431412, 10592.364458132537, 10634.09610183143, 10637.308574942605, 29263.7073629261, 29495.557566636948, 29647.703522964493, 30207.69792302049, 30897.691023089483, 35462.0, 36923.0, 37021.0, 38019.23961520809, 38956.80521597374, 6182.598131121463, 6450.41946224842, 6465.903011454926, 6467.644279564669, 6504.284528701744, 10823.296485728402, 11299.887001129884, 11422.885771142182, 11491.023263022737, 11824.46789894474, 9721.513924303616, 9833.901660983298, 9900.504974751379, 10076.244281678757, 10232.079112879877, 9810.75473113178, 9959.103680668775, 10099.798004040025, 10100.696979090639, 10102.242331824995, 10284.434356110485, 10319.587216511256, 10326.328788628714, 10360.119389851947, 10376.533056012346, 6343.777967771106, 6397.488200943821, 6488.091667166506, 6490.740370385321, 6493.090967264492, 10450.0, 10451.477426128511, 10474.581016759244, 10625.149988000787, 10657.733556661145], "unit": "ms", "name": "jquery.html", "value": 6357.5732042111495}, {"lowerIsBetter": false, "replicates": [1482.4959513765332, 1686.8060173080096, 1715.9656806863863, 1723.3881971899975, 1725.3788636091012, 7211.819704507383, 7408.296211859878, 7476.775696729093, 7507.699692012313, 7532.661030253638, 7511.586862722548, 7559.546427214357, 7606.277403646659, 7608.277213664693, 7626.19924907885, 1940.6215787921396, 1969.1532640964379, 1975.4764987278384, 1975.6345076160885, 1983.186893373717, 2119.109973811003, 2136.0174319812904, 2145.710329105574, 2180.716506854115, 2181.149351752818, 1888.9244430222843, 1913.1868955693774, 1921.8750781199246, 2094.2984100326407, 2118.3115487466634, 2090.550531635698, 2116.9788302117013, 2117.76704562498, 2117.798809113132, 2122.872627642331, 2091.6862470629376, 2140.4327853118934, 2144.0994782191515, 2154.8060674539365, 2160.211522794169, 7304.707811687526, 7376.7786966391095, 7399.889001664979, 7422.2577742225885, 7467.141278752904, 4296.763677997709, 4333.978330108329, 4396.1427521633295, 4398.318260669601, 4400.911981760379, 2882.3082460209607, 2893.8263704177816, 2941.0588611644284, 2941.5293553031624, 2943.0, 840.6175190288404, 892.9776755581097, 898.2006014646969, 1771.5925337172393, 1795.5690634247687, 9779.657711980046, 9841.50792460374, 9868.555914983843, 9901.801963960752, 9970.90029099707, 3744.6817020553012, 3771.0949372150485, 3816.694664426839, 3819.4079917612817, 3923.843046278117, 7503.437242206747, 7556.65995030225, 7566.167721550625, 7566.886496702554, 7576.7348142814735, 4231.534531201565, 4240.830366785356, 4245.12974840157, 4247.51153617338, 4265.296226122655, 3910.4720862683744, 3910.530736311661, 3915.256101340736, 3923.5291764988383, 3933.901652458654, 3199.2961548459302, 3210.502372132323, 3217.6621454746914, 3229.3864165808423, 3259.6088469383353, 958.0898146760605, 964.3442459127721, 967.4437198610827, 978.4520668425704, 984.0651381187901, 697.5988806436319, 763.0957315581054, 775.5889378629336, 808.0303635637259, 855.4995327733221, 6680.5991640501725, 6736.1916570010935, 6745.190577130677, 6746.797596072126, 6750.35871592198, 626.0765371077715, 635.1489004733587, 638.8370965403792, 650.4796163069525, 770.2567022822891, 5042.596592272609, 5084.33903592538, 5086.796528138833, 5123.129068058439, 5124.871878203, 8621.741347759576, 8704.78238044054, 8776.912230877737, 8799.0, 8965.50689712072, 8724.389292749447, 8737.694180703646, 8745.693900713444, 8818.33862460318, 8825.161609647073, 6840.452763778985, 6936.0636314096955, 7006.894896576556, 7010.894836577456, 7052.259512751088, 6304.243490781136, 6384.680765961776, 6399.072134540373, 6407.8718425630295, 6432.517561182836, 7404.777856664308, 7742.845143097219, 7758.7672369829, 7768.378529717722, 7819.139894611474, 7885.842283154419, 7925.207479252029, 8050.194980502137, 8134.145914678874, 8205.79485512867, 6698.866022679616, 6721.529492935448, 6724.260331363448, 6751.088603038527, 6753.3246675332075, 6627.867442651216, 6631.237407697983, 6644.60132392058, 6659.300773418721, 6695.665216739241, 6436.0989461476365, 6558.376954189344, 6604.3725846044545, 6628.072069910313, 6703.028060931235, 5730.111832665943, 6268.373162683695, 6313.05304204373, 6336.144620476177, 6359.8092057238355, 6372.872542549216, 6373.521985850987, 6393.680315984089, 6410.711517981609, 6421.839454013687, 5938.940610593839, 5998.25021872266, 6022.36765139654, 6037.728302226498, 6046.879062418639, 6078.54410919174, 6120.54095942815, 6120.816375508742, 6120.908186377297, 6121.418465245794], "unit": "ms", "name": "mootools.html", "value": 4084.538076229408}, {"lowerIsBetter": false, "replicates": [318.3457993822693, 319.4951975878113, 325.82405501029444, 326.2073162215816, 328.579418344519, 5507.862303442411, 5568.972155139229, 5599.35607405148, 5608.186812912125, 5650.152477128433, 5505.614606977513, 5558.610897237195, 5561.388247292794, 5572.86067848304, 5574.916376254349, 4158.5009798824185, 4278.828846846122, 4287.678424118188, 4294.935575966363, 4301.032267739764, 4239.215745087154, 4249.936250956238, 4252.893677658052, 4258.701890867641, 4267.679924005696, 4226.239276930151, 4235.470566179228, 4239.512456067561, 4239.512456067561, 4243.809028593705, 4227.070044590185, 4230.957690423103, 4232.640225580829, 4233.640140588053, 4247.745135291892, 3696.7781933083834, 3707.9988403131274, 3708.0915175782106, 3709.647583479592, 3711.888643340704, 5221.634485586011, 5340.519353258225, 5341.813036543703, 5343.118385466432, 5350.812721554766, 4833.2266837306215, 4855.538723821267, 4871.050145221683, 4872.8538143855385, 4874.098291816025, 5836.212111364996, 5852.707364631794, 5860.648361098348, 5862.20860183874, 5863.091220860773, 3922.980385098056, 4013.2174226025936, 4016.357382818764, 4016.6184212499766, 4018.1160144768105, 6051.788187413464, 6169.845753856144, 6175.7529698811995, 6175.783847565313, 6178.320384757673, 4080.265552200573, 4087.3868919662286, 4090.406891000788, 4094.303968325392, 4110.0752330725345, 4155.1897380010605, 4159.022629682022, 4161.542230354658, 4169.187008533368, 4169.2703776838935, 4799.28010798383, 4808.134535783593, 4810.687305325143, 4812.0, 4820.903581928342, 5633.521150702236, 5858.414158584107, 5862.824115276549, 5865.35481097079, 5865.73604187804, 1474.4102359056249, 1506.7363211437955, 1507.3518387093654, 1508.0499285450096, 1510.358097808427, 988.2686811759246, 992.692265397729, 994.7314225159312, 1001.9949900250452, 1020.1685626214611, 5134.409542902614, 5156.535911767884, 5162.5611822994715, 5180.844574662766, 5181.948180518222, 5931.656995486758, 6054.364291749391, 6135.662538560333, 6146.262448506208, 6155.784547540815, 5155.74221288934, 5173.198154286091, 5173.948260517422, 5185.481451854785, 5205.687658740488, 3254.2677897473354, 3297.5713157289397, 3314.6022477302877, 3317.8506967186536, 3320.4853247746155, 5579.079451890392, 5734.741936612862, 5757.827265182052, 5767.394423585547, 5784.305883293948, 6266.216722909637, 6295.96852015737, 6309.274433440213, 6318.241810982711, 6330.746770129235, 5756.280464941966, 5762.394948530427, 5765.376753577112, 5773.797917072882, 5794.855128621818, 5964.880702385841, 6090.0, 6133.938660613337, 6135.754569817157, 6145.66198859067, 6005.129256257906, 6008.5493587981955, 6010.188624535632, 6013.6692481913915, 6013.759449622141, 5754.309482862083, 5757.942420575908, 5764.654120752768, 5775.047117225611, 5790.594658373873, 4158.812853421543, 4198.412222288943, 4202.117555313418, 4203.76879271643, 4212.073343864345, 5972.34304226526, 6148.16999705052, 6155.415235552616, 6160.045192995093, 6161.784337548164, 5913.6747478887355, 5918.822435326947, 5924.4667979882015, 5926.7925622603, 5929.762809487572, 5877.441643043904, 5900.055991041413, 5933.495652869382, 5935.703214839327, 5937.020391635332, 5602.52378547828, 5738.856528586819, 5771.0, 5776.942230577809, 5777.768889244383, 5933.389308704156, 5934.258217722785, 5954.940450595612, 5974.0, 5978.312494063239, 5624.465675760796, 5798.884022319615, 5800.651960882361, 5809.2738407699035, 5816.127580862735], "unit": "ms", "name": "prototype.html", "value": 4390.964200133203}, {"lowerIsBetter": false, "replicates": [621.8569728962341, 630.4357599948047, 691.5332150798216, 736.4439847914826, 771.1286246541409, 11130.944345278273, 11250.66248012561, 11307.434628268595, 11327.943360283207, 11380.601678941239, 12578.308193049379, 12815.102942793985, 12816.23102613844, 12831.42258598363, 12835.614931552045, 605.3885575568663, 607.9300880398766, 763.9159692433827, 780.4848799792138, 782.5500337306072, 754.2645920227789, 768.170375993928, 773.3812949640266, 773.4817672159638, 774.4965772248028, 794.8291117409756, 803.7508372404544, 805.9838803223961, 805.995970020152, 806.330745481252, 798.0343784021342, 802.6468353924255, 804.3364224514798, 805.0781854776307, 807.858624740668, 584.7865529081897, 587.5622661117452, 591.3967752892027, 592.5318997991582, 593.9287285525721, 11698.47356868943, 11723.824142637868, 11757.0, 11795.764084718343, 11801.940990294994, 9273.258139348904, 9526.380785249006, 9688.660896868576, 9972.351797133164, 9972.650957216463, 8945.507997060158, 9068.138526839939, 9305.860412093823, 9698.51507424626, 10418.426986515738, 2785.5960885671466, 2829.6038554602374, 2851.6435445569305, 2882.8126171798767, 2927.238917881345, 35459.29081418383, 35496.64503354985, 35734.285314293826, 36277.274454511025, 36311.4553281701, 6601.438877695449, 6989.580625162506, 7030.894536581955, 7043.36609705129, 7057.541259818198, 10969.177311701655, 11064.778704425866, 11074.889251107386, 11077.72305692348, 11100.333979961066, 5351.411344752074, 5455.1544510600925, 5486.451354864562, 5568.9443105568425, 5707.286589176353, 3434.9828250858586, 3507.473878918183, 3514.086337552255, 3529.2764983178386, 3566.8038257896064, 2435.1233555919853, 2473.7773600376054, 2477.764612361823, 2482.1808803094937, 2486.788622967068, 384.34085543293384, 386.6906474820189, 388.93388124018986, 396.23526593674484, 396.2431755347273, 429.2573847244285, 451.4853067503049, 458.7522737721593, 471.73347058911605, 513.2327170879558, 7784.571848548271, 7936.960315198503, 7972.920270797334, 8017.759467215993, 8122.268995790408, 535.7749745107064, 536.1207619504016, 539.7450926595602, 557.4648337595872, 578.0375674501992, 3614.801185934746, 3736.75711078779, 3800.467934489174, 3868.129670824042, 3898.8830335089992, 51752.74123629358, 54397.72801136048, 55538.72230638821, 55755.721221394444, 55818.44181558213, 45298.54701453009, 46260.53739462562, 46438.30342544865, 46489.767551162025, 46824.0, 42722.14555708931, 42843.35734963978, 42844.57155428468, 42869.356104730825, 43840.561594383646, 7748.612569371621, 7756.806079848049, 7785.766427007199, 7988.480748751313, 8133.552654604054, 33365.16587085342, 33685.83157084199, 34164.31671366509, 34339.4849077269, 34449.138771529906, 40113.799431002655, 42196.36705449482, 42516.57483425126, 43348.0, 43504.0, 7058.61177635235, 7205.315495027964, 7298.854022919406, 7325.963370183115, 7333.945819779917, 11065.004149626573, 11276.492557834754, 11384.089272857986, 11517.769644606893, 11720.70698232551, 10323.741906452398, 10400.167986561208, 10583.153347732008, 10868.184886133413, 10938.398388088732, 10130.898691012995, 10299.433531155859, 10616.150707943192, 10632.0, 10651.946740266249, 10537.73655658584, 10869.858664840394, 10949.726256843323, 10998.230123891251, 11080.390578517936, 9305.395149315273, 9547.33168678186, 9560.665376711782, 9756.658516951873, 9940.0, 8975.910240897769, 9122.315826313186, 9149.908500914906, 9190.632374705205, 9192.678256261266], "unit": "ms", "name": "yui.html", "value": 5425.84621914082}], "name": "dromaeo_css", "value": 6042.9558744260585}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 107.0, 114.0, 113.0, 116.0, 126.0, 114.0, 115.0, 114.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [161.0, 131.0, 168.0, 176.0, 134.0, 158.0, 157.0, 150.0, 164.0, 142.0], "unit": "ms", "name": "audio-beat-detection", "value": 154.1}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 165.0, 164.0, 165.0, 168.0, 167.0, 163.0, 165.0, 167.0], "unit": "ms", "name": "audio-dft", "value": 165.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 146.0, 72.0, 73.0, 72.0, 73.0, 151.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 138.0, 91.0, 91.0, 92.0, 126.0, 91.0, 92.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 103.7}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 150.0, 147.0, 148.0, 147.0, 148.0, 148.0, 149.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 77.0, 74.0, 73.0, 73.0, 79.0, 73.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 74.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 71.0, 69.0, 68.0, 70.0, 69.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [91.0, 83.0, 82.0, 83.0, 83.0, 83.0, 84.0, 84.0, 84.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [125.0, 120.0, 135.0, 134.0, 120.0, 123.0, 123.0, 126.0, 135.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [134.0, 161.0, 154.0, 135.0, 154.0, 137.0, 146.0, 143.0, 148.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 70.0, 71.0, 73.0, 70.0, 70.0, 70.0, 71.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1551.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.15875346712352], "unit": "score", "name": "Richards", "value": 216.36595800000006}, {"lowerIsBetter": false, "replicates": [191.0949742021785], "unit": "score", "name": "DeltaBlue", "value": 345.99549399999995}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1064.9627263045793], "unit": "score", "name": "RayTrace", "value": 694.8496709999997}, {"lowerIsBetter": false, "replicates": [713.2667617689016], "unit": "score", "name": "Earley", "value": 934.3811260000003}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [25846.153846153848], "unit": "score", "name": "RegExp", "value": 35.24644345238097}, {"lowerIsBetter": false, "replicates": [607.7248038624019], "unit": "score", "name": "Splay", "value": 134.09194339622647}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21358.303666515523}]} 01:21:00 INFO - RETURN: dromaeo_css: 6042.96 01:21:00 INFO - RETURN: kraken: 1551.90 01:21:00 INFO - RETURN: v8_7: 21358.30 01:21:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,43]]", "result": "21358.30"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,43]]", "result": "1551.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,43]]", "result": "6042.96"}}} 01:21:00 INFO - Return code: 0 01:21:00 INFO - # TBPL SUCCESS # 01:21:00 INFO - Running post-action listener: _resource_record_post_action 01:21:00 INFO - Running post-run listener: _resource_record_post_run 01:21:01 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 343011328; Read time: 0; Write time: 228552 01:21:01 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 6447104; Read time: 0; Write time: 948 01:21:01 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 299311104; Read time: 0; Write time: 215416 01:21:01 INFO - Running post-run listener: _upload_blobber_files 01:21:01 INFO - Blob upload gear active. 01:21:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:21:01 INFO - Copying logs to upload dir... 01:21:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1329.279812 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 9 secs) (at 2015-11-19 01:21:00.424295) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 01:21:00.428215) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010038 build_url: 'https://queue.taskcluster.net/v1/task/XePZYpmET4C-DDzgI-8CGA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 01:21:00.480139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 01:21:00.480489) ========= 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=cd88c086d1ff67493cfd1714000001ba-1447914060.840934-501156056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 01:21:00.529530) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 01:21:00.529864) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 01:21:00.530130) ========= ========= Total master_lag: 0.27 =========