builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1468699617.04 results: success (0) buildid: 20160716103004 builduid: 0a20baba015240249ef8f4f2f7f3fe6f revision: dc97f8b36a22d36be518e56261df85205bb535d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.036023) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.036538) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.036806) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.109883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.110147) ========= 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=db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 13:06:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-07-16 13:06:57 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085476 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.209141) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.209426) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022224 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.259120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.259467) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dc97f8b36a22d36be518e56261df85205bb535d2 --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 dc97f8b36a22d36be518e56261df85205bb535d2 --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=db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 13:06:57,503 truncating revision to first 12 chars 2016-07-16 13:06:57,503 Setting DEBUG logging. 2016-07-16 13:06:57,503 attempt 1/10 2016-07-16 13:06:57,503 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/dc97f8b36a22?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 13:06:57,810 unpacking tar archive at: mozilla-inbound-dc97f8b36a22/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.908811) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.909115) ========= script_repo_revision: dc97f8b36a22d36be518e56261df85205bb535d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.909585) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.909862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 13:06:57.919829) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-16 13:06:57.920560) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:06:58 INFO - MultiFileLogger online at 20160716 13:06:58 in /builds/slave/test 13:06:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:06:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:06:58 INFO - {'append_to_log': False, 13:06:58 INFO - 'base_work_dir': '/builds/slave/test', 13:06:58 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:06:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:06:58 INFO - 'branch': 'Mozilla-Inbound', 13:06:58 INFO - 'buildbot_json_path': 'buildprops.json', 13:06:58 INFO - 'config_files': ('talos/linux_config.py',), 13:06:58 INFO - 'default_actions': ('clobber', 13:06:58 INFO - 'read-buildbot-config', 13:06:58 INFO - 'download-and-extract', 13:06:58 INFO - 'populate-webroot', 13:06:58 INFO - 'create-virtualenv', 13:06:58 INFO - 'install', 13:06:58 INFO - 'run-tests'), 13:06:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:06:58 INFO - 'download_minidump_stackwalk': True, 13:06:58 INFO - 'download_symbols': 'ondemand', 13:06:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:06:58 INFO - 'tooltool.py': '/tools/tooltool.py', 13:06:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:06:58 INFO - '/tools/misc-python/virtualenv.py')}, 13:06:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:06:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:06:58 INFO - 'installer_path': 'installer.exe', 13:06:58 INFO - 'log_level': 'info', 13:06:58 INFO - 'log_name': 'talos', 13:06:58 INFO - 'log_to_console': True, 13:06:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:06:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:06:58 INFO - 'opt_config_files': (), 13:06:58 INFO - 'pip_index': False, 13:06:58 INFO - 'sps_profile': False, 13:06:58 INFO - 'sps_profile_interval': 0, 13:06:58 INFO - 'suite': 'dromaeojs-e10s', 13:06:58 INFO - 'system_bits': '32', 13:06:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:06:58 INFO - 'title': 'talos-linux64-ix-031', 13:06:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:06:58 INFO - 'use_talos_json': True, 13:06:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:06:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:06:58 INFO - 'work_dir': 'build'} 13:06:58 INFO - ##### 13:06:58 INFO - ##### Running clobber step. 13:06:58 INFO - ##### 13:06:58 INFO - Running pre-action listener: _resource_record_pre_action 13:06:58 INFO - Running main action method: clobber 13:06:58 INFO - rmtree: /builds/slave/test/build 13:06:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:06:58 INFO - Running post-action listener: _resource_record_post_action 13:06:58 INFO - ##### 13:06:58 INFO - ##### Finished clobber step (success) 13:06:58 INFO - ##### 13:06:58 INFO - ##### 13:06:58 INFO - ##### Running read-buildbot-config step. 13:06:58 INFO - ##### 13:06:58 INFO - Running pre-action listener: _resource_record_pre_action 13:06:58 INFO - Running main action method: read_buildbot_config 13:06:58 INFO - Using buildbot properties: 13:06:58 INFO - { 13:06:58 INFO - "project": "", 13:06:58 INFO - "product": "firefox", 13:06:58 INFO - "script_repo_revision": "production", 13:06:58 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 13:06:58 INFO - "repository": "", 13:06:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 13:06:58 INFO - "buildid": "20160716103004", 13:06:58 INFO - "pgo_build": "True", 13:06:58 INFO - "basedir": "/builds/slave/test", 13:06:58 INFO - "buildnumber": 1299, 13:06:58 INFO - "slavename": "talos-linux64-ix-031", 13:06:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:06:58 INFO - "platform": "ubuntu64_hw", 13:06:58 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:06:58 INFO - "branch": "mozilla-inbound", 13:06:58 INFO - "repo_path": "integration/mozilla-inbound", 13:06:58 INFO - "revision": "dc97f8b36a22d36be518e56261df85205bb535d2", 13:06:58 INFO - "stage_platform": "linux64-pgo", 13:06:58 INFO - "builduid": "0a20baba015240249ef8f4f2f7f3fe6f", 13:06:58 INFO - "slavebuilddir": "test" 13:06:58 INFO - } 13:06:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:06:58 INFO - Running post-action listener: _resource_record_post_action 13:06:58 INFO - ##### 13:06:58 INFO - ##### Finished read-buildbot-config step (success) 13:06:58 INFO - ##### 13:06:58 INFO - ##### 13:06:58 INFO - ##### Running download-and-extract step. 13:06:58 INFO - ##### 13:06:58 INFO - Running pre-action listener: _resource_record_pre_action 13:06:58 INFO - Running main action method: download_and_extract 13:06:58 INFO - mkdir: /builds/slave/test/build/tests 13:06:58 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')]} 13:06:58 INFO - https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:07:05 INFO - Downloaded 1361 bytes. 13:07:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:07:05 INFO - Using the following test package requirements: 13:07:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:07:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:07:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:05 INFO - u'jsshell-linux-x86_64.zip'], 13:07:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:07:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:07:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:07:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:07:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:07:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:05 INFO - https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:07:07 INFO - Downloaded 24334583 bytes. 13:07:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:07:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:07:08 INFO - Return code: 0 13:07:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:08 INFO - https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:07:10 INFO - Downloaded 24334583 bytes. 13:07:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:07:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:07:11 INFO - Return code: 0 13:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:11 INFO - https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:07:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:07:12 INFO - Downloaded 14403317 bytes. 13:07:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:07:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:07:12 INFO - Return code: 0 13:07:12 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')]} 13:07:12 INFO - https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:07:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:07:15 INFO - Downloaded 60806289 bytes. 13:07:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:15 INFO - mkdir: /builds/slave/test/properties 13:07:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:15 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:15 INFO - Contents: 13:07:15 INFO - build_url:https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:07:15 INFO - Running post-action listener: _resource_record_post_action 13:07:15 INFO - Running post-action listener: set_extra_try_arguments 13:07:15 INFO - ##### 13:07:15 INFO - ##### Finished download-and-extract step (success) 13:07:15 INFO - ##### 13:07:15 INFO - ##### 13:07:15 INFO - ##### Running populate-webroot step. 13:07:15 INFO - ##### 13:07:15 INFO - Running pre-action listener: _resource_record_pre_action 13:07:15 INFO - Running main action method: populate_webroot 13:07:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:15 INFO - '--tppagecycles', 13:07:15 INFO - '7'], 13:07:15 INFO - 'tests': ['tsvgm']}}, 13:07:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:07:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:07:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:07:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:15 INFO - 'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:15 INFO - 'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['damp', 'tps']}, 13:07:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:15 INFO - 'tests': ['damp', 'tps']}, 13:07:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['dromaeo_dom']}, 13:07:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['basic_compositor_video']}, 13:07:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:07:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['a11yr', 13:07:15 INFO - 'ts_paint', 13:07:15 INFO - 'tpaint', 13:07:15 INFO - 'sessionrestore', 13:07:15 INFO - 'sessionrestore_no_auto_restore', 13:07:15 INFO - 'tabpaint']}, 13:07:15 INFO - 'other-e10s': {'tests': ['a11yr', 13:07:15 INFO - 'ts_paint', 13:07:15 INFO - 'tpaint', 13:07:15 INFO - 'sessionrestore', 13:07:15 INFO - 'sessionrestore_no_auto_restore', 13:07:15 INFO - 'tabpaint']}, 13:07:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:07:15 INFO - 'ts_paint', 13:07:15 INFO - 'tpaint', 13:07:15 INFO - 'sessionrestore', 13:07:15 INFO - 'sessionrestore_no_auto_restore', 13:07:15 INFO - 'tabpaint']}, 13:07:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:07:15 INFO - 'ts_paint', 13:07:15 INFO - 'tpaint', 13:07:15 INFO - 'sessionrestore', 13:07:15 INFO - 'sessionrestore_no_auto_restore', 13:07:15 INFO - 'tabpaint']}, 13:07:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['a11yr', 13:07:15 INFO - 'ts_paint', 13:07:15 INFO - 'tpaint', 13:07:15 INFO - 'sessionrestore', 13:07:15 INFO - 'sessionrestore_no_auto_restore', 13:07:15 INFO - 'tabpaint']}, 13:07:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['a11yr', 13:07:15 INFO - 'ts_paint', 13:07:15 INFO - 'tpaint', 13:07:15 INFO - 'sessionrestore', 13:07:15 INFO - 'sessionrestore_no_auto_restore', 13:07:15 INFO - 'tabpaint']}, 13:07:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['tsvgx', 13:07:15 INFO - 'tsvgr_opacity', 13:07:15 INFO - 'tart', 13:07:15 INFO - 'tscrollx', 13:07:15 INFO - 'cart']}, 13:07:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:07:15 INFO - 'tsvgr_opacity', 13:07:15 INFO - 'tart', 13:07:15 INFO - 'tscrollx', 13:07:15 INFO - 'cart']}, 13:07:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:15 INFO - 'talos_options': ['--disable-e10s'], 13:07:15 INFO - 'tests': ['tp5o']}, 13:07:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:15 INFO - 'tests': ['tp5o']}, 13:07:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:15 INFO - 'talos_options': ['--disable-e10s', 13:07:15 INFO - '--xperf_path', 13:07:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:15 INFO - 'tests': ['tp5n']}, 13:07:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:15 INFO - 'talos_options': ['--xperf_path', 13:07:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:15 INFO - 'tests': ['tp5n']}}, 13:07:15 INFO - 'talos.zip': {'path': '', 13:07:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:15 INFO - Running post-action listener: _resource_record_post_action 13:07:15 INFO - ##### 13:07:15 INFO - ##### Finished populate-webroot step (success) 13:07:15 INFO - ##### 13:07:15 INFO - ##### 13:07:15 INFO - ##### Running create-virtualenv step. 13:07:15 INFO - ##### 13:07:15 INFO - Running pre-action listener: _resource_record_pre_action 13:07:15 INFO - Running main action method: create_virtualenv 13:07:15 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:15 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 13:07:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:15 INFO - Using real prefix '/usr' 13:07:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:16 INFO - Installing distribute.............................................................................................................................................................................................done. 13:07:18 INFO - Installing pip.................done. 13:07:18 INFO - Return code: 0 13:07:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', '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 13:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:07:18 INFO - Using env: {'DISPLAY': ':0', 13:07:18 INFO - 'HOME': '/home/cltbld', 13:07:18 INFO - 'LANG': 'en_US.UTF-8', 13:07:18 INFO - 'LANGUAGE': 'en_US:en', 13:07:18 INFO - 'LOGNAME': 'cltbld', 13:07:18 INFO - 'MAIL': '/var/mail/cltbld', 13:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:18 INFO - 'MOZ_NO_REMOTE': '1', 13:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:18 INFO - 'NO_EM_RESTART': '1', 13:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:18 INFO - 'PWD': '/builds/slave/test', 13:07:18 INFO - 'SHELL': '/bin/bash', 13:07:18 INFO - 'SHLVL': '1', 13:07:18 INFO - 'TERM': 'linux', 13:07:18 INFO - 'TMOUT': '86400', 13:07:18 INFO - 'USER': 'cltbld', 13:07:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', 13:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:18 INFO - '_': '/tools/buildbot/bin/python'} 13:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:18 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 13:07:18 INFO - Cleaning up... 13:07:18 INFO - Return code: 0 13:07:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', '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 13:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 13:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 13:07:18 INFO - Using env: {'DISPLAY': ':0', 13:07:18 INFO - 'HOME': '/home/cltbld', 13:07:18 INFO - 'LANG': 'en_US.UTF-8', 13:07:18 INFO - 'LANGUAGE': 'en_US:en', 13:07:18 INFO - 'LOGNAME': 'cltbld', 13:07:18 INFO - 'MAIL': '/var/mail/cltbld', 13:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:18 INFO - 'MOZ_NO_REMOTE': '1', 13:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:18 INFO - 'NO_EM_RESTART': '1', 13:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:18 INFO - 'PWD': '/builds/slave/test', 13:07:18 INFO - 'SHELL': '/bin/bash', 13:07:18 INFO - 'SHLVL': '1', 13:07:18 INFO - 'TERM': 'linux', 13:07:18 INFO - 'TMOUT': '86400', 13:07:18 INFO - 'USER': 'cltbld', 13:07:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', 13:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:18 INFO - '_': '/tools/buildbot/bin/python'} 13:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:18 INFO - Downloading/unpacking psutil>=3.1.1 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:07:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:20 INFO - Installing collected packages: psutil 13:07:20 INFO - Running setup.py install for psutil 13:07:20 INFO - building 'psutil._psutil_linux' extension 13:07:20 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 13:07:21 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 13:07:21 INFO - building 'psutil._psutil_posix' extension 13:07:21 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 13:07:21 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 13:07:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:21 INFO - Successfully installed psutil 13:07:21 INFO - Cleaning up... 13:07:21 INFO - Return code: 0 13:07:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', '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 13:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 13:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 13:07:21 INFO - Using env: {'DISPLAY': ':0', 13:07:21 INFO - 'HOME': '/home/cltbld', 13:07:21 INFO - 'LANG': 'en_US.UTF-8', 13:07:21 INFO - 'LANGUAGE': 'en_US:en', 13:07:21 INFO - 'LOGNAME': 'cltbld', 13:07:21 INFO - 'MAIL': '/var/mail/cltbld', 13:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:21 INFO - 'MOZ_NO_REMOTE': '1', 13:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:21 INFO - 'NO_EM_RESTART': '1', 13:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:21 INFO - 'PWD': '/builds/slave/test', 13:07:21 INFO - 'SHELL': '/bin/bash', 13:07:21 INFO - 'SHLVL': '1', 13:07:21 INFO - 'TERM': 'linux', 13:07:21 INFO - 'TMOUT': '86400', 13:07:21 INFO - 'USER': 'cltbld', 13:07:21 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', 13:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:21 INFO - '_': '/tools/buildbot/bin/python'} 13:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:07:21 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 13:07:21 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 13:07:21 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 13:07:21 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 13:07:21 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 13:07:21 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 13:07:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:07:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:07:23 INFO - Installing collected packages: mozsystemmonitor 13:07:23 INFO - Running setup.py install for mozsystemmonitor 13:07:23 INFO - Successfully installed mozsystemmonitor 13:07:23 INFO - Cleaning up... 13:07:23 INFO - Return code: 0 13:07:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', '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 13:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema==2.5.1 13:07:23 INFO - Using env: {'DISPLAY': ':0', 13:07:23 INFO - 'HOME': '/home/cltbld', 13:07:23 INFO - 'LANG': 'en_US.UTF-8', 13:07:23 INFO - 'LANGUAGE': 'en_US:en', 13:07:23 INFO - 'LOGNAME': 'cltbld', 13:07:23 INFO - 'MAIL': '/var/mail/cltbld', 13:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:23 INFO - 'MOZ_NO_REMOTE': '1', 13:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:23 INFO - 'NO_EM_RESTART': '1', 13:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:23 INFO - 'PWD': '/builds/slave/test', 13:07:23 INFO - 'SHELL': '/bin/bash', 13:07:23 INFO - 'SHLVL': '1', 13:07:23 INFO - 'TERM': 'linux', 13:07:23 INFO - 'TMOUT': '86400', 13:07:23 INFO - 'USER': 'cltbld', 13:07:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', 13:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:23 INFO - '_': '/tools/buildbot/bin/python'} 13:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:23 INFO - Downloading/unpacking jsonschema==2.5.1 13:07:23 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 13:07:23 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 13:07:23 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 13:07:23 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 13:07:23 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 13:07:23 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 13:07:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:07:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:07:25 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 13:07:25 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 13:07:25 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 13:07:25 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 13:07:25 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 13:07:25 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 13:07:26 INFO - Downloading functools32-3.2.3-2.tar.gz 13:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:07:26 INFO - warning: no files found matching '*.txt' 13:07:26 INFO - no previously-included directories found matching 'build' 13:07:26 INFO - no previously-included directories found matching 'dist' 13:07:26 INFO - no previously-included directories found matching '.git*' 13:07:26 INFO - Installing collected packages: jsonschema, functools32 13:07:26 INFO - Running setup.py install for functools32 13:07:26 INFO - warning: no files found matching '*.txt' 13:07:26 INFO - no previously-included directories found matching 'build' 13:07:26 INFO - no previously-included directories found matching 'dist' 13:07:26 INFO - no previously-included directories found matching '.git*' 13:07:26 INFO - Successfully installed jsonschema functools32 13:07:26 INFO - Cleaning up... 13:07:26 INFO - Return code: 0 13:07:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', '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 13:07:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:07:26 INFO - Using env: {'DISPLAY': ':0', 13:07:26 INFO - 'HOME': '/home/cltbld', 13:07:26 INFO - 'LANG': 'en_US.UTF-8', 13:07:26 INFO - 'LANGUAGE': 'en_US:en', 13:07:26 INFO - 'LOGNAME': 'cltbld', 13:07:26 INFO - 'MAIL': '/var/mail/cltbld', 13:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:26 INFO - 'MOZ_NO_REMOTE': '1', 13:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:26 INFO - 'NO_EM_RESTART': '1', 13:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:26 INFO - 'PWD': '/builds/slave/test', 13:07:26 INFO - 'SHELL': '/bin/bash', 13:07:26 INFO - 'SHLVL': '1', 13:07:26 INFO - 'TERM': 'linux', 13:07:26 INFO - 'TMOUT': '86400', 13:07:26 INFO - 'USER': 'cltbld', 13:07:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', 13:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:26 INFO - '_': '/tools/buildbot/bin/python'} 13:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:26 INFO - Downloading/unpacking blobuploader==1.2.4 13:07:26 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 13:07:26 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 13:07:26 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 13:07:26 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 13:07:26 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 13:07:26 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 13:07:28 INFO - Downloading blobuploader-1.2.4.tar.gz 13:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:07:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:07:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07: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 13:07:29 INFO - Downloading docopt-0.6.1.tar.gz 13:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:07:29 INFO - Installing collected packages: blobuploader, requests, docopt 13:07:29 INFO - Running setup.py install for blobuploader 13:07:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:07:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:07:29 INFO - Running setup.py install for requests 13:07:29 INFO - Running setup.py install for docopt 13:07:29 INFO - Successfully installed blobuploader requests docopt 13:07:29 INFO - Cleaning up... 13:07:29 INFO - Return code: 0 13:07:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:29 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')]} 13:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:29 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')]} 13:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', '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 13:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 13:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 13:07:29 INFO - Using env: {'DISPLAY': ':0', 13:07:29 INFO - 'HOME': '/home/cltbld', 13:07:29 INFO - 'LANG': 'en_US.UTF-8', 13:07:29 INFO - 'LANGUAGE': 'en_US:en', 13:07:29 INFO - 'LOGNAME': 'cltbld', 13:07:29 INFO - 'MAIL': '/var/mail/cltbld', 13:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:29 INFO - 'MOZ_NO_REMOTE': '1', 13:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:29 INFO - 'NO_EM_RESTART': '1', 13:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:29 INFO - 'PWD': '/builds/slave/test', 13:07:29 INFO - 'SHELL': '/bin/bash', 13:07:29 INFO - 'SHLVL': '1', 13:07:29 INFO - 'TERM': 'linux', 13:07:29 INFO - 'TMOUT': '86400', 13:07:29 INFO - 'USER': 'cltbld', 13:07:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', 13:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:29 INFO - '_': '/tools/buildbot/bin/python'} 13:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:30 INFO - Running setup.py (path:/tmp/pip-7mfPth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:30 INFO - Running setup.py (path:/tmp/pip-ujHKp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:30 INFO - Running setup.py (path:/tmp/pip-Hft5Ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:30 INFO - Running setup.py (path:/tmp/pip-Vru1sR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:30 INFO - Running setup.py (path:/tmp/pip-ZDFvBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:30 INFO - Running setup.py (path:/tmp/pip-LLL6Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:30 INFO - Running setup.py (path:/tmp/pip-rYqN7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:30 INFO - Running setup.py (path:/tmp/pip-9tmsPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:30 INFO - Running setup.py (path:/tmp/pip-D20E9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:30 INFO - Running setup.py (path:/tmp/pip-82uqiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:30 INFO - Running setup.py (path:/tmp/pip-UHbXle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:30 INFO - Running setup.py (path:/tmp/pip-Lz1FSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:30 INFO - Running setup.py (path:/tmp/pip-aj9pnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:30 INFO - Running setup.py (path:/tmp/pip-Z_QxP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:31 INFO - Running setup.py (path:/tmp/pip-wZKgJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:31 INFO - Running setup.py (path:/tmp/pip-MeRXWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:31 INFO - Running setup.py (path:/tmp/pip-SxtIyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:07:31 INFO - Running setup.py install for manifestparser 13:07:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:07:31 INFO - Running setup.py install for mozcrash 13:07:31 INFO - Running setup.py install for mozdebug 13:07:31 INFO - Running setup.py install for mozdevice 13:07:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:07:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:07:31 INFO - Running setup.py install for mozfile 13:07:31 INFO - Running setup.py install for mozhttpd 13:07:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:07:31 INFO - Running setup.py install for mozinfo 13:07:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Running setup.py install for mozInstall 13:07:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Running setup.py install for mozleak 13:07:32 INFO - Running setup.py install for mozlog 13:07:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Running setup.py install for moznetwork 13:07:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Running setup.py install for mozprocess 13:07:32 INFO - Running setup.py install for mozprofile 13:07:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Running setup.py install for mozrunner 13:07:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:07:32 INFO - Running setup.py install for mozscreenshot 13:07:32 INFO - Running setup.py install for moztest 13:07:32 INFO - Running setup.py install for mozversion 13:07:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:07:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:07:33 INFO - Cleaning up... 13:07:33 INFO - Return code: 0 13:07:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:33 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')]} 13:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:33 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')]} 13:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', '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 13:07:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:07:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:07:33 INFO - Using env: {'DISPLAY': ':0', 13:07:33 INFO - 'HOME': '/home/cltbld', 13:07:33 INFO - 'LANG': 'en_US.UTF-8', 13:07:33 INFO - 'LANGUAGE': 'en_US:en', 13:07:33 INFO - 'LOGNAME': 'cltbld', 13:07:33 INFO - 'MAIL': '/var/mail/cltbld', 13:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:33 INFO - 'MOZ_NO_REMOTE': '1', 13:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:33 INFO - 'NO_EM_RESTART': '1', 13:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:33 INFO - 'PWD': '/builds/slave/test', 13:07:33 INFO - 'SHELL': '/bin/bash', 13:07:33 INFO - 'SHLVL': '1', 13:07:33 INFO - 'TERM': 'linux', 13:07:33 INFO - 'TMOUT': '86400', 13:07:33 INFO - 'USER': 'cltbld', 13:07:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', 13:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:33 INFO - '_': '/tools/buildbot/bin/python'} 13:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:33 INFO - Running setup.py (path:/tmp/pip-jR11I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:33 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)) 13:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:33 INFO - Running setup.py (path:/tmp/pip-uWim7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 13:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:33 INFO - Running setup.py (path:/tmp/pip-JCiyIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:33 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)) 13:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:33 INFO - Running setup.py (path:/tmp/pip-Oz3jYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 13:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:33 INFO - Running setup.py (path:/tmp/pip-9EogmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:33 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)) 13:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:33 INFO - Running setup.py (path:/tmp/pip-fMsw_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:33 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)) 13:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:33 INFO - Running setup.py (path:/tmp/pip-IqwPKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:33 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)) 13:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:33 INFO - Running setup.py (path:/tmp/pip-Nq1JLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:33 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)) 13:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:33 INFO - Running setup.py (path:/tmp/pip-Ix6r0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:33 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)) 13:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:33 INFO - Running setup.py (path:/tmp/pip-kX5wfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 13:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:34 INFO - Running setup.py (path:/tmp/pip-FmxfMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:34 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)) 13:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:34 INFO - Running setup.py (path:/tmp/pip-OHKP_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 13:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:34 INFO - Running setup.py (path:/tmp/pip-aQrLsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 13:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:34 INFO - Running setup.py (path:/tmp/pip-lzwObe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:34 INFO - Running setup.py (path:/tmp/pip-BL5xu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:34 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)) 13:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:34 INFO - Running setup.py (path:/tmp/pip-d16BMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:34 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)) 13:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:34 INFO - Running setup.py (path:/tmp/pip-NTNBtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:34 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)) 13:07:34 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:07:34 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:07:34 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)) 13:07:34 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:07:34 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:07:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:07:34 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 13:07:34 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 13:07:34 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 13:07:34 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 13:07:34 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 13:07:34 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 13:07:36 INFO - Downloading blessings-1.6.tar.gz 13:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:07:36 INFO - Installing collected packages: blessings 13:07:36 INFO - Running setup.py install for blessings 13:07:36 INFO - Successfully installed blessings 13:07:36 INFO - Cleaning up... 13:07:36 INFO - Return code: 0 13:07:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:07:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:07:36 INFO - Reading from file tmpfile_stdout 13:07:36 INFO - Current package versions: 13:07:36 INFO - argparse == 1.2.1 13:07:36 INFO - blessings == 1.6 13:07:36 INFO - blobuploader == 1.2.4 13:07:36 INFO - docopt == 0.6.1 13:07:36 INFO - functools32 == 3.2.3-2 13:07:36 INFO - jsonschema == 2.5.1 13:07:36 INFO - manifestparser == 1.1 13:07:36 INFO - mozInstall == 1.12 13:07:36 INFO - mozcrash == 0.17 13:07:36 INFO - mozdebug == 0.1 13:07:36 INFO - mozdevice == 0.48 13:07:36 INFO - mozfile == 1.2 13:07:36 INFO - mozhttpd == 0.7 13:07:36 INFO - mozinfo == 0.9 13:07:36 INFO - mozleak == 0.1 13:07:36 INFO - mozlog == 3.2 13:07:36 INFO - moznetwork == 0.27 13:07:36 INFO - mozprocess == 0.23 13:07:36 INFO - mozprofile == 0.28 13:07:36 INFO - mozrunner == 6.12 13:07:36 INFO - mozscreenshot == 0.1 13:07:36 INFO - mozsystemmonitor == 0.3 13:07:36 INFO - moztest == 0.7 13:07:36 INFO - mozversion == 1.4 13:07:36 INFO - psutil == 3.1.1 13:07:36 INFO - requests == 1.2.3 13:07:36 INFO - wsgiref == 0.1.2 13:07:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:36 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')]} 13:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:36 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')]} 13:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', '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 13:07:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 13:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 13:07:36 INFO - Using env: {'DISPLAY': ':0', 13:07:36 INFO - 'HOME': '/home/cltbld', 13:07:36 INFO - 'LANG': 'en_US.UTF-8', 13:07:36 INFO - 'LANGUAGE': 'en_US:en', 13:07:36 INFO - 'LOGNAME': 'cltbld', 13:07:36 INFO - 'MAIL': '/var/mail/cltbld', 13:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:36 INFO - 'MOZ_NO_REMOTE': '1', 13:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:36 INFO - 'NO_EM_RESTART': '1', 13:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:36 INFO - 'PWD': '/builds/slave/test', 13:07:36 INFO - 'SHELL': '/bin/bash', 13:07:36 INFO - 'SHLVL': '1', 13:07:36 INFO - 'TERM': 'linux', 13:07:36 INFO - 'TMOUT': '86400', 13:07:36 INFO - 'USER': 'cltbld', 13:07:36 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', 13:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:36 INFO - '_': '/tools/buildbot/bin/python'} 13:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:07:37 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 2)) 13:07:37 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 3)) 13:07:37 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 4)) 13:07:37 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 5)) 13:07:37 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 6)) 13:07:37 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 7)) 13:07:37 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 8)) 13:07:37 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 9)) 13:07:37 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:07:37 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 4)) 13:07:37 INFO - Cleaning up... 13:07:37 INFO - Return code: 0 13:07:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1904030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b33400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, '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': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', '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 13:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 13:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 13:07:37 INFO - Using env: {'DISPLAY': ':0', 13:07:37 INFO - 'HOME': '/home/cltbld', 13:07:37 INFO - 'LANG': 'en_US.UTF-8', 13:07:37 INFO - 'LANGUAGE': 'en_US:en', 13:07:37 INFO - 'LOGNAME': 'cltbld', 13:07:37 INFO - 'MAIL': '/var/mail/cltbld', 13:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:37 INFO - 'MOZ_NO_REMOTE': '1', 13:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:37 INFO - 'NO_EM_RESTART': '1', 13:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:37 INFO - 'PWD': '/builds/slave/test', 13:07:37 INFO - 'SHELL': '/bin/bash', 13:07:37 INFO - 'SHLVL': '1', 13:07:37 INFO - 'TERM': 'linux', 13:07:37 INFO - 'TMOUT': '86400', 13:07:37 INFO - 'USER': 'cltbld', 13:07:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', 13:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:37 INFO - '_': '/tools/buildbot/bin/python'} 13:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:07:37 INFO - Cleaning up... 13:07:37 INFO - Return code: 0 13:07:37 INFO - Running post-action listener: _resource_record_post_action 13:07:37 INFO - Running post-action listener: _start_resource_monitoring 13:07:37 INFO - Starting resource monitoring. 13:07:37 INFO - ##### 13:07:37 INFO - ##### Finished create-virtualenv step (success) 13:07:37 INFO - ##### 13:07:37 INFO - ##### 13:07:37 INFO - ##### Running install step. 13:07:37 INFO - ##### 13:07:37 INFO - Running pre-action listener: _resource_record_pre_action 13:07:37 INFO - Running main action method: install 13:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:07:37 INFO - Reading from file tmpfile_stdout 13:07:37 INFO - Detecting whether we're running mozinstall >=1.0... 13:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:07:37 INFO - Reading from file tmpfile_stdout 13:07:37 INFO - Output received: 13:07:37 INFO - Usage: mozinstall [options] installer 13:07:37 INFO - Options: 13:07:37 INFO - -h, --help show this help message and exit 13:07:37 INFO - -d DEST, --destination=DEST 13:07:37 INFO - Directory to install application into. [default: 13:07:37 INFO - "/builds/slave/test"] 13:07:37 INFO - --app=APP Application being installed. [default: firefox] 13:07:37 INFO - mkdir: /builds/slave/test/build/application 13:07:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:07:54 INFO - Reading from file tmpfile_stdout 13:07:54 INFO - Output received: 13:07:54 INFO - /builds/slave/test/build/application/firefox/firefox 13:07:54 INFO - Running post-action listener: _resource_record_post_action 13:07:54 INFO - ##### 13:07:54 INFO - ##### Finished install step (success) 13:07:54 INFO - ##### 13:07:54 INFO - ##### 13:07:54 INFO - ##### Running run-tests step. 13:07:54 INFO - ##### 13:07:54 INFO - Running pre-action listener: _resource_record_pre_action 13:07:54 INFO - Running main action method: run_tests 13:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:07:54 INFO - Python 2.7.3 13:07:54 INFO - Return code: 0 13:07:54 INFO - grabbing minidump binary from tooltool 13:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:54 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc2570>, '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 0x1bc3470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:07:54 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 13:07:54 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 13:07:54 INFO - Calling ['/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'] with output_timeout 600 13:07:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:07:54 INFO - Return code: 0 13:07:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:07:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:07:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:07:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:07:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:07:54 INFO - Using env: {'DISPLAY': ':0', 13:07:54 INFO - 'HOME': '/home/cltbld', 13:07:54 INFO - 'LANG': 'en_US.UTF-8', 13:07:54 INFO - 'LANGUAGE': 'en_US:en', 13:07:54 INFO - 'LOGNAME': 'cltbld', 13:07:54 INFO - 'MAIL': '/var/mail/cltbld', 13:07:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:07:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:54 INFO - 'MOZ_NO_REMOTE': '1', 13:07:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:54 INFO - 'NO_EM_RESTART': '1', 13:07:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:54 INFO - 'PWD': '/builds/slave/test', 13:07:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:07:54 INFO - 'SHELL': '/bin/bash', 13:07:54 INFO - 'SHLVL': '1', 13:07:54 INFO - 'TERM': 'linux', 13:07:54 INFO - 'TMOUT': '86400', 13:07:54 INFO - 'USER': 'cltbld', 13:07:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773', 13:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:54 INFO - '_': '/tools/buildbot/bin/python'} 13:07:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:07:55 INFO - mozversion application_buildid: 20160716103004 13:07:55 INFO - mozversion application_changeset: dc97f8b36a22d36be518e56261df85205bb535d2 13:07:55 INFO - mozversion application_display_name: Nightly 13:07:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:07:55 INFO - mozversion application_name: Firefox 13:07:55 INFO - mozversion application_remotingname: firefox 13:07:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:07:55 INFO - mozversion application_vendor: Mozilla 13:07:55 INFO - mozversion application_version: 50.0a1 13:07:55 INFO - mozversion platform_buildid: 20160716103004 13:07:55 INFO - mozversion platform_changeset: dc97f8b36a22d36be518e56261df85205bb535d2 13:07:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:07:55 INFO - mozversion platform_version: 50.0a1 13:07:55 INFO - using testdate: 1468699675 13:07:55 INFO - actual date: 1468699675 13:07:55 INFO - starting webserver on 'localhost:48140' 13:07:55 INFO - SUITE-START | Running 2 tests 13:07:55 INFO - TEST-START | dromaeo_css 13:07:55 INFO - operating with platform_type : linux_ 13:07:55 INFO - Initialising browser for dromaeo_css test... 13:07:55 INFO - TEST-INFO | started process 19577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7N2Kug/profile http://localhost:48140/getInfo.html) 13:07:58 INFO - PROCESS | 19577 | JavaScript error: , line 0: uncaught exception: undefined 13:07:59 INFO - PROCESS | 19577 | __metrics Screen width/height:1600/1200 13:07:59 INFO - PROCESS | 19577 | colorDepth:24 13:07:59 INFO - PROCESS | 19577 | Browser inner width/height: 1024/697 13:07:59 INFO - PROCESS | 19577 | __metrics 13:08:00 ERROR - PROCESS | 19577 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 13:08:01 INFO - TEST-INFO | 19577: exit 0 13:08:01 INFO - Browser initialized. 13:08:01 INFO - Running cycle 1/1 for dromaeo_css test... 13:08:01 INFO - TEST-INFO | started process 19698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7N2Kug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:13 INFO - PROCESS | 19698 | RSS: Main: 167858176 13:08:13 INFO - PROCESS | 19698 | 13:09:02 INFO - PROCESS | 19698 | 1468699742655 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] 13:11:10 INFO - PROCESS | 19698 | Cycle 1(1): loaded http://localhost:48140/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48140/tests/dromaeo/cssquery-ext.html) 13:11:11 INFO - PROCESS | 19698 | RSS: Main: 171560960 13:11:11 INFO - PROCESS | 19698 | 13:14:13 INFO - PROCESS | 19698 | Cycle 1(1): loaded http://localhost:48140/tests/dromaeo/cssquery-ext.html (next: http://localhost:48140/tests/dromaeo/cssquery-jquery.html) 13:14:14 INFO - PROCESS | 19698 | RSS: Main: 168243200 13:14:14 INFO - PROCESS | 19698 | 13:17:15 INFO - PROCESS | 19698 | Cycle 1(1): loaded http://localhost:48140/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48140/tests/dromaeo/cssquery-mootools.html) 13:17:16 INFO - PROCESS | 19698 | RSS: Main: 172896256 13:17:16 INFO - PROCESS | 19698 | 13:20:18 INFO - PROCESS | 19698 | Cycle 1(1): loaded http://localhost:48140/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48140/tests/dromaeo/cssquery-prototype.html) 13:20:19 INFO - PROCESS | 19698 | RSS: Main: 167636992 13:20:19 INFO - PROCESS | 19698 | 13:23:21 INFO - PROCESS | 19698 | Cycle 1(1): loaded http://localhost:48140/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48140/tests/dromaeo/cssquery-yui.html) 13:23:22 INFO - PROCESS | 19698 | RSS: Main: 169807872 13:23:22 INFO - PROCESS | 19698 | 13:26:24 INFO - PROCESS | 19698 | Cycle 1(1): loaded http://localhost:48140/tests/dromaeo/cssquery-yui.html (next: http://localhost:48140/tests/dromaeo/cssquery-dojo.html) 13:26:25 INFO - PROCESS | 19698 | RSS: Main: 172716032 13:26:25 INFO - PROCESS | 19698 | 13:26:25 INFO - PROCESS | 19698 | __start_tp_report 13:26:25 INFO - PROCESS | 19698 | _x_x_mozilla_page_load 13:26:25 INFO - PROCESS | 19698 | _x_x_mozilla_page_load_details 13:26:25 INFO - PROCESS | 19698 | |i|pagename|runs| 13:26:25 INFO - PROCESS | 19698 | |0;dojo.html;3107.3474570340227;3113.7976031557946;3117.3765246950607;3141.811491310523;3159.857806398712;5442.945570544293;5445.83662490125;5446.564274858012;5460.78156873725;5519.254900588429;5294.232336311233;5342.465753424655;5347.919781203285;5391.191321301807;5407.161889907071;4865.683730557511;4954.405471343443;5019.0463811875625;5099.286099946011;5114.053900028488;5049.4698056704065;5108.744562771846;5115.437301896788;5121.436641969381;5138.177891537355;437.80150420139887;4978.477259887714;4994.675346102528;5021.999999999982;5077.213031980049;4987.800487980477;4993.800247990076;4995.725235112068;5012.573931215851;5033.119204139298;4973.7513124344;4985.127602669555;4989.226669866177;5015.5736762375245;5023.2214006829;5274.525292723673;5278.630495865291;5340.706261155635;5385.649932754359;5453.590980676426;5682.147677848315;5691.117876729114;5693.146028095777;5695.487406133468;5713.171590119451;5711.7144142792695;5762.97118514409;5772.220750198711;5775.249217601727;5796.942030579682;5434.157705555645;5444.3194600674915;5461.99999999996;5478.643888147258;5503.3395992480755;5989.970050149721;5991.7603295867675;5995.700214989233;6001.549883758736;6049.606775559574;5598.552115830806;5670.376258611549;5770.19217309577;5799.681017543991;5814.59297849155;5822.3304320003745;5847.590668653239;5853.2976042875125;5858.2677165354335;5910;5757.88484230313;5792.304923409218;5793.565482588822;5802.4197580241635;5816.680082595413;5649.68926709035;5809.157672137517;5818.883622327529;5848;5868.941310586925;4376.256036473807;4410.404595379647;4494.955050449519;4499.595036446735;4552.726836389827;3983.960160398417;4003.2393845169327;4006.6994975376965;4022.6982976276895;4048.8785336439955;5454.154606036071;5496.780128794883;5602.97198514013;5605.187247849039;5605.831825045255;5836.766529338779;5910.143029260733;5912.970435147797;5917.822465326047;5975.223220981245;5557.722113894289;5563.388027316992;5565.30433695788;5574.832755017356;5583.609147359727;4898.79979405048;4919.0899683558655;4962.330085438492;5001.249812528077;5003.699778013331;6044.1840351552855;6044.274687037584;6046.486048685823;6075.088736689444;6087.6956152192215;5844.912326315024;5856.882862342729;5869.35437101927;5881.3236477803885;5883.205767221456;5930.555208359477;5971.402859713994;5993.041113421831;6025.126356678345;6046.365131661112;5718;5740.282464691913;5757;5759;5762.250907382014;5841;5849.444302791228;5850.707464626837;5869.73586188614;5870.26621672291;5509.724513774215;5671.886562268649;5727.140928860705;5767.192593037062;5813.302403711582;5758.568107391879;5774.9133762994425;5781.653100813965;5791.507721843691;5795.942040579709;5537.750801214036;5674.886502269849;5679.204911312337;5732.713364331683;5733.397993210653;5628.380878103323;5635.323761148688;5664.235328230801;5679.403662615531;5685.090385538294;5604.887902242014;5667.631603945731;5671.8865622688145;5673.8865222694485;5675.858103547279 13:26:25 INFO - PROCESS | 19698 | |1;ext.html;549.5831342982227;593.9376365481625;604.6613896218117;605.7910021042741;637.1716768201337;39797.2040559189;43758.34362484558;44245;44479;44557;44127.3380899286;44596.554034459645;44599;44609.10781784362;44660.3300950486;8840.115988401141;8928.598213080395;8947.821043579124;8982.820343593125;8983.19151276385;8943.418677785956;9045.954770226139;9050.547472626375;9087.454752714826;9089.181973622373;9095.181433670969;9102.226310763594;9108.59011344491;9134.908650913505;9157.358984871062;9039.819203615923;9065.682701105463;9079;9085.273178145733;9131.086891310815;8953.283737301;8984.146506081977;9020.909790902073;9049.276057915351;9067.365284430092;33109.337813243845;41121.794391028154;41316.58683413157;41583.792081039704;41623;3341.832908354597;3418.5555877735983;3515.455104458813;3556.395412779834;3599.42409214527;31973;32104.839475802706;32248.6775132248;32434.837825810955;33330;4316.6546676265825;4342.848000319974;4396.450443694538;4452.487963884162;4467.039586488921;350635;350741;351060;351207;351788.41057947255;35337.116572085906;35360.82319588386;35378;35537.64462355395;36104.63895361013;37024.81487592545;37264.627353726115;37416;37546.43680344797;37613.81193094017;14817.851821481647;15054.322555485029;15059.096454212782;15113.697726045417;15119.54641360739;12338.198017128858;12366.690832729253;12403.875961240272;12416.937915310365;12470.875291247154;8376.748697538962;8482.618282177193;8507.914920850835;8530.914690853013;8554.871676924851;3211.132994091582;3300.9339813204083;3301.7783420134706;3305;3317;1064.6380230721593;1125.2798209146154;1146.896779289868;1198.8801119888117;1232.1128787273149;33599.664003359656;33713.49429758556;33931.66068339335;34033.659663403545;34214.31571368608;1107.828286615576;1119.9552017919355;1144.542183126756;1157.4907040901976;1275.4515558309831;17263.223154958057;17780.97723387027;17814.46556603304;17826.91086544585;17833.286668533114;157097;158688;574271;579099;579162;59874.70062649659;61464;61597;61801;61810;1331.8335208098988;1364.1201425080767;1378.6346618146;1384.2732565403041;1397.2594524901817;31947.840260798548;32498.51252231171;32775.50836737498;33119.834400828804;33696;53522.73238633782;53572.732136339066;53864.730676347936;53880;53929;490268;491044;491894;493086;495722;26572.335691607863;27074;28227.71772282251;28955.42089158247;29031;49555;50201.74899125481;50274;50630.493695064055;51123.23315150201;41491.37762933498;42879;42988.78505607452;43432.34851477294;43512;42590.78704606457;42989;43105.784471077444;43124.35313470363;43334.78332608317;40465;40577.18845623012;40835.79582102071;42812.57187428086;42910.78544607257;35721.642783571835;38405.4239186418;38457.807710962385;38477;38479.807600961816;28960.710392896643;29249.268768280963;29293;29447.705522944496;29620.851895740383 13:26:25 INFO - PROCESS | 19698 | |2;jquery.html;393.88577312579355;396.3579002016733;397.280921532027;403.3204051173772;414.50880706362943;15987.280572374242;19342.613147737055;20162.59674806503;20861.26985555504;21011.57976840464;19415.4175374739;19906;19954.201831926704;19994.700079498783;20005.899970500162;5484.890302193954;5862.88274234515;5868.677222752747;5874.030784920505;5876.676782776945;5617.634853734494;5762.049261871786;5844.1818145459665;5849.590528662995;5855.79504717335;5711.371749107595;5713.114467257561;5745.368009518949;5761.625494342875;5789.507891829199;5525.723713814293;5717.285339332583;5721.370649228582;5733.111367738007;5766.135079738031;5075.467075957045;5087.745612719349;5091.389033315989;5102.38771347437;5133.563647090002;21937.561248774935;23064.308070757903;23082.53834923292;23524.294271171722;23721;2366.9171578994824;2424;2449.155041510676;2544.656471376359;2602.8958841646313;10339.948300258451;10584.682459526226;10611.787764244671;13275.668108297274;13485.941776561334;1950.317388913883;2000.9599808003904;2015.5364266218705;2043.7751847296934;2047.9590408191902;86633;87948.56025719958;87976.560117199;88870.55564722135;89686.5515672424;10874.293170943864;11100.888991110147;11194.10447164225;11314.490847911864;11366.602168924048;12148.149629525848;12769.0423218259;12897.419616117297;15662;15739.685206296039;7807.336376407955;7923.603819808986;7966.601669916481;8018.278354948083;8053.07389650186;7821.765347039598;7858.5677787722225;8055.718049868226;8085.636146373427;8120.309773669186;3984.5019372578427;3986.5216174059296;4076.3274059780397;4120.1553681495825;4129.215449064728;1997.3308941504467;2007.1168685778212;2024.382563318202;2028.239410221167;2058.423641380416;920.2959735802117;965.2422848064236;972.7616733900239;1030.6650338639972;1106.7461662711603;19058.809411905702;19599.706004409945;19669.60660786776;19789.60420791576;20091;1008.2639673038576;1018.9898101018895;1030.701096681969;1053.1627356251797;1080.670395529371;10546.525406356732;10934.617288394868;10964.287321324247;10993.835092473619;11027.724306892393;536862;539604;542076;543592;549379;93423.53288233651;93765;95689.52155239179;96623.51688241654;96989;1006.1447769395954;1015.8577799108131;1027.9486025698686;1028.1209565821116;1029.120102312512;16818;17127.400540981005;17202.65594688124;17248.655026899643;17581.472555823344;44440;44972.77513612411;45086.64740057803;45425.31862022006;45436.31845522386;62291;65274.67362663346;65288.347116528224;65409.67295163494;65653.67173164104;7526.698932042876;7790.337821285254;8637.179467950535;8698.086700896567;8734.213920747163;13047.543335983575;13221.272829994443;13270.933645331712;13352.799708004582;13391.464341426234;6192.783252586138;8473.898393208843;10865.13078953666;11913.16607837443;12083;11614.883851161718;11668.88331116678;11706.941465292619;11754.942055215071;11766;11620.186586938833;11903.226290291102;11929.403529823301;12127.636170914886;12196.390180491117;7718.266764657348;7960.681572737026;7961.442699011013;7993.960030199812;8151.062627797879;10767.300125491818;11744.236624619372;11802.409879506162;11969.581064662694;12163.148579599343 13:26:25 INFO - PROCESS | 19698 | |3;mootools.html;1479.3490864019827;1492.2538730634683;1638.4265507072525;1796.452082114956;1812.8096549862264;7449;8580.44227125238;8582.957085214573;9191.1727944485;9195.862062069074;8791.604377802998;9001;9027.954860225705;9031.232345250644;9090.136437038487;2344.6951896253463;2363.9881800590974;2371.158238825218;2371.833971621987;2376.7147942246957;2339.578875802355;2343.4844334246523;2380.833341666084;2382.309130352196;2388.3790214544256;2355.9764402356013;2367.0531787285136;2368.786809187173;2401.2556107606697;2403.5553422616786;2327.371609665398;2351.6119840226515;2356.1871154451687;2364.598018336887;2367.0768400323886;2256.187772401934;2268.0814270220585;2273.30664147435;2276.1578216059997;2281.6805647209403;9138.17756401927;9171.358004939657;9199.172074513259;9246.58390372428;9250.121238482334;5180.171172612401;5299.33758280215;5372.54333381663;5374.220737993008;5390.757415916293;3388.491726241059;3517.8065206413635;3547.3792086385038;3612.24142929985;3651.1602331463914;1172.818213176959;1198.646399312205;1202.206543681175;1250.0312258000122;1256.1395444120715;12854.393200849894;12892.226466412045;12897.161684490384;12904.677383065498;12905.935470322682;4706.066827716946;4738.47876733559;4789.185838407479;4859.07677541266;4937.40751109862;10639.89360106389;10661.147108231324;10663.573457061786;10696.786064278827;10765.89234107649;5378.542823860016;5380.811671591554;5418.539424148991;5435.320584926884;5436.266104075979;4378.868633940987;4905.9264111038365;4969.329140566049;5052.8484145475695;5058.1654027085115;4093.058407625277;4101.887527923122;4107.589241075869;4134.359174327984;4178.498580170338;1314.9289868457026;1331.088204579866;1341.4835288413835;1342.5502456676927;1363.761341765207;1045.4668119259081;1056.630179437191;1059.0627294843964;1084.5770149641646;1087.2986923434341;6407.615543067431;6515.762005218993;6526.608403495806;6543.672816359163;6545;446.2257982400532;459.36148753233033;461.28270539311694;465.2625588442289;473.656598965754;4105.322621767435;4167.06241095751;4180.226658068267;4185.811638476276;4188.790560471964;10926.562937482571;11286.548538058385;11325.150613704005;11403.315801051964;11429.885701143048;11194.328340299608;11212.719682007852;11230.550777968952;11271.436428178722;11326.546938122383;8041.8793718094275;8191.8771218431775;8262.339012878956;8351.248387645019;8357.498550087013;6361.109444677842;6579.901301480578;6660.411821657169;6674.265830758515;6733.764318248838;10206.13247873939;10252;10347.068763811292;10356;10443.634472793416;10268.537915793957;10432.739181520523;10535.789284214427;10557.683269501927;10578;7071.292870712888;7663.463557550918;7933.127355990721;8089.959550202211;8213.260806527442;8880.200781929658;8892.822143557221;8898.199162075185;8918.24194943437;8942.195202431813;7747.961260193889;7910.446268761361;7959.044914610284;8045.155258697752;8114.756557303291;7846.0976987647155;7929.881051784343;7935.960320198362;7974.561399123104;7977.242161994601;7205.387542058984;7310;7440.7023719052795;7479.663415146223;7486.438517111347;5447.400785913625;5490.560755139659;5546.112621980464;5631.380548139783;5645.858853528531;5352.304200453916;5404.7297635118875;5607.383187849252;5635.718214089361;5783.884322313615 13:26:25 INFO - PROCESS | 19698 | |4;prototype.html;328.5236407209547;330.8511169973512;334.80915877949576;339.0303731328401;340.0716045196615;5461.726913654321;5645.633033852797;5728.7110400159945;5745.683987380692;5784.884302313956;5612.130119831432;5648.604597678164;5681.119426488891;5691.8577035574135;5696.25948626679;4427.579379958899;4440.622547083485;4450.577195166462;4459.777011149429;4472.955270447286;4152.342500799491;4355.281378572532;4379.547453426092;4439.422875026242;4442.622377097934;4317.4819021717285;4347.5652434756585;4352.630026447756;4355.629771469429;4359.084592235635;4367.104743527585;4373.497047839507;4375.8249670013165;4383.3863259143745;4384.517703052662;3742.3450896093345;3775.8112094395447;3821.7706937583835;3828.4257361395735;3841.4621952926614;5473.576870013785;5477.780888764445;5478.260434841325;5496.917546236809;5508.03609368363;4953.975230123826;4955.60355171589;4956.166218499142;4965.230389289666;5002.949970500321;5804.680742559158;5932.584719069667;5941.405859414067;5957.553183511211;5968.492678122365;4140.503139623234;4140.585941405865;4151.543330233671;4180.686448516343;4196.097838964607;6098.847528811771;6126.540509461808;6183.907241391383;6206.510437494969;6224.439800417938;4194.916101677949;4247.256730072225;4248.766317852548;4260.318349064135;4288.1638080573985;4283.5502272260965;4288.592583704543;4290.785460726951;4327.783610819446;4362.9781851091175;4981.178105612534;5025;5036.294918711384;5036.64743467961;5043.344365232496;5631.211630371751;5922.407759224043;5959.433853783884;5993.970030149909;6066.908996364969;1465.4504560789703;1480.8297045839652;1483.2657834372055;1493.3056128900114;1497.430976229026;883.5626364949263;917.2295271971576;938.1931538876561;939.7650587353162;942.1708896171325;5027.597792176617;5029.874253143627;5040.218766091261;5053.216751403538;5077.517635824591;5375.139977603565;5389.299391079213;5421.810236641778;5424.504727825166;5438.945610543923;5072.213806859942;5085.067674283749;5088.567471764942;5350.491703288181;5790.218320526675;3247.3342964692183;3265.248992731685;3274.345130973815;3298.3897978873506;3300.752443566742;6117.96941015292;6355.917380070662;6371.23545174582;6403.679816009274;6406.935930640727;6246.781362652286;6251.937480625226;6259.435141214696;6260.436560709558;6308.337624549448;6305.211848518935;6306.9684651576445;6322.683865806691;6358.7456501740335;6382.234131904108;5858.238429004202;6013.5189184865985;6079.696015199311;6091.847703807263;6102;6021.789237376671;6058.27300723916;6077.6961151943115;6116.868379349835;6169.537284703755;6098.390160983866;6333.669929314711;6400.967995160181;6401.943679293051;6461.386168314003;4261.74429534229;4285.4000439939055;4296.806643701104;4309.612134907873;4332.220200363839;6234.096056071935;6248.562600617913;6249.562530622995;6270.529710271839;6271.153394291712;5655.858603534944;5983.401659833982;5989.311229208697;6000.279966404059;6018.277806663228;5982.235240603945;6005.747844558291;6010.617557961606;6024.849378765566;6054.758774451315;5749.9712501437225;5924.585279030426;5932.911006334994;5940.554458415722;5977.641341519523;5976.521878249642;6001.789937352171;6025.638461692312;6027.126066720213;6029.78895738647;5844.853878653068;5864.706764661835;5901.645901245939;5916.970415147896;5946.137810017437 13:26:25 INFO - PROCESS | 19698 | |5;yui.html;780.6213986216684;795.769226924192;816.8529664660363;843.0490604962089;850.8218959463771;15412.691746165085;16548.83451165488;16573;16612;16644.833551664495;15339;16130.435434759785;16146.596335091599;16895.15524223787;16922.576935576584;808.0424696734359;815.5799763121997;833.3666413525734;837.0917554453425;837.4849467577426;833.2500749325595;842.2335674536142;842.5744998775609;842.6755699055877;843.0936743001298;875.7372788163557;876.3471213945587;876.7588913048899;877.7630039889226;879.705298724928;868.891388576428;869.8477766390856;869.886914701088;871.376965469689;872.1148034744707;633.0093403823048;637.2321352769948;637.3499030988365;637.6301744987896;637.7417146055855;16866.746998795028;17049.57376065596;17068.743968840477;17101.48695539136;17102.31590736369;14859.554213373616;14910.17994010329;15021.173835439047;15625.531234062997;15681.607959800982;12931.741365172738;12981.805272920914;13058;13096.410661520255;13601.59195224135;3971.106501037272;4003.97998010011;4132.504099508048;4153.460050193456;4204.600562946515;83035;83911.99999999939;84495.57752211261;84924.57537712334;85046.57476712638;11834;11940;12036.157468977262;12255.93872030652;12469.376531173404;22028.11887524513;22171.55656886853;22199.22302719397;22212.222572209896;22317.888410557844;9039.412438191628;9074.682386116454;9229.723108306762;9231.446113233227;9237;4788.712677239377;4891.926621100686;5022.2466630005065;5181.896362072737;5298.867528311823;3723.6834869035893;4059.939100913489;4296.2696341621995;4296.978515107405;4331.328644060176;721.2174790352421;721.5526373648372;729.3909833381281;729.6096588325327;729.7847135095053;627.9215098112736;657.1916542652564;737.1854101218184;755.5859030397936;764.9158592554815;9812.509374531388;10042.949785251027;10142.695719128438;10200.591976320864;10632.681019569425;681.9181698196248;734.302412707919;783.3889566138307;784.8312612788278;793.2503783924136;4844.927326090041;5064.088464076428;5098.923516147261;5257.158854583248;5290.761915713802;87170.56414718012;90344.54827725819;91778;107655;115493;90555;92253;99455.50272248738;103767.4811625937;105639;85884.57057714672;86725.56637216899;88182.55908720415;89021.55489222641;89213;9485.33602647808;9663.27525435581;9664.75838104053;9724.076212759777;9911.553980071058;52691;52959;53280.20079698885;54493.45506544884;54577.45422545724;68952.6552367235;70135.29864701288;78559.21440785748;79020;82729;13903.860961390257;13946.16323020622;13986.790198146833;14106.858931410554;14178.716425671635;15846.762298565762;16000.279987400361;16006.67986640284;16018.519444416686;16908.830911690726;14975.625609359853;15048.172350520388;15053.94622376467;15298.31157597933;15502.9224853875;14673.192974386084;14719.268607770788;14989.875759318313;15097.698046039237;15556.844431555539;14434.927825360806;14614.342354593857;14758.33587488544;14967.251637418303;15199.088054716753;11647.41762911868;11891.28652280866;12018.663998494283;12162.635120946386;12437.253764774143;11079.058280046287;11517.596884109016;12655.303958282015;12681.873181268069;12725.681857953625 13:26:25 INFO - PROCESS | 19698 | __end_tp_report 13:26:25 INFO - PROCESS | 19698 | __start_cc_report 13:26:25 INFO - PROCESS | 19698 | _x_x_mozilla_cycle_collect,362 13:26:25 INFO - PROCESS | 19698 | __end_cc_report 13:26:25 INFO - PROCESS | 19698 | __startTimestamp1468700785003__endTimestamp 13:26:25 INFO - PROCESS | 19698 | 13:26:25 INFO - PROCESS | 19698 | ------- Summary: start ------- 13:26:25 INFO - PROCESS | 19698 | Number of tests: 6 13:26:25 INFO - PROCESS | 19698 | 13:26:25 INFO - PROCESS | 19698 | [#0] dojo.html Cycles:165 Average:5396.52 Median:5664.24 stddev:722.81 (12.8%) stddev-sans-first:702.37 13:26:25 INFO - PROCESS | 19698 | Values: 3107.3 3113.8 3117.4 3141.8 3159.9 5442.9 5445.8 5446.6 5460.8 5519.3 5294.2 5342.5 5347.9 5391.2 5407.2 4865.7 4954.4 5019.0 5099.3 5114.1 5049.5 5108.7 5115.4 5121.4 5138.2 437.8 4978.5 4994.7 5022.0 5077.2 4987.8 4993.8 4995.7 5012.6 5033.1 4973.8 4985.1 4989.2 5015.6 5023.2 5274.5 5278.6 5340.7 5385.6 5453.6 5682.1 5691.1 5693.1 5695.5 5713.2 5711.7 5763.0 5772.2 5775.2 5796.9 5434.2 5444.3 5462.0 5478.6 5503.3 5990.0 5991.8 5995.7 6001.5 6049.6 5598.6 5670.4 5770.2 5799.7 5814.6 5822.3 5847.6 5853.3 5858.3 5910.0 5757.9 5792.3 5793.6 5802.4 5816.7 5649.7 5809.2 5818.9 5848.0 5868.9 4376.3 4410.4 4495.0 4499.6 4552.7 3984.0 4003.2 4006.7 4022.7 4048.9 5454.2 5496.8 5603.0 5605.2 5605.8 5836.8 5910.1 5913.0 5917.8 5975.2 5557.7 5563.4 5565.3 5574.8 5583.6 4898.8 4919.1 4962.3 5001.2 5003.7 6044.2 6044.3 6046.5 6075.1 6087.7 5844.9 5856.9 5869.4 5881.3 5883.2 5930.6 5971.4 5993.0 6025.1 6046.4 5718.0 5740.3 5757.0 5759.0 5762.3 5841.0 5849.4 5850.7 5869.7 5870.3 5509.7 5671.9 5727.1 5767.2 5813.3 5758.6 5774.9 5781.7 5791.5 5795.9 5537.8 5674.9 5679.2 5732.7 5733.4 5628.4 5635.3 5664.2 5679.4 5685.1 5604.9 5667.6 5671.9 5673.9 5675.9 13:26:25 INFO - PROCESS | 19698 | 13:26:25 INFO - PROCESS | 19698 | [#1] ext.html Cycles:180 Average:57086.92 Median:40706.49 stddev:116847.22 (287.0%) stddev-sans-first:117097.90 13:26:25 INFO - PROCESS | 19698 | Values: 549.6 593.9 604.7 605.8 637.2 39797.2 43758.3 44245.0 44479.0 44557.0 44127.3 44596.6 44599.0 44609.1 44660.3 8840.1 8928.6 8947.8 8982.8 8983.2 8943.4 9046.0 9050.5 9087.5 9089.2 9095.2 9102.2 9108.6 9134.9 9157.4 9039.8 9065.7 9079.0 9085.3 9131.1 8953.3 8984.1 9020.9 9049.3 9067.4 33109.3 41121.8 41316.6 41583.8 41623.0 3341.8 3418.6 3515.5 3556.4 3599.4 31973.0 32104.8 32248.7 32434.8 33330.0 4316.7 4342.8 4396.5 4452.5 4467.0 350635.0 350741.0 351060.0 351207.0 351788.4 35337.1 35360.8 35378.0 35537.6 36104.6 37024.8 37264.6 37416.0 37546.4 37613.8 14817.9 15054.3 15059.1 15113.7 15119.5 12338.2 12366.7 12403.9 12416.9 12470.9 8376.7 8482.6 8507.9 8530.9 8554.9 3211.1 3300.9 3301.8 3305.0 3317.0 1064.6 1125.3 1146.9 1198.9 1232.1 33599.7 33713.5 33931.7 34033.7 34214.3 1107.8 1120.0 1144.5 1157.5 1275.5 17263.2 17781.0 17814.5 17826.9 17833.3 157097.0 158688.0 574271.0 579099.0 579162.0 59874.7 61464.0 61597.0 61801.0 61810.0 1331.8 1364.1 1378.6 1384.3 1397.3 31947.8 32498.5 32775.5 33119.8 33696.0 53522.7 53572.7 53864.7 53880.0 53929.0 490268.0 491044.0 491894.0 493086.0 495722.0 26572.3 27074.0 28227.7 28955.4 29031.0 49555.0 50201.7 50274.0 50630.5 51123.2 41491.4 42879.0 42988.8 43432.3 43512.0 42590.8 42989.0 43105.8 43124.4 43334.8 40465.0 40577.2 40835.8 42812.6 42910.8 35721.6 38405.4 38457.8 38477.0 38479.8 28960.7 29249.3 29293.0 29447.7 29620.9 13:26:25 INFO - PROCESS | 19698 | 13:26:25 INFO - PROCESS | 19698 | [#2] jquery.html Cycles:180 Average:30980.82 Median:13072.50 stddev:89437.86 (684.2%) stddev-sans-first:89659.27 13:26:25 INFO - PROCESS | 19698 | Values: 393.9 396.4 397.3 403.3 414.5 15987.3 19342.6 20162.6 20861.3 21011.6 19415.4 19906.0 19954.2 19994.7 20005.9 5484.9 5862.9 5868.7 5874.0 5876.7 5617.6 5762.0 5844.2 5849.6 5855.8 5711.4 5713.1 5745.4 5761.6 5789.5 5525.7 5717.3 5721.4 5733.1 5766.1 5075.5 5087.7 5091.4 5102.4 5133.6 21937.6 23064.3 23082.5 23524.3 23721.0 2366.9 2424.0 2449.2 2544.7 2602.9 10339.9 10584.7 10611.8 13275.7 13485.9 1950.3 2001.0 2015.5 2043.8 2048.0 86633.0 87948.6 87976.6 88870.6 89686.6 10874.3 11100.9 11194.1 11314.5 11366.6 12148.1 12769.0 12897.4 15662.0 15739.7 7807.3 7923.6 7966.6 8018.3 8053.1 7821.8 7858.6 8055.7 8085.6 8120.3 3984.5 3986.5 4076.3 4120.2 4129.2 1997.3 2007.1 2024.4 2028.2 2058.4 920.3 965.2 972.8 1030.7 1106.7 19058.8 19599.7 19669.6 19789.6 20091.0 1008.3 1019.0 1030.7 1053.2 1080.7 10546.5 10934.6 10964.3 10993.8 11027.7 536862.0 539604.0 542076.0 543592.0 549379.0 93423.5 93765.0 95689.5 96623.5 96989.0 1006.1 1015.9 1027.9 1028.1 1029.1 16818.0 17127.4 17202.7 17248.7 17581.5 44440.0 44972.8 45086.6 45425.3 45436.3 62291.0 65274.7 65288.3 65409.7 65653.7 7526.7 7790.3 8637.2 8698.1 8734.2 13047.5 13221.3 13270.9 13352.8 13391.5 6192.8 8473.9 10865.1 11913.2 12083.0 11614.9 11668.9 11706.9 11754.9 11766.0 11620.2 11903.2 11929.4 12127.6 12196.4 7718.3 7960.7 7961.4 7994.0 8151.1 10767.3 11744.2 11802.4 11969.6 12163.1 13:26:25 INFO - PROCESS | 19698 | 13:26:25 INFO - PROCESS | 19698 | [#3] mootools.html Cycles:180 Average:5995.07 Median:2412.55 stddev:3421.90 (141.8%) stddev-sans-first:3414.67 13:26:25 INFO - PROCESS | 19698 | Values: 1479.3 1492.3 1638.4 1796.5 1812.8 7449.0 8580.4 8583.0 9191.2 9195.9 8791.6 9001.0 9028.0 9031.2 9090.1 2344.7 2364.0 2371.2 2371.8 2376.7 2339.6 2343.5 2380.8 2382.3 2388.4 2356.0 2367.1 2368.8 2401.3 2403.6 2327.4 2351.6 2356.2 2364.6 2367.1 2256.2 2268.1 2273.3 2276.2 2281.7 9138.2 9171.4 9199.2 9246.6 9250.1 5180.2 5299.3 5372.5 5374.2 5390.8 3388.5 3517.8 3547.4 3612.2 3651.2 1172.8 1198.6 1202.2 1250.0 1256.1 12854.4 12892.2 12897.2 12904.7 12905.9 4706.1 4738.5 4789.2 4859.1 4937.4 10639.9 10661.1 10663.6 10696.8 10765.9 5378.5 5380.8 5418.5 5435.3 5436.3 4378.9 4905.9 4969.3 5052.8 5058.2 4093.1 4101.9 4107.6 4134.4 4178.5 1314.9 1331.1 1341.5 1342.6 1363.8 1045.5 1056.6 1059.1 1084.6 1087.3 6407.6 6515.8 6526.6 6543.7 6545.0 446.2 459.4 461.3 465.3 473.7 4105.3 4167.1 4180.2 4185.8 4188.8 10926.6 11286.5 11325.2 11403.3 11429.9 11194.3 11212.7 11230.6 11271.4 11326.5 8041.9 8191.9 8262.3 8351.2 8357.5 6361.1 6579.9 6660.4 6674.3 6733.8 10206.1 10252.0 10347.1 10356.0 10443.6 10268.5 10432.7 10535.8 10557.7 10578.0 7071.3 7663.5 7933.1 8090.0 8213.3 8880.2 8892.8 8898.2 8918.2 8942.2 7748.0 7910.4 7959.0 8045.2 8114.8 7846.1 7929.9 7936.0 7974.6 7977.2 7205.4 7310.0 7440.7 7479.7 7486.4 5447.4 5490.6 5546.1 5631.4 5645.9 5352.3 5404.7 5607.4 5635.7 5783.9 13:26:25 INFO - PROCESS | 19698 | 13:26:25 INFO - PROCESS | 19698 | [#4] prototype.html Cycles:180 Average:4953.40 Median:5621.67 stddev:1483.46 (26.4%) stddev-sans-first:1446.44 13:26:25 INFO - PROCESS | 19698 | Values: 328.5 330.9 334.8 339.0 340.1 5461.7 5645.6 5728.7 5745.7 5784.9 5612.1 5648.6 5681.1 5691.9 5696.3 4427.6 4440.6 4450.6 4459.8 4473.0 4152.3 4355.3 4379.5 4439.4 4442.6 4317.5 4347.6 4352.6 4355.6 4359.1 4367.1 4373.5 4375.8 4383.4 4384.5 3742.3 3775.8 3821.8 3828.4 3841.5 5473.6 5477.8 5478.3 5496.9 5508.0 4954.0 4955.6 4956.2 4965.2 5002.9 5804.7 5932.6 5941.4 5957.6 5968.5 4140.5 4140.6 4151.5 4180.7 4196.1 6098.8 6126.5 6183.9 6206.5 6224.4 4194.9 4247.3 4248.8 4260.3 4288.2 4283.6 4288.6 4290.8 4327.8 4363.0 4981.2 5025.0 5036.3 5036.6 5043.3 5631.2 5922.4 5959.4 5994.0 6066.9 1465.5 1480.8 1483.3 1493.3 1497.4 883.6 917.2 938.2 939.8 942.2 5027.6 5029.9 5040.2 5053.2 5077.5 5375.1 5389.3 5421.8 5424.5 5438.9 5072.2 5085.1 5088.6 5350.5 5790.2 3247.3 3265.2 3274.3 3298.4 3300.8 6118.0 6355.9 6371.2 6403.7 6406.9 6246.8 6251.9 6259.4 6260.4 6308.3 6305.2 6307.0 6322.7 6358.7 6382.2 5858.2 6013.5 6079.7 6091.8 6102.0 6021.8 6058.3 6077.7 6116.9 6169.5 6098.4 6333.7 6401.0 6401.9 6461.4 4261.7 4285.4 4296.8 4309.6 4332.2 6234.1 6248.6 6249.6 6270.5 6271.2 5655.9 5983.4 5989.3 6000.3 6018.3 5982.2 6005.7 6010.6 6024.8 6054.8 5750.0 5924.6 5932.9 5940.6 5977.6 5976.5 6001.8 6025.6 6027.1 6029.8 5844.9 5864.7 5901.6 5917.0 5946.1 13:26:25 INFO - PROCESS | 19698 | 13:26:25 INFO - PROCESS | 19698 | [#5] yui.html Cycles:180 Average:21236.15 Median:4957.09 stddev:29156.40 (588.2%) stddev-sans-first:29197.74 13:26:25 INFO - PROCESS | 19698 | Values: 780.6 795.8 816.9 843.0 850.8 15412.7 16548.8 16573.0 16612.0 16644.8 15339.0 16130.4 16146.6 16895.2 16922.6 808.0 815.6 833.4 837.1 837.5 833.3 842.2 842.6 842.7 843.1 875.7 876.3 876.8 877.8 879.7 868.9 869.8 869.9 871.4 872.1 633.0 637.2 637.3 637.6 637.7 16866.7 17049.6 17068.7 17101.5 17102.3 14859.6 14910.2 15021.2 15625.5 15681.6 12931.7 12981.8 13058.0 13096.4 13601.6 3971.1 4004.0 4132.5 4153.5 4204.6 83035.0 83912.0 84495.6 84924.6 85046.6 11834.0 11940.0 12036.2 12255.9 12469.4 22028.1 22171.6 22199.2 22212.2 22317.9 9039.4 9074.7 9229.7 9231.4 9237.0 4788.7 4891.9 5022.2 5181.9 5298.9 3723.7 4059.9 4296.3 4297.0 4331.3 721.2 721.6 729.4 729.6 729.8 627.9 657.2 737.2 755.6 764.9 9812.5 10042.9 10142.7 10200.6 10632.7 681.9 734.3 783.4 784.8 793.3 4844.9 5064.1 5098.9 5257.2 5290.8 87170.6 90344.5 91778.0 107655.0 115493.0 90555.0 92253.0 99455.5 103767.5 105639.0 85884.6 86725.6 88182.6 89021.6 89213.0 9485.3 9663.3 9664.8 9724.1 9911.6 52691.0 52959.0 53280.2 54493.5 54577.5 68952.7 70135.3 78559.2 79020.0 82729.0 13903.9 13946.2 13986.8 14106.9 14178.7 15846.8 16000.3 16006.7 16018.5 16908.8 14975.6 15048.2 15053.9 15298.3 15502.9 14673.2 14719.3 14989.9 15097.7 15556.8 14434.9 14614.3 14758.3 14967.3 15199.1 11647.4 11891.3 12018.7 12162.6 12437.3 11079.1 11517.6 12655.3 12681.9 12725.7 13:26:25 INFO - PROCESS | 19698 | -------- Summary: end -------- 13:26:25 INFO - PROCESS | 19698 | 13:26:25 INFO - TEST-INFO | 19698: exit 0 13:26:25 INFO - TEST-OK | dromaeo_css | took 1110678ms 13:26:25 INFO - TEST-START | kraken 13:26:25 INFO - operating with platform_type : linux_ 13:26:25 INFO - Initialising browser for kraken test... 13:26:25 INFO - TEST-INFO | started process 19942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY_2xFx/profile http://localhost:48140/getInfo.html) 13:26:29 INFO - PROCESS | 19942 | JavaScript error: , line 0: uncaught exception: undefined 13:26:30 INFO - PROCESS | 19942 | __metrics Screen width/height:1600/1200 13:26:30 INFO - PROCESS | 19942 | colorDepth:24 13:26:30 INFO - PROCESS | 19942 | Browser inner width/height: 1024/697 13:26:30 INFO - PROCESS | 19942 | __metrics 13:26:31 ERROR - PROCESS | 19942 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 13:26:31 INFO - TEST-INFO | 19942: exit 0 13:26:31 INFO - Browser initialized. 13:26:31 INFO - Running cycle 1/1 for kraken test... 13:26:31 INFO - TEST-INFO | started process 20064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY_2xFx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:43 INFO - PROCESS | 20064 | RSS: Main: 168480768 13:26:43 INFO - PROCESS | 20064 | 13:26:46 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48140/tests/kraken/driver.html?testName=audio-beat-detection) 13:26:47 INFO - PROCESS | 20064 | RSS: Main: 173625344 13:26:47 INFO - PROCESS | 20064 | 13:26:49 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48140/tests/kraken/driver.html?testName=audio-dft) 13:26:50 INFO - PROCESS | 20064 | RSS: Main: 173264896 13:26:50 INFO - PROCESS | 20064 | 13:26:53 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48140/tests/kraken/driver.html?testName=audio-fft) 13:26:53 INFO - PROCESS | 20064 | RSS: Main: 167579648 13:26:53 INFO - PROCESS | 20064 | 13:26:55 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48140/tests/kraken/driver.html?testName=audio-oscillator) 13:26:56 INFO - PROCESS | 20064 | RSS: Main: 168800256 13:26:56 INFO - PROCESS | 20064 | 13:26:58 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48140/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:26:59 INFO - PROCESS | 20064 | RSS: Main: 169119744 13:26:59 INFO - PROCESS | 20064 | 13:27:02 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48140/tests/kraken/driver.html?testName=imaging-darkroom) 13:27:02 INFO - PROCESS | 20064 | RSS: Main: 168980480 13:27:02 INFO - PROCESS | 20064 | 13:27:06 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48140/tests/kraken/driver.html?testName=imaging-desaturate) 13:27:07 INFO - PROCESS | 20064 | RSS: Main: 166912000 13:27:07 INFO - PROCESS | 20064 | 13:27:09 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48140/tests/kraken/driver.html?testName=json-parse-financial) 13:27:10 INFO - PROCESS | 20064 | RSS: Main: 168345600 13:27:10 INFO - PROCESS | 20064 | 13:27:12 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48140/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:27:12 INFO - PROCESS | 20064 | RSS: Main: 168419328 13:27:12 INFO - PROCESS | 20064 | 13:27:14 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48140/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:27:15 INFO - PROCESS | 20064 | RSS: Main: 168497152 13:27:15 INFO - PROCESS | 20064 | 13:27:17 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48140/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:27:17 INFO - PROCESS | 20064 | RSS: Main: 168853504 13:27:17 INFO - PROCESS | 20064 | 13:27:20 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:27:21 INFO - PROCESS | 20064 | RSS: Main: 169123840 13:27:21 INFO - PROCESS | 20064 | 13:27:23 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:27:24 INFO - PROCESS | 20064 | RSS: Main: 169136128 13:27:24 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | Cycle 1(1): loaded http://localhost:48140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48140/tests/kraken/driver.html?testName=ai-astar) 13:27:26 INFO - PROCESS | 20064 | RSS: Main: 169734144 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | __start_tp_report 13:27:26 INFO - PROCESS | 20064 | _x_x_mozilla_page_load 13:27:26 INFO - PROCESS | 20064 | _x_x_mozilla_page_load_details 13:27:26 INFO - PROCESS | 20064 | |i|pagename|runs| 13:27:26 INFO - PROCESS | 20064 | |0;ai-astar;102;113;104;111;112;111;111;111;113;111 13:27:26 INFO - PROCESS | 20064 | |1;audio-beat-detection;150;130;148;172;124;141;147;124;179;117 13:27:26 INFO - PROCESS | 20064 | |2;audio-dft;163;161;162;160;163;164;163;173;161;164 13:27:26 INFO - PROCESS | 20064 | |3;audio-fft;76;75;75;168;76;75;75;75;157;77 13:27:26 INFO - PROCESS | 20064 | |4;audio-oscillator;84;83;160;84;84;84;151;83;83;136 13:27:26 INFO - PROCESS | 20064 | |5;imaging-gaussian-blur;117;117;117;117;118;118;118;117;117;120 13:27:26 INFO - PROCESS | 20064 | |6;imaging-darkroom;147;147;147;148;147;148;146;148;146;147 13:27:26 INFO - PROCESS | 20064 | |7;imaging-desaturate;96;96;96;96;95;96;97;96;96;95 13:27:26 INFO - PROCESS | 20064 | |8;json-parse-financial;53;53;52;53;55;53;52;58;53;52 13:27:26 INFO - PROCESS | 20064 | |9;json-stringify-tinderbox;63;63;63;63;65;63;62;63;63;63 13:27:26 INFO - PROCESS | 20064 | |10;stanford-crypto-aes;77;76;77;78;75;83;84;77;80;80 13:27:26 INFO - PROCESS | 20064 | |11;stanford-crypto-ccm;130;128;123;125;124;143;134;142;173;127 13:27:26 INFO - PROCESS | 20064 | |12;stanford-crypto-pbkdf2;158;161;159;161;161;162;164;159;162;162 13:27:26 INFO - PROCESS | 20064 | |13;stanford-crypto-sha256-iterative;64;65;63;62;62;68;64;63;63;65 13:27:26 INFO - PROCESS | 20064 | __end_tp_report 13:27:26 INFO - PROCESS | 20064 | __start_cc_report 13:27:26 INFO - PROCESS | 20064 | _x_x_mozilla_cycle_collect,922 13:27:26 INFO - PROCESS | 20064 | __end_cc_report 13:27:26 INFO - PROCESS | 20064 | __startTimestamp1468700846471__endTimestamp 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | ------- Summary: start ------- 13:27:26 INFO - PROCESS | 20064 | Number of tests: 14 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.75 (3.4%) stddev-sans-first:2.68 13:27:26 INFO - PROCESS | 20064 | Values: 102.0 113.0 104.0 111.0 112.0 111.0 111.0 111.0 113.0 111.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:147.50 stddev:20.54 (13.9%) stddev-sans-first:21.64 13:27:26 INFO - PROCESS | 20064 | Values: 150.0 130.0 148.0 172.0 124.0 141.0 147.0 124.0 179.0 117.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:3.63 (2.2%) stddev-sans-first:3.84 13:27:26 INFO - PROCESS | 20064 | Values: 163.0 161.0 162.0 160.0 163.0 164.0 163.0 173.0 161.0 164.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:36.78 (49.0%) stddev-sans-first:38.50 13:27:26 INFO - PROCESS | 20064 | Values: 76.0 75.0 75.0 168.0 76.0 75.0 75.0 75.0 157.0 77.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:83.50 stddev:32.12 (38.5%) stddev-sans-first:33.31 13:27:26 INFO - PROCESS | 20064 | Values: 84.0 83.0 160.0 84.0 84.0 84.0 151.0 83.0 83.0 136.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.00 13:27:26 INFO - PROCESS | 20064 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 120.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 13:27:26 INFO - PROCESS | 20064 | Values: 147.0 147.0 147.0 148.0 147.0 148.0 146.0 148.0 146.0 147.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:27:26 INFO - PROCESS | 20064 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 95.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.84 (3.5%) stddev-sans-first:1.94 13:27:26 INFO - PROCESS | 20064 | Values: 53.0 53.0 52.0 53.0 55.0 53.0 52.0 58.0 53.0 52.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 13:27:26 INFO - PROCESS | 20064 | Values: 63.0 63.0 63.0 63.0 65.0 63.0 62.0 63.0 63.0 63.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:2.98 (3.8%) stddev-sans-first:3.10 13:27:26 INFO - PROCESS | 20064 | Values: 77.0 76.0 77.0 78.0 75.0 83.0 84.0 77.0 80.0 80.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:132.00 stddev:15.13 (11.5%) stddev-sans-first:15.95 13:27:26 INFO - PROCESS | 20064 | Values: 130.0 128.0 123.0 125.0 124.0 143.0 134.0 142.0 173.0 127.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.50 stddev:1.79 (1.1%) stddev-sans-first:1.56 13:27:26 INFO - PROCESS | 20064 | Values: 158.0 161.0 159.0 161.0 161.0 162.0 164.0 159.0 162.0 162.0 13:27:26 INFO - PROCESS | 20064 | 13:27:26 INFO - PROCESS | 20064 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.79 (2.8%) stddev-sans-first:1.90 13:27:26 INFO - PROCESS | 20064 | Values: 64.0 65.0 63.0 62.0 62.0 68.0 64.0 63.0 63.0 65.0 13:27:26 INFO - PROCESS | 20064 | -------- Summary: end -------- 13:27:26 INFO - PROCESS | 20064 | 13:27:27 INFO - TEST-INFO | 20064: exit 0 13:27:27 INFO - TEST-OK | kraken | took 61703ms 13:27:27 INFO - SUITE-END | took 1172s 13:27:27 INFO - Completed test suite (00:19:32) 13:27:27 INFO - javascript benchmark 13:27:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7360.591272083418, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.3474570340227, 3113.7976031557946, 3117.3765246950607, 3141.811491310523, 3159.857806398712, 5442.945570544293, 5445.83662490125, 5446.564274858012, 5460.78156873725, 5519.254900588429, 5294.232336311233, 5342.465753424655, 5347.919781203285, 5391.191321301807, 5407.161889907071, 4865.683730557511, 4954.405471343443, 5019.0463811875625, 5099.286099946011, 5114.053900028488, 5049.4698056704065, 5108.744562771846, 5115.437301896788, 5121.436641969381, 5138.177891537355, 437.80150420139887, 4978.477259887714, 4994.675346102528, 5021.999999999982, 5077.213031980049, 4987.800487980477, 4993.800247990076, 4995.725235112068, 5012.573931215851, 5033.119204139298, 4973.7513124344, 4985.127602669555, 4989.226669866177, 5015.5736762375245, 5023.2214006829, 5274.525292723673, 5278.630495865291, 5340.706261155635, 5385.649932754359, 5453.590980676426, 5682.147677848315, 5691.117876729114, 5693.146028095777, 5695.487406133468, 5713.171590119451, 5711.7144142792695, 5762.97118514409, 5772.220750198711, 5775.249217601727, 5796.942030579682, 5434.157705555645, 5444.3194600674915, 5461.99999999996, 5478.643888147258, 5503.3395992480755, 5989.970050149721, 5991.7603295867675, 5995.700214989233, 6001.549883758736, 6049.606775559574, 5598.552115830806, 5670.376258611549, 5770.19217309577, 5799.681017543991, 5814.59297849155, 5822.3304320003745, 5847.590668653239, 5853.2976042875125, 5858.2677165354335, 5910.0, 5757.88484230313, 5792.304923409218, 5793.565482588822, 5802.4197580241635, 5816.680082595413, 5649.68926709035, 5809.157672137517, 5818.883622327529, 5848.0, 5868.941310586925, 4376.256036473807, 4410.404595379647, 4494.955050449519, 4499.595036446735, 4552.726836389827, 3983.960160398417, 4003.2393845169327, 4006.6994975376965, 4022.6982976276895, 4048.8785336439955, 5454.154606036071, 5496.780128794883, 5602.97198514013, 5605.187247849039, 5605.831825045255, 5836.766529338779, 5910.143029260733, 5912.970435147797, 5917.822465326047, 5975.223220981245, 5557.722113894289, 5563.388027316992, 5565.30433695788, 5574.832755017356, 5583.609147359727, 4898.79979405048, 4919.0899683558655, 4962.330085438492, 5001.249812528077, 5003.699778013331, 6044.1840351552855, 6044.274687037584, 6046.486048685823, 6075.088736689444, 6087.6956152192215, 5844.912326315024, 5856.882862342729, 5869.35437101927, 5881.3236477803885, 5883.205767221456, 5930.555208359477, 5971.402859713994, 5993.041113421831, 6025.126356678345, 6046.365131661112, 5718.0, 5740.282464691913, 5757.0, 5759.0, 5762.250907382014, 5841.0, 5849.444302791228, 5850.707464626837, 5869.73586188614, 5870.26621672291, 5509.724513774215, 5671.886562268649, 5727.140928860705, 5767.192593037062, 5813.302403711582, 5758.568107391879, 5774.9133762994425, 5781.653100813965, 5791.507721843691, 5795.942040579709, 5537.750801214036, 5674.886502269849, 5679.204911312337, 5732.713364331683, 5733.397993210653, 5628.380878103323, 5635.323761148688, 5664.235328230801, 5679.403662615531, 5685.090385538294, 5604.887902242014, 5667.631603945731, 5671.8865622688145, 5673.8865222694485, 5675.858103547279], "value": 5350.272154444292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.5831342982227, 593.9376365481625, 604.6613896218117, 605.7910021042741, 637.1716768201337, 39797.2040559189, 43758.34362484558, 44245.0, 44479.0, 44557.0, 44127.3380899286, 44596.554034459645, 44599.0, 44609.10781784362, 44660.3300950486, 8840.115988401141, 8928.598213080395, 8947.821043579124, 8982.820343593125, 8983.19151276385, 8943.418677785956, 9045.954770226139, 9050.547472626375, 9087.454752714826, 9089.181973622373, 9095.181433670969, 9102.226310763594, 9108.59011344491, 9134.908650913505, 9157.358984871062, 9039.819203615923, 9065.682701105463, 9079.0, 9085.273178145733, 9131.086891310815, 8953.283737301, 8984.146506081977, 9020.909790902073, 9049.276057915351, 9067.365284430092, 33109.337813243845, 41121.794391028154, 41316.58683413157, 41583.792081039704, 41623.0, 3341.832908354597, 3418.5555877735983, 3515.455104458813, 3556.395412779834, 3599.42409214527, 31973.0, 32104.839475802706, 32248.6775132248, 32434.837825810955, 33330.0, 4316.6546676265825, 4342.848000319974, 4396.450443694538, 4452.487963884162, 4467.039586488921, 350635.0, 350741.0, 351060.0, 351207.0, 351788.41057947255, 35337.116572085906, 35360.82319588386, 35378.0, 35537.64462355395, 36104.63895361013, 37024.81487592545, 37264.627353726115, 37416.0, 37546.43680344797, 37613.81193094017, 14817.851821481647, 15054.322555485029, 15059.096454212782, 15113.697726045417, 15119.54641360739, 12338.198017128858, 12366.690832729253, 12403.875961240272, 12416.937915310365, 12470.875291247154, 8376.748697538962, 8482.618282177193, 8507.914920850835, 8530.914690853013, 8554.871676924851, 3211.132994091582, 3300.9339813204083, 3301.7783420134706, 3305.0, 3317.0, 1064.6380230721593, 1125.2798209146154, 1146.896779289868, 1198.8801119888117, 1232.1128787273149, 33599.664003359656, 33713.49429758556, 33931.66068339335, 34033.659663403545, 34214.31571368608, 1107.828286615576, 1119.9552017919355, 1144.542183126756, 1157.4907040901976, 1275.4515558309831, 17263.223154958057, 17780.97723387027, 17814.46556603304, 17826.91086544585, 17833.286668533114, 157097.0, 158688.0, 574271.0, 579099.0, 579162.0, 59874.70062649659, 61464.0, 61597.0, 61801.0, 61810.0, 1331.8335208098988, 1364.1201425080767, 1378.6346618146, 1384.2732565403041, 1397.2594524901817, 31947.840260798548, 32498.51252231171, 32775.50836737498, 33119.834400828804, 33696.0, 53522.73238633782, 53572.732136339066, 53864.730676347936, 53880.0, 53929.0, 490268.0, 491044.0, 491894.0, 493086.0, 495722.0, 26572.335691607863, 27074.0, 28227.71772282251, 28955.42089158247, 29031.0, 49555.0, 50201.74899125481, 50274.0, 50630.493695064055, 51123.23315150201, 41491.37762933498, 42879.0, 42988.78505607452, 43432.34851477294, 43512.0, 42590.78704606457, 42989.0, 43105.784471077444, 43124.35313470363, 43334.78332608317, 40465.0, 40577.18845623012, 40835.79582102071, 42812.57187428086, 42910.78544607257, 35721.642783571835, 38405.4239186418, 38457.807710962385, 38477.0, 38479.807600961816, 28960.710392896643, 29249.268768280963, 29293.0, 29447.705522944496, 29620.851895740383], "value": 18939.170574204367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.88577312579355, 396.3579002016733, 397.280921532027, 403.3204051173772, 414.50880706362943, 15987.280572374242, 19342.613147737055, 20162.59674806503, 20861.26985555504, 21011.57976840464, 19415.4175374739, 19906.0, 19954.201831926704, 19994.700079498783, 20005.899970500162, 5484.890302193954, 5862.88274234515, 5868.677222752747, 5874.030784920505, 5876.676782776945, 5617.634853734494, 5762.049261871786, 5844.1818145459665, 5849.590528662995, 5855.79504717335, 5711.371749107595, 5713.114467257561, 5745.368009518949, 5761.625494342875, 5789.507891829199, 5525.723713814293, 5717.285339332583, 5721.370649228582, 5733.111367738007, 5766.135079738031, 5075.467075957045, 5087.745612719349, 5091.389033315989, 5102.38771347437, 5133.563647090002, 21937.561248774935, 23064.308070757903, 23082.53834923292, 23524.294271171722, 23721.0, 2366.9171578994824, 2424.0, 2449.155041510676, 2544.656471376359, 2602.8958841646313, 10339.948300258451, 10584.682459526226, 10611.787764244671, 13275.668108297274, 13485.941776561334, 1950.317388913883, 2000.9599808003904, 2015.5364266218705, 2043.7751847296934, 2047.9590408191902, 86633.0, 87948.56025719958, 87976.560117199, 88870.55564722135, 89686.5515672424, 10874.293170943864, 11100.888991110147, 11194.10447164225, 11314.490847911864, 11366.602168924048, 12148.149629525848, 12769.0423218259, 12897.419616117297, 15662.0, 15739.685206296039, 7807.336376407955, 7923.603819808986, 7966.601669916481, 8018.278354948083, 8053.07389650186, 7821.765347039598, 7858.5677787722225, 8055.718049868226, 8085.636146373427, 8120.309773669186, 3984.5019372578427, 3986.5216174059296, 4076.3274059780397, 4120.1553681495825, 4129.215449064728, 1997.3308941504467, 2007.1168685778212, 2024.382563318202, 2028.239410221167, 2058.423641380416, 920.2959735802117, 965.2422848064236, 972.7616733900239, 1030.6650338639972, 1106.7461662711603, 19058.809411905702, 19599.706004409945, 19669.60660786776, 19789.60420791576, 20091.0, 1008.2639673038576, 1018.9898101018895, 1030.701096681969, 1053.1627356251797, 1080.670395529371, 10546.525406356732, 10934.617288394868, 10964.287321324247, 10993.835092473619, 11027.724306892393, 536862.0, 539604.0, 542076.0, 543592.0, 549379.0, 93423.53288233651, 93765.0, 95689.52155239179, 96623.51688241654, 96989.0, 1006.1447769395954, 1015.8577799108131, 1027.9486025698686, 1028.1209565821116, 1029.120102312512, 16818.0, 17127.400540981005, 17202.65594688124, 17248.655026899643, 17581.472555823344, 44440.0, 44972.77513612411, 45086.64740057803, 45425.31862022006, 45436.31845522386, 62291.0, 65274.67362663346, 65288.347116528224, 65409.67295163494, 65653.67173164104, 7526.698932042876, 7790.337821285254, 8637.179467950535, 8698.086700896567, 8734.213920747163, 13047.543335983575, 13221.272829994443, 13270.933645331712, 13352.799708004582, 13391.464341426234, 6192.783252586138, 8473.898393208843, 10865.13078953666, 11913.16607837443, 12083.0, 11614.883851161718, 11668.88331116678, 11706.941465292619, 11754.942055215071, 11766.0, 11620.186586938833, 11903.226290291102, 11929.403529823301, 12127.636170914886, 12196.390180491117, 7718.266764657348, 7960.681572737026, 7961.442699011013, 7993.960030199812, 8151.062627797879, 10767.300125491818, 11744.236624619372, 11802.409879506162, 11969.581064662694, 12163.148579599343], "value": 9284.977405863718, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.3490864019827, 1492.2538730634683, 1638.4265507072525, 1796.452082114956, 1812.8096549862264, 7449.0, 8580.44227125238, 8582.957085214573, 9191.1727944485, 9195.862062069074, 8791.604377802998, 9001.0, 9027.954860225705, 9031.232345250644, 9090.136437038487, 2344.6951896253463, 2363.9881800590974, 2371.158238825218, 2371.833971621987, 2376.7147942246957, 2339.578875802355, 2343.4844334246523, 2380.833341666084, 2382.309130352196, 2388.3790214544256, 2355.9764402356013, 2367.0531787285136, 2368.786809187173, 2401.2556107606697, 2403.5553422616786, 2327.371609665398, 2351.6119840226515, 2356.1871154451687, 2364.598018336887, 2367.0768400323886, 2256.187772401934, 2268.0814270220585, 2273.30664147435, 2276.1578216059997, 2281.6805647209403, 9138.17756401927, 9171.358004939657, 9199.172074513259, 9246.58390372428, 9250.121238482334, 5180.171172612401, 5299.33758280215, 5372.54333381663, 5374.220737993008, 5390.757415916293, 3388.491726241059, 3517.8065206413635, 3547.3792086385038, 3612.24142929985, 3651.1602331463914, 1172.818213176959, 1198.646399312205, 1202.206543681175, 1250.0312258000122, 1256.1395444120715, 12854.393200849894, 12892.226466412045, 12897.161684490384, 12904.677383065498, 12905.935470322682, 4706.066827716946, 4738.47876733559, 4789.185838407479, 4859.07677541266, 4937.40751109862, 10639.89360106389, 10661.147108231324, 10663.573457061786, 10696.786064278827, 10765.89234107649, 5378.542823860016, 5380.811671591554, 5418.539424148991, 5435.320584926884, 5436.266104075979, 4378.868633940987, 4905.9264111038365, 4969.329140566049, 5052.8484145475695, 5058.1654027085115, 4093.058407625277, 4101.887527923122, 4107.589241075869, 4134.359174327984, 4178.498580170338, 1314.9289868457026, 1331.088204579866, 1341.4835288413835, 1342.5502456676927, 1363.761341765207, 1045.4668119259081, 1056.630179437191, 1059.0627294843964, 1084.5770149641646, 1087.2986923434341, 6407.615543067431, 6515.762005218993, 6526.608403495806, 6543.672816359163, 6545.0, 446.2257982400532, 459.36148753233033, 461.28270539311694, 465.2625588442289, 473.656598965754, 4105.322621767435, 4167.06241095751, 4180.226658068267, 4185.811638476276, 4188.790560471964, 10926.562937482571, 11286.548538058385, 11325.150613704005, 11403.315801051964, 11429.885701143048, 11194.328340299608, 11212.719682007852, 11230.550777968952, 11271.436428178722, 11326.546938122383, 8041.8793718094275, 8191.8771218431775, 8262.339012878956, 8351.248387645019, 8357.498550087013, 6361.109444677842, 6579.901301480578, 6660.411821657169, 6674.265830758515, 6733.764318248838, 10206.13247873939, 10252.0, 10347.068763811292, 10356.0, 10443.634472793416, 10268.537915793957, 10432.739181520523, 10535.789284214427, 10557.683269501927, 10578.0, 7071.292870712888, 7663.463557550918, 7933.127355990721, 8089.959550202211, 8213.260806527442, 8880.200781929658, 8892.822143557221, 8898.199162075185, 8918.24194943437, 8942.195202431813, 7747.961260193889, 7910.446268761361, 7959.044914610284, 8045.155258697752, 8114.756557303291, 7846.0976987647155, 7929.881051784343, 7935.960320198362, 7974.561399123104, 7977.242161994601, 7205.387542058984, 7310.0, 7440.7023719052795, 7479.663415146223, 7486.438517111347, 5447.400785913625, 5490.560755139659, 5546.112621980464, 5631.380548139783, 5645.858853528531, 5352.304200453916, 5404.7297635118875, 5607.383187849252, 5635.718214089361, 5783.884322313615], "value": 4720.3375904931545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.5236407209547, 330.8511169973512, 334.80915877949576, 339.0303731328401, 340.0716045196615, 5461.726913654321, 5645.633033852797, 5728.7110400159945, 5745.683987380692, 5784.884302313956, 5612.130119831432, 5648.604597678164, 5681.119426488891, 5691.8577035574135, 5696.25948626679, 4427.579379958899, 4440.622547083485, 4450.577195166462, 4459.777011149429, 4472.955270447286, 4152.342500799491, 4355.281378572532, 4379.547453426092, 4439.422875026242, 4442.622377097934, 4317.4819021717285, 4347.5652434756585, 4352.630026447756, 4355.629771469429, 4359.084592235635, 4367.104743527585, 4373.497047839507, 4375.8249670013165, 4383.3863259143745, 4384.517703052662, 3742.3450896093345, 3775.8112094395447, 3821.7706937583835, 3828.4257361395735, 3841.4621952926614, 5473.576870013785, 5477.780888764445, 5478.260434841325, 5496.917546236809, 5508.03609368363, 4953.975230123826, 4955.60355171589, 4956.166218499142, 4965.230389289666, 5002.949970500321, 5804.680742559158, 5932.584719069667, 5941.405859414067, 5957.553183511211, 5968.492678122365, 4140.503139623234, 4140.585941405865, 4151.543330233671, 4180.686448516343, 4196.097838964607, 6098.847528811771, 6126.540509461808, 6183.907241391383, 6206.510437494969, 6224.439800417938, 4194.916101677949, 4247.256730072225, 4248.766317852548, 4260.318349064135, 4288.1638080573985, 4283.5502272260965, 4288.592583704543, 4290.785460726951, 4327.783610819446, 4362.9781851091175, 4981.178105612534, 5025.0, 5036.294918711384, 5036.64743467961, 5043.344365232496, 5631.211630371751, 5922.407759224043, 5959.433853783884, 5993.970030149909, 6066.908996364969, 1465.4504560789703, 1480.8297045839652, 1483.2657834372055, 1493.3056128900114, 1497.430976229026, 883.5626364949263, 917.2295271971576, 938.1931538876561, 939.7650587353162, 942.1708896171325, 5027.597792176617, 5029.874253143627, 5040.218766091261, 5053.216751403538, 5077.517635824591, 5375.139977603565, 5389.299391079213, 5421.810236641778, 5424.504727825166, 5438.945610543923, 5072.213806859942, 5085.067674283749, 5088.567471764942, 5350.491703288181, 5790.218320526675, 3247.3342964692183, 3265.248992731685, 3274.345130973815, 3298.3897978873506, 3300.752443566742, 6117.96941015292, 6355.917380070662, 6371.23545174582, 6403.679816009274, 6406.935930640727, 6246.781362652286, 6251.937480625226, 6259.435141214696, 6260.436560709558, 6308.337624549448, 6305.211848518935, 6306.9684651576445, 6322.683865806691, 6358.7456501740335, 6382.234131904108, 5858.238429004202, 6013.5189184865985, 6079.696015199311, 6091.847703807263, 6102.0, 6021.789237376671, 6058.27300723916, 6077.6961151943115, 6116.868379349835, 6169.537284703755, 6098.390160983866, 6333.669929314711, 6400.967995160181, 6401.943679293051, 6461.386168314003, 4261.74429534229, 4285.4000439939055, 4296.806643701104, 4309.612134907873, 4332.220200363839, 6234.096056071935, 6248.562600617913, 6249.562530622995, 6270.529710271839, 6271.153394291712, 5655.858603534944, 5983.401659833982, 5989.311229208697, 6000.279966404059, 6018.277806663228, 5982.235240603945, 6005.747844558291, 6010.617557961606, 6024.849378765566, 6054.758774451315, 5749.9712501437225, 5924.585279030426, 5932.911006334994, 5940.554458415722, 5977.641341519523, 5976.521878249642, 6001.789937352171, 6025.638461692312, 6027.126066720213, 6029.78895738647, 5844.853878653068, 5864.706764661835, 5901.645901245939, 5916.970415147896, 5946.137810017437], "value": 4470.63267940194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.6213986216684, 795.769226924192, 816.8529664660363, 843.0490604962089, 850.8218959463771, 15412.691746165085, 16548.83451165488, 16573.0, 16612.0, 16644.833551664495, 15339.0, 16130.435434759785, 16146.596335091599, 16895.15524223787, 16922.576935576584, 808.0424696734359, 815.5799763121997, 833.3666413525734, 837.0917554453425, 837.4849467577426, 833.2500749325595, 842.2335674536142, 842.5744998775609, 842.6755699055877, 843.0936743001298, 875.7372788163557, 876.3471213945587, 876.7588913048899, 877.7630039889226, 879.705298724928, 868.891388576428, 869.8477766390856, 869.886914701088, 871.376965469689, 872.1148034744707, 633.0093403823048, 637.2321352769948, 637.3499030988365, 637.6301744987896, 637.7417146055855, 16866.746998795028, 17049.57376065596, 17068.743968840477, 17101.48695539136, 17102.31590736369, 14859.554213373616, 14910.17994010329, 15021.173835439047, 15625.531234062997, 15681.607959800982, 12931.741365172738, 12981.805272920914, 13058.0, 13096.410661520255, 13601.59195224135, 3971.106501037272, 4003.97998010011, 4132.504099508048, 4153.460050193456, 4204.600562946515, 83035.0, 83911.99999999939, 84495.57752211261, 84924.57537712334, 85046.57476712638, 11834.0, 11940.0, 12036.157468977262, 12255.93872030652, 12469.376531173404, 22028.11887524513, 22171.55656886853, 22199.22302719397, 22212.222572209896, 22317.888410557844, 9039.412438191628, 9074.682386116454, 9229.723108306762, 9231.446113233227, 9237.0, 4788.712677239377, 4891.926621100686, 5022.2466630005065, 5181.896362072737, 5298.867528311823, 3723.6834869035893, 4059.939100913489, 4296.2696341621995, 4296.978515107405, 4331.328644060176, 721.2174790352421, 721.5526373648372, 729.3909833381281, 729.6096588325327, 729.7847135095053, 627.9215098112736, 657.1916542652564, 737.1854101218184, 755.5859030397936, 764.9158592554815, 9812.509374531388, 10042.949785251027, 10142.695719128438, 10200.591976320864, 10632.681019569425, 681.9181698196248, 734.302412707919, 783.3889566138307, 784.8312612788278, 793.2503783924136, 4844.927326090041, 5064.088464076428, 5098.923516147261, 5257.158854583248, 5290.761915713802, 87170.56414718012, 90344.54827725819, 91778.0, 107655.0, 115493.0, 90555.0, 92253.0, 99455.50272248738, 103767.4811625937, 105639.0, 85884.57057714672, 86725.56637216899, 88182.55908720415, 89021.55489222641, 89213.0, 9485.33602647808, 9663.27525435581, 9664.75838104053, 9724.076212759777, 9911.553980071058, 52691.0, 52959.0, 53280.20079698885, 54493.45506544884, 54577.45422545724, 68952.6552367235, 70135.29864701288, 78559.21440785748, 79020.0, 82729.0, 13903.860961390257, 13946.16323020622, 13986.790198146833, 14106.858931410554, 14178.716425671635, 15846.762298565762, 16000.279987400361, 16006.67986640284, 16018.519444416686, 16908.830911690726, 14975.625609359853, 15048.172350520388, 15053.94622376467, 15298.31157597933, 15502.9224853875, 14673.192974386084, 14719.268607770788, 14989.875759318313, 15097.698046039237, 15556.844431555539, 14434.927825360806, 14614.342354593857, 14758.33587488544, 14967.251637418303, 15199.088054716753, 11647.41762911868, 11891.28652280866, 12018.663998494283, 12162.635120946386, 12437.253764774143, 11079.058280046287, 11517.596884109016, 12655.303958282015, 12681.873181268069, 12725.681857953625], "value": 8008.962491175438, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 104.0, 111.0, 112.0, 111.0, 111.0, 111.0, 113.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 130.0, 148.0, 172.0, 124.0, 141.0, 147.0, 124.0, 179.0, 117.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 160.0, 163.0, 164.0, 163.0, 173.0, 161.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 168.0, 76.0, 75.0, 75.0, 75.0, 157.0, 77.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 160.0, 84.0, 84.0, 84.0, 151.0, 83.0, 83.0, 136.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 120.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 148.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 55.0, 53.0, 52.0, 58.0, 53.0, 52.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 65.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 78.0, 75.0, 83.0, 84.0, 77.0, 80.0, 80.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 128.0, 123.0, 125.0, 124.0, 143.0, 134.0, 142.0, 173.0, 127.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 159.0, 161.0, 161.0, 162.0, 164.0, 159.0, 162.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 62.0, 62.0, 68.0, 64.0, 63.0, 63.0, 65.0], "value": 63.9, "unit": "score"}]}]} 13:27:27 INFO - Return code: 0 13:27:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:27:27 ERROR - # TBPL SUCCESS # 13:27:27 INFO - Running post-action listener: _resource_record_post_action 13:27:27 INFO - ##### 13:27:27 INFO - ##### Finished run-tests step (success) 13:27:27 INFO - ##### 13:27:27 INFO - Running post-run listener: _resource_record_post_run 13:27:27 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 554180608; Read time: 0; Write time: 488468 13:27:27 INFO - TinderboxPrint: CPU usage
13.3% 13:27:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:27:27 INFO - TinderboxPrint: I/O write bytes / time
554,180,608 / 488,468 13:27:27 INFO - TinderboxPrint: CPU idle
8,227.3 (86.6%) 13:27:27 INFO - TinderboxPrint: CPU user
1,213.4 (12.8%) 13:27:27 INFO - TinderboxPrint: Swap in / out
0 / 0 13:27:27 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257466368; Read time: 0; Write time: 276756 13:27:27 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 296714240; Read time: 0; Write time: 211712 13:27:28 INFO - Running post-run listener: _upload_blobber_files 13:27:28 INFO - Blob upload gear active. 13:27:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:27:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:27:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:27:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:27:28 INFO - (blobuploader) - INFO - Open directory for files ... 13:27:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:27:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:29 INFO - (blobuploader) - INFO - Done attempting. 13:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:34 INFO - (blobuploader) - INFO - Done attempting. 13:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:27:34 INFO - (blobuploader) - INFO - Done attempting. 13:27:34 INFO - (blobuploader) - INFO - Iteration through files over. 13:27:34 INFO - Return code: 0 13:27:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:27:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:27:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/697b04e6902fc120fcdf8a059e89aff188307994773546a1d801ae6eb883a0dd5fa1592dd5157b0ec52b82bcc8d97d5d76c168bee564f8b21fec6d6fdba4f408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1665adae007c42f01fc090294179122e73ba47919c0c9be89206462c1620f2aec309f0ec556fbc5e0097cc804d82770783ed770087c6a848491a6740eae69db9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2c0dfba171bd747eba88fd610ac75f6ec654a758c902848b2afe50170d36987ed3e91b5485d617285f98843665812c15c22f4119b7a9d49d7ecf85fc63ef25ec"} 13:27:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:27:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:27:34 INFO - Contents: 13:27:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/697b04e6902fc120fcdf8a059e89aff188307994773546a1d801ae6eb883a0dd5fa1592dd5157b0ec52b82bcc8d97d5d76c168bee564f8b21fec6d6fdba4f408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1665adae007c42f01fc090294179122e73ba47919c0c9be89206462c1620f2aec309f0ec556fbc5e0097cc804d82770783ed770087c6a848491a6740eae69db9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2c0dfba171bd747eba88fd610ac75f6ec654a758c902848b2afe50170d36987ed3e91b5485d617285f98843665812c15c22f4119b7a9d49d7ecf85fc63ef25ec"} 13:27:34 INFO - Running post-run listener: copy_logs_to_upload_dir 13:27:34 INFO - Copying logs to upload dir... 13:27:34 INFO - mkdir: /builds/slave/test/build/upload/logs 13:27:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.823265 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-16 13:27:34.763193) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 13:27:34.767844) ========= 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=db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/697b04e6902fc120fcdf8a059e89aff188307994773546a1d801ae6eb883a0dd5fa1592dd5157b0ec52b82bcc8d97d5d76c168bee564f8b21fec6d6fdba4f408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1665adae007c42f01fc090294179122e73ba47919c0c9be89206462c1620f2aec309f0ec556fbc5e0097cc804d82770783ed770087c6a848491a6740eae69db9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2c0dfba171bd747eba88fd610ac75f6ec654a758c902848b2afe50170d36987ed3e91b5485d617285f98843665812c15c22f4119b7a9d49d7ecf85fc63ef25ec"} build_url:https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/bDtCsjoARJGtFSMn5LP52g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/697b04e6902fc120fcdf8a059e89aff188307994773546a1d801ae6eb883a0dd5fa1592dd5157b0ec52b82bcc8d97d5d76c168bee564f8b21fec6d6fdba4f408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1665adae007c42f01fc090294179122e73ba47919c0c9be89206462c1620f2aec309f0ec556fbc5e0097cc804d82770783ed770087c6a848491a6740eae69db9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2c0dfba171bd747eba88fd610ac75f6ec654a758c902848b2afe50170d36987ed3e91b5485d617285f98843665812c15c22f4119b7a9d49d7ecf85fc63ef25ec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 13:27:34.793836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:27:34.794206) ========= 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=db0483c52d987ecb441a263b000001ad-1468688452.728339-1828127773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 13:27:34.878963) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 13:27:34.879428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 13:27:34.879891) ========= ========= Total master_lag: 0.17 =========