builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1467879900.59 results: success (0) buildid: 20160706220754 builduid: f926da4d07b44942bffdb65154673f3c revision: 3ead61d6add6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:00.587030) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:00.587766) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:00.588094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:00.603551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:00.603905) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 01:25:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-07-07 01:25:00 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133728 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:00.754013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:00.754320) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020072 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:00.804346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:00.804722) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3ead61d6add6 --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 3ead61d6add6 --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=82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 01:25:01,008 Setting DEBUG logging. 2016-07-07 01:25:01,008 attempt 1/10 2016-07-07 01:25:01,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3ead61d6add6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 01:25:01,319 unpacking tar archive at: mozilla-inbound-3ead61d6add6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:01.498186) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:01.498533) ========= script_repo_revision: 3ead61d6add6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:01.498976) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:01.499286) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 01:25:01.508446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-07 01:25:01.508853) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:25:01 INFO - MultiFileLogger online at 20160707 01:25:01 in /builds/slave/test 01:25:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:25:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:25:01 INFO - {'append_to_log': False, 01:25:01 INFO - 'base_work_dir': '/builds/slave/test', 01:25:01 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:25:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:25:01 INFO - 'branch': 'Mozilla-Inbound', 01:25:01 INFO - 'buildbot_json_path': 'buildprops.json', 01:25:01 INFO - 'config_files': ('talos/linux_config.py',), 01:25:01 INFO - 'default_actions': ('clobber', 01:25:01 INFO - 'read-buildbot-config', 01:25:01 INFO - 'download-and-extract', 01:25:01 INFO - 'populate-webroot', 01:25:01 INFO - 'create-virtualenv', 01:25:01 INFO - 'install', 01:25:01 INFO - 'run-tests'), 01:25:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:25:01 INFO - 'download_minidump_stackwalk': True, 01:25:01 INFO - 'download_symbols': 'ondemand', 01:25:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:25:01 INFO - 'tooltool.py': '/tools/tooltool.py', 01:25:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:25:01 INFO - '/tools/misc-python/virtualenv.py')}, 01:25:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:25:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:25:01 INFO - 'installer_path': 'installer.exe', 01:25:01 INFO - 'log_level': 'info', 01:25:01 INFO - 'log_name': 'talos', 01:25:01 INFO - 'log_to_console': True, 01:25:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:25:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:25:01 INFO - 'opt_config_files': (), 01:25:01 INFO - 'pip_index': False, 01:25:01 INFO - 'sps_profile': False, 01:25:01 INFO - 'sps_profile_interval': 0, 01:25:01 INFO - 'suite': 'dromaeojs', 01:25:01 INFO - 'system_bits': '32', 01:25:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:25:01 INFO - 'title': 'talos-linux64-ix-066', 01:25:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:25:01 INFO - 'use_talos_json': True, 01:25:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:25:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:25:01 INFO - 'work_dir': 'build'} 01:25:01 INFO - ##### 01:25:01 INFO - ##### Running clobber step. 01:25:01 INFO - ##### 01:25:01 INFO - Running pre-action listener: _resource_record_pre_action 01:25:01 INFO - Running main action method: clobber 01:25:01 INFO - rmtree: /builds/slave/test/build 01:25:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:25:02 INFO - Running post-action listener: _resource_record_post_action 01:25:02 INFO - ##### 01:25:02 INFO - ##### Finished clobber step (success) 01:25:02 INFO - ##### 01:25:02 INFO - ##### 01:25:02 INFO - ##### Running read-buildbot-config step. 01:25:02 INFO - ##### 01:25:02 INFO - Running pre-action listener: _resource_record_pre_action 01:25:02 INFO - Running main action method: read_buildbot_config 01:25:02 INFO - Using buildbot properties: 01:25:02 INFO - { 01:25:02 INFO - "project": "", 01:25:02 INFO - "product": "firefox", 01:25:02 INFO - "script_repo_revision": "production", 01:25:02 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:25:02 INFO - "repository": "", 01:25:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:25:02 INFO - "buildid": "20160706220754", 01:25:02 INFO - "pgo_build": "True", 01:25:02 INFO - "basedir": "/builds/slave/test", 01:25:02 INFO - "buildnumber": 1212, 01:25:02 INFO - "slavename": "talos-linux64-ix-066", 01:25:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:25:02 INFO - "platform": "ubuntu64_hw", 01:25:02 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:25:02 INFO - "branch": "mozilla-inbound", 01:25:02 INFO - "repo_path": "integration/mozilla-inbound", 01:25:02 INFO - "revision": "3ead61d6add6", 01:25:02 INFO - "stage_platform": "linux64-pgo", 01:25:02 INFO - "builduid": "f926da4d07b44942bffdb65154673f3c", 01:25:02 INFO - "slavebuilddir": "test" 01:25:02 INFO - } 01:25:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:25:02 INFO - Running post-action listener: _resource_record_post_action 01:25:02 INFO - ##### 01:25:02 INFO - ##### Finished read-buildbot-config step (success) 01:25:02 INFO - ##### 01:25:02 INFO - ##### 01:25:02 INFO - ##### Running download-and-extract step. 01:25:02 INFO - ##### 01:25:02 INFO - Running pre-action listener: _resource_record_pre_action 01:25:02 INFO - Running main action method: download_and_extract 01:25:02 INFO - mkdir: /builds/slave/test/build/tests 01:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:02 INFO - https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:25:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:25:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:25:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/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 01:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/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 01:25:05 INFO - Downloaded 1361 bytes. 01:25:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:25:06 INFO - Using the following test package requirements: 01:25:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:25:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:25:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:06 INFO - u'jsshell-linux-x86_64.zip'], 01:25:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:25:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:25:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:25:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:25:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:25:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:25:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:25:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:06 INFO - https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:25:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:25:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:25:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/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 01:25:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/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 01:25:07 INFO - Downloaded 24304481 bytes. 01:25: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'] 01:25: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 01:25:08 INFO - Return code: 0 01:25: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 01:25: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')]} 01:25:08 INFO - https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:25:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:25:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:25:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/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 01:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/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 01:25:10 INFO - Downloaded 24304481 bytes. 01:25: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'] 01:25: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 01:25:11 INFO - Return code: 0 01:25: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')]} 01:25:11 INFO - https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:25:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:25:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/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 01:25:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/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 01:25:12 INFO - Downloaded 14403333 bytes. 01:25: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'] 01:25: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 01:25:12 INFO - Return code: 0 01:25: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')]} 01:25:12 INFO - https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:25:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:25:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:25:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/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 01:25:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DEU9tM25TK2nb6ERaLWjCQ/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 01:25:14 INFO - Downloaded 60440733 bytes. 01:25:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:25:14 INFO - mkdir: /builds/slave/test/properties 01:25:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:25:14 INFO - Writing to file /builds/slave/test/properties/build_url 01:25:14 INFO - Contents: 01:25:14 INFO - build_url:https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:25:14 INFO - Running post-action listener: _resource_record_post_action 01:25:14 INFO - Running post-action listener: set_extra_try_arguments 01:25:14 INFO - ##### 01:25:14 INFO - ##### Finished download-and-extract step (success) 01:25:14 INFO - ##### 01:25:14 INFO - ##### 01:25:14 INFO - ##### Running populate-webroot step. 01:25:14 INFO - ##### 01:25:14 INFO - Running pre-action listener: _resource_record_pre_action 01:25:14 INFO - Running main action method: populate_webroot 01:25:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:25:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:25:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:25:14 INFO - '--tppagecycles', 01:25:14 INFO - '7'], 01:25:14 INFO - 'tests': ['tsvgm']}}, 01:25:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:25:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:25:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:25:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:25:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:14 INFO - 'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:25:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:14 INFO - 'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['damp', 'tps']}, 01:25:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:14 INFO - 'tests': ['damp', 'tps']}, 01:25:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['dromaeo_dom']}, 01:25:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:25:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['basic_compositor_video']}, 01:25:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:25:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['a11yr', 01:25:14 INFO - 'ts_paint', 01:25:14 INFO - 'tpaint', 01:25:14 INFO - 'sessionrestore', 01:25:14 INFO - 'sessionrestore_no_auto_restore', 01:25:14 INFO - 'tabpaint']}, 01:25:14 INFO - 'other-e10s': {'tests': ['a11yr', 01:25:14 INFO - 'ts_paint', 01:25:14 INFO - 'tpaint', 01:25:14 INFO - 'sessionrestore', 01:25:14 INFO - 'sessionrestore_no_auto_restore', 01:25:14 INFO - 'tabpaint']}, 01:25:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:25:14 INFO - 'ts_paint', 01:25:14 INFO - 'tpaint', 01:25:14 INFO - 'sessionrestore', 01:25:14 INFO - 'sessionrestore_no_auto_restore', 01:25:14 INFO - 'tabpaint']}, 01:25:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:25:14 INFO - 'ts_paint', 01:25:14 INFO - 'tpaint', 01:25:14 INFO - 'sessionrestore', 01:25:14 INFO - 'sessionrestore_no_auto_restore', 01:25:14 INFO - 'tabpaint']}, 01:25:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['a11yr', 01:25:14 INFO - 'ts_paint', 01:25:14 INFO - 'tpaint', 01:25:14 INFO - 'sessionrestore', 01:25:14 INFO - 'sessionrestore_no_auto_restore', 01:25:14 INFO - 'tabpaint']}, 01:25:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['a11yr', 01:25:14 INFO - 'ts_paint', 01:25:14 INFO - 'tpaint', 01:25:14 INFO - 'sessionrestore', 01:25:14 INFO - 'sessionrestore_no_auto_restore', 01:25:14 INFO - 'tabpaint']}, 01:25:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['tsvgx', 01:25:14 INFO - 'tsvgr_opacity', 01:25:14 INFO - 'tart', 01:25:14 INFO - 'tscrollx', 01:25:14 INFO - 'cart']}, 01:25:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:25:14 INFO - 'tsvgr_opacity', 01:25:14 INFO - 'tart', 01:25:14 INFO - 'tscrollx', 01:25:14 INFO - 'cart']}, 01:25:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:14 INFO - 'talos_options': ['--disable-e10s'], 01:25:14 INFO - 'tests': ['tp5o']}, 01:25:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:14 INFO - 'tests': ['tp5o']}, 01:25:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:14 INFO - 'talos_options': ['--disable-e10s', 01:25:14 INFO - '--xperf_path', 01:25:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:14 INFO - 'tests': ['tp5n']}, 01:25:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:25:14 INFO - 'talos_options': ['--xperf_path', 01:25:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:25:14 INFO - 'tests': ['tp5n']}}, 01:25:14 INFO - 'talos.zip': {'path': '', 01:25:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:25:14 INFO - Running post-action listener: _resource_record_post_action 01:25:14 INFO - ##### 01:25:14 INFO - ##### Finished populate-webroot step (success) 01:25:14 INFO - ##### 01:25:14 INFO - ##### 01:25:14 INFO - ##### Running create-virtualenv step. 01:25:14 INFO - ##### 01:25:14 INFO - Running pre-action listener: _resource_record_pre_action 01:25:14 INFO - Running main action method: create_virtualenv 01:25:14 INFO - Creating virtualenv /builds/slave/test/build/venv 01:25:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:25:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:25:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:25:15 INFO - Using real prefix '/usr' 01:25:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:25:15 INFO - Installing distribute.............................................................................................................................................................................................done. 01:25:17 INFO - Installing pip.................done. 01:25:17 INFO - Return code: 0 01:25:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:17 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 0x226e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d3b0>, '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 0x252e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:17 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 01:25:17 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 01:25:17 INFO - Using env: {'DISPLAY': ':0', 01:25:17 INFO - 'HOME': '/home/cltbld', 01:25:17 INFO - 'LANG': 'en_US.UTF-8', 01:25:17 INFO - 'LANGUAGE': 'en_US:en', 01:25:17 INFO - 'LOGNAME': 'cltbld', 01:25:17 INFO - 'MAIL': '/var/mail/cltbld', 01:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:17 INFO - 'MOZ_NO_REMOTE': '1', 01:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:17 INFO - 'NO_EM_RESTART': '1', 01:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:17 INFO - 'PWD': '/builds/slave/test', 01:25:17 INFO - 'SHELL': '/bin/bash', 01:25:17 INFO - 'SHLVL': '1', 01:25:17 INFO - 'TERM': 'linux', 01:25:17 INFO - 'TMOUT': '86400', 01:25:17 INFO - 'USER': 'cltbld', 01:25:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 01:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:17 INFO - '_': '/tools/buildbot/bin/python'} 01:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:25:17 INFO - Cleaning up... 01:25:17 INFO - Return code: 0 01:25:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:17 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 0x226e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d3b0>, '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 0x252e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:17 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 01:25:17 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 01:25:17 INFO - Using env: {'DISPLAY': ':0', 01:25:17 INFO - 'HOME': '/home/cltbld', 01:25:17 INFO - 'LANG': 'en_US.UTF-8', 01:25:17 INFO - 'LANGUAGE': 'en_US:en', 01:25:17 INFO - 'LOGNAME': 'cltbld', 01:25:17 INFO - 'MAIL': '/var/mail/cltbld', 01:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:17 INFO - 'MOZ_NO_REMOTE': '1', 01:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:17 INFO - 'NO_EM_RESTART': '1', 01:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:17 INFO - 'PWD': '/builds/slave/test', 01:25:17 INFO - 'SHELL': '/bin/bash', 01:25:17 INFO - 'SHLVL': '1', 01:25:17 INFO - 'TERM': 'linux', 01:25:17 INFO - 'TMOUT': '86400', 01:25:17 INFO - 'USER': 'cltbld', 01:25:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 01:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:17 INFO - '_': '/tools/buildbot/bin/python'} 01:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:17 INFO - Downloading/unpacking psutil>=3.1.1 01:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:19 INFO - Installing collected packages: psutil 01:25:19 INFO - Running setup.py install for psutil 01:25:20 INFO - building 'psutil._psutil_linux' extension 01:25: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 01:25:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:25:20 INFO - building 'psutil._psutil_posix' extension 01:25:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:25:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:25:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:25:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:25:20 INFO - Successfully installed psutil 01:25:20 INFO - Cleaning up... 01:25:20 INFO - Return code: 0 01:25:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:20 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 0x226e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d3b0>, '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 0x252e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:20 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 01:25:20 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 01:25:20 INFO - Using env: {'DISPLAY': ':0', 01:25:20 INFO - 'HOME': '/home/cltbld', 01:25:20 INFO - 'LANG': 'en_US.UTF-8', 01:25:20 INFO - 'LANGUAGE': 'en_US:en', 01:25:20 INFO - 'LOGNAME': 'cltbld', 01:25:20 INFO - 'MAIL': '/var/mail/cltbld', 01:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:20 INFO - 'MOZ_NO_REMOTE': '1', 01:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:20 INFO - 'NO_EM_RESTART': '1', 01:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:20 INFO - 'PWD': '/builds/slave/test', 01:25:20 INFO - 'SHELL': '/bin/bash', 01:25:20 INFO - 'SHLVL': '1', 01:25:20 INFO - 'TERM': 'linux', 01:25:20 INFO - 'TMOUT': '86400', 01:25:20 INFO - 'USER': 'cltbld', 01:25:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 01:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:20 INFO - '_': '/tools/buildbot/bin/python'} 01:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:25:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:25:22 INFO - Installing collected packages: mozsystemmonitor 01:25:22 INFO - Running setup.py install for mozsystemmonitor 01:25:22 INFO - Successfully installed mozsystemmonitor 01:25:22 INFO - Cleaning up... 01:25:22 INFO - Return code: 0 01:25:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:22 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 0x226e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d3b0>, '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 0x252e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:22 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 01:25:22 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 01:25:22 INFO - Using env: {'DISPLAY': ':0', 01:25:22 INFO - 'HOME': '/home/cltbld', 01:25:22 INFO - 'LANG': 'en_US.UTF-8', 01:25:22 INFO - 'LANGUAGE': 'en_US:en', 01:25:22 INFO - 'LOGNAME': 'cltbld', 01:25:22 INFO - 'MAIL': '/var/mail/cltbld', 01:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:22 INFO - 'MOZ_NO_REMOTE': '1', 01:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:22 INFO - 'NO_EM_RESTART': '1', 01:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:22 INFO - 'PWD': '/builds/slave/test', 01:25:22 INFO - 'SHELL': '/bin/bash', 01:25:22 INFO - 'SHLVL': '1', 01:25:22 INFO - 'TERM': 'linux', 01:25:22 INFO - 'TMOUT': '86400', 01:25:22 INFO - 'USER': 'cltbld', 01:25:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 01:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:22 INFO - '_': '/tools/buildbot/bin/python'} 01:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:23 INFO - Downloading/unpacking jsonschema==2.5.1 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:25:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:25 INFO - Downloading functools32-3.2.3-2.tar.gz 01:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:25:25 INFO - warning: no files found matching '*.txt' 01:25:25 INFO - no previously-included directories found matching 'build' 01:25:25 INFO - no previously-included directories found matching 'dist' 01:25:25 INFO - no previously-included directories found matching '.git*' 01:25:25 INFO - Installing collected packages: jsonschema, functools32 01:25:25 INFO - Running setup.py install for functools32 01:25:25 INFO - warning: no files found matching '*.txt' 01:25:25 INFO - no previously-included directories found matching 'build' 01:25:25 INFO - no previously-included directories found matching 'dist' 01:25:25 INFO - no previously-included directories found matching '.git*' 01:25:25 INFO - Successfully installed jsonschema functools32 01:25:25 INFO - Cleaning up... 01:25:25 INFO - Return code: 0 01:25:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:25 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 0x226e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d3b0>, '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 0x252e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:25 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 01:25:25 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 01:25:25 INFO - Using env: {'DISPLAY': ':0', 01:25:25 INFO - 'HOME': '/home/cltbld', 01:25:25 INFO - 'LANG': 'en_US.UTF-8', 01:25:25 INFO - 'LANGUAGE': 'en_US:en', 01:25:25 INFO - 'LOGNAME': 'cltbld', 01:25:25 INFO - 'MAIL': '/var/mail/cltbld', 01:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:25 INFO - 'MOZ_NO_REMOTE': '1', 01:25:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:25 INFO - 'NO_EM_RESTART': '1', 01:25:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:25 INFO - 'PWD': '/builds/slave/test', 01:25:25 INFO - 'SHELL': '/bin/bash', 01:25:25 INFO - 'SHLVL': '1', 01:25:25 INFO - 'TERM': 'linux', 01:25:25 INFO - 'TMOUT': '86400', 01:25:25 INFO - 'USER': 'cltbld', 01:25:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 01:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:25 INFO - '_': '/tools/buildbot/bin/python'} 01:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:25 INFO - Downloading/unpacking blobuploader==1.2.4 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25: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 01:25:27 INFO - Downloading blobuploader-1.2.4.tar.gz 01:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:25:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:25:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:28 INFO - Downloading docopt-0.6.1.tar.gz 01:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:25:28 INFO - Installing collected packages: blobuploader, requests, docopt 01:25:28 INFO - Running setup.py install for blobuploader 01:25:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:25:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:25:28 INFO - Running setup.py install for requests 01:25:28 INFO - Running setup.py install for docopt 01:25:28 INFO - Successfully installed blobuploader requests docopt 01:25:28 INFO - Cleaning up... 01:25:28 INFO - Return code: 0 01:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:28 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 0x226e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d3b0>, '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 0x252e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:28 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 01:25:28 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 01:25:28 INFO - Using env: {'DISPLAY': ':0', 01:25:28 INFO - 'HOME': '/home/cltbld', 01:25:28 INFO - 'LANG': 'en_US.UTF-8', 01:25:28 INFO - 'LANGUAGE': 'en_US:en', 01:25:28 INFO - 'LOGNAME': 'cltbld', 01:25:28 INFO - 'MAIL': '/var/mail/cltbld', 01:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:28 INFO - 'MOZ_NO_REMOTE': '1', 01:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:28 INFO - 'NO_EM_RESTART': '1', 01:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:28 INFO - 'PWD': '/builds/slave/test', 01:25:28 INFO - 'SHELL': '/bin/bash', 01:25:28 INFO - 'SHLVL': '1', 01:25:28 INFO - 'TERM': 'linux', 01:25:28 INFO - 'TMOUT': '86400', 01:25:28 INFO - 'USER': 'cltbld', 01:25:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 01:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:28 INFO - '_': '/tools/buildbot/bin/python'} 01:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:29 INFO - Running setup.py (path:/tmp/pip-FU86B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:29 INFO - Running setup.py (path:/tmp/pip-EAPrSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:29 INFO - Running setup.py (path:/tmp/pip-GXBOEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:29 INFO - Running setup.py (path:/tmp/pip-9tyhJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:29 INFO - Running setup.py (path:/tmp/pip-DYrcGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:29 INFO - Running setup.py (path:/tmp/pip-3543Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:29 INFO - Running setup.py (path:/tmp/pip-7uuUwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:29 INFO - Running setup.py (path:/tmp/pip-nmKUBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:29 INFO - Running setup.py (path:/tmp/pip-L0kn_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:29 INFO - Running setup.py (path:/tmp/pip-9NmFjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:29 INFO - Running setup.py (path:/tmp/pip-CaQPkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:29 INFO - Running setup.py (path:/tmp/pip-yV55xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:29 INFO - Running setup.py (path:/tmp/pip-qw6NgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:29 INFO - Running setup.py (path:/tmp/pip-aYkf57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:30 INFO - Running setup.py (path:/tmp/pip-_M0j8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:30 INFO - Running setup.py (path:/tmp/pip-zyyFeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:30 INFO - Running setup.py (path:/tmp/pip-PPOL_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:25:30 INFO - Running setup.py install for manifestparser 01:25:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:25:30 INFO - Running setup.py install for mozcrash 01:25:30 INFO - Running setup.py install for mozdebug 01:25:30 INFO - Running setup.py install for mozdevice 01:25:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:25:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:25:30 INFO - Running setup.py install for mozfile 01:25:30 INFO - Running setup.py install for mozhttpd 01:25:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:25:30 INFO - Running setup.py install for mozinfo 01:25:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:25:30 INFO - Running setup.py install for mozInstall 01:25:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Running setup.py install for mozleak 01:25:31 INFO - Running setup.py install for mozlog 01:25:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Running setup.py install for moznetwork 01:25:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Running setup.py install for mozprocess 01:25:31 INFO - Running setup.py install for mozprofile 01:25:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Running setup.py install for mozrunner 01:25:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:25:31 INFO - Running setup.py install for mozscreenshot 01:25:31 INFO - Running setup.py install for moztest 01:25:31 INFO - Running setup.py install for mozversion 01:25:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:25:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:25:32 INFO - Cleaning up... 01:25:32 INFO - Return code: 0 01:25:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:32 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 0x226e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d3b0>, '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 0x252e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:32 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 01:25:32 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 01:25:32 INFO - Using env: {'DISPLAY': ':0', 01:25:32 INFO - 'HOME': '/home/cltbld', 01:25:32 INFO - 'LANG': 'en_US.UTF-8', 01:25:32 INFO - 'LANGUAGE': 'en_US:en', 01:25:32 INFO - 'LOGNAME': 'cltbld', 01:25:32 INFO - 'MAIL': '/var/mail/cltbld', 01:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:32 INFO - 'MOZ_NO_REMOTE': '1', 01:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:32 INFO - 'NO_EM_RESTART': '1', 01:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:32 INFO - 'PWD': '/builds/slave/test', 01:25:32 INFO - 'SHELL': '/bin/bash', 01:25:32 INFO - 'SHLVL': '1', 01:25:32 INFO - 'TERM': 'linux', 01:25:32 INFO - 'TMOUT': '86400', 01:25:32 INFO - 'USER': 'cltbld', 01:25:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 01:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:32 INFO - '_': '/tools/buildbot/bin/python'} 01:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:25:32 INFO - Running setup.py (path:/tmp/pip-0TaKgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:25:32 INFO - Running setup.py (path:/tmp/pip-AAc_ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:25:32 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)) 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:25:32 INFO - Running setup.py (path:/tmp/pip-C4Q6b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:25:32 INFO - Running setup.py (path:/tmp/pip-xVIzbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:25:32 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)) 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:25:32 INFO - Running setup.py (path:/tmp/pip-g8oV62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:25:32 INFO - Running setup.py (path:/tmp/pip-mR8rAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:25:32 INFO - Running setup.py (path:/tmp/pip-g7RLk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:25:32 INFO - Running setup.py (path:/tmp/pip-Oc75TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:25:32 INFO - Running setup.py (path:/tmp/pip-bEzxkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:25:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:25:32 INFO - Running setup.py (path:/tmp/pip-VS0HE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:25:32 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)) 01:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:25:32 INFO - Running setup.py (path:/tmp/pip-685_nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:25:33 INFO - Running setup.py (path:/tmp/pip-nt9HrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:25:33 INFO - Running setup.py (path:/tmp/pip-4NNlYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:25:33 INFO - Running setup.py (path:/tmp/pip-FBClt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:25:33 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)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:33 INFO - Running setup.py (path:/tmp/pip-mDOPlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:25:33 INFO - Running setup.py (path:/tmp/pip-K7I8xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:25:33 INFO - Running setup.py (path:/tmp/pip-wvOhw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:25:33 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)) 01:25:33 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)) 01:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:25:33 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)) 01:25:33 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)) 01:25:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:25:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:25:35 INFO - Downloading blessings-1.6.tar.gz 01:25:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:25:35 INFO - Installing collected packages: blessings 01:25:35 INFO - Running setup.py install for blessings 01:25:35 INFO - Successfully installed blessings 01:25:35 INFO - Cleaning up... 01:25:35 INFO - Return code: 0 01:25:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:25:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:35 INFO - Reading from file tmpfile_stdout 01:25:35 INFO - Current package versions: 01:25:35 INFO - argparse == 1.2.1 01:25:35 INFO - blessings == 1.6 01:25:35 INFO - blobuploader == 1.2.4 01:25:35 INFO - docopt == 0.6.1 01:25:35 INFO - functools32 == 3.2.3-2 01:25:35 INFO - jsonschema == 2.5.1 01:25:35 INFO - manifestparser == 1.1 01:25:35 INFO - mozInstall == 1.12 01:25:35 INFO - mozcrash == 0.17 01:25:35 INFO - mozdebug == 0.1 01:25:35 INFO - mozdevice == 0.48 01:25:35 INFO - mozfile == 1.2 01:25:35 INFO - mozhttpd == 0.7 01:25:35 INFO - mozinfo == 0.9 01:25:35 INFO - mozleak == 0.1 01:25:35 INFO - mozlog == 3.2 01:25:35 INFO - moznetwork == 0.27 01:25:35 INFO - mozprocess == 0.23 01:25:35 INFO - mozprofile == 0.28 01:25:35 INFO - mozrunner == 6.12 01:25:35 INFO - mozscreenshot == 0.1 01:25:35 INFO - mozsystemmonitor == 0.3 01:25:35 INFO - moztest == 0.7 01:25:35 INFO - mozversion == 1.4 01:25:35 INFO - psutil == 3.1.1 01:25:35 INFO - requests == 1.2.3 01:25:35 INFO - wsgiref == 0.1.2 01:25:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:35 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 0x226e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d3b0>, '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 0x252e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:35 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 01:25:35 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 01:25:35 INFO - Using env: {'DISPLAY': ':0', 01:25:35 INFO - 'HOME': '/home/cltbld', 01:25:35 INFO - 'LANG': 'en_US.UTF-8', 01:25:35 INFO - 'LANGUAGE': 'en_US:en', 01:25:35 INFO - 'LOGNAME': 'cltbld', 01:25:35 INFO - 'MAIL': '/var/mail/cltbld', 01:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:35 INFO - 'MOZ_NO_REMOTE': '1', 01:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:35 INFO - 'NO_EM_RESTART': '1', 01:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:35 INFO - 'PWD': '/builds/slave/test', 01:25:35 INFO - 'SHELL': '/bin/bash', 01:25:35 INFO - 'SHLVL': '1', 01:25:35 INFO - 'TERM': 'linux', 01:25:35 INFO - 'TMOUT': '86400', 01:25:35 INFO - 'USER': 'cltbld', 01:25:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 01:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:35 INFO - '_': '/tools/buildbot/bin/python'} 01:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 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)) 01:25:36 INFO - Cleaning up... 01:25:36 INFO - Return code: 0 01:25:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:25: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')]} 01:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25: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')]} 01:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:25:36 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 0x226e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252d3b0>, '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 0x252e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:25:36 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 01:25:36 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 01:25:36 INFO - Using env: {'DISPLAY': ':0', 01:25:36 INFO - 'HOME': '/home/cltbld', 01:25:36 INFO - 'LANG': 'en_US.UTF-8', 01:25:36 INFO - 'LANGUAGE': 'en_US:en', 01:25:36 INFO - 'LOGNAME': 'cltbld', 01:25:36 INFO - 'MAIL': '/var/mail/cltbld', 01:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:36 INFO - 'MOZ_NO_REMOTE': '1', 01:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:36 INFO - 'NO_EM_RESTART': '1', 01:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:36 INFO - 'PWD': '/builds/slave/test', 01:25:36 INFO - 'SHELL': '/bin/bash', 01:25:36 INFO - 'SHLVL': '1', 01:25:36 INFO - 'TERM': 'linux', 01:25:36 INFO - 'TMOUT': '86400', 01:25:36 INFO - 'USER': 'cltbld', 01:25:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 01:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:36 INFO - '_': '/tools/buildbot/bin/python'} 01:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:25:36 INFO - Cleaning up... 01:25:36 INFO - Return code: 0 01:25:36 INFO - Running post-action listener: _resource_record_post_action 01:25:36 INFO - Running post-action listener: _start_resource_monitoring 01:25:36 INFO - Starting resource monitoring. 01:25:36 INFO - ##### 01:25:36 INFO - ##### Finished create-virtualenv step (success) 01:25:36 INFO - ##### 01:25:36 INFO - ##### 01:25:36 INFO - ##### Running install step. 01:25:36 INFO - ##### 01:25:36 INFO - Running pre-action listener: _resource_record_pre_action 01:25:36 INFO - Running main action method: install 01:25:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:25:36 INFO - Reading from file tmpfile_stdout 01:25:36 INFO - Detecting whether we're running mozinstall >=1.0... 01:25:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:25:36 INFO - Reading from file tmpfile_stdout 01:25:36 INFO - Output received: 01:25:36 INFO - Usage: mozinstall [options] installer 01:25:36 INFO - Options: 01:25:36 INFO - -h, --help show this help message and exit 01:25:36 INFO - -d DEST, --destination=DEST 01:25:36 INFO - Directory to install application into. [default: 01:25:36 INFO - "/builds/slave/test"] 01:25:36 INFO - --app=APP Application being installed. [default: firefox] 01:25:36 INFO - mkdir: /builds/slave/test/build/application 01:25:36 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'] 01:25:36 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 01:25:53 INFO - Reading from file tmpfile_stdout 01:25:53 INFO - Output received: 01:25:53 INFO - /builds/slave/test/build/application/firefox/firefox 01:25:53 INFO - Running post-action listener: _resource_record_post_action 01:25:53 INFO - ##### 01:25:53 INFO - ##### Finished install step (success) 01:25:53 INFO - ##### 01:25:53 INFO - ##### 01:25:53 INFO - ##### Running run-tests step. 01:25:53 INFO - ##### 01:25:53 INFO - Running pre-action listener: _resource_record_pre_action 01:25:53 INFO - Running main action method: run_tests 01:25:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:25:53 INFO - Python 2.7.3 01:25:53 INFO - Return code: 0 01:25:53 INFO - grabbing minidump binary from tooltool 01:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:25:53 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 0x252d3b0>, '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 0x252e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:25:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:25:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:25:53 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 01:25:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:25:53 INFO - Return code: 0 01:25:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:25:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:25:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:25:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:25:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:25:53 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:25:53 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:25:53 INFO - Using env: {'DISPLAY': ':0', 01:25:53 INFO - 'HOME': '/home/cltbld', 01:25:53 INFO - 'LANG': 'en_US.UTF-8', 01:25:53 INFO - 'LANGUAGE': 'en_US:en', 01:25:53 INFO - 'LOGNAME': 'cltbld', 01:25:53 INFO - 'MAIL': '/var/mail/cltbld', 01:25:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:25:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:25:53 INFO - 'MOZ_NO_REMOTE': '1', 01:25:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:25:53 INFO - 'NO_EM_RESTART': '1', 01:25:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:25:53 INFO - 'PWD': '/builds/slave/test', 01:25:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:25:53 INFO - 'SHELL': '/bin/bash', 01:25:53 INFO - 'SHLVL': '1', 01:25:53 INFO - 'TERM': 'linux', 01:25:53 INFO - 'TMOUT': '86400', 01:25:53 INFO - 'USER': 'cltbld', 01:25:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764', 01:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:25:53 INFO - '_': '/tools/buildbot/bin/python'} 01:25:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:25:54 INFO - mozversion application_buildid: 20160706220754 01:25:54 INFO - mozversion application_changeset: 3ead61d6add69268a1a240a9bc36891b9e3b763a 01:25:54 INFO - mozversion application_display_name: Nightly 01:25:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:25:54 INFO - mozversion application_name: Firefox 01:25:54 INFO - mozversion application_remotingname: firefox 01:25:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:25:54 INFO - mozversion application_vendor: Mozilla 01:25:54 INFO - mozversion application_version: 50.0a1 01:25:54 INFO - mozversion platform_buildid: 20160706220754 01:25:54 INFO - mozversion platform_changeset: 3ead61d6add69268a1a240a9bc36891b9e3b763a 01:25:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:25:54 INFO - mozversion platform_version: 50.0a1 01:25:54 INFO - using testdate: 1467879954 01:25:54 INFO - actual date: 1467879954 01:25:54 INFO - starting webserver on 'localhost:40936' 01:25:54 INFO - SUITE-START | Running 2 tests 01:25:54 INFO - TEST-START | dromaeo_css 01:25:54 INFO - operating with platform_type : linux_ 01:25:54 INFO - Initialising browser for dromaeo_css test... 01:25:54 INFO - TEST-INFO | started process 11500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFipC7T/profile http://localhost:40936/getInfo.html) 01:25:58 INFO - PROCESS | 11500 | __metrics Screen width/height:1600/1200 01:25:58 INFO - PROCESS | 11500 | colorDepth:24 01:25:58 INFO - PROCESS | 11500 | Browser inner width/height: 1024/697 01:25:58 INFO - PROCESS | 11500 | __metrics 01:25:59 INFO - PROCESS | 11500 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:26:00 INFO - TEST-INFO | 11500: exit 0 01:26:00 INFO - Browser initialized. 01:26:00 INFO - Running cycle 1/1 for dromaeo_css test... 01:26:00 INFO - TEST-INFO | started process 11588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFipC7T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:26:12 INFO - PROCESS | 11588 | RSS: Main: 157417472 01:26:12 INFO - PROCESS | 11588 | 01:27:03 INFO - PROCESS | 11588 | 1467880023675 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:29:11 INFO - PROCESS | 11588 | Cycle 1(1): loaded http://localhost:40936/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40936/tests/dromaeo/cssquery-ext.html) 01:29:12 INFO - PROCESS | 11588 | RSS: Main: 258060288 01:29:12 INFO - PROCESS | 11588 | 01:32:15 INFO - PROCESS | 11588 | Cycle 1(1): loaded http://localhost:40936/tests/dromaeo/cssquery-ext.html (next: http://localhost:40936/tests/dromaeo/cssquery-jquery.html) 01:32:15 INFO - PROCESS | 11588 | RSS: Main: 243048448 01:32:15 INFO - PROCESS | 11588 | 01:35:17 INFO - PROCESS | 11588 | Cycle 1(1): loaded http://localhost:40936/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40936/tests/dromaeo/cssquery-mootools.html) 01:35:18 INFO - PROCESS | 11588 | RSS: Main: 239558656 01:35:18 INFO - PROCESS | 11588 | 01:38:20 INFO - PROCESS | 11588 | Cycle 1(1): loaded http://localhost:40936/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40936/tests/dromaeo/cssquery-prototype.html) 01:38:20 INFO - PROCESS | 11588 | RSS: Main: 243068928 01:38:20 INFO - PROCESS | 11588 | 01:41:23 INFO - PROCESS | 11588 | Cycle 1(1): loaded http://localhost:40936/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40936/tests/dromaeo/cssquery-yui.html) 01:41:23 INFO - PROCESS | 11588 | RSS: Main: 232046592 01:41:23 INFO - PROCESS | 11588 | 01:44:26 INFO - PROCESS | 11588 | Cycle 1(1): loaded http://localhost:40936/tests/dromaeo/cssquery-yui.html (next: http://localhost:40936/tests/dromaeo/cssquery-dojo.html) 01:44:26 INFO - PROCESS | 11588 | RSS: Main: 276811776 01:44:26 INFO - PROCESS | 11588 | 01:44:26 INFO - PROCESS | 11588 | __start_tp_report 01:44:26 INFO - PROCESS | 11588 | _x_x_mozilla_page_load 01:44:26 INFO - PROCESS | 11588 | _x_x_mozilla_page_load_details 01:44:26 INFO - PROCESS | 11588 | |i|pagename|runs| 01:44:26 INFO - PROCESS | 11588 | |0;dojo.html;3073.7233648971596;3096.4890793019154;3130.2487403023265;3132.420502207091;3139.43490171769;5147.408048074472;5257.158854583258;5272.103742363798;5380.7847686092555;5400.432954539776;5280.709560974145;5297.231901374298;5309.681419114856;5312.043832110218;5336.252924590561;4759.428868535781;4807.903841923159;4842.709437433748;4851.975740121295;5008.424031236418;4916.655834091615;4943.505649435064;4944.629152813535;4992.825251116194;5008.824691135811;4757.3815403997605;4776.47458779534;4777.020710754287;4797.30439086334;4806.158922188603;4782.378290822206;4872.9756351218375;4882.609391248691;4888.340074089988;4915.213565829486;4696.342512048316;4772.7613619319245;4814.807407703723;4830.468648448667;4870.6347023972985;5261.053010458116;5316;5318.760655770499;5322.494363035506;5331.386890507602;5663.7168141593165;5687.232223649796;5694.060480020791;5707.74315155819;5708.5433165347085;5534.1975413565215;5613.129964855454;5666.150077488369;5734.197212390269;5761.510271626917;5348.358197016344;5362.088444964365;5366;5366.8926621467745;5370.731463426813;5845.736941837543;5858.912116318259;5878.323992740804;5883.117532370179;5884.617499862496;5434.429384914527;5499.092649712833;5518.33779946401;5560.221568980346;5655.010373184677;5651.802186923438;5695.658260504383;5699.259096317535;5705.429457054262;5706.115552089433;5583.720813959286;5589.496945274945;5591.384947655754;5593.300837395325;5629.4652008059165;5534.916976245279;5553.111502159635;5593.412691667398;5619.971900140555;5649.802256920988;4335.241332766753;4339.175556644227;4344.543822898613;4346.152500262482;4377.1683380157665;3863.3046051710962;3876.8255428505786;3887.611238876146;3934.86227982025;3947.0527073502153;5233.842984710464;5268.868278292996;5327.520523152934;5356.1697936819855;5366.168243922199;5688.829335119953;5696.572757043238;5698.487136157766;5713.085906255063;5724.627899186539;5262.842114736564;5354.437784032621;5369.060414427459;5382.946170538323;5383.138697808332;4947.604191664658;4967.105920934267;4993.850184494471;5029.899402011939;5036.5718913892;5878.647281163144;5883.735231914574;5898.675572843535;5899.734511946973;5904.940950590525;5526.696031718294;5656.85857853557;5713.600047996601;5735.197072409949;5735.4551317624755;5869.383714709894;5883.058710606282;5885.14665373527;5893.528517718658;5903.291605007426;5602.13166959122;5633.0705433604635;5636.239107720406;5636.549076073986;5639.520640745583;5520.475554822286;5524.088525393265;5567.053600887778;5731.283589551306;5732.656040637575;5463.562914966873;5479.397266300624;5493.807716729895;5500.064988951808;5534.557235421237;5420.9728951356565;5454.209139674805;5460.26286451324;5463.7814487420055;5525.419830917695;5316.867078322918;5408.594355423437;5443.183522471661;5480.890382192254;5495.835124946258;5625.5218306442775;5625.549956003591;5628.718564071698;5661.122526008476;5677.574181936454;5467;5514.889702206014;5516.310461192351;5518.779248830002;5519.530839878656 01:44:26 INFO - PROCESS | 11588 | |1;ext.html;582.9154772557979;610.9572329936905;617.1298469158487;618.8081694674651;621.8569728962339;43608.78195609021;44697;44830;45025.77487112564;48051.75974120125;45549.54450455494;46322.536774632244;46332.07335853281;46356;46511.76744116283;8991.651252312156;9127.224185944202;9134.26925845934;9141.680041198526;9145.72562823113;9032.638694452247;9132.726018219464;9139;9139.588718507683;9141.908580914205;9174.220191283748;9215.2627789777;9216.124468175512;9217.815643687121;9222.677206297782;9159;9191.770205744842;9203.263738900872;9203.585838637277;9206.125418085272;8955.238804701608;9029.954850225773;9031.187193152648;9034.051424600388;9043;42315.36526952098;42324.78837605823;42553.78723106396;42642.57357426417;42697.57302426967;3622.42041273395;3696.8890933272046;3722.32998060349;3761.793101379423;4054.108096218827;32914.17714557131;32995.83502082474;33255.833720831244;33309.66690333114;34643.30713385718;4351.369051487548;4515.571020753023;4582.816687332503;4588.013577080944;4589.747563883985;337936;338476;340482;341033.9999999975;341298;57511.56221094423;57548.95735947749;57713.71143144257;57719;57946;59724;59747;60125;60188;60243.69878150669;16253.593660158354;16444.6711065778;16464.259108340153;16470.258838352303;16473.83526164747;12926.353682315847;12974;12987.740245195044;12992.545260916011;13002.674933126558;15020.549383518512;16634.58413539671;16817.747733784003;16865.241064152142;16868.156592170344;5526.4197259288;6464.191976003;6477.060826180272;6669.399754022064;6669.833254168685;1064.8775390830153;1094.2723089145788;1102.101787043557;1125.5216532973454;1182.0720734223764;32966.67033329636;34297.82851085729;34387.82806086003;36830.8158459206;36934;1057.3338796558119;1116.6984914073155;1125.6848082536903;1133.637236084445;1192.952281908714;16704.582385440463;17271.74092388615;17290.740638890427;17317.826821731873;17364.305427782747;563084;570083;575795;577487;579663;57534;57660.135097973565;57821.42178578245;57843;57971;1155.4800339847102;1313.3039489070807;1374.8418931822969;1460.1750011243614;1548.3187397545043;29963;34306.48540271848;34462.48306275458;34644.84366730197;34680.65319346774;52991.20513192382;53797.73101134626;53978;54048.45951540434;54206.45793542014;496885;506151;507014;508914;509498;36418.63581364152;42774.78612606917;42962.78518607387;44309.11381772411;44351;45020;49206;49515.25727114024;50065;50518;40986;41068.58931410647;41541.1691766169;42006.57993420149;42104.57895421007;41067.589324106375;41760;41956.79021604872;42244;42808.78595607002;41389.793051034554;41788.16423671449;43145.568544314156;43182.352264715424;43434;35238.47142292817;37333.70578581689;37587.248255034196;38121.237575248895;38390.616093839824;28245.293867653472;28525.42949140964;28847.278818028877;28910.42179156363;28950.276243094093 01:44:26 INFO - PROCESS | 11588 | |2;jquery.html;383.20676200265456;391.9941200881987;394.6921401306981;396.8908550148711;412.98141583628734;18055.81944180558;20580.69128963063;20620.617618983364;20929.05819238136;20988.160473581058;18612.906935465337;18819.24723011078;19454.513637159078;19636.312729054487;19685.704714429296;5678.091505359143;5759.539236861052;5901.586888917777;5902.055671092626;5970.97014514929;5849.356570777232;5854.707264636772;5855.385184555625;5866.6480011199255;5871.500922421599;5606.383297837235;5776.59563830532;5778.104393818965;5784;5832.9708351458185;5669.262995810518;5754.309482862062;5777.046787280094;5803.82588522345;5812.070068788995;5177.715225662625;5200.115980283323;5211.817586384496;5212.270282160501;5224.242484839677;23194.53610927772;23332.300030998926;23754.168604098773;24050.518989620283;24101.87949060261;2116.481462041794;2270.71616047994;2351.8588884666974;2444.973111293261;2487.962680559793;9656.903430965742;9684.467354295512;9773;9913.355631883904;10171.84742228867;1844.400569814802;1913.8373238274764;1935.6225536020481;1984.960300793976;2029.188324670129;83121.58439207826;85121.14878851257;85763;87787;89074;10089.798204035878;10227.693169204937;10807.729806754895;10933.726656833644;11124.165687573464;14955.70088598222;15052.623684407758;15066.171360575274;15085.170315632746;15086.622834429227;7720;8293.21214484623;8310.376721745894;8333.583320833934;8428.32573394127;7848.725294614661;8114.513129212266;8186.386021048445;8238.258556729923;8288.171182881664;4231.217224813419;4330.675199360061;4331.4152589400655;4345.196138714285;4659.44086709597;1871.1860340751816;1911.1113332300547;1927.633749587574;1968.675168597194;1995.5210749420326;981.9509024548744;1000.174855744014;1030.1398332392387;1058.2221867263072;1080.7946490166844;19397.8060219396;20125.597488050156;20210.78735275888;20272.695909561367;20687.58624827495;904.3127223310331;937.2595649436869;967.4920666650065;995.2237254941158;1029.464678367245;10386.32488888235;10803;11712.180147389772;11949.22330048544;12045.819312710317;433865;515672;515715;517328;525566;57911;68494.31505684879;87568;88430;102316.48841755744;982.8034393121261;1016.2835201183149;1046.429695815767;1049.6588608702355;1049.7428130108171;13638.659033524242;18529.53676158107;19056.8094319055;19066.95131767766;19190.424287271406;46736.29895551637;47200.52799471961;47267.527324727685;47481.52518474771;47892.76053619709;61795;62315.6884215576;62892;63487.36512634999;63611.681941589995;7659.885101723367;7714.884276735741;8433.156684331763;8727.738167854974;9022.729318120468;8962.955185224033;13607;13660.180389176681;14009.789853152008;14161.150330980174;12090.818637720617;12255.632331030083;12388.380580970736;12441.129120961446;12629.179103358252;11964.341961192218;11987.820182697442;12219.75560488803;12487.12590118683;12626.053046021401;11550.537978480766;12051.81922271149;12358.876411235773;12493.93753031229;12635.162888291608;7261.673224705007;7543.73596924105;7645.61771911391;7882.921170788219;8463.873041904253;11270.605528806453;12175.14773965814;12212.267263964191;12214.938925305316;12226.083043771574 01:44:26 INFO - PROCESS | 11588 | |3;mootools.html;1439.0358459831914;1464.502069296439;1575.7557578575324;1704.7528108424272;1734.6183839555301;8232.91767082329;8690.130986901308;8774.517401542913;8780.165884240987;8783.516906570136;7487.475876688634;8367.121452247518;8574.571271436434;8605.741827745162;8799.604017819198;2267.3424706835;2291.8968646410867;2293.472501324696;2293.7591552886956;2295.2081531871477;2226.053927080984;2277.089164334271;2278.111536500766;2278.7037685100913;2281.577908087001;1966.8328192103688;2107.1466056247245;2147.5490147069136;2156.7196264485597;2171.446281198292;2143.431990522513;2146.431195733132;2159.093180864033;2159.4709296222527;2223.3552269841725;2231.1967691631;2255.9323220303418;2261.0955617752866;2261.7738226177416;2264.3320220534983;8800.515971621558;8901.198892099743;8912.821743565157;8916.108389161096;8955.238804701608;4893.143699852547;4997.175466048097;4997.750112494361;5000.924986125211;5018.447970723218;3140.4661207594536;3196.1689960610174;3286.6384697683234;3304.0913748719295;3307.851146698404;1074.8763892152347;1080.189857606795;1103.4813637590319;1105.9336439813637;1123.0622430270735;12230.327331996737;12232.082593805411;12235.755284894341;12244.510219591206;12249.203801752858;4249.2563801334645;4375.081232941118;4389.670774691847;4501.437320334958;4505.864824055284;10388.584456621802;10391.740206494747;10399.376037437778;10400.947995259976;10405.27163098591;5098.821541246039;5111.437741848394;5111.744412779346;5122.052420302256;5125.051865404837;4649.5350464953235;4702.858914232578;4746.2168742157155;4752.3584316116885;4757.119932812371;3818.427235914635;3833.4249862520846;3879.437481565157;3919.1573811630637;3941.1132495188926;1095.5015467962057;1131.7849608574345;1132.7394699219226;1160.9535618575162;1166.8833116688263;815.7185770909027;978.0268632710498;986.6793292180071;993.1756641987133;1035.4822588705647;6016.639001659914;6246.562740608114;6268.4671802896355;6316.873662526816;6376.139221205078;978.8287049766262;996.0487734213808;1002.318423472046;1003.1322905686528;1004.3572113847143;4286.164197981426;4354.608085272341;4412.0734645724115;4429.136318417942;4443.955560444419;10534.57861685524;11034.558617655364;11093.889061109447;11097;11112.61105861307;9598.184154346958;10326.277160598836;10954.56181752721;10955.56177752881;10992.560297588167;8196.672133114727;8331.6667333306;8364.623591938378;8370.581470926429;8416.537090460084;6223.3465486123305;6479.384458476437;6483.092367068709;6522.967385163044;6541.247756508063;10163.034511721375;10262.384256944608;10305.433201174008;10346.741331466774;10351.63769268072;10322.48387580633;10606.363618182933;10618.256722029384;10623.256372053882;10628.468576571295;7501.812454688677;7600.46796724224;7601.733939312318;7604.885926710993;7607.771766847003;8363.163683631832;8409.705660301861;8521.360897932556;8562.357823163413;8567.657293708182;7674.270944260286;7702.345300649507;7703.268189521987;7714.4599878008;7747.92252077472;7595.468317217742;7628.1227658817725;7679;7737.419693522896;7795.376369890282;7078.823029424306;7266.709331626887;7272.345488906024;7274.854502909806;7278.927210728037;5259.132243179833;5478.671279723229;5485.890282194414;5605.411431799603;5644;5262.105442074933;5308.203769434615;5492.368377636623;5607.299087614048;5628.155776633538 01:44:26 INFO - PROCESS | 11588 | |4;prototype.html;322.74503142517415;322.9128135403441;334.1862564655066;336.60280868575086;337.15542565872516;5230.398504172017;5245.213218017299;5253.842384728459;5309.8938021239555;5314.441983591715;4991.900161996758;5064.088464076464;5180.559652429548;5189.6107791915565;5246.711430871301;4084.775337356444;4093.7339072960312;4112.650424713903;4119.382092686099;4126.339785634299;4130.401091841682;4137.441445404877;4156.314208155666;4157.50109986802;4161.334186530155;3963;4044.2720310344275;4123.299039163349;4136.200752672597;4149.46057012588;4102.138550904314;4123.402106694542;4124.45333000125;4128.236276288896;4135.77253251071;3694.538182727159;3699.315626609059;3707.7775333480076;3709;3710.2950439416422;5110.897782044338;5114.232865070232;5122.1036318644465;5174.146265866128;5208.270842082112;4733.313669517935;4752.738599377033;4753.3582966299455;4770.856874293777;4771.880702982418;5453.4273901240595;5463.617546771728;5481;5484.643498172606;5499.917501237484;3865.632764887331;3956.7823769692654;3959.148783011666;3971.543272523668;3997.5778271918657;5773.364929857712;5779.88440231193;5784;5791.65250084992;5797.217375654275;4080.5511393746665;4082.3060079786505;4082.9591704083173;4086.652634526039;4087.2847251730827;3922.5292964844402;4124.731892426983;4129.814158362881;4135.110951145518;4138;4710.175719249118;4711.175544279806;4740.19416699162;4750.406199225097;4756.524347565285;5539.639923404966;5564.777408903598;5613.691246981455;5614.747336369873;5623;1392.4151856220412;1402.9719405611831;1419.2477986667084;1421.9335498376217;1431.1127101197324;888.9555522223992;906.8639704044446;916.5783739479781;920.742192186189;925.7132585705874;4719.693219940693;4763.833265835679;4765.142274390573;4773.188557945157;4774.259989701602;4985.775640096132;4990.950090499121;5022.8196373852115;5037.244413338029;5043.519971219846;4574.4968053514085;4707.093627081038;4714.38712967312;4768.737719425465;4783.904321913542;2665.560182569893;2680.664916885389;2680.6783186017415;2686;2690.596410538435;5134.794608215704;5139.563137133311;5141.922871156861;5151.201563757623;5162.741862906914;4717.622590192776;5027.698338099725;5051.368578927634;5101;5115.7953681852305;5103.591712662978;5134.589232861287;5136.229565565046;5141.640085194001;5157.355330583677;4937.691511749461;4973.502649734997;4975.353204083446;4985.6260780442335;4997.200447928314;4855.417349917891;4883.658143929891;4892.926606100982;5201.921971170511;5673.914891276717;5839.284732599362;5880.647161170344;5884.440623234761;5893.410658934073;5900.527957763455;3846.6922646188796;3958.0896393829003;3971.980140099281;3979.900502487461;3997.7201595889173;5201.375834899836;5328.413874473727;5567.8886422272135;5631.6902570359025;5652.180433836988;5468.863278418072;5489.121740521658;5519.724013799374;5548.805791797267;5566.860828479321;5497.725113744376;5523.723813809213;5556.333240011225;5582.944170558405;5598.776048957996;5318.4681531848055;5521.309836270466;5531.778728850801;5533.806316778893;5537.6954267515675;5508.504234618904;5526.866992266656;5571.164325351067;5586.245856809279;5618.943810561842;5420.349558053059;5440.483154100354;5456.45435456467;5502.064649009758;5516.724163791875 01:44:26 INFO - PROCESS | 11588 | |5;yui.html;741.907261592301;783.23634456405;836.5315423362917;861.6424183963655;872.6640243506248;14175.078619889713;14254.572362829105;14290.285485725724;14302.141871487705;15899.84100158998;13899.444022239099;14717;14726.410943562245;14727;14731.48439804607;648.1832890557907;790.063774427304;804.2038382001834;809.0291650019971;809.6275713171948;790.2492631999623;815.2011029191395;818.7257268814924;822.0792712162356;822.6010384963288;856.9742907712779;859.4413631139778;860.0968982568278;860.496609483453;862.168007872403;690.8203866994568;712.273481049332;855.7689423855555;856.7001549457702;856.8500512410303;517.6583454919735;597.3638075449633;610.664134725899;612.5069319198044;614.7295190116334;14380.137191768526;14502.637434064127;14506;14512.1292722437;14553.927230363886;13964.371603277878;14182.43270269188;14207.573772786833;14258.2157981311;14486.782698259534;12322.938385308016;12942.352882355844;13074.411651475706;13313.733725325535;13646.317684115755;4592.655550833668;4604.125216208943;4669.509701481364;4705.811767529295;4831.541003604652;82033.17966820316;82168.17831821725;83286;84017;84061;10146.847797283046;10359.378437293635;10368.326058806153;10411.791764164675;10522.210834187314;17894.28422863071;18003.459896203134;19217;19325.323613673736;19401.80598194;8632.179942905414;8659.263962563253;8744.912550874536;8809.691660791841;8969.237614802814;4712.151812673683;4747.691400058985;4769.403824521934;4817.7350245736825;4888.071266459361;3431.69114779671;3545.840437180333;3548.716102711777;3560.181158333598;3561.1097225693575;594.7056207177475;597.5876645114944;604.6644112517595;614.5667304550282;622.0110025060176;616.0225675581345;637.1271358239242;681.2063945503533;684.5413572906165;697.4629535257823;9477.431354118775;9645.08371704687;9742.512874356396;10202.642907498202;10218.437985910847;665.0556210181554;668.5353679192914;678.131991051455;680.5338343234899;737.2848337112991;4529.818807247739;4756.571908528249;4776.283557466339;4783.1390349736685;4793.089313030513;77497.6125119382;119333;122260;123437.38281308537;123673.38163309125;69614.65192674004;106789;107280;107610.46194768976;108031;90224.54887725519;91944.54027729819;93583.53208233915;94037.52981235187;94352.99999999863;9220.492872891788;9319.34764566501;9422.670206542738;9466.52667366615;9489;54517;55111.48885111457;55475.72262138664;55665;56177.43822561722;75719.62140189264;80300;83100.58449707713;83568.58215708882;84403;11167.553297867995;11172.888271117185;11331.603393881174;11337.716557086138;11810.82283765727;12522.186057906207;12529.373531323216;12740;12759.872401275868;12799.768420317467;12630.431630576462;12665.81001285;12846.35768211567;12901.806472902726;13365;11903.404829758305;11985.852243372985;11994.340311282964;12080.275183489019;12107.818382724443;12193.878061219275;12869.35653217354;12884.677883052998;13023.934880325538;13049.934750326567;10118.797624047626;10136.341137826017;10387.636432724817;10456.68629941103;10845.566177352817;10206.897931020594;10410.843837342294;10478.161747060065;10634;10662.200334974752 01:44:26 INFO - PROCESS | 11588 | __end_tp_report 01:44:26 INFO - PROCESS | 11588 | __start_cc_report 01:44:26 INFO - PROCESS | 11588 | _x_x_mozilla_cycle_collect,943 01:44:26 INFO - PROCESS | 11588 | __end_cc_report 01:44:26 INFO - PROCESS | 11588 | __startTimestamp1467881066973__endTimestamp 01:44:26 INFO - PROCESS | 11588 | 01:44:26 INFO - PROCESS | 11588 | ------- Summary: start ------- 01:44:26 INFO - PROCESS | 11588 | Number of tests: 6 01:44:26 INFO - PROCESS | 11588 | 01:44:26 INFO - PROCESS | 11588 | [#0] dojo.html Cycles:165 Average:5276.81 Median:5463.56 stddev:585.61 (10.7%) stddev-sans-first:561.33 01:44:26 INFO - PROCESS | 11588 | Values: 3073.7 3096.5 3130.2 3132.4 3139.4 5147.4 5257.2 5272.1 5380.8 5400.4 5280.7 5297.2 5309.7 5312.0 5336.3 4759.4 4807.9 4842.7 4852.0 5008.4 4916.7 4943.5 4944.6 4992.8 5008.8 4757.4 4776.5 4777.0 4797.3 4806.2 4782.4 4873.0 4882.6 4888.3 4915.2 4696.3 4772.8 4814.8 4830.5 4870.6 5261.1 5316.0 5318.8 5322.5 5331.4 5663.7 5687.2 5694.1 5707.7 5708.5 5534.2 5613.1 5666.2 5734.2 5761.5 5348.4 5362.1 5366.0 5366.9 5370.7 5845.7 5858.9 5878.3 5883.1 5884.6 5434.4 5499.1 5518.3 5560.2 5655.0 5651.8 5695.7 5699.3 5705.4 5706.1 5583.7 5589.5 5591.4 5593.3 5629.5 5534.9 5553.1 5593.4 5620.0 5649.8 4335.2 4339.2 4344.5 4346.2 4377.2 3863.3 3876.8 3887.6 3934.9 3947.1 5233.8 5268.9 5327.5 5356.2 5366.2 5688.8 5696.6 5698.5 5713.1 5724.6 5262.8 5354.4 5369.1 5382.9 5383.1 4947.6 4967.1 4993.9 5029.9 5036.6 5878.6 5883.7 5898.7 5899.7 5904.9 5526.7 5656.9 5713.6 5735.2 5735.5 5869.4 5883.1 5885.1 5893.5 5903.3 5602.1 5633.1 5636.2 5636.5 5639.5 5520.5 5524.1 5567.1 5731.3 5732.7 5463.6 5479.4 5493.8 5500.1 5534.6 5421.0 5454.2 5460.3 5463.8 5525.4 5316.9 5408.6 5443.2 5480.9 5495.8 5625.5 5625.5 5628.7 5661.1 5677.6 5467.0 5514.9 5516.3 5518.8 5519.5 01:44:26 INFO - PROCESS | 11588 | 01:44:26 INFO - PROCESS | 11588 | [#1] ext.html Cycles:180 Average:63744.84 Median:43163.96 stddev:128312.62 (297.3%) stddev-sans-first:128584.94 01:44:26 INFO - PROCESS | 11588 | Values: 582.9 611.0 617.1 618.8 621.9 43608.8 44697.0 44830.0 45025.8 48051.8 45549.5 46322.5 46332.1 46356.0 46511.8 8991.7 9127.2 9134.3 9141.7 9145.7 9032.6 9132.7 9139.0 9139.6 9141.9 9174.2 9215.3 9216.1 9217.8 9222.7 9159.0 9191.8 9203.3 9203.6 9206.1 8955.2 9030.0 9031.2 9034.1 9043.0 42315.4 42324.8 42553.8 42642.6 42697.6 3622.4 3696.9 3722.3 3761.8 4054.1 32914.2 32995.8 33255.8 33309.7 34643.3 4351.4 4515.6 4582.8 4588.0 4589.7 337936.0 338476.0 340482.0 341034.0 341298.0 57511.6 57549.0 57713.7 57719.0 57946.0 59724.0 59747.0 60125.0 60188.0 60243.7 16253.6 16444.7 16464.3 16470.3 16473.8 12926.4 12974.0 12987.7 12992.5 13002.7 15020.5 16634.6 16817.7 16865.2 16868.2 5526.4 6464.2 6477.1 6669.4 6669.8 1064.9 1094.3 1102.1 1125.5 1182.1 32966.7 34297.8 34387.8 36830.8 36934.0 1057.3 1116.7 1125.7 1133.6 1193.0 16704.6 17271.7 17290.7 17317.8 17364.3 563084.0 570083.0 575795.0 577487.0 579663.0 57534.0 57660.1 57821.4 57843.0 57971.0 1155.5 1313.3 1374.8 1460.2 1548.3 29963.0 34306.5 34462.5 34644.8 34680.7 52991.2 53797.7 53978.0 54048.5 54206.5 496885.0 506151.0 507014.0 508914.0 509498.0 36418.6 42774.8 42962.8 44309.1 44351.0 45020.0 49206.0 49515.3 50065.0 50518.0 40986.0 41068.6 41541.2 42006.6 42104.6 41067.6 41760.0 41956.8 42244.0 42808.8 41389.8 41788.2 43145.6 43182.4 43434.0 35238.5 37333.7 37587.2 38121.2 38390.6 28245.3 28525.4 28847.3 28910.4 28950.3 01:44:26 INFO - PROCESS | 11588 | 01:44:26 INFO - PROCESS | 11588 | [#2] jquery.html Cycles:180 Average:29544.01 Median:387.60 stddev:82836.30 (21371.6%) stddev-sans-first:83039.74 01:44:26 INFO - PROCESS | 11588 | Values: 383.2 392.0 394.7 396.9 413.0 18055.8 20580.7 20620.6 20929.1 20988.2 18612.9 18819.2 19454.5 19636.3 19685.7 5678.1 5759.5 5901.6 5902.1 5971.0 5849.4 5854.7 5855.4 5866.6 5871.5 5606.4 5776.6 5778.1 5784.0 5833.0 5669.3 5754.3 5777.0 5803.8 5812.1 5177.7 5200.1 5211.8 5212.3 5224.2 23194.5 23332.3 23754.2 24050.5 24101.9 2116.5 2270.7 2351.9 2445.0 2488.0 9656.9 9684.5 9773.0 9913.4 10171.8 1844.4 1913.8 1935.6 1985.0 2029.2 83121.6 85121.1 85763.0 87787.0 89074.0 10089.8 10227.7 10807.7 10933.7 11124.2 14955.7 15052.6 15066.2 15085.2 15086.6 7720.0 8293.2 8310.4 8333.6 8428.3 7848.7 8114.5 8186.4 8238.3 8288.2 4231.2 4330.7 4331.4 4345.2 4659.4 1871.2 1911.1 1927.6 1968.7 1995.5 982.0 1000.2 1030.1 1058.2 1080.8 19397.8 20125.6 20210.8 20272.7 20687.6 904.3 937.3 967.5 995.2 1029.5 10386.3 10803.0 11712.2 11949.2 12045.8 433865.0 515672.0 515715.0 517328.0 525566.0 57911.0 68494.3 87568.0 88430.0 102316.5 982.8 1016.3 1046.4 1049.7 1049.7 13638.7 18529.5 19056.8 19067.0 19190.4 46736.3 47200.5 47267.5 47481.5 47892.8 61795.0 62315.7 62892.0 63487.4 63611.7 7659.9 7714.9 8433.2 8727.7 9022.7 8963.0 13607.0 13660.2 14009.8 14161.2 12090.8 12255.6 12388.4 12441.1 12629.2 11964.3 11987.8 12219.8 12487.1 12626.1 11550.5 12051.8 12358.9 12493.9 12635.2 7261.7 7543.7 7645.6 7882.9 8463.9 11270.6 12175.1 12212.3 12214.9 12226.1 01:44:26 INFO - PROCESS | 11588 | 01:44:26 INFO - PROCESS | 11588 | [#3] mootools.html Cycles:180 Average:5811.61 Median:4472.70 stddev:3324.22 (74.3%) stddev-sans-first:3317.30 01:44:26 INFO - PROCESS | 11588 | Values: 1439.0 1464.5 1575.8 1704.8 1734.6 8232.9 8690.1 8774.5 8780.2 8783.5 7487.5 8367.1 8574.6 8605.7 8799.6 2267.3 2291.9 2293.5 2293.8 2295.2 2226.1 2277.1 2278.1 2278.7 2281.6 1966.8 2107.1 2147.5 2156.7 2171.4 2143.4 2146.4 2159.1 2159.5 2223.4 2231.2 2255.9 2261.1 2261.8 2264.3 8800.5 8901.2 8912.8 8916.1 8955.2 4893.1 4997.2 4997.8 5000.9 5018.4 3140.5 3196.2 3286.6 3304.1 3307.9 1074.9 1080.2 1103.5 1105.9 1123.1 12230.3 12232.1 12235.8 12244.5 12249.2 4249.3 4375.1 4389.7 4501.4 4505.9 10388.6 10391.7 10399.4 10400.9 10405.3 5098.8 5111.4 5111.7 5122.1 5125.1 4649.5 4702.9 4746.2 4752.4 4757.1 3818.4 3833.4 3879.4 3919.2 3941.1 1095.5 1131.8 1132.7 1161.0 1166.9 815.7 978.0 986.7 993.2 1035.5 6016.6 6246.6 6268.5 6316.9 6376.1 978.8 996.0 1002.3 1003.1 1004.4 4286.2 4354.6 4412.1 4429.1 4444.0 10534.6 11034.6 11093.9 11097.0 11112.6 9598.2 10326.3 10954.6 10955.6 10992.6 8196.7 8331.7 8364.6 8370.6 8416.5 6223.3 6479.4 6483.1 6523.0 6541.2 10163.0 10262.4 10305.4 10346.7 10351.6 10322.5 10606.4 10618.3 10623.3 10628.5 7501.8 7600.5 7601.7 7604.9 7607.8 8363.2 8409.7 8521.4 8562.4 8567.7 7674.3 7702.3 7703.3 7714.5 7747.9 7595.5 7628.1 7679.0 7737.4 7795.4 7078.8 7266.7 7272.3 7274.9 7278.9 5259.1 5478.7 5485.9 5605.4 5644.0 5262.1 5308.2 5492.4 5607.3 5628.2 01:44:26 INFO - PROCESS | 11588 | 01:44:26 INFO - PROCESS | 11588 | [#4] prototype.html Cycles:180 Average:4507.25 Median:4994.55 stddev:1304.02 (26.1%) stddev-sans-first:1269.30 01:44:26 INFO - PROCESS | 11588 | Values: 322.7 322.9 334.2 336.6 337.2 5230.4 5245.2 5253.8 5309.9 5314.4 4991.9 5064.1 5180.6 5189.6 5246.7 4084.8 4093.7 4112.7 4119.4 4126.3 4130.4 4137.4 4156.3 4157.5 4161.3 3963.0 4044.3 4123.3 4136.2 4149.5 4102.1 4123.4 4124.5 4128.2 4135.8 3694.5 3699.3 3707.8 3709.0 3710.3 5110.9 5114.2 5122.1 5174.1 5208.3 4733.3 4752.7 4753.4 4770.9 4771.9 5453.4 5463.6 5481.0 5484.6 5499.9 3865.6 3956.8 3959.1 3971.5 3997.6 5773.4 5779.9 5784.0 5791.7 5797.2 4080.6 4082.3 4083.0 4086.7 4087.3 3922.5 4124.7 4129.8 4135.1 4138.0 4710.2 4711.2 4740.2 4750.4 4756.5 5539.6 5564.8 5613.7 5614.7 5623.0 1392.4 1403.0 1419.2 1421.9 1431.1 889.0 906.9 916.6 920.7 925.7 4719.7 4763.8 4765.1 4773.2 4774.3 4985.8 4991.0 5022.8 5037.2 5043.5 4574.5 4707.1 4714.4 4768.7 4783.9 2665.6 2680.7 2680.7 2686.0 2690.6 5134.8 5139.6 5141.9 5151.2 5162.7 4717.6 5027.7 5051.4 5101.0 5115.8 5103.6 5134.6 5136.2 5141.6 5157.4 4937.7 4973.5 4975.4 4985.6 4997.2 4855.4 4883.7 4892.9 5201.9 5673.9 5839.3 5880.6 5884.4 5893.4 5900.5 3846.7 3958.1 3972.0 3979.9 3997.7 5201.4 5328.4 5567.9 5631.7 5652.2 5468.9 5489.1 5519.7 5548.8 5566.9 5497.7 5523.7 5556.3 5582.9 5598.8 5318.5 5521.3 5531.8 5533.8 5537.7 5508.5 5526.9 5571.2 5586.2 5618.9 5420.3 5440.5 5456.5 5502.1 5516.7 01:44:26 INFO - PROCESS | 11588 | 01:44:26 INFO - PROCESS | 11588 | [#5] yui.html Cycles:180 Average:21134.37 Median:4729.92 stddev:31401.00 (663.9%) stddev-sans-first:31451.76 01:44:26 INFO - PROCESS | 11588 | Values: 741.9 783.2 836.5 861.6 872.7 14175.1 14254.6 14290.3 14302.1 15899.8 13899.4 14717.0 14726.4 14727.0 14731.5 648.2 790.1 804.2 809.0 809.6 790.2 815.2 818.7 822.1 822.6 857.0 859.4 860.1 860.5 862.2 690.8 712.3 855.8 856.7 856.9 517.7 597.4 610.7 612.5 614.7 14380.1 14502.6 14506.0 14512.1 14553.9 13964.4 14182.4 14207.6 14258.2 14486.8 12322.9 12942.4 13074.4 13313.7 13646.3 4592.7 4604.1 4669.5 4705.8 4831.5 82033.2 82168.2 83286.0 84017.0 84061.0 10146.8 10359.4 10368.3 10411.8 10522.2 17894.3 18003.5 19217.0 19325.3 19401.8 8632.2 8659.3 8744.9 8809.7 8969.2 4712.2 4747.7 4769.4 4817.7 4888.1 3431.7 3545.8 3548.7 3560.2 3561.1 594.7 597.6 604.7 614.6 622.0 616.0 637.1 681.2 684.5 697.5 9477.4 9645.1 9742.5 10202.6 10218.4 665.1 668.5 678.1 680.5 737.3 4529.8 4756.6 4776.3 4783.1 4793.1 77497.6 119333.0 122260.0 123437.4 123673.4 69614.7 106789.0 107280.0 107610.5 108031.0 90224.5 91944.5 93583.5 94037.5 94353.0 9220.5 9319.3 9422.7 9466.5 9489.0 54517.0 55111.5 55475.7 55665.0 56177.4 75719.6 80300.0 83100.6 83568.6 84403.0 11167.6 11172.9 11331.6 11337.7 11810.8 12522.2 12529.4 12740.0 12759.9 12799.8 12630.4 12665.8 12846.4 12901.8 13365.0 11903.4 11985.9 11994.3 12080.3 12107.8 12193.9 12869.4 12884.7 13023.9 13049.9 10118.8 10136.3 10387.6 10456.7 10845.6 10206.9 10410.8 10478.2 10634.0 10662.2 01:44:26 INFO - PROCESS | 11588 | -------- Summary: end -------- 01:44:26 INFO - PROCESS | 11588 | 01:44:27 INFO - TEST-INFO | 11588: exit 0 01:44:27 INFO - TEST-OK | dromaeo_css | took 1113752ms 01:44:27 INFO - TEST-START | kraken 01:44:27 INFO - operating with platform_type : linux_ 01:44:27 INFO - Initialising browser for kraken test... 01:44:27 INFO - TEST-INFO | started process 11782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp96g7I2/profile http://localhost:40936/getInfo.html) 01:44:31 INFO - PROCESS | 11782 | __metrics Screen width/height:1600/1200 01:44:31 INFO - PROCESS | 11782 | colorDepth:24 01:44:31 INFO - PROCESS | 11782 | Browser inner width/height: 1024/697 01:44:31 INFO - PROCESS | 11782 | __metrics 01:44:32 INFO - PROCESS | 11782 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:44:33 INFO - TEST-INFO | 11782: exit 0 01:44:33 INFO - Browser initialized. 01:44:33 INFO - Running cycle 1/1 for kraken test... 01:44:33 INFO - TEST-INFO | started process 11862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp96g7I2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:44:45 INFO - PROCESS | 11862 | RSS: Main: 157024256 01:44:45 INFO - PROCESS | 11862 | 01:44:48 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40936/tests/kraken/driver.html?testName=audio-beat-detection) 01:44:48 INFO - PROCESS | 11862 | RSS: Main: 215519232 01:44:48 INFO - PROCESS | 11862 | 01:44:51 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40936/tests/kraken/driver.html?testName=audio-dft) 01:44:52 INFO - PROCESS | 11862 | RSS: Main: 203608064 01:44:52 INFO - PROCESS | 11862 | 01:44:55 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40936/tests/kraken/driver.html?testName=audio-fft) 01:44:55 INFO - PROCESS | 11862 | RSS: Main: 269651968 01:44:55 INFO - PROCESS | 11862 | 01:44:57 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40936/tests/kraken/driver.html?testName=audio-oscillator) 01:44:58 INFO - PROCESS | 11862 | RSS: Main: 179802112 01:44:58 INFO - PROCESS | 11862 | 01:45:00 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40936/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:45:01 INFO - PROCESS | 11862 | RSS: Main: 184270848 01:45:01 INFO - PROCESS | 11862 | 01:45:04 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40936/tests/kraken/driver.html?testName=imaging-darkroom) 01:45:04 INFO - PROCESS | 11862 | RSS: Main: 219082752 01:45:04 INFO - PROCESS | 11862 | 01:45:08 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40936/tests/kraken/driver.html?testName=imaging-desaturate) 01:45:08 INFO - PROCESS | 11862 | RSS: Main: 221028352 01:45:08 INFO - PROCESS | 11862 | 01:45:11 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40936/tests/kraken/driver.html?testName=json-parse-financial) 01:45:12 INFO - PROCESS | 11862 | RSS: Main: 221159424 01:45:12 INFO - PROCESS | 11862 | 01:45:13 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40936/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:45:14 INFO - PROCESS | 11862 | RSS: Main: 206024704 01:45:14 INFO - PROCESS | 11862 | 01:45:16 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40936/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:45:16 INFO - PROCESS | 11862 | RSS: Main: 209289216 01:45:16 INFO - PROCESS | 11862 | 01:45:18 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40936/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:45:19 INFO - PROCESS | 11862 | RSS: Main: 209342464 01:45:19 INFO - PROCESS | 11862 | 01:45:21 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:45:22 INFO - PROCESS | 11862 | RSS: Main: 222109696 01:45:22 INFO - PROCESS | 11862 | 01:45:25 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:45:25 INFO - PROCESS | 11862 | RSS: Main: 222408704 01:45:25 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | Cycle 1(1): loaded http://localhost:40936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40936/tests/kraken/driver.html?testName=ai-astar) 01:45:27 INFO - PROCESS | 11862 | RSS: Main: 264003584 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | __start_tp_report 01:45:27 INFO - PROCESS | 11862 | _x_x_mozilla_page_load 01:45:27 INFO - PROCESS | 11862 | _x_x_mozilla_page_load_details 01:45:27 INFO - PROCESS | 11862 | |i|pagename|runs| 01:45:27 INFO - PROCESS | 11862 | |0;ai-astar;101;111;112;112;111;111;111;111;111;111 01:45:27 INFO - PROCESS | 11862 | |1;audio-beat-detection;140;117;116;173;115;122;144;116;162;119 01:45:27 INFO - PROCESS | 11862 | |2;audio-dft;160;161;160;160;158;160;161;159;161;161 01:45:27 INFO - PROCESS | 11862 | |3;audio-fft;74;75;75;126;76;76;76;75;119;74 01:45:27 INFO - PROCESS | 11862 | |4;audio-oscillator;84;84;114;84;84;84;111;84;84;127 01:45:27 INFO - PROCESS | 11862 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 01:45:27 INFO - PROCESS | 11862 | |6;imaging-darkroom;146;146;146;147;145;146;145;145;145;145 01:45:27 INFO - PROCESS | 11862 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 01:45:27 INFO - PROCESS | 11862 | |8;json-parse-financial;52;53;52;51;52;51;52;52;52;52 01:45:27 INFO - PROCESS | 11862 | |9;json-stringify-tinderbox;61;62;61;61;62;60;61;61;62;62 01:45:27 INFO - PROCESS | 11862 | |10;stanford-crypto-aes;75;75;74;76;76;76;75;76;75;79 01:45:27 INFO - PROCESS | 11862 | |11;stanford-crypto-ccm;121;117;123;116;125;127;122;126;180;128 01:45:27 INFO - PROCESS | 11862 | |12;stanford-crypto-pbkdf2;164;160;158;157;156;157;156;155;162;160 01:45:27 INFO - PROCESS | 11862 | |13;stanford-crypto-sha256-iterative;63;66;63;63;66;62;62;63;63;61 01:45:27 INFO - PROCESS | 11862 | __end_tp_report 01:45:27 INFO - PROCESS | 11862 | __start_cc_report 01:45:27 INFO - PROCESS | 11862 | _x_x_mozilla_cycle_collect,1673 01:45:27 INFO - PROCESS | 11862 | __end_cc_report 01:45:27 INFO - PROCESS | 11862 | __startTimestamp1467881127735__endTimestamp 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | ------- Summary: start ------- 01:45:27 INFO - PROCESS | 11862 | Number of tests: 14 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.26 (2.9%) stddev-sans-first:0.44 01:45:27 INFO - PROCESS | 11862 | Values: 101.0 111.0 112.0 112.0 111.0 111.0 111.0 111.0 111.0 111.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:131.00 stddev:21.30 (16.3%) stddev-sans-first:22.41 01:45:27 INFO - PROCESS | 11862 | Values: 140.0 117.0 116.0 173.0 115.0 122.0 144.0 116.0 162.0 119.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:0.99 (0.6%) stddev-sans-first:1.05 01:45:27 INFO - PROCESS | 11862 | Values: 160.0 161.0 160.0 160.0 158.0 160.0 161.0 159.0 161.0 161.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#3] audio-fft Cycles:10 Average:84.60 Median:75.00 stddev:20.06 (26.7%) stddev-sans-first:20.90 01:45:27 INFO - PROCESS | 11862 | Values: 74.0 75.0 75.0 126.0 76.0 76.0 76.0 75.0 119.0 74.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.00 stddev:16.59 (19.8%) stddev-sans-first:17.20 01:45:27 INFO - PROCESS | 11862 | Values: 84.0 84.0 114.0 84.0 84.0 84.0 111.0 84.0 84.0 127.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:45:27 INFO - PROCESS | 11862 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 01:45:27 INFO - PROCESS | 11862 | Values: 146.0 146.0 146.0 147.0 145.0 146.0 145.0 145.0 145.0 145.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:45:27 INFO - PROCESS | 11862 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 01:45:27 INFO - PROCESS | 11862 | Values: 52.0 53.0 52.0 51.0 52.0 51.0 52.0 52.0 52.0 52.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 01:45:27 INFO - PROCESS | 11862 | Values: 61.0 62.0 61.0 61.0 62.0 60.0 61.0 61.0 62.0 62.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.00 stddev:1.34 (1.8%) stddev-sans-first:1.39 01:45:27 INFO - PROCESS | 11862 | Values: 75.0 75.0 74.0 76.0 76.0 76.0 75.0 76.0 75.0 79.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:125.50 stddev:18.53 (14.8%) stddev-sans-first:19.46 01:45:27 INFO - PROCESS | 11862 | Values: 121.0 117.0 123.0 116.0 125.0 127.0 122.0 126.0 180.0 128.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.00 stddev:2.92 (1.8%) stddev-sans-first:2.32 01:45:27 INFO - PROCESS | 11862 | Values: 164.0 160.0 158.0 157.0 156.0 157.0 156.0 155.0 162.0 160.0 01:45:27 INFO - PROCESS | 11862 | 01:45:27 INFO - PROCESS | 11862 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.62 (2.6%) stddev-sans-first:1.72 01:45:27 INFO - PROCESS | 11862 | Values: 63.0 66.0 63.0 63.0 66.0 62.0 62.0 63.0 63.0 61.0 01:45:27 INFO - PROCESS | 11862 | -------- Summary: end -------- 01:45:27 INFO - PROCESS | 11862 | 01:45:28 INFO - TEST-INFO | 11862: exit 0 01:45:28 INFO - TEST-OK | kraken | took 60899ms 01:45:28 INFO - SUITE-END | took 1174s 01:45:28 INFO - Completed test suite (00:19:34) 01:45:28 INFO - javascript benchmark 01:45:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.7233648971596, 3096.4890793019154, 3130.2487403023265, 3132.420502207091, 3139.43490171769, 5147.408048074472, 5257.158854583258, 5272.103742363798, 5380.7847686092555, 5400.432954539776, 5280.709560974145, 5297.231901374298, 5309.681419114856, 5312.043832110218, 5336.252924590561, 4759.428868535781, 4807.903841923159, 4842.709437433748, 4851.975740121295, 5008.424031236418, 4916.655834091615, 4943.505649435064, 4944.629152813535, 4992.825251116194, 5008.824691135811, 4757.3815403997605, 4776.47458779534, 4777.020710754287, 4797.30439086334, 4806.158922188603, 4782.378290822206, 4872.9756351218375, 4882.609391248691, 4888.340074089988, 4915.213565829486, 4696.342512048316, 4772.7613619319245, 4814.807407703723, 4830.468648448667, 4870.6347023972985, 5261.053010458116, 5316.0, 5318.760655770499, 5322.494363035506, 5331.386890507602, 5663.7168141593165, 5687.232223649796, 5694.060480020791, 5707.74315155819, 5708.5433165347085, 5534.1975413565215, 5613.129964855454, 5666.150077488369, 5734.197212390269, 5761.510271626917, 5348.358197016344, 5362.088444964365, 5366.0, 5366.8926621467745, 5370.731463426813, 5845.736941837543, 5858.912116318259, 5878.323992740804, 5883.117532370179, 5884.617499862496, 5434.429384914527, 5499.092649712833, 5518.33779946401, 5560.221568980346, 5655.010373184677, 5651.802186923438, 5695.658260504383, 5699.259096317535, 5705.429457054262, 5706.115552089433, 5583.720813959286, 5589.496945274945, 5591.384947655754, 5593.300837395325, 5629.4652008059165, 5534.916976245279, 5553.111502159635, 5593.412691667398, 5619.971900140555, 5649.802256920988, 4335.241332766753, 4339.175556644227, 4344.543822898613, 4346.152500262482, 4377.1683380157665, 3863.3046051710962, 3876.8255428505786, 3887.611238876146, 3934.86227982025, 3947.0527073502153, 5233.842984710464, 5268.868278292996, 5327.520523152934, 5356.1697936819855, 5366.168243922199, 5688.829335119953, 5696.572757043238, 5698.487136157766, 5713.085906255063, 5724.627899186539, 5262.842114736564, 5354.437784032621, 5369.060414427459, 5382.946170538323, 5383.138697808332, 4947.604191664658, 4967.105920934267, 4993.850184494471, 5029.899402011939, 5036.5718913892, 5878.647281163144, 5883.735231914574, 5898.675572843535, 5899.734511946973, 5904.940950590525, 5526.696031718294, 5656.85857853557, 5713.600047996601, 5735.197072409949, 5735.4551317624755, 5869.383714709894, 5883.058710606282, 5885.14665373527, 5893.528517718658, 5903.291605007426, 5602.13166959122, 5633.0705433604635, 5636.239107720406, 5636.549076073986, 5639.520640745583, 5520.475554822286, 5524.088525393265, 5567.053600887778, 5731.283589551306, 5732.656040637575, 5463.562914966873, 5479.397266300624, 5493.807716729895, 5500.064988951808, 5534.557235421237, 5420.9728951356565, 5454.209139674805, 5460.26286451324, 5463.7814487420055, 5525.419830917695, 5316.867078322918, 5408.594355423437, 5443.183522471661, 5480.890382192254, 5495.835124946258, 5625.5218306442775, 5625.549956003591, 5628.718564071698, 5661.122526008476, 5677.574181936454, 5467.0, 5514.889702206014, 5516.310461192351, 5518.779248830002, 5519.530839878656], "value": 5238.250861925037, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.9154772557979, 610.9572329936905, 617.1298469158487, 618.8081694674651, 621.8569728962339, 43608.78195609021, 44697.0, 44830.0, 45025.77487112564, 48051.75974120125, 45549.54450455494, 46322.536774632244, 46332.07335853281, 46356.0, 46511.76744116283, 8991.651252312156, 9127.224185944202, 9134.26925845934, 9141.680041198526, 9145.72562823113, 9032.638694452247, 9132.726018219464, 9139.0, 9139.588718507683, 9141.908580914205, 9174.220191283748, 9215.2627789777, 9216.124468175512, 9217.815643687121, 9222.677206297782, 9159.0, 9191.770205744842, 9203.263738900872, 9203.585838637277, 9206.125418085272, 8955.238804701608, 9029.954850225773, 9031.187193152648, 9034.051424600388, 9043.0, 42315.36526952098, 42324.78837605823, 42553.78723106396, 42642.57357426417, 42697.57302426967, 3622.42041273395, 3696.8890933272046, 3722.32998060349, 3761.793101379423, 4054.108096218827, 32914.17714557131, 32995.83502082474, 33255.833720831244, 33309.66690333114, 34643.30713385718, 4351.369051487548, 4515.571020753023, 4582.816687332503, 4588.013577080944, 4589.747563883985, 337936.0, 338476.0, 340482.0, 341033.9999999975, 341298.0, 57511.56221094423, 57548.95735947749, 57713.71143144257, 57719.0, 57946.0, 59724.0, 59747.0, 60125.0, 60188.0, 60243.69878150669, 16253.593660158354, 16444.6711065778, 16464.259108340153, 16470.258838352303, 16473.83526164747, 12926.353682315847, 12974.0, 12987.740245195044, 12992.545260916011, 13002.674933126558, 15020.549383518512, 16634.58413539671, 16817.747733784003, 16865.241064152142, 16868.156592170344, 5526.4197259288, 6464.191976003, 6477.060826180272, 6669.399754022064, 6669.833254168685, 1064.8775390830153, 1094.2723089145788, 1102.101787043557, 1125.5216532973454, 1182.0720734223764, 32966.67033329636, 34297.82851085729, 34387.82806086003, 36830.8158459206, 36934.0, 1057.3338796558119, 1116.6984914073155, 1125.6848082536903, 1133.637236084445, 1192.952281908714, 16704.582385440463, 17271.74092388615, 17290.740638890427, 17317.826821731873, 17364.305427782747, 563084.0, 570083.0, 575795.0, 577487.0, 579663.0, 57534.0, 57660.135097973565, 57821.42178578245, 57843.0, 57971.0, 1155.4800339847102, 1313.3039489070807, 1374.8418931822969, 1460.1750011243614, 1548.3187397545043, 29963.0, 34306.48540271848, 34462.48306275458, 34644.84366730197, 34680.65319346774, 52991.20513192382, 53797.73101134626, 53978.0, 54048.45951540434, 54206.45793542014, 496885.0, 506151.0, 507014.0, 508914.0, 509498.0, 36418.63581364152, 42774.78612606917, 42962.78518607387, 44309.11381772411, 44351.0, 45020.0, 49206.0, 49515.25727114024, 50065.0, 50518.0, 40986.0, 41068.58931410647, 41541.1691766169, 42006.57993420149, 42104.57895421007, 41067.589324106375, 41760.0, 41956.79021604872, 42244.0, 42808.78595607002, 41389.793051034554, 41788.16423671449, 43145.568544314156, 43182.352264715424, 43434.0, 35238.47142292817, 37333.70578581689, 37587.248255034196, 38121.237575248895, 38390.616093839824, 28245.293867653472, 28525.42949140964, 28847.278818028877, 28910.42179156363, 28950.276243094093], "value": 20765.27904427571, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.20676200265456, 391.9941200881987, 394.6921401306981, 396.8908550148711, 412.98141583628734, 18055.81944180558, 20580.69128963063, 20620.617618983364, 20929.05819238136, 20988.160473581058, 18612.906935465337, 18819.24723011078, 19454.513637159078, 19636.312729054487, 19685.704714429296, 5678.091505359143, 5759.539236861052, 5901.586888917777, 5902.055671092626, 5970.97014514929, 5849.356570777232, 5854.707264636772, 5855.385184555625, 5866.6480011199255, 5871.500922421599, 5606.383297837235, 5776.59563830532, 5778.104393818965, 5784.0, 5832.9708351458185, 5669.262995810518, 5754.309482862062, 5777.046787280094, 5803.82588522345, 5812.070068788995, 5177.715225662625, 5200.115980283323, 5211.817586384496, 5212.270282160501, 5224.242484839677, 23194.53610927772, 23332.300030998926, 23754.168604098773, 24050.518989620283, 24101.87949060261, 2116.481462041794, 2270.71616047994, 2351.8588884666974, 2444.973111293261, 2487.962680559793, 9656.903430965742, 9684.467354295512, 9773.0, 9913.355631883904, 10171.84742228867, 1844.400569814802, 1913.8373238274764, 1935.6225536020481, 1984.960300793976, 2029.188324670129, 83121.58439207826, 85121.14878851257, 85763.0, 87787.0, 89074.0, 10089.798204035878, 10227.693169204937, 10807.729806754895, 10933.726656833644, 11124.165687573464, 14955.70088598222, 15052.623684407758, 15066.171360575274, 15085.170315632746, 15086.622834429227, 7720.0, 8293.21214484623, 8310.376721745894, 8333.583320833934, 8428.32573394127, 7848.725294614661, 8114.513129212266, 8186.386021048445, 8238.258556729923, 8288.171182881664, 4231.217224813419, 4330.675199360061, 4331.4152589400655, 4345.196138714285, 4659.44086709597, 1871.1860340751816, 1911.1113332300547, 1927.633749587574, 1968.675168597194, 1995.5210749420326, 981.9509024548744, 1000.174855744014, 1030.1398332392387, 1058.2221867263072, 1080.7946490166844, 19397.8060219396, 20125.597488050156, 20210.78735275888, 20272.695909561367, 20687.58624827495, 904.3127223310331, 937.2595649436869, 967.4920666650065, 995.2237254941158, 1029.464678367245, 10386.32488888235, 10803.0, 11712.180147389772, 11949.22330048544, 12045.819312710317, 433865.0, 515672.0, 515715.0, 517328.0, 525566.0, 57911.0, 68494.31505684879, 87568.0, 88430.0, 102316.48841755744, 982.8034393121261, 1016.2835201183149, 1046.429695815767, 1049.6588608702355, 1049.7428130108171, 13638.659033524242, 18529.53676158107, 19056.8094319055, 19066.95131767766, 19190.424287271406, 46736.29895551637, 47200.52799471961, 47267.527324727685, 47481.52518474771, 47892.76053619709, 61795.0, 62315.6884215576, 62892.0, 63487.36512634999, 63611.681941589995, 7659.885101723367, 7714.884276735741, 8433.156684331763, 8727.738167854974, 9022.729318120468, 8962.955185224033, 13607.0, 13660.180389176681, 14009.789853152008, 14161.150330980174, 12090.818637720617, 12255.632331030083, 12388.380580970736, 12441.129120961446, 12629.179103358252, 11964.341961192218, 11987.820182697442, 12219.75560488803, 12487.12590118683, 12626.053046021401, 11550.537978480766, 12051.81922271149, 12358.876411235773, 12493.93753031229, 12635.162888291608, 7261.673224705007, 7543.73596924105, 7645.61771911391, 7882.921170788219, 8463.873041904253, 11270.605528806453, 12175.14773965814, 12212.267263964191, 12214.938925305316, 12226.083043771574], "value": 9291.375997190675, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.0358459831914, 1464.502069296439, 1575.7557578575324, 1704.7528108424272, 1734.6183839555301, 8232.91767082329, 8690.130986901308, 8774.517401542913, 8780.165884240987, 8783.516906570136, 7487.475876688634, 8367.121452247518, 8574.571271436434, 8605.741827745162, 8799.604017819198, 2267.3424706835, 2291.8968646410867, 2293.472501324696, 2293.7591552886956, 2295.2081531871477, 2226.053927080984, 2277.089164334271, 2278.111536500766, 2278.7037685100913, 2281.577908087001, 1966.8328192103688, 2107.1466056247245, 2147.5490147069136, 2156.7196264485597, 2171.446281198292, 2143.431990522513, 2146.431195733132, 2159.093180864033, 2159.4709296222527, 2223.3552269841725, 2231.1967691631, 2255.9323220303418, 2261.0955617752866, 2261.7738226177416, 2264.3320220534983, 8800.515971621558, 8901.198892099743, 8912.821743565157, 8916.108389161096, 8955.238804701608, 4893.143699852547, 4997.175466048097, 4997.750112494361, 5000.924986125211, 5018.447970723218, 3140.4661207594536, 3196.1689960610174, 3286.6384697683234, 3304.0913748719295, 3307.851146698404, 1074.8763892152347, 1080.189857606795, 1103.4813637590319, 1105.9336439813637, 1123.0622430270735, 12230.327331996737, 12232.082593805411, 12235.755284894341, 12244.510219591206, 12249.203801752858, 4249.2563801334645, 4375.081232941118, 4389.670774691847, 4501.437320334958, 4505.864824055284, 10388.584456621802, 10391.740206494747, 10399.376037437778, 10400.947995259976, 10405.27163098591, 5098.821541246039, 5111.437741848394, 5111.744412779346, 5122.052420302256, 5125.051865404837, 4649.5350464953235, 4702.858914232578, 4746.2168742157155, 4752.3584316116885, 4757.119932812371, 3818.427235914635, 3833.4249862520846, 3879.437481565157, 3919.1573811630637, 3941.1132495188926, 1095.5015467962057, 1131.7849608574345, 1132.7394699219226, 1160.9535618575162, 1166.8833116688263, 815.7185770909027, 978.0268632710498, 986.6793292180071, 993.1756641987133, 1035.4822588705647, 6016.639001659914, 6246.562740608114, 6268.4671802896355, 6316.873662526816, 6376.139221205078, 978.8287049766262, 996.0487734213808, 1002.318423472046, 1003.1322905686528, 1004.3572113847143, 4286.164197981426, 4354.608085272341, 4412.0734645724115, 4429.136318417942, 4443.955560444419, 10534.57861685524, 11034.558617655364, 11093.889061109447, 11097.0, 11112.61105861307, 9598.184154346958, 10326.277160598836, 10954.56181752721, 10955.56177752881, 10992.560297588167, 8196.672133114727, 8331.6667333306, 8364.623591938378, 8370.581470926429, 8416.537090460084, 6223.3465486123305, 6479.384458476437, 6483.092367068709, 6522.967385163044, 6541.247756508063, 10163.034511721375, 10262.384256944608, 10305.433201174008, 10346.741331466774, 10351.63769268072, 10322.48387580633, 10606.363618182933, 10618.256722029384, 10623.256372053882, 10628.468576571295, 7501.812454688677, 7600.46796724224, 7601.733939312318, 7604.885926710993, 7607.771766847003, 8363.163683631832, 8409.705660301861, 8521.360897932556, 8562.357823163413, 8567.657293708182, 7674.270944260286, 7702.345300649507, 7703.268189521987, 7714.4599878008, 7747.92252077472, 7595.468317217742, 7628.1227658817725, 7679.0, 7737.419693522896, 7795.376369890282, 7078.823029424306, 7266.709331626887, 7272.345488906024, 7274.854502909806, 7278.927210728037, 5259.132243179833, 5478.671279723229, 5485.890282194414, 5605.411431799603, 5644.0, 5262.105442074933, 5308.203769434615, 5492.368377636623, 5607.299087614048, 5628.155776633538], "value": 4621.194787589496, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.74503142517415, 322.9128135403441, 334.1862564655066, 336.60280868575086, 337.15542565872516, 5230.398504172017, 5245.213218017299, 5253.842384728459, 5309.8938021239555, 5314.441983591715, 4991.900161996758, 5064.088464076464, 5180.559652429548, 5189.6107791915565, 5246.711430871301, 4084.775337356444, 4093.7339072960312, 4112.650424713903, 4119.382092686099, 4126.339785634299, 4130.401091841682, 4137.441445404877, 4156.314208155666, 4157.50109986802, 4161.334186530155, 3963.0, 4044.2720310344275, 4123.299039163349, 4136.200752672597, 4149.46057012588, 4102.138550904314, 4123.402106694542, 4124.45333000125, 4128.236276288896, 4135.77253251071, 3694.538182727159, 3699.315626609059, 3707.7775333480076, 3709.0, 3710.2950439416422, 5110.897782044338, 5114.232865070232, 5122.1036318644465, 5174.146265866128, 5208.270842082112, 4733.313669517935, 4752.738599377033, 4753.3582966299455, 4770.856874293777, 4771.880702982418, 5453.4273901240595, 5463.617546771728, 5481.0, 5484.643498172606, 5499.917501237484, 3865.632764887331, 3956.7823769692654, 3959.148783011666, 3971.543272523668, 3997.5778271918657, 5773.364929857712, 5779.88440231193, 5784.0, 5791.65250084992, 5797.217375654275, 4080.5511393746665, 4082.3060079786505, 4082.9591704083173, 4086.652634526039, 4087.2847251730827, 3922.5292964844402, 4124.731892426983, 4129.814158362881, 4135.110951145518, 4138.0, 4710.175719249118, 4711.175544279806, 4740.19416699162, 4750.406199225097, 4756.524347565285, 5539.639923404966, 5564.777408903598, 5613.691246981455, 5614.747336369873, 5623.0, 1392.4151856220412, 1402.9719405611831, 1419.2477986667084, 1421.9335498376217, 1431.1127101197324, 888.9555522223992, 906.8639704044446, 916.5783739479781, 920.742192186189, 925.7132585705874, 4719.693219940693, 4763.833265835679, 4765.142274390573, 4773.188557945157, 4774.259989701602, 4985.775640096132, 4990.950090499121, 5022.8196373852115, 5037.244413338029, 5043.519971219846, 4574.4968053514085, 4707.093627081038, 4714.38712967312, 4768.737719425465, 4783.904321913542, 2665.560182569893, 2680.664916885389, 2680.6783186017415, 2686.0, 2690.596410538435, 5134.794608215704, 5139.563137133311, 5141.922871156861, 5151.201563757623, 5162.741862906914, 4717.622590192776, 5027.698338099725, 5051.368578927634, 5101.0, 5115.7953681852305, 5103.591712662978, 5134.589232861287, 5136.229565565046, 5141.640085194001, 5157.355330583677, 4937.691511749461, 4973.502649734997, 4975.353204083446, 4985.6260780442335, 4997.200447928314, 4855.417349917891, 4883.658143929891, 4892.926606100982, 5201.921971170511, 5673.914891276717, 5839.284732599362, 5880.647161170344, 5884.440623234761, 5893.410658934073, 5900.527957763455, 3846.6922646188796, 3958.0896393829003, 3971.980140099281, 3979.900502487461, 3997.7201595889173, 5201.375834899836, 5328.413874473727, 5567.8886422272135, 5631.6902570359025, 5652.180433836988, 5468.863278418072, 5489.121740521658, 5519.724013799374, 5548.805791797267, 5566.860828479321, 5497.725113744376, 5523.723813809213, 5556.333240011225, 5582.944170558405, 5598.776048957996, 5318.4681531848055, 5521.309836270466, 5531.778728850801, 5533.806316778893, 5537.6954267515675, 5508.504234618904, 5526.866992266656, 5571.164325351067, 5586.245856809279, 5618.943810561842, 5420.349558053059, 5440.483154100354, 5456.45435456467, 5502.064649009758, 5516.724163791875], "value": 4094.55231516379, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.907261592301, 783.23634456405, 836.5315423362917, 861.6424183963655, 872.6640243506248, 14175.078619889713, 14254.572362829105, 14290.285485725724, 14302.141871487705, 15899.84100158998, 13899.444022239099, 14717.0, 14726.410943562245, 14727.0, 14731.48439804607, 648.1832890557907, 790.063774427304, 804.2038382001834, 809.0291650019971, 809.6275713171948, 790.2492631999623, 815.2011029191395, 818.7257268814924, 822.0792712162356, 822.6010384963288, 856.9742907712779, 859.4413631139778, 860.0968982568278, 860.496609483453, 862.168007872403, 690.8203866994568, 712.273481049332, 855.7689423855555, 856.7001549457702, 856.8500512410303, 517.6583454919735, 597.3638075449633, 610.664134725899, 612.5069319198044, 614.7295190116334, 14380.137191768526, 14502.637434064127, 14506.0, 14512.1292722437, 14553.927230363886, 13964.371603277878, 14182.43270269188, 14207.573772786833, 14258.2157981311, 14486.782698259534, 12322.938385308016, 12942.352882355844, 13074.411651475706, 13313.733725325535, 13646.317684115755, 4592.655550833668, 4604.125216208943, 4669.509701481364, 4705.811767529295, 4831.541003604652, 82033.17966820316, 82168.17831821725, 83286.0, 84017.0, 84061.0, 10146.847797283046, 10359.378437293635, 10368.326058806153, 10411.791764164675, 10522.210834187314, 17894.28422863071, 18003.459896203134, 19217.0, 19325.323613673736, 19401.80598194, 8632.179942905414, 8659.263962563253, 8744.912550874536, 8809.691660791841, 8969.237614802814, 4712.151812673683, 4747.691400058985, 4769.403824521934, 4817.7350245736825, 4888.071266459361, 3431.69114779671, 3545.840437180333, 3548.716102711777, 3560.181158333598, 3561.1097225693575, 594.7056207177475, 597.5876645114944, 604.6644112517595, 614.5667304550282, 622.0110025060176, 616.0225675581345, 637.1271358239242, 681.2063945503533, 684.5413572906165, 697.4629535257823, 9477.431354118775, 9645.08371704687, 9742.512874356396, 10202.642907498202, 10218.437985910847, 665.0556210181554, 668.5353679192914, 678.131991051455, 680.5338343234899, 737.2848337112991, 4529.818807247739, 4756.571908528249, 4776.283557466339, 4783.1390349736685, 4793.089313030513, 77497.6125119382, 119333.0, 122260.0, 123437.38281308537, 123673.38163309125, 69614.65192674004, 106789.0, 107280.0, 107610.46194768976, 108031.0, 90224.54887725519, 91944.54027729819, 93583.53208233915, 94037.52981235187, 94352.99999999863, 9220.492872891788, 9319.34764566501, 9422.670206542738, 9466.52667366615, 9489.0, 54517.0, 55111.48885111457, 55475.72262138664, 55665.0, 56177.43822561722, 75719.62140189264, 80300.0, 83100.58449707713, 83568.58215708882, 84403.0, 11167.553297867995, 11172.888271117185, 11331.603393881174, 11337.716557086138, 11810.82283765727, 12522.186057906207, 12529.373531323216, 12740.0, 12759.872401275868, 12799.768420317467, 12630.431630576462, 12665.81001285, 12846.35768211567, 12901.806472902726, 13365.0, 11903.404829758305, 11985.852243372985, 11994.340311282964, 12080.275183489019, 12107.818382724443, 12193.878061219275, 12869.35653217354, 12884.677883052998, 13023.934880325538, 13049.934750326567, 10118.797624047626, 10136.341137826017, 10387.636432724817, 10456.68629941103, 10845.566177352817, 10206.897931020594, 10410.843837342294, 10478.161747060065, 10634.0, 10662.200334974752], "value": 7440.288201414054, "unit": "score"}], "name": "dromaeo_css", "value": 7225.487402887671, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 117.0, 116.0, 173.0, 115.0, 122.0, 144.0, 116.0, 162.0, 119.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 158.0, 160.0, 161.0, 159.0, 161.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 126.0, 76.0, 76.0, 76.0, 75.0, 119.0, 74.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 84.0, 84.0, 111.0, 84.0, 84.0, 127.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 51.0, 52.0, 51.0, 52.0, 52.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 60.0, 61.0, 61.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 76.0, 76.0, 76.0, 75.0, 76.0, 75.0, 79.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 123.0, 116.0, 125.0, 127.0, 122.0, 126.0, 180.0, 128.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 158.0, 157.0, 156.0, 157.0, 156.0, 155.0, 162.0, 160.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 63.0, 66.0, 62.0, 62.0, 63.0, 63.0, 61.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1477.9, "alertThreshold": 2.0}]} 01:45:28 INFO - Return code: 0 01:45:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:45:29 INFO - # TBPL SUCCESS # 01:45:29 INFO - Running post-action listener: _resource_record_post_action 01:45:29 INFO - ##### 01:45:29 INFO - ##### Finished run-tests step (success) 01:45:29 INFO - ##### 01:45:29 INFO - Running post-run listener: _resource_record_post_run 01:45:29 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 151552; Write bytes: 560816128; Read time: 396; Write time: 582660 01:45:29 INFO - TinderboxPrint: CPU usage
13.0% 01:45:29 INFO - TinderboxPrint: I/O read bytes / time
151,552 / 396 01:45:29 INFO - TinderboxPrint: I/O write bytes / time
560,816,128 / 582,660 01:45:29 INFO - TinderboxPrint: CPU idle
8,271.8 (86.9%) 01:45:29 INFO - TinderboxPrint: CPU user
1,197.0 (12.6%) 01:45:29 INFO - TinderboxPrint: Swap in / out
0 / 0 01:45:29 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 266539008; Read time: 0; Write time: 374500 01:45:29 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 147456; Write bytes: 294277120; Read time: 380; Write time: 208160 01:45:29 INFO - Running post-run listener: _upload_blobber_files 01:45:29 INFO - Blob upload gear active. 01:45:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:45:29 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 01:45:29 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'] 01:45:29 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 01:45:30 INFO - (blobuploader) - INFO - Open directory for files ... 01:45:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:45:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:33 INFO - (blobuploader) - INFO - Done attempting. 01:45:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:45:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:45:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:34 INFO - (blobuploader) - INFO - Done attempting. 01:45:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:45:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:45:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:45:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:45:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:45:35 INFO - (blobuploader) - INFO - Done attempting. 01:45:35 INFO - (blobuploader) - INFO - Iteration through files over. 01:45:35 INFO - Return code: 0 01:45:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:45:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:45:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d4b27bafb24ee6d86f1fcfb2adcdb80e702ea2e5b49441623e5b83ac21dce0925b67c6e2f51477321a7d49fd113e993317c477d066ea0a244a463d407121a80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b924b1454c99e50494131d122b60e23a37b7d38deb8665e7bf099b37adb1a2a70a433e4d99975c8310a63233a34e85c4b917bba74cab3729a6719b9a5702bdb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d5ef8c64926d46e655bcee765d72a2b9e5fd7df41c026ab69f95fc59152e43dfb015a701e554a06fdbb7f05a2da38ad67a528e3276a770ab8ca0f67aca58667"} 01:45:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:45:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:45:35 INFO - Contents: 01:45:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d4b27bafb24ee6d86f1fcfb2adcdb80e702ea2e5b49441623e5b83ac21dce0925b67c6e2f51477321a7d49fd113e993317c477d066ea0a244a463d407121a80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b924b1454c99e50494131d122b60e23a37b7d38deb8665e7bf099b37adb1a2a70a433e4d99975c8310a63233a34e85c4b917bba74cab3729a6719b9a5702bdb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d5ef8c64926d46e655bcee765d72a2b9e5fd7df41c026ab69f95fc59152e43dfb015a701e554a06fdbb7f05a2da38ad67a528e3276a770ab8ca0f67aca58667"} 01:45:35 INFO - Running post-run listener: copy_logs_to_upload_dir 01:45:35 INFO - Copying logs to upload dir... 01:45:35 INFO - mkdir: /builds/slave/test/build/upload/logs 01:45:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.706283 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-07 01:45:35.217270) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 01:45:35.221019) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d4b27bafb24ee6d86f1fcfb2adcdb80e702ea2e5b49441623e5b83ac21dce0925b67c6e2f51477321a7d49fd113e993317c477d066ea0a244a463d407121a80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b924b1454c99e50494131d122b60e23a37b7d38deb8665e7bf099b37adb1a2a70a433e4d99975c8310a63233a34e85c4b917bba74cab3729a6719b9a5702bdb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d5ef8c64926d46e655bcee765d72a2b9e5fd7df41c026ab69f95fc59152e43dfb015a701e554a06fdbb7f05a2da38ad67a528e3276a770ab8ca0f67aca58667"} build_url:https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/DEU9tM25TK2nb6ERaLWjCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9d4b27bafb24ee6d86f1fcfb2adcdb80e702ea2e5b49441623e5b83ac21dce0925b67c6e2f51477321a7d49fd113e993317c477d066ea0a244a463d407121a80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b924b1454c99e50494131d122b60e23a37b7d38deb8665e7bf099b37adb1a2a70a433e4d99975c8310a63233a34e85c4b917bba74cab3729a6719b9a5702bdb1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d5ef8c64926d46e655bcee765d72a2b9e5fd7df41c026ab69f95fc59152e43dfb015a701e554a06fdbb7f05a2da38ad67a528e3276a770ab8ca0f67aca58667"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 01:45:35.250498) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 01:45:35.251069) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467877803.85240-1599268764 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 01:45:35.330423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 01:45:35.330820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 01:45:35.331141) ========= ========= Total master_lag: 0.16 =========