builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1467634698.04 results: success (0) buildid: 20160704040124 builduid: 79a69ab63448480e8a3c073aca689dda revision: 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.037618) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.037984) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.038284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.064926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.065185) ========= 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=41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 05:18:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.4M=0s 2016-07-04 05:18:20 (89.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103966 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.187756) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.188065) ========= 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=41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020176 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.239696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.240001) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 --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=41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 05:18:20,283 truncating revision to first 12 chars 2016-07-04 05:18:20,283 Setting DEBUG logging. 2016-07-04 05:18:20,283 attempt 1/10 2016-07-04 05:18:20,283 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/99bab2d812fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 05:18:20,606 unpacking tar archive at: mozilla-central-99bab2d812fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690706 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.944305) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.944574) ========= script_repo_revision: 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.944946) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.945213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 05:18:18.959022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-04 05:18:18.959292) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:18:21 INFO - MultiFileLogger online at 20160704 05:18:21 in /builds/slave/test 05:18:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:18:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:18:21 INFO - {'append_to_log': False, 05:18:21 INFO - 'base_work_dir': '/builds/slave/test', 05:18:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:18:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:18:21 INFO - 'branch': 'Firefox-Non-PGO', 05:18:21 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:21 INFO - 'config_files': ('talos/linux_config.py',), 05:18:21 INFO - 'default_actions': ('clobber', 05:18:21 INFO - 'read-buildbot-config', 05:18:21 INFO - 'download-and-extract', 05:18:21 INFO - 'populate-webroot', 05:18:21 INFO - 'create-virtualenv', 05:18:21 INFO - 'install', 05:18:21 INFO - 'run-tests'), 05:18:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:21 INFO - 'download_minidump_stackwalk': True, 05:18:21 INFO - 'download_symbols': 'ondemand', 05:18:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:21 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:21 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:21 INFO - 'installer_path': 'installer.exe', 05:18:21 INFO - 'log_level': 'info', 05:18:21 INFO - 'log_name': 'talos', 05:18:21 INFO - 'log_to_console': True, 05:18:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:18:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:18:21 INFO - 'opt_config_files': (), 05:18:21 INFO - 'pip_index': False, 05:18:21 INFO - 'sps_profile': False, 05:18:21 INFO - 'sps_profile_interval': 0, 05:18:21 INFO - 'suite': 'dromaeojs', 05:18:21 INFO - 'system_bits': '32', 05:18:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:21 INFO - 'title': 'talos-linux64-ix-026', 05:18:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:21 INFO - 'use_talos_json': True, 05:18:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:18:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:21 INFO - 'work_dir': 'build'} 05:18:21 INFO - ##### 05:18:21 INFO - ##### Running clobber step. 05:18:21 INFO - ##### 05:18:21 INFO - Running pre-action listener: _resource_record_pre_action 05:18:21 INFO - Running main action method: clobber 05:18:21 INFO - rmtree: /builds/slave/test/build 05:18:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:18:21 INFO - Running post-action listener: _resource_record_post_action 05:18:21 INFO - ##### 05:18:21 INFO - ##### Finished clobber step (success) 05:18:21 INFO - ##### 05:18:21 INFO - ##### 05:18:21 INFO - ##### Running read-buildbot-config step. 05:18:21 INFO - ##### 05:18:21 INFO - Running pre-action listener: _resource_record_pre_action 05:18:21 INFO - Running main action method: read_buildbot_config 05:18:21 INFO - Using buildbot properties: 05:18:21 INFO - { 05:18:21 INFO - "project": "", 05:18:21 INFO - "product": "firefox", 05:18:21 INFO - "script_repo_revision": "production", 05:18:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:18:21 INFO - "repository": "", 05:18:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:18:21 INFO - "buildid": "20160704040124", 05:18:21 INFO - "pgo_build": "False", 05:18:21 INFO - "basedir": "/builds/slave/test", 05:18:21 INFO - "buildnumber": 539, 05:18:21 INFO - "slavename": "talos-linux64-ix-026", 05:18:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:18:21 INFO - "platform": "ubuntu64_hw", 05:18:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:18:21 INFO - "branch": "mozilla-central", 05:18:21 INFO - "repo_path": "mozilla-central", 05:18:21 INFO - "revision": "99bab2d812fc9619c122fcdd84c6f085ced8c1e8", 05:18:21 INFO - "stage_platform": "linux64", 05:18:21 INFO - "builduid": "79a69ab63448480e8a3c073aca689dda", 05:18:21 INFO - "slavebuilddir": "test" 05:18:21 INFO - } 05:18:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:18:21 INFO - Running post-action listener: _resource_record_post_action 05:18:21 INFO - ##### 05:18:21 INFO - ##### Finished read-buildbot-config step (success) 05:18:21 INFO - ##### 05:18:21 INFO - ##### 05:18:21 INFO - ##### Running download-and-extract step. 05:18:21 INFO - ##### 05:18:21 INFO - Running pre-action listener: _resource_record_pre_action 05:18:21 INFO - Running main action method: download_and_extract 05:18:21 INFO - mkdir: /builds/slave/test/build/tests 05:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:21 INFO - https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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 05:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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 05:18:33 INFO - Downloaded 1361 bytes. 05:18:33 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:18:33 INFO - Using the following test package requirements: 05:18:33 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:33 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:18:33 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:18:33 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:33 INFO - u'jsshell-linux-x86_64.zip'], 05:18:33 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:18:33 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:18:33 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:18:33 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:18:33 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:18:33 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:18:33 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:18:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:33 INFO - https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:18:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:18:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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 05:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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 05:18:37 INFO - Downloaded 22705963 bytes. 05:18:37 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'] 05:18:37 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 05:18:38 INFO - Return code: 0 05:18:38 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 05:18:38 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')]} 05:18:38 INFO - https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:18:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:18:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:18:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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 05:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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 05:18:41 INFO - Downloaded 22705963 bytes. 05:18:41 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'] 05:18:41 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 05:18:42 INFO - Return code: 0 05:18:42 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')]} 05:18:42 INFO - https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:18:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:18:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:18:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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 05:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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 05:18:43 INFO - Downloaded 14405327 bytes. 05:18:43 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'] 05:18:43 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 05:18:44 INFO - Return code: 0 05:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:44 INFO - https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:18:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:18:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:18:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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 05:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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 05:18:45 INFO - Downloaded 56478844 bytes. 05:18:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:18:45 INFO - mkdir: /builds/slave/test/properties 05:18:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:18:45 INFO - Writing to file /builds/slave/test/properties/build_url 05:18:45 INFO - Contents: 05:18:45 INFO - build_url:https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:18:46 INFO - Running post-action listener: _resource_record_post_action 05:18:46 INFO - Running post-action listener: set_extra_try_arguments 05:18:46 INFO - ##### 05:18:46 INFO - ##### Finished download-and-extract step (success) 05:18:46 INFO - ##### 05:18:46 INFO - ##### 05:18:46 INFO - ##### Running populate-webroot step. 05:18:46 INFO - ##### 05:18:46 INFO - Running pre-action listener: _resource_record_pre_action 05:18:46 INFO - Running main action method: populate_webroot 05:18:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:46 INFO - '--tppagecycles', 05:18:46 INFO - '7'], 05:18:46 INFO - 'tests': ['tsvgm']}}, 05:18:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:18:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:18:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:18:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:46 INFO - 'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:46 INFO - 'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['damp', 'tps']}, 05:18:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:46 INFO - 'tests': ['damp', 'tps']}, 05:18:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['dromaeo_dom']}, 05:18:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['basic_compositor_video']}, 05:18:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:18:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['a11yr', 05:18:46 INFO - 'ts_paint', 05:18:46 INFO - 'tpaint', 05:18:46 INFO - 'sessionrestore', 05:18:46 INFO - 'sessionrestore_no_auto_restore', 05:18:46 INFO - 'tabpaint']}, 05:18:46 INFO - 'other-e10s': {'tests': ['a11yr', 05:18:46 INFO - 'ts_paint', 05:18:46 INFO - 'tpaint', 05:18:46 INFO - 'sessionrestore', 05:18:46 INFO - 'sessionrestore_no_auto_restore', 05:18:46 INFO - 'tabpaint']}, 05:18:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:18:46 INFO - 'ts_paint', 05:18:46 INFO - 'tpaint', 05:18:46 INFO - 'sessionrestore', 05:18:46 INFO - 'sessionrestore_no_auto_restore', 05:18:46 INFO - 'tabpaint']}, 05:18:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:18:46 INFO - 'ts_paint', 05:18:46 INFO - 'tpaint', 05:18:46 INFO - 'sessionrestore', 05:18:46 INFO - 'sessionrestore_no_auto_restore', 05:18:46 INFO - 'tabpaint']}, 05:18:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['a11yr', 05:18:46 INFO - 'ts_paint', 05:18:46 INFO - 'tpaint', 05:18:46 INFO - 'sessionrestore', 05:18:46 INFO - 'sessionrestore_no_auto_restore', 05:18:46 INFO - 'tabpaint']}, 05:18:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['a11yr', 05:18:46 INFO - 'ts_paint', 05:18:46 INFO - 'tpaint', 05:18:46 INFO - 'sessionrestore', 05:18:46 INFO - 'sessionrestore_no_auto_restore', 05:18:46 INFO - 'tabpaint']}, 05:18:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['tsvgx', 05:18:46 INFO - 'tsvgr_opacity', 05:18:46 INFO - 'tart', 05:18:46 INFO - 'tscrollx', 05:18:46 INFO - 'cart']}, 05:18:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:18:46 INFO - 'tsvgr_opacity', 05:18:46 INFO - 'tart', 05:18:46 INFO - 'tscrollx', 05:18:46 INFO - 'cart']}, 05:18:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:46 INFO - 'talos_options': ['--disable-e10s'], 05:18:46 INFO - 'tests': ['tp5o']}, 05:18:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:46 INFO - 'tests': ['tp5o']}, 05:18:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:46 INFO - 'talos_options': ['--disable-e10s', 05:18:46 INFO - '--xperf_path', 05:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:46 INFO - 'tests': ['tp5n']}, 05:18:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:46 INFO - 'talos_options': ['--xperf_path', 05:18:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:46 INFO - 'tests': ['tp5n']}}, 05:18:46 INFO - 'talos.zip': {'path': '', 05:18:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:46 INFO - Running post-action listener: _resource_record_post_action 05:18:46 INFO - ##### 05:18:46 INFO - ##### Finished populate-webroot step (success) 05:18:46 INFO - ##### 05:18:46 INFO - ##### 05:18:46 INFO - ##### Running create-virtualenv step. 05:18:46 INFO - ##### 05:18:46 INFO - Running pre-action listener: _resource_record_pre_action 05:18:46 INFO - Running main action method: create_virtualenv 05:18:46 INFO - Creating virtualenv /builds/slave/test/build/venv 05:18:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:18:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:18:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:46 INFO - Using real prefix '/usr' 05:18:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:18:47 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:49 INFO - Installing pip.................done. 05:18:49 INFO - Return code: 0 05:18:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:49 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 0x1416030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d53b0>, '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 0x16d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6740>, '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': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', '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 05:18:49 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 05:18:49 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 05:18:49 INFO - Using env: {'DISPLAY': ':0', 05:18:49 INFO - 'HOME': '/home/cltbld', 05:18:49 INFO - 'LANG': 'en_US.UTF-8', 05:18:49 INFO - 'LANGUAGE': 'en_US:en', 05:18:49 INFO - 'LOGNAME': 'cltbld', 05:18:49 INFO - 'MAIL': '/var/mail/cltbld', 05:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:49 INFO - 'MOZ_NO_REMOTE': '1', 05:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:49 INFO - 'NO_EM_RESTART': '1', 05:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:49 INFO - 'PWD': '/builds/slave/test', 05:18:49 INFO - 'SHELL': '/bin/bash', 05:18:49 INFO - 'SHLVL': '1', 05:18:49 INFO - 'TERM': 'linux', 05:18:49 INFO - 'TMOUT': '86400', 05:18:49 INFO - 'USER': 'cltbld', 05:18:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', 05:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:49 INFO - '_': '/tools/buildbot/bin/python'} 05:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:18:49 INFO - Cleaning up... 05:18:49 INFO - Return code: 0 05:18:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:49 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 0x1416030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d53b0>, '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 0x16d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6740>, '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': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', '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 05:18:49 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 05:18:49 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 05:18:49 INFO - Using env: {'DISPLAY': ':0', 05:18:49 INFO - 'HOME': '/home/cltbld', 05:18:49 INFO - 'LANG': 'en_US.UTF-8', 05:18:49 INFO - 'LANGUAGE': 'en_US:en', 05:18:49 INFO - 'LOGNAME': 'cltbld', 05:18:49 INFO - 'MAIL': '/var/mail/cltbld', 05:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:49 INFO - 'MOZ_NO_REMOTE': '1', 05:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:49 INFO - 'NO_EM_RESTART': '1', 05:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:49 INFO - 'PWD': '/builds/slave/test', 05:18:49 INFO - 'SHELL': '/bin/bash', 05:18:49 INFO - 'SHLVL': '1', 05:18:49 INFO - 'TERM': 'linux', 05:18:49 INFO - 'TMOUT': '86400', 05:18:49 INFO - 'USER': 'cltbld', 05:18:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', 05:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:49 INFO - '_': '/tools/buildbot/bin/python'} 05:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:49 INFO - Downloading/unpacking psutil>=3.1.1 05:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:51 INFO - Installing collected packages: psutil 05:18:51 INFO - Running setup.py install for psutil 05:18:51 INFO - building 'psutil._psutil_linux' extension 05:18:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:18:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:18:51 INFO - building 'psutil._psutil_posix' extension 05:18:51 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 05:18:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:52 INFO - Successfully installed psutil 05:18:52 INFO - Cleaning up... 05:18:52 INFO - Return code: 0 05:18:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:52 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 0x1416030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d53b0>, '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 0x16d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6740>, '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': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', '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 05:18:52 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 05:18:52 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 05:18:52 INFO - Using env: {'DISPLAY': ':0', 05:18:52 INFO - 'HOME': '/home/cltbld', 05:18:52 INFO - 'LANG': 'en_US.UTF-8', 05:18:52 INFO - 'LANGUAGE': 'en_US:en', 05:18:52 INFO - 'LOGNAME': 'cltbld', 05:18:52 INFO - 'MAIL': '/var/mail/cltbld', 05:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:52 INFO - 'MOZ_NO_REMOTE': '1', 05:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:52 INFO - 'NO_EM_RESTART': '1', 05:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:52 INFO - 'PWD': '/builds/slave/test', 05:18:52 INFO - 'SHELL': '/bin/bash', 05:18:52 INFO - 'SHLVL': '1', 05:18:52 INFO - 'TERM': 'linux', 05:18:52 INFO - 'TMOUT': '86400', 05:18:52 INFO - 'USER': 'cltbld', 05:18:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', 05:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:52 INFO - '_': '/tools/buildbot/bin/python'} 05:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:18:54 INFO - Installing collected packages: mozsystemmonitor 05:18:54 INFO - Running setup.py install for mozsystemmonitor 05:18:54 INFO - Successfully installed mozsystemmonitor 05:18:54 INFO - Cleaning up... 05:18:54 INFO - Return code: 0 05:18:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:54 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 0x1416030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d53b0>, '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 0x16d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6740>, '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': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', '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 05:18:54 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 05:18:54 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 05:18:54 INFO - Using env: {'DISPLAY': ':0', 05:18:54 INFO - 'HOME': '/home/cltbld', 05:18:54 INFO - 'LANG': 'en_US.UTF-8', 05:18:54 INFO - 'LANGUAGE': 'en_US:en', 05:18:54 INFO - 'LOGNAME': 'cltbld', 05:18:54 INFO - 'MAIL': '/var/mail/cltbld', 05:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:54 INFO - 'MOZ_NO_REMOTE': '1', 05:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:54 INFO - 'NO_EM_RESTART': '1', 05:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:54 INFO - 'PWD': '/builds/slave/test', 05:18:54 INFO - 'SHELL': '/bin/bash', 05:18:54 INFO - 'SHLVL': '1', 05:18:54 INFO - 'TERM': 'linux', 05:18:54 INFO - 'TMOUT': '86400', 05:18:54 INFO - 'USER': 'cltbld', 05:18:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', 05:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:54 INFO - '_': '/tools/buildbot/bin/python'} 05:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:54 INFO - Downloading/unpacking jsonschema==2.5.1 05:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:56 INFO - warning: no files found matching '*.txt' 05:18:56 INFO - no previously-included directories found matching 'build' 05:18:56 INFO - no previously-included directories found matching 'dist' 05:18:56 INFO - no previously-included directories found matching '.git*' 05:18:56 INFO - Installing collected packages: jsonschema, functools32 05:18:56 INFO - Running setup.py install for functools32 05:18:56 INFO - warning: no files found matching '*.txt' 05:18:56 INFO - no previously-included directories found matching 'build' 05:18:56 INFO - no previously-included directories found matching 'dist' 05:18:56 INFO - no previously-included directories found matching '.git*' 05:18:57 INFO - Successfully installed jsonschema functools32 05:18:57 INFO - Cleaning up... 05:18:57 INFO - Return code: 0 05:18:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:57 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 0x1416030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d53b0>, '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 0x16d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6740>, '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': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', '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 05:18:57 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 05:18:57 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 05:18:57 INFO - Using env: {'DISPLAY': ':0', 05:18:57 INFO - 'HOME': '/home/cltbld', 05:18:57 INFO - 'LANG': 'en_US.UTF-8', 05:18:57 INFO - 'LANGUAGE': 'en_US:en', 05:18:57 INFO - 'LOGNAME': 'cltbld', 05:18:57 INFO - 'MAIL': '/var/mail/cltbld', 05:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:57 INFO - 'MOZ_NO_REMOTE': '1', 05:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:57 INFO - 'NO_EM_RESTART': '1', 05:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:57 INFO - 'PWD': '/builds/slave/test', 05:18:57 INFO - 'SHELL': '/bin/bash', 05:18:57 INFO - 'SHLVL': '1', 05:18:57 INFO - 'TERM': 'linux', 05:18:57 INFO - 'TMOUT': '86400', 05:18:57 INFO - 'USER': 'cltbld', 05:18:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', 05:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:57 INFO - '_': '/tools/buildbot/bin/python'} 05:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:57 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 05:18:57 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 05:18:57 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 05:18:57 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 05:18:57 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 05:18:57 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 05:18:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:59 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 05:18:59 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 05:18:59 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 05:18:59 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 05:18:59 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 05:18:59 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 05:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:18:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18:59 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 05:18:59 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 05:18:59 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 05:18:59 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 05:18:59 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 05:18:59 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 05:18:59 INFO - Downloading docopt-0.6.1.tar.gz 05:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:59 INFO - Running setup.py install for blobuploader 05:18:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:18:59 INFO - Running setup.py install for requests 05:19:00 INFO - Running setup.py install for docopt 05:19:00 INFO - Successfully installed blobuploader requests docopt 05:19:00 INFO - Cleaning up... 05:19:00 INFO - Return code: 0 05:19:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:00 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 0x1416030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d53b0>, '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 0x16d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6740>, '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': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', '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 05:19:00 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 05:19:00 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 05:19:00 INFO - Using env: {'DISPLAY': ':0', 05:19:00 INFO - 'HOME': '/home/cltbld', 05:19:00 INFO - 'LANG': 'en_US.UTF-8', 05:19:00 INFO - 'LANGUAGE': 'en_US:en', 05:19:00 INFO - 'LOGNAME': 'cltbld', 05:19:00 INFO - 'MAIL': '/var/mail/cltbld', 05:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:00 INFO - 'MOZ_NO_REMOTE': '1', 05:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:00 INFO - 'NO_EM_RESTART': '1', 05:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:00 INFO - 'PWD': '/builds/slave/test', 05:19:00 INFO - 'SHELL': '/bin/bash', 05:19:00 INFO - 'SHLVL': '1', 05:19:00 INFO - 'TERM': 'linux', 05:19:00 INFO - 'TMOUT': '86400', 05:19:00 INFO - 'USER': 'cltbld', 05:19:00 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', 05:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:00 INFO - '_': '/tools/buildbot/bin/python'} 05:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:00 INFO - Running setup.py (path:/tmp/pip-YrP5y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:00 INFO - Running setup.py (path:/tmp/pip-WiRMkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:00 INFO - Running setup.py (path:/tmp/pip-ULimvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:00 INFO - Running setup.py (path:/tmp/pip-7SrO_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:01 INFO - Running setup.py (path:/tmp/pip-HzBE00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:01 INFO - Running setup.py (path:/tmp/pip-7ahKVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:01 INFO - Running setup.py (path:/tmp/pip-ShTRBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:01 INFO - Running setup.py (path:/tmp/pip-mWT3jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:01 INFO - Running setup.py (path:/tmp/pip-MuyetE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:01 INFO - Running setup.py (path:/tmp/pip-otw1aa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:01 INFO - Running setup.py (path:/tmp/pip-tKFFU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:01 INFO - Running setup.py (path:/tmp/pip-iwkQpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:01 INFO - Running setup.py (path:/tmp/pip-BOZxj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:01 INFO - Running setup.py (path:/tmp/pip-0yr05M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:01 INFO - Running setup.py (path:/tmp/pip-6yCRFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:01 INFO - Running setup.py (path:/tmp/pip-C35X2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:01 INFO - Running setup.py (path:/tmp/pip-IWsUm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:19:01 INFO - Running setup.py install for manifestparser 05:19:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:19:02 INFO - Running setup.py install for mozcrash 05:19:02 INFO - Running setup.py install for mozdebug 05:19:02 INFO - Running setup.py install for mozdevice 05:19:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:19:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:19:02 INFO - Running setup.py install for mozfile 05:19:02 INFO - Running setup.py install for mozhttpd 05:19:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:19:02 INFO - Running setup.py install for mozinfo 05:19:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:19:02 INFO - Running setup.py install for mozInstall 05:19:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:19:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:19:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:19:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:19:02 INFO - Running setup.py install for mozleak 05:19:02 INFO - Running setup.py install for mozlog 05:19:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:19:03 INFO - Running setup.py install for moznetwork 05:19:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:19:03 INFO - Running setup.py install for mozprocess 05:19:03 INFO - Running setup.py install for mozprofile 05:19:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:19:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:19:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:19:03 INFO - Running setup.py install for mozrunner 05:19:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:19:03 INFO - Running setup.py install for mozscreenshot 05:19:03 INFO - Running setup.py install for moztest 05:19:03 INFO - Running setup.py install for mozversion 05:19:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:19:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:19:03 INFO - Cleaning up... 05:19:03 INFO - Return code: 0 05:19:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:03 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 0x1416030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d53b0>, '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 0x16d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6740>, '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': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', '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 05:19:03 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 05:19:03 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 05:19:03 INFO - Using env: {'DISPLAY': ':0', 05:19:03 INFO - 'HOME': '/home/cltbld', 05:19:03 INFO - 'LANG': 'en_US.UTF-8', 05:19:03 INFO - 'LANGUAGE': 'en_US:en', 05:19:03 INFO - 'LOGNAME': 'cltbld', 05:19:03 INFO - 'MAIL': '/var/mail/cltbld', 05:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:03 INFO - 'MOZ_NO_REMOTE': '1', 05:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:03 INFO - 'NO_EM_RESTART': '1', 05:19:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:03 INFO - 'PWD': '/builds/slave/test', 05:19:03 INFO - 'SHELL': '/bin/bash', 05:19:03 INFO - 'SHLVL': '1', 05:19:03 INFO - 'TERM': 'linux', 05:19:03 INFO - 'TMOUT': '86400', 05:19:03 INFO - 'USER': 'cltbld', 05:19:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', 05:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:03 INFO - '_': '/tools/buildbot/bin/python'} 05:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:04 INFO - Running setup.py (path:/tmp/pip-DYxAta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:04 INFO - Running setup.py (path:/tmp/pip-aywUg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:04 INFO - Running setup.py (path:/tmp/pip-LSOYGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:04 INFO - Running setup.py (path:/tmp/pip-gfUKyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:04 INFO - Running setup.py (path:/tmp/pip-S39Ztf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:04 INFO - Running setup.py (path:/tmp/pip-syLkj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:04 INFO - Running setup.py (path:/tmp/pip-lK4zoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:04 INFO - Running setup.py (path:/tmp/pip-Plb97R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:04 INFO - Running setup.py (path:/tmp/pip-aCCoN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:04 INFO - Running setup.py (path:/tmp/pip-D682Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:04 INFO - Running setup.py (path:/tmp/pip-j6vmmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:04 INFO - Running setup.py (path:/tmp/pip-nJH0_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:04 INFO - Running setup.py (path:/tmp/pip-0dUhrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:04 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)) 05:19:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:04 INFO - Running setup.py (path:/tmp/pip-0vVMV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:05 INFO - Running setup.py (path:/tmp/pip-fr9Bw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:05 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)) 05:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:05 INFO - Running setup.py (path:/tmp/pip-E6km8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:05 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)) 05:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:05 INFO - Running setup.py (path:/tmp/pip-JMGOAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:05 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)) 05:19:05 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)) 05:19:05 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)) 05:19:05 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)) 05:19:05 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)) 05:19:05 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)) 05:19:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:19:05 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 05:19:05 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 05:19:05 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 05:19:05 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 05:19:05 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 05:19:05 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 05:19:07 INFO - Downloading blessings-1.6.tar.gz 05:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:19:07 INFO - Installing collected packages: blessings 05:19:07 INFO - Running setup.py install for blessings 05:19:07 INFO - Successfully installed blessings 05:19:07 INFO - Cleaning up... 05:19:07 INFO - Return code: 0 05:19:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:19:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:07 INFO - Reading from file tmpfile_stdout 05:19:07 INFO - Current package versions: 05:19:07 INFO - argparse == 1.2.1 05:19:07 INFO - blessings == 1.6 05:19:07 INFO - blobuploader == 1.2.4 05:19:07 INFO - docopt == 0.6.1 05:19:07 INFO - functools32 == 3.2.3-2 05:19:07 INFO - jsonschema == 2.5.1 05:19:07 INFO - manifestparser == 1.1 05:19:07 INFO - mozInstall == 1.12 05:19:07 INFO - mozcrash == 0.17 05:19:07 INFO - mozdebug == 0.1 05:19:07 INFO - mozdevice == 0.48 05:19:07 INFO - mozfile == 1.2 05:19:07 INFO - mozhttpd == 0.7 05:19:07 INFO - mozinfo == 0.9 05:19:07 INFO - mozleak == 0.1 05:19:07 INFO - mozlog == 3.2 05:19:07 INFO - moznetwork == 0.27 05:19:07 INFO - mozprocess == 0.22 05:19:07 INFO - mozprofile == 0.28 05:19:07 INFO - mozrunner == 6.11 05:19:07 INFO - mozscreenshot == 0.1 05:19:07 INFO - mozsystemmonitor == 0.3 05:19:07 INFO - moztest == 0.7 05:19:07 INFO - mozversion == 1.4 05:19:07 INFO - psutil == 3.1.1 05:19:07 INFO - requests == 1.2.3 05:19:07 INFO - wsgiref == 0.1.2 05:19:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:07 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')]} 05:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:07 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')]} 05:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:07 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 0x1416030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d53b0>, '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 0x16d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6740>, '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': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', '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 05:19:07 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 05:19:07 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 05:19:07 INFO - Using env: {'DISPLAY': ':0', 05:19:07 INFO - 'HOME': '/home/cltbld', 05:19:07 INFO - 'LANG': 'en_US.UTF-8', 05:19:07 INFO - 'LANGUAGE': 'en_US:en', 05:19:07 INFO - 'LOGNAME': 'cltbld', 05:19:07 INFO - 'MAIL': '/var/mail/cltbld', 05:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:07 INFO - 'MOZ_NO_REMOTE': '1', 05:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:07 INFO - 'NO_EM_RESTART': '1', 05:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:07 INFO - 'PWD': '/builds/slave/test', 05:19:07 INFO - 'SHELL': '/bin/bash', 05:19:07 INFO - 'SHLVL': '1', 05:19:07 INFO - 'TERM': 'linux', 05:19:07 INFO - 'TMOUT': '86400', 05:19:07 INFO - 'USER': 'cltbld', 05:19:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', 05:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:07 INFO - '_': '/tools/buildbot/bin/python'} 05:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:07 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)) 05:19:07 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)) 05:19:07 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)) 05:19:07 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)) 05:19:07 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)) 05:19:07 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)) 05:19:07 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)) 05:19:07 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)) 05:19:07 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)) 05:19:07 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)) 05:19:07 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)) 05:19:07 INFO - Cleaning up... 05:19:07 INFO - Return code: 0 05:19:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:19:07 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')]} 05:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:07 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')]} 05:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:07 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 0x1416030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d7180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d53b0>, '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 0x16d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6740>, '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': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', '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 05:19:07 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 05:19:07 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 05:19:07 INFO - Using env: {'DISPLAY': ':0', 05:19:07 INFO - 'HOME': '/home/cltbld', 05:19:07 INFO - 'LANG': 'en_US.UTF-8', 05:19:07 INFO - 'LANGUAGE': 'en_US:en', 05:19:07 INFO - 'LOGNAME': 'cltbld', 05:19:07 INFO - 'MAIL': '/var/mail/cltbld', 05:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:07 INFO - 'MOZ_NO_REMOTE': '1', 05:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:07 INFO - 'NO_EM_RESTART': '1', 05:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:07 INFO - 'PWD': '/builds/slave/test', 05:19:07 INFO - 'SHELL': '/bin/bash', 05:19:07 INFO - 'SHLVL': '1', 05:19:07 INFO - 'TERM': 'linux', 05:19:07 INFO - 'TMOUT': '86400', 05:19:07 INFO - 'USER': 'cltbld', 05:19:07 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', 05:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:07 INFO - '_': '/tools/buildbot/bin/python'} 05:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:19:08 INFO - Cleaning up... 05:19:08 INFO - Return code: 0 05:19:08 INFO - Running post-action listener: _resource_record_post_action 05:19:08 INFO - Running post-action listener: _start_resource_monitoring 05:19:08 INFO - Starting resource monitoring. 05:19:08 INFO - ##### 05:19:08 INFO - ##### Finished create-virtualenv step (success) 05:19:08 INFO - ##### 05:19:08 INFO - ##### 05:19:08 INFO - ##### Running install step. 05:19:08 INFO - ##### 05:19:08 INFO - Running pre-action listener: _resource_record_pre_action 05:19:08 INFO - Running main action method: install 05:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:08 INFO - Reading from file tmpfile_stdout 05:19:08 INFO - Detecting whether we're running mozinstall >=1.0... 05:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:19:08 INFO - Reading from file tmpfile_stdout 05:19:08 INFO - Output received: 05:19:08 INFO - Usage: mozinstall [options] installer 05:19:08 INFO - Options: 05:19:08 INFO - -h, --help show this help message and exit 05:19:08 INFO - -d DEST, --destination=DEST 05:19:08 INFO - Directory to install application into. [default: 05:19:08 INFO - "/builds/slave/test"] 05:19:08 INFO - --app=APP Application being installed. [default: firefox] 05:19:08 INFO - mkdir: /builds/slave/test/build/application 05:19:08 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'] 05:19:08 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 05:19:24 INFO - Reading from file tmpfile_stdout 05:19:24 INFO - Output received: 05:19:24 INFO - /builds/slave/test/build/application/firefox/firefox 05:19:24 INFO - Running post-action listener: _resource_record_post_action 05:19:24 INFO - ##### 05:19:24 INFO - ##### Finished install step (success) 05:19:24 INFO - ##### 05:19:24 INFO - ##### 05:19:24 INFO - ##### Running run-tests step. 05:19:24 INFO - ##### 05:19:24 INFO - Running pre-action listener: _resource_record_pre_action 05:19:24 INFO - Running main action method: run_tests 05:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:19:24 INFO - Python 2.7.3 05:19:24 INFO - Return code: 0 05:19:24 INFO - grabbing minidump binary from tooltool 05:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:24 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 0x16d53b0>, '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 0x16d62b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d6740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:19:24 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 05:19:24 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 05:19:24 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 05:19:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:19:24 INFO - Return code: 0 05:19:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:19:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:19:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:19:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:19:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 05:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 05:19:24 INFO - Using env: {'DISPLAY': ':0', 05:19:24 INFO - 'HOME': '/home/cltbld', 05:19:24 INFO - 'LANG': 'en_US.UTF-8', 05:19:24 INFO - 'LANGUAGE': 'en_US:en', 05:19:24 INFO - 'LOGNAME': 'cltbld', 05:19:24 INFO - 'MAIL': '/var/mail/cltbld', 05:19:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:19:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:24 INFO - 'MOZ_NO_REMOTE': '1', 05:19:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:19:24 INFO - 'NO_EM_RESTART': '1', 05:19:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:24 INFO - 'PWD': '/builds/slave/test', 05:19:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:19:24 INFO - 'SHELL': '/bin/bash', 05:19:24 INFO - 'SHLVL': '1', 05:19:24 INFO - 'TERM': 'linux', 05:19:24 INFO - 'TMOUT': '86400', 05:19:24 INFO - 'USER': 'cltbld', 05:19:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919', 05:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:24 INFO - '_': '/tools/buildbot/bin/python'} 05:19:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 05:19:24 INFO - mozversion application_buildid: 20160704040124 05:19:24 INFO - mozversion application_changeset: 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 05:19:24 INFO - mozversion application_display_name: Nightly 05:19:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:19:24 INFO - mozversion application_name: Firefox 05:19:24 INFO - mozversion application_remotingname: firefox 05:19:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:19:24 INFO - mozversion application_vendor: Mozilla 05:19:24 INFO - mozversion application_version: 50.0a1 05:19:24 INFO - mozversion platform_buildid: 20160704040124 05:19:24 INFO - mozversion platform_changeset: 99bab2d812fc9619c122fcdd84c6f085ced8c1e8 05:19:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:19:24 INFO - mozversion platform_version: 50.0a1 05:19:24 INFO - using testdate: 1467634764 05:19:24 INFO - actual date: 1467634764 05:19:24 INFO - starting webserver on 'localhost:44772' 05:19:24 INFO - SUITE-START | Running 2 tests 05:19:24 INFO - TEST-START | dromaeo_css 05:19:24 INFO - operating with platform_type : linux_ 05:19:24 INFO - Initialising browser for dromaeo_css test... 05:19:24 INFO - TEST-INFO | started process 17490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ZKVpD/profile http://localhost:44772/getInfo.html) 05:19:28 INFO - PROCESS | 17490 | __metrics Screen width/height:1600/1200 05:19:28 INFO - PROCESS | 17490 | colorDepth:24 05:19:28 INFO - PROCESS | 17490 | Browser inner width/height: 1024/697 05:19:28 INFO - PROCESS | 17490 | __metrics 05:19:29 INFO - PROCESS | 17490 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:19:30 INFO - TEST-INFO | 17490: exit 0 05:19:30 INFO - Browser initialized. 05:19:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:19:30 INFO - TEST-INFO | started process 17572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8ZKVpD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:42 INFO - PROCESS | 17572 | RSS: Main: 159150080 05:19:42 INFO - PROCESS | 17572 | 05:20:34 INFO - PROCESS | 17572 | 1467634834869 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] 05:22:46 INFO - PROCESS | 17572 | Cycle 1(1): loaded http://localhost:44772/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44772/tests/dromaeo/cssquery-ext.html) 05:22:47 INFO - PROCESS | 17572 | RSS: Main: 259895296 05:22:47 INFO - PROCESS | 17572 | 05:25:50 INFO - PROCESS | 17572 | Cycle 1(1): loaded http://localhost:44772/tests/dromaeo/cssquery-ext.html (next: http://localhost:44772/tests/dromaeo/cssquery-jquery.html) 05:25:50 INFO - PROCESS | 17572 | RSS: Main: 252751872 05:25:50 INFO - PROCESS | 17572 | 05:28:53 INFO - PROCESS | 17572 | Cycle 1(1): loaded http://localhost:44772/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44772/tests/dromaeo/cssquery-mootools.html) 05:28:53 INFO - PROCESS | 17572 | RSS: Main: 248950784 05:28:53 INFO - PROCESS | 17572 | 05:31:55 INFO - PROCESS | 17572 | Cycle 1(1): loaded http://localhost:44772/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44772/tests/dromaeo/cssquery-prototype.html) 05:31:56 INFO - PROCESS | 17572 | RSS: Main: 237379584 05:31:56 INFO - PROCESS | 17572 | 05:34:59 INFO - PROCESS | 17572 | Cycle 1(1): loaded http://localhost:44772/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44772/tests/dromaeo/cssquery-yui.html) 05:35:00 INFO - PROCESS | 17572 | RSS: Main: 230121472 05:35:00 INFO - PROCESS | 17572 | 05:38:03 INFO - PROCESS | 17572 | Cycle 1(1): loaded http://localhost:44772/tests/dromaeo/cssquery-yui.html (next: http://localhost:44772/tests/dromaeo/cssquery-dojo.html) 05:38:03 INFO - PROCESS | 17572 | RSS: Main: 320675840 05:38:03 INFO - PROCESS | 17572 | 05:38:03 INFO - PROCESS | 17572 | __start_tp_report 05:38:03 INFO - PROCESS | 17572 | _x_x_mozilla_page_load 05:38:03 INFO - PROCESS | 17572 | _x_x_mozilla_page_load_details 05:38:03 INFO - PROCESS | 17572 | |i|pagename|runs| 05:38:03 INFO - PROCESS | 17572 | |0;dojo.html;2632.7235640257773;2663.920082397526;2675.9331016724577;2697.2717366311094;2706.5804800255955;4754.7860346284415;4806.182948898687;4820.493848145947;4898.26526021097;4955.430125535565;4813.3983252093485;4861.635377346695;4879.43886453058;4898.26526021097;4903.803847846091;4378.890527736816;4397.406350142738;4414.117176564684;4462.73223606583;4546.113507865967;4441.62246209071;4456;4544.7273163610125;4572.177008138534;4598.839040633578;4322.330038843953;4496.303073023687;4529.977350113245;4546.340780586796;4554.590086892179;4338.457692788402;4386.144701783153;4414.227510185737;4418.911621767579;4423.557644235583;4383.736975781463;4448.1770872388715;4460.710053846489;4461.821527138911;4511.390962220091;4749.952500474986;4916.041371932474;4936.4076310842565;4948.628852836052;4979.253112033188;5124.92312615311;5208.921866172011;5209.791608335662;5286.15421532553;5286.471352864683;5275.815346462856;5277;5288.947110528922;5301.416844147141;5306.8407947761625;4800.303955926371;4921.212605983062;4933.358663373739;4940.357753492023;4940.6788558743565;5303.602229832778;5342.412334643263;5367.221752845816;5421.972890135524;5422.349318081855;5146.87132821675;5187.559057480081;5201.661891977085;5207.661502002434;5210.296609957607;5230.424653288135;5236.502532259429;5281.313429254173;5286.07493688603;5292.073887069748;5042.773075211624;5091.87270318245;5127.2052831811125;5152.098382782998;5173.534381905646;5141.2288156776785;5160.509751573594;5163.096458119814;5171.172612382001;5219.217117432416;4357.651387888961;4435.534268901719;4443.955560444419;4453.643708503312;4490.259107247333;3844.1927195289304;3852.056246219638;3858.421236814444;3923.136909879822;3924.7645141291614;4500.662450316174;4513.571210734975;4531.478879928784;4545.499995000548;4557.043020965568;5248.501392367719;5272.051030814414;5272.6836389816735;5275.129603615437;5326.813561525328;4356.28121359972;4456.487503937024;4474.463064432224;4489.416375871116;4501.459824821042;4712.316714076508;4713.3872596562915;4719.5752382285755;4719.646026548023;4768.713877167312;4842.661013729005;4889.65772395936;4899.216125419915;4899.338589290543;4934.087193869145;5103.948960510347;5150.639455238097;5185.9222111667605;5204.0892843752945;5247.763850626655;4886.315915771866;4897.265410188358;4903.95096049035;4919.581835543876;4969.652124351261;5157.149070403341;5164.225366195101;5167.560757335668;5171.405288391883;5171.715555644476;5035.295058691713;5133.050385678662;5166.070107380708;5175.404828444777;5195.090859099567;5038.093143234253;5047.369078865142;5049.469805670352;5056.6207534434325;5104.183330667075;4952.430470495795;5026.44709082008;5035.924461133012;5047.646664733434;5050.419201791841;4893.339399181207;4952.306677065286;4961.330220420197;4972.129877271391;5011;5080.618953578422;5088.414832294334;5091.6181286402925;5093.898122037613;5145.07388670043;4906.092372911023;4965.726885021359;4990.72551009698;4998.925016124688;4999.475055119306 05:38:03 INFO - PROCESS | 17572 | |1;ext.html;573.0515996026576;576.1818218130256;577.2956992469188;581.2240658720608;587.5593305021234;27184.728152718468;40131.39802902959;41144.38283425751;41562.7921860391;45152.322715159215;41608.79195604025;41764.37353439693;41984.16031679372;42018;42107.78946105273;7838.999999999985;7986.241307075818;7986.720464783704;7990.720324788634;7993.320567751748;7821.5307081575;7885.172056934025;7908.683652653887;7908.9604551977445;7911.485753426037;7958.323542498894;7961.7611471655655;7964.442489025741;7975.4815936964205;8010.599470026505;7903.723369682062;7931.206879312081;7932.682692692285;7941.682332706685;7950.920490795076;7855;7914.445988780788;7932;7932.286094251545;7932.920670793276;39521.80239098786;39900.800495997624;39933.60066399328;39943.20113597741;39948.40077398841;2831.773458123366;2841.346490307241;2982.5078861987963;3123.1879711275233;3439.673231043072;29723.554146687817;29830.85084574585;29971.850140749375;30219.848900755576;30275.554225580367;3501.9474707879403;3560.181158333572;3571.39286321326;3581.623929487392;3621.5473065866768;256358;257267;257318;258465;258479;32645.67354326474;54119.94100442483;54543.45456545463;54576.72711636416;54631.72684136554;34542.13644658904;34714.479282810775;34722.826385868415;34729.13177170591;34749.47875781865;13745.24401157926;13956.790648140286;13957.58127256184;13958.930205348908;13963.58109256724;11268.380239086766;11304.208705390543;11360.147988900866;11370.488328025258;11393.886061139283;8088.555129467935;8099;8108.067572229151;8151.307138893142;8168.224018718212;3120.7659425543175;3122.9063128106195;3172.191091271711;3189.744820414361;3204.230984563688;843.0936743001175;878.6134100995541;889.0575989451203;939.8919124300793;1008.1884083312857;28209.294767630563;28709.56935645967;28917;29341;29395;957.2437774158476;964.3876138652007;981.2934687025473;1016.3139880580578;1040.47976011994;14983.775243371358;15349.923250383677;15454.536363909101;15542.222888855513;15670.216489175496;389941;391800;393074;393532;394723;49507.25739113916;49982.50017499851;50003;50140.49859501358;50230.49769502331;1060.740118670915;1141.5890279499374;1179.162794415957;1202.657242685848;1215.3012018089635;28832.567511487763;29492;29686.554701679925;29993.550096749004;30125.69874301229;42176.15647686968;42616.57383426126;42731.58147348267;42799.78600107104;42844.143117138105;289319;290398;290553;290742;292112;24890.253292401256;26054.609180861924;26192.214233573024;26230.606540902285;26263.343416414744;41974.160516788885;42313.365299519915;42873.571264286955;43635.127297454506;43749;36295;37392.25215495621;37500.812495937345;37589.4361584571;38022;36187.27625447529;36250.27499450049;36332.4117871877;36687.26625467529;37425.62574374222;32748.672513274563;33139.83430082931;33237.833810831755;36617.267654646224;37496.81251593724;32290.192745181557;33392;33740;33908.66091339055;34069.318613627096;25632.475101658358;25873.22380328593;25911.352216194748;26016.479670406865;26261 05:38:03 INFO - PROCESS | 17572 | |2;jquery.html;351.3500024953837;378.7500249835109;378.8503541101265;385.9228154369126;395.6755460522371;12812.551560695378;13185.472581096757;17814.64370712588;17864.196111174995;17887.642247155065;15274.465393711222;15836.920815395935;15972.84027159728;16187.757183642254;16195.676086478263;3781.394976803712;5114.3095682083;5341;5345.251664766935;5348.358197016363;5963.135345374918;6357.046443033559;6357.2371315442215;6416.3262857400005;6474.02889566564;6087.391260873921;6222.688865556704;6238.4385405313515;6379.776707815227;6408.166938298014;6287.811365659038;6304;6304.432601065881;6311.589746666498;6345.333739957307;5331.333583302087;5526.723663816833;5531.9723401382735;5533.059379905426;5533.059379905426;21942.451438714;22218.777812221833;22238.110475581117;22370.77629223703;23037.193698220482;1975.7036444533292;2011.0045527463853;2016.6470867598111;2028.4320390290743;2454;13478.797818032737;13561.932190339085;13670.52153174644;13772.724545509134;14392.568222953329;1687.1817168673183;1730.87018473615;1732.4282986614387;1847.4642353717406;1868.2807119259182;47025.29462058072;60477.6976115121;61843.38156618421;63551.36448635501;72946.63526682333;9868;10040.949795250977;10122.848157277647;10404.739881503023;10540.0513953743;14075;14137.505187318395;14159.504417345344;14182.574522764333;14188.361523731457;7014.508984371045;7095.9645201773665;7121.537100088582;7131.786046418616;7210.639468026578;6701.329867013357;6713.429358504582;6756.763513277012;6887.965560172267;6894.482913781386;4368.628666563314;4391.890202744957;4405.383246345515;4409.823607055746;4421.661645457723;1730.264637529045;1798.3615816385256;1817.2367605605677;1817.5456135966008;1818.1999920035141;842.5197637346776;849.6304107713041;852.5098068610449;854.5428195915156;871.664409202449;17215.65568688619;17922.014289214218;18104.90947545254;18186.272549098154;18647.81352186488;818.3167055508717;822.481836443049;836.7740710008263;845.7124577643631;847.8134810341714;8377.287930525974;9998.250131240186;10195.337303075275;10198.541065652063;10276.743081423025;417572;420397;423319;424274;424497;81707.59146204349;81741;82973.75539366914;83069;85263.14736852676;885.3881050899871;889.350773935031;889.3818795936762;903.9502827344559;904.1184844776421;15871.28579213915;16088.356465741239;16344;16463.34146634169;16663.83336166671;31456;41235.38146927858;41370.1725965485;41595.7920210397;42399.57600423956;53054.204186936455;55623;56172.43827561672;56455.71772141113;58120.4187958115;7676.15562288159;7831.17772633888;7950.24472675095;8061.717839875576;8112.1076681566165;11175.21773475849;11695.415229238673;11735;11741.47163377633;12039.699007524881;10410.27128101056;10604.840927386249;10682.57269709203;10874.456277185951;10890.401027943539;10707.625233116803;10779.461026948778;10914.890851091704;11058.889411105785;11066.114710823276;10413.323133996266;10519.21105917044;10586.311889727143;10586.735331616772;10861.185411094042;7618.276263754934;7855.764327070197;7859.84280314402;7964.561949092856;8168.141150597244;10310.690679279634;10345.63790267337;10556.208284378548;10576.471176440993;10975.28660637056 05:38:03 INFO - PROCESS | 17572 | |3;mootools.html;1257.4341546304165;1388.2850332078979;1400.0759498730836;1503.9398424063038;1675.9832401675988;6956.130483689539;7608.581528015964;7849.293563579276;7907.8418431631335;7909.4067944904145;7549.924500754991;7799.844003119934;7800.531968081905;8016.95991520043;8026.43814932955;2267.24047444106;2311.895964681585;2313.6992191015142;2315.8305055946726;2317.571249318881;2251.7860803223666;2261.4007288068674;2315.0392587076344;2316.930492085232;2319.8376113671966;2246.4945387287894;2277.0436416704943;2283.1552325639454;2303.9078436862505;2306.123673004264;2243.517643706611;2246.6742322363248;2256.2216035467736;2259.288324177887;2259.751427342991;2243.32700189944;2248.9212877549207;2249.2352600116037;2257.6952111464907;2258.559580881729;7932.04815422153;7947.483413578157;7955.840883182362;8027.317677997377;8137.79655508617;4791;4859.635527335464;4865.732384718839;4870.025994801019;4878.195097808857;3042.9695703042908;3157.068664743906;3189.5853539039776;3200.7119359257545;3205.406999705062;939.567798812547;943.3349488610513;957.7031120352643;967.0909345215546;972.246508955558;10953.233273670847;11103.05624021951;11133.276337038067;11155.665330040112;11216.775664486746;4368.956310436855;4459.219636563588;4617.746023968714;4643.442786865598;4644.442666879996;9574.904250957401;9619.18236949867;9633.951830240803;9635.421874687541;9638.132568068908;4849.224124140192;4850;4850.248211527219;4851.902961940741;4855.344528488608;3893.2213557288655;4255.936160957588;4370.038591509863;4442.73343599385;4454.643628509712;3831.1571454280015;3846.9230615387537;3938.606139386096;3977.343738283209;3979.4030895365927;1253.4798058805675;1285.7749893768553;1290.0840403313564;1294.6310301564008;1299.9610011699665;712.2592503796097;720.0243669827413;835.2065537739172;855.7047818502607;858.5020688000944;5349.090654588651;5482.231483047013;5516.834494965157;5614.550835933115;5627.268455100811;439.7075944496938;441.5143342323483;441.55182489772903;459.9793009314589;594.7918228620035;3700.130469339703;3826.559945606291;3872.7482713623526;3874.7093967952515;3885.825137868746;9469.715908522756;9833.065858743408;9841.45871977048;9927.305088643725;9946.154576861049;9739.318247722733;9789.314747967715;9854.556544955494;9963.750906227402;9990.200783937267;7452.888206676904;7475.850482990419;7480.47636665439;7507.662155203029;7595.468317217742;5206.739663016759;5227.477252274742;5374.865628359323;5400.162974738922;5450.727463626724;8935.776605584653;9295.581698823704;9358.29812764059;9386.859197112186;9391.342606017786;9055.36612437123;9372.203362714246;9390.530473476163;9403.764905877408;9492.620295188115;6924.480663950325;6961.338672826073;6961.408280296231;6992.0560724303605;7000.159980802133;7469.215732348242;7801.531908085533;7802.102758182881;8060.31487323584;8065.354771618374;6955.791326260221;7183.964080179566;7195.352418282379;7211.314925082109;7285;6896.7586134485055;6935.791926242221;6992.265812089658;7019.157701075904;7021.789346319619;6429.4856411486035;6429.7106630200815;6495.772647957298;6546.509011824037;6559.704813283318;4548.88627784308;4657.767111644472;4689.976550117364;4707.929381059355;4823.131836269365;4769.76151192432;4908.214685650279;4938.678985865908;5026.59787217029;5042.042012017705 05:38:03 INFO - PROCESS | 17572 | |4;prototype.html;304.5568697545072;308.3124632070483;308.71289700578467;313.351362679254;313.995290070649;4796.11271914696;4850.054239423313;4852.199387101124;4866.513348665132;4869.561739443449;4804.351412559304;4814.879628009301;4815.614750819935;4818.229083346665;4826.3001864729595;3598.118460977051;3678.2275722098393;3695.9836045087545;3756.1736417988;3813.970228038428;3765.9435108473394;3780.10821721382;3797.3924172132465;3798.4112462568346;3812.1232116613196;3598.208394153295;3745.382011968036;3764.1154328732728;3765.642263984917;3768.5100936878166;3626.1841085755627;3730.291244663505;3732.850685972558;3734.495843061179;3763.4919285896326;3304.686054824788;3309.652486488908;3310.1062713067336;3315.1214928044087;3317.668233176687;4718.834840780556;4729.9763501182615;4733.408323959505;4736.9526304736855;4741.478437371887;4185.707000509966;4270.6156445919705;4285.828566857322;4298.957010429887;4333.1766964277;4976.701397916137;5000.0999820032375;5004.798848276424;5009.974950125263;5024.171011783052;3609.8014609196484;3625.9456108158397;3626.782393056425;3635.0912271932016;3635.4001589737663;5056.898862022739;5261.973690131525;5272.839975205448;5277.525022747933;5326.999999999961;3596.964030359663;3608.1160115771804;3628.4738712886483;3633.509476220729;3644.9453258201147;3652.908677283089;3655.469956856241;3657.579378371468;3667.94498082529;3669.449582562637;4236.533981262059;4236.872893813191;4243.215005224043;4243.42713733642;4243.427137336482;4851.56335929768;5056.519630635084;5056.519630635084;5076.949230507647;5111.463296353903;1262.8295180150747;1273.3633183408297;1283.2108253424265;1285.1839082182694;1285.3444743180858;799.1089934722743;820.8481430935296;854.3848429131016;875.5840975536696;884.3720958119678;4488.236999710057;4492.393526873896;4493.842715505007;4508.887277818081;4519.819207231674;5178.559822415137;5192.273081768555;5197.818076367309;5210.921836172461;5228.607854410934;4298.720583162147;4403.427554417969;4433.578810013044;4454.354118652777;4534.571609942924;2750.0237415717534;2783.2067860660018;2785.206216228365;2786.7073957234197;2820.1116648255734;4909.459959404463;4921.606271498272;4931.679440836406;4943.604511639061;4949.554540091337;5063.822766203165;5331.280277162611;5362.249285100089;5377.596680248997;5380.219868119179;4928.507149285043;4945.8021679132435;4948.802047918187;4953.67801092935;4960.222275525717;5255.894882102413;5256.316678831728;5263.7894484220205;5264.763085661231;5282.392524859691;4930.115882208948;5194.3766747990485;5207.739613019258;5220.694826293427;5238.5023422774775;4910.729909854992;4961.776720047535;4975.303457515878;4977.153883839684;4977.377827771528;3687.0966613179944;3725.776453412804;3727.3849814781343;3731.776093434403;3731.813409329577;5107.233914912793;5223.138182200047;5240.240165176105;5279.1817268323475;5287.576993840406;4994.725290109079;5020.682213296489;5042.520960508746;5089.720065396439;5091.159958606937;5103.336566246513;5110.259012443249;5114.4118426379955;5116.1046816806165;5117.795288188431;4780.498047704941;4792.664513484023;4967.180415231446;4984.978079493622;5034.270030845581;5028.145215313479;5029.27075574047;5036.597072234139;5039.899202016012;5054.418741844588;4890.706557606555;4997.200447928314;5007.624428167829;5008.123578373843;5025.41699364699 05:38:03 INFO - PROCESS | 17572 | |5;yui.html;648.435860801103;654.0385633119314;710.6659869861163;714.8320144765979;742.8922806193106;13133.212007279559;13676.452941882337;13679.658008549792;13686.589402317946;13688.452461901525;12928.418221180045;13801.993554672857;14592;14598.927005364985;15117.092974421543;630.7603110817882;774.9070111586617;798.2815466080544;801.2308184143229;801.2468279816983;748.621945917311;755.5051441305953;759.1725019728494;796.8087658961865;796.9601519923981;839;839.0644431458941;840.3991146330403;841.0916210492653;843.5529169540154;650.847050943028;656.0585559721767;828.4449418889328;829.4898637338024;829.5230242610493;494.12786431947643;494.29069285575315;555.6443875919415;576.7664096041068;581.0122791254884;13353.465861365534;13383.866161338457;13406;13430.529931452353;13487.055906086578;12675.873241267562;13439.26084065376;13464.932675336659;13577.796333055012;13955.232462214573;10036.498175091288;11443.370614616193;11855.525778968831;12007.45966431504;12236.81644775329;4321.2005778931;4335.826566937319;4376.168527979706;4401.141777353385;4474.910501789978;61680.69159654218;61916.380836191965;62539.6873015632;62546.68726656383;62677;9968.152707019839;10118.139958103497;10183.18534517237;10373.688789336333;10602.787944241072;18946;19173.137208825636;19173.520661983563;19192.904035479733;19207.51981200481;7301.744438944717;7308.086489188851;7328.706851725978;7338.816529586697;7347.8530429392185;3686.7972261525338;3750.662440380379;3858.5176852893387;3885.378339465672;3962.9405558916637;2844.8008639395043;2932.252275669733;2940.0738767288235;2942.4262268857797;2950.5279155335043;502.09622679177335;506.42773665758193;518.5618152660995;520.5783315514445;523.2360753300225;545.5281181777734;550.3698265485996;550.4907960136858;558.2686680448626;605.452065880379;8398.454100483448;8473.49159050459;8477.788055298666;8560.571971401405;9425.104615061558;600.3096439094988;624.6064979063252;634.7619642634012;636.7548493829909;647.8288776439397;4263.488381394252;4289.378040184156;4312.7627980461375;4315.762633055212;4377.190219809346;55580.72209639007;79821.20178798254;82063;83076;93185.53407233056;50214.24678629824;55408.16887746687;74563.25436745671;83180.36711891388;83571;46736;62127.9999999991;71751;72233;73664.63167684234;8588.570571471277;9382;9384.390014649027;9395.2953528487;9524.904750952679;38858.41712374373;41696.79151604344;43617.345739813296;44419.77790111029;44657.55342446534;40078.79960600178;47858.282125767444;61451.07823382563;61471.385286148354;62100.37899620946;11288.548458061585;11291.322520648788;11384.715382115182;11598;11760.88239117598;13180.275084870424;13375;13440.327983600586;14108;14429.062110962754;11531.711707207387;11912.285262884254;12188.756224875275;13224.537141200397;13393.799093013808;12332.630021099381;12337.753244935231;12600.495980160691;12716.809247861105;13519.459221631025;12381.442835072623;13012.41444135035;13085.214887106804;13726.45094196221;13882;10648;11164.162687798285;11186.552537898719;11250.606228781953;11676.357800321064;9814.85277720849;10644.254902156774;10703.250772445854;10744.247902646739;10747.785044298915 05:38:03 INFO - PROCESS | 17572 | __end_tp_report 05:38:03 INFO - PROCESS | 17572 | __start_cc_report 05:38:03 INFO - PROCESS | 17572 | _x_x_mozilla_cycle_collect,960 05:38:03 INFO - PROCESS | 17572 | __end_cc_report 05:38:03 INFO - PROCESS | 17572 | __startTimestamp1467635883528__endTimestamp 05:38:03 INFO - PROCESS | 17572 | 05:38:03 INFO - PROCESS | 17572 | ------- Summary: start ------- 05:38:03 INFO - PROCESS | 17572 | Number of tests: 6 05:38:03 INFO - PROCESS | 17572 | 05:38:03 INFO - PROCESS | 17572 | [#0] dojo.html Cycles:165 Average:4813.70 Median:4940.68 stddev:512.73 (10.4%) stddev-sans-first:484.91 05:38:03 INFO - PROCESS | 17572 | Values: 2632.7 2663.9 2675.9 2697.3 2706.6 4754.8 4806.2 4820.5 4898.3 4955.4 4813.4 4861.6 4879.4 4898.3 4903.8 4378.9 4397.4 4414.1 4462.7 4546.1 4441.6 4456.0 4544.7 4572.2 4598.8 4322.3 4496.3 4530.0 4546.3 4554.6 4338.5 4386.1 4414.2 4418.9 4423.6 4383.7 4448.2 4460.7 4461.8 4511.4 4750.0 4916.0 4936.4 4948.6 4979.3 5124.9 5208.9 5209.8 5286.2 5286.5 5275.8 5277.0 5288.9 5301.4 5306.8 4800.3 4921.2 4933.4 4940.4 4940.7 5303.6 5342.4 5367.2 5422.0 5422.3 5146.9 5187.6 5201.7 5207.7 5210.3 5230.4 5236.5 5281.3 5286.1 5292.1 5042.8 5091.9 5127.2 5152.1 5173.5 5141.2 5160.5 5163.1 5171.2 5219.2 4357.7 4435.5 4444.0 4453.6 4490.3 3844.2 3852.1 3858.4 3923.1 3924.8 4500.7 4513.6 4531.5 4545.5 4557.0 5248.5 5272.1 5272.7 5275.1 5326.8 4356.3 4456.5 4474.5 4489.4 4501.5 4712.3 4713.4 4719.6 4719.6 4768.7 4842.7 4889.7 4899.2 4899.3 4934.1 5103.9 5150.6 5185.9 5204.1 5247.8 4886.3 4897.3 4904.0 4919.6 4969.7 5157.1 5164.2 5167.6 5171.4 5171.7 5035.3 5133.1 5166.1 5175.4 5195.1 5038.1 5047.4 5049.5 5056.6 5104.2 4952.4 5026.4 5035.9 5047.6 5050.4 4893.3 4952.3 4961.3 4972.1 5011.0 5080.6 5088.4 5091.6 5093.9 5145.1 4906.1 4965.7 4990.7 4998.9 4999.5 05:38:03 INFO - PROCESS | 17572 | 05:38:03 INFO - PROCESS | 17572 | [#1] ext.html Cycles:180 Average:46284.53 Median:36313.71 stddev:84013.29 (231.4%) stddev-sans-first:84178.87 05:38:03 INFO - PROCESS | 17572 | Values: 573.1 576.2 577.3 581.2 587.6 27184.7 40131.4 41144.4 41562.8 45152.3 41608.8 41764.4 41984.2 42018.0 42107.8 7839.0 7986.2 7986.7 7990.7 7993.3 7821.5 7885.2 7908.7 7909.0 7911.5 7958.3 7961.8 7964.4 7975.5 8010.6 7903.7 7931.2 7932.7 7941.7 7950.9 7855.0 7914.4 7932.0 7932.3 7932.9 39521.8 39900.8 39933.6 39943.2 39948.4 2831.8 2841.3 2982.5 3123.2 3439.7 29723.6 29830.9 29971.9 30219.8 30275.6 3501.9 3560.2 3571.4 3581.6 3621.5 256358.0 257267.0 257318.0 258465.0 258479.0 32645.7 54119.9 54543.5 54576.7 54631.7 34542.1 34714.5 34722.8 34729.1 34749.5 13745.2 13956.8 13957.6 13958.9 13963.6 11268.4 11304.2 11360.1 11370.5 11393.9 8088.6 8099.0 8108.1 8151.3 8168.2 3120.8 3122.9 3172.2 3189.7 3204.2 843.1 878.6 889.1 939.9 1008.2 28209.3 28709.6 28917.0 29341.0 29395.0 957.2 964.4 981.3 1016.3 1040.5 14983.8 15349.9 15454.5 15542.2 15670.2 389941.0 391800.0 393074.0 393532.0 394723.0 49507.3 49982.5 50003.0 50140.5 50230.5 1060.7 1141.6 1179.2 1202.7 1215.3 28832.6 29492.0 29686.6 29993.6 30125.7 42176.2 42616.6 42731.6 42799.8 42844.1 289319.0 290398.0 290553.0 290742.0 292112.0 24890.3 26054.6 26192.2 26230.6 26263.3 41974.2 42313.4 42873.6 43635.1 43749.0 36295.0 37392.3 37500.8 37589.4 38022.0 36187.3 36250.3 36332.4 36687.3 37425.6 32748.7 33139.8 33237.8 36617.3 37496.8 32290.2 33392.0 33740.0 33908.7 34069.3 25632.5 25873.2 25911.4 26016.5 26261.0 05:38:03 INFO - PROCESS | 17572 | 05:38:03 INFO - PROCESS | 17572 | [#2] jquery.html Cycles:180 Average:25682.46 Median:41482.98 stddev:69510.60 (167.6%) stddev-sans-first:69679.57 05:38:03 INFO - PROCESS | 17572 | Values: 351.4 378.8 378.9 385.9 395.7 12812.6 13185.5 17814.6 17864.2 17887.6 15274.5 15836.9 15972.8 16187.8 16195.7 3781.4 5114.3 5341.0 5345.3 5348.4 5963.1 6357.0 6357.2 6416.3 6474.0 6087.4 6222.7 6238.4 6379.8 6408.2 6287.8 6304.0 6304.4 6311.6 6345.3 5331.3 5526.7 5532.0 5533.1 5533.1 21942.5 22218.8 22238.1 22370.8 23037.2 1975.7 2011.0 2016.6 2028.4 2454.0 13478.8 13561.9 13670.5 13772.7 14392.6 1687.2 1730.9 1732.4 1847.5 1868.3 47025.3 60477.7 61843.4 63551.4 72946.6 9868.0 10040.9 10122.8 10404.7 10540.1 14075.0 14137.5 14159.5 14182.6 14188.4 7014.5 7096.0 7121.5 7131.8 7210.6 6701.3 6713.4 6756.8 6888.0 6894.5 4368.6 4391.9 4405.4 4409.8 4421.7 1730.3 1798.4 1817.2 1817.5 1818.2 842.5 849.6 852.5 854.5 871.7 17215.7 17922.0 18104.9 18186.3 18647.8 818.3 822.5 836.8 845.7 847.8 8377.3 9998.3 10195.3 10198.5 10276.7 417572.0 420397.0 423319.0 424274.0 424497.0 81707.6 81741.0 82973.8 83069.0 85263.1 885.4 889.4 889.4 904.0 904.1 15871.3 16088.4 16344.0 16463.3 16663.8 31456.0 41235.4 41370.2 41595.8 42399.6 53054.2 55623.0 56172.4 56455.7 58120.4 7676.2 7831.2 7950.2 8061.7 8112.1 11175.2 11695.4 11735.0 11741.5 12039.7 10410.3 10604.8 10682.6 10874.5 10890.4 10707.6 10779.5 10914.9 11058.9 11066.1 10413.3 10519.2 10586.3 10586.7 10861.2 7618.3 7855.8 7859.8 7964.6 8168.1 10310.7 10345.6 10556.2 10576.5 10975.3 05:38:03 INFO - PROCESS | 17572 | 05:38:03 INFO - PROCESS | 17572 | [#3] mootools.html Cycles:180 Average:5325.10 Median:5288.28 stddev:2978.13 (56.3%) stddev-sans-first:2970.79 05:38:03 INFO - PROCESS | 17572 | Values: 1257.4 1388.3 1400.1 1503.9 1676.0 6956.1 7608.6 7849.3 7907.8 7909.4 7549.9 7799.8 7800.5 8017.0 8026.4 2267.2 2311.9 2313.7 2315.8 2317.6 2251.8 2261.4 2315.0 2316.9 2319.8 2246.5 2277.0 2283.2 2303.9 2306.1 2243.5 2246.7 2256.2 2259.3 2259.8 2243.3 2248.9 2249.2 2257.7 2258.6 7932.0 7947.5 7955.8 8027.3 8137.8 4791.0 4859.6 4865.7 4870.0 4878.2 3043.0 3157.1 3189.6 3200.7 3205.4 939.6 943.3 957.7 967.1 972.2 10953.2 11103.1 11133.3 11155.7 11216.8 4369.0 4459.2 4617.7 4643.4 4644.4 9574.9 9619.2 9634.0 9635.4 9638.1 4849.2 4850.0 4850.2 4851.9 4855.3 3893.2 4255.9 4370.0 4442.7 4454.6 3831.2 3846.9 3938.6 3977.3 3979.4 1253.5 1285.8 1290.1 1294.6 1300.0 712.3 720.0 835.2 855.7 858.5 5349.1 5482.2 5516.8 5614.6 5627.3 439.7 441.5 441.6 460.0 594.8 3700.1 3826.6 3872.7 3874.7 3885.8 9469.7 9833.1 9841.5 9927.3 9946.2 9739.3 9789.3 9854.6 9963.8 9990.2 7452.9 7475.9 7480.5 7507.7 7595.5 5206.7 5227.5 5374.9 5400.2 5450.7 8935.8 9295.6 9358.3 9386.9 9391.3 9055.4 9372.2 9390.5 9403.8 9492.6 6924.5 6961.3 6961.4 6992.1 7000.2 7469.2 7801.5 7802.1 8060.3 8065.4 6955.8 7184.0 7195.4 7211.3 7285.0 6896.8 6935.8 6992.3 7019.2 7021.8 6429.5 6429.7 6495.8 6546.5 6559.7 4548.9 4657.8 4690.0 4707.9 4823.1 4769.8 4908.2 4938.7 5026.6 5042.0 05:38:03 INFO - PROCESS | 17572 | 05:38:03 INFO - PROCESS | 17572 | [#4] prototype.html Cycles:180 Average:4202.93 Median:4816.92 stddev:1226.61 (25.5%) stddev-sans-first:1194.64 05:38:03 INFO - PROCESS | 17572 | Values: 304.6 308.3 308.7 313.4 314.0 4796.1 4850.1 4852.2 4866.5 4869.6 4804.4 4814.9 4815.6 4818.2 4826.3 3598.1 3678.2 3696.0 3756.2 3814.0 3765.9 3780.1 3797.4 3798.4 3812.1 3598.2 3745.4 3764.1 3765.6 3768.5 3626.2 3730.3 3732.9 3734.5 3763.5 3304.7 3309.7 3310.1 3315.1 3317.7 4718.8 4730.0 4733.4 4737.0 4741.5 4185.7 4270.6 4285.8 4299.0 4333.2 4976.7 5000.1 5004.8 5010.0 5024.2 3609.8 3625.9 3626.8 3635.1 3635.4 5056.9 5262.0 5272.8 5277.5 5327.0 3597.0 3608.1 3628.5 3633.5 3644.9 3652.9 3655.5 3657.6 3667.9 3669.4 4236.5 4236.9 4243.2 4243.4 4243.4 4851.6 5056.5 5056.5 5076.9 5111.5 1262.8 1273.4 1283.2 1285.2 1285.3 799.1 820.8 854.4 875.6 884.4 4488.2 4492.4 4493.8 4508.9 4519.8 5178.6 5192.3 5197.8 5210.9 5228.6 4298.7 4403.4 4433.6 4454.4 4534.6 2750.0 2783.2 2785.2 2786.7 2820.1 4909.5 4921.6 4931.7 4943.6 4949.6 5063.8 5331.3 5362.2 5377.6 5380.2 4928.5 4945.8 4948.8 4953.7 4960.2 5255.9 5256.3 5263.8 5264.8 5282.4 4930.1 5194.4 5207.7 5220.7 5238.5 4910.7 4961.8 4975.3 4977.2 4977.4 3687.1 3725.8 3727.4 3731.8 3731.8 5107.2 5223.1 5240.2 5279.2 5287.6 4994.7 5020.7 5042.5 5089.7 5091.2 5103.3 5110.3 5114.4 5116.1 5117.8 4780.5 4792.7 4967.2 4985.0 5034.3 5028.1 5029.3 5036.6 5039.9 5054.4 4890.7 4997.2 5007.6 5008.1 5025.4 05:38:03 INFO - PROCESS | 17572 | 05:38:03 INFO - PROCESS | 17572 | [#5] yui.html Cycles:180 Average:16680.23 Median:24410.46 stddev:21893.95 (89.7%) stddev-sans-first:21922.27 05:38:03 INFO - PROCESS | 17572 | Values: 648.4 654.0 710.7 714.8 742.9 13133.2 13676.5 13679.7 13686.6 13688.5 12928.4 13802.0 14592.0 14598.9 15117.1 630.8 774.9 798.3 801.2 801.2 748.6 755.5 759.2 796.8 797.0 839.0 839.1 840.4 841.1 843.6 650.8 656.1 828.4 829.5 829.5 494.1 494.3 555.6 576.8 581.0 13353.5 13383.9 13406.0 13430.5 13487.1 12675.9 13439.3 13464.9 13577.8 13955.2 10036.5 11443.4 11855.5 12007.5 12236.8 4321.2 4335.8 4376.2 4401.1 4474.9 61680.7 61916.4 62539.7 62546.7 62677.0 9968.2 10118.1 10183.2 10373.7 10602.8 18946.0 19173.1 19173.5 19192.9 19207.5 7301.7 7308.1 7328.7 7338.8 7347.9 3686.8 3750.7 3858.5 3885.4 3962.9 2844.8 2932.3 2940.1 2942.4 2950.5 502.1 506.4 518.6 520.6 523.2 545.5 550.4 550.5 558.3 605.5 8398.5 8473.5 8477.8 8560.6 9425.1 600.3 624.6 634.8 636.8 647.8 4263.5 4289.4 4312.8 4315.8 4377.2 55580.7 79821.2 82063.0 83076.0 93185.5 50214.2 55408.2 74563.3 83180.4 83571.0 46736.0 62128.0 71751.0 72233.0 73664.6 8588.6 9382.0 9384.4 9395.3 9524.9 38858.4 41696.8 43617.3 44419.8 44657.6 40078.8 47858.3 61451.1 61471.4 62100.4 11288.5 11291.3 11384.7 11598.0 11760.9 13180.3 13375.0 13440.3 14108.0 14429.1 11531.7 11912.3 12188.8 13224.5 13393.8 12332.6 12337.8 12600.5 12716.8 13519.5 12381.4 13012.4 13085.2 13726.5 13882.0 10648.0 11164.2 11186.6 11250.6 11676.4 9814.9 10644.3 10703.3 10744.2 10747.8 05:38:03 INFO - PROCESS | 17572 | -------- Summary: end -------- 05:38:03 INFO - PROCESS | 17572 | 05:38:04 INFO - TEST-INFO | 17572: exit 0 05:38:04 INFO - TEST-OK | dromaeo_css | took 1119417ms 05:38:04 INFO - TEST-START | kraken 05:38:04 INFO - operating with platform_type : linux_ 05:38:04 INFO - Initialising browser for kraken test... 05:38:04 INFO - TEST-INFO | started process 17761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI2AHYZ/profile http://localhost:44772/getInfo.html) 05:38:08 INFO - PROCESS | 17761 | __metrics Screen width/height:1600/1200 05:38:08 INFO - PROCESS | 17761 | colorDepth:24 05:38:08 INFO - PROCESS | 17761 | Browser inner width/height: 1024/697 05:38:08 INFO - PROCESS | 17761 | __metrics 05:38:09 INFO - PROCESS | 17761 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:38:10 INFO - TEST-INFO | 17761: exit 0 05:38:10 INFO - Browser initialized. 05:38:10 INFO - Running cycle 1/1 for kraken test... 05:38:10 INFO - TEST-INFO | started process 17844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI2AHYZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:22 INFO - PROCESS | 17844 | RSS: Main: 159002624 05:38:22 INFO - PROCESS | 17844 | 05:38:24 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44772/tests/kraken/driver.html?testName=audio-beat-detection) 05:38:25 INFO - PROCESS | 17844 | RSS: Main: 217284608 05:38:25 INFO - PROCESS | 17844 | 05:38:28 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44772/tests/kraken/driver.html?testName=audio-dft) 05:38:29 INFO - PROCESS | 17844 | RSS: Main: 204324864 05:38:29 INFO - PROCESS | 17844 | 05:38:32 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44772/tests/kraken/driver.html?testName=audio-fft) 05:38:32 INFO - PROCESS | 17844 | RSS: Main: 271486976 05:38:32 INFO - PROCESS | 17844 | 05:38:35 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44772/tests/kraken/driver.html?testName=audio-oscillator) 05:38:35 INFO - PROCESS | 17844 | RSS: Main: 181329920 05:38:35 INFO - PROCESS | 17844 | 05:38:38 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44772/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:38 INFO - PROCESS | 17844 | RSS: Main: 185729024 05:38:38 INFO - PROCESS | 17844 | 05:38:41 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44772/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:42 INFO - PROCESS | 17844 | RSS: Main: 222101504 05:38:42 INFO - PROCESS | 17844 | 05:38:45 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44772/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:46 INFO - PROCESS | 17844 | RSS: Main: 222457856 05:38:46 INFO - PROCESS | 17844 | 05:38:49 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44772/tests/kraken/driver.html?testName=json-parse-financial) 05:38:50 INFO - PROCESS | 17844 | RSS: Main: 222121984 05:38:50 INFO - PROCESS | 17844 | 05:38:51 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44772/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:52 INFO - PROCESS | 17844 | RSS: Main: 210092032 05:38:52 INFO - PROCESS | 17844 | 05:38:54 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44772/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:54 INFO - PROCESS | 17844 | RSS: Main: 214413312 05:38:54 INFO - PROCESS | 17844 | 05:38:57 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44772/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:57 INFO - PROCESS | 17844 | RSS: Main: 212852736 05:38:57 INFO - PROCESS | 17844 | 05:39:00 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:39:01 INFO - PROCESS | 17844 | RSS: Main: 225533952 05:39:01 INFO - PROCESS | 17844 | 05:39:04 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:39:04 INFO - PROCESS | 17844 | RSS: Main: 225980416 05:39:04 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | Cycle 1(1): loaded http://localhost:44772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44772/tests/kraken/driver.html?testName=ai-astar) 05:39:06 INFO - PROCESS | 17844 | RSS: Main: 268177408 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | __start_tp_report 05:39:06 INFO - PROCESS | 17844 | _x_x_mozilla_page_load 05:39:06 INFO - PROCESS | 17844 | _x_x_mozilla_page_load_details 05:39:06 INFO - PROCESS | 17844 | |i|pagename|runs| 05:39:06 INFO - PROCESS | 17844 | |0;ai-astar;103;113;113;112;113;114;113;113;113;114 05:39:06 INFO - PROCESS | 17844 | |1;audio-beat-detection;150;121;125;175;124;123;149;121;157;123 05:39:06 INFO - PROCESS | 17844 | |2;audio-dft;163;160;163;161;161;170;162;160;160;167 05:39:06 INFO - PROCESS | 17844 | |3;audio-fft;77;77;78;125;77;76;75;75;114;76 05:39:06 INFO - PROCESS | 17844 | |4;audio-oscillator;85;86;113;85;85;85;134;84;85;128 05:39:06 INFO - PROCESS | 17844 | |5;imaging-gaussian-blur;117;117;118;117;116;117;117;117;117;116 05:39:06 INFO - PROCESS | 17844 | |6;imaging-darkroom;147;147;148;146;146;145;147;147;147;146 05:39:06 INFO - PROCESS | 17844 | |7;imaging-desaturate;95;95;95;95;94;95;94;95;95;94 05:39:06 INFO - PROCESS | 17844 | |8;json-parse-financial;64;64;64;64;65;66;63;65;64;64 05:39:06 INFO - PROCESS | 17844 | |9;json-stringify-tinderbox;64;63;64;64;64;65;65;65;66;65 05:39:06 INFO - PROCESS | 17844 | |10;stanford-crypto-aes;86;78;80;85;83;80;79;78;93;83 05:39:06 INFO - PROCESS | 17844 | |11;stanford-crypto-ccm;151;129;138;135;127;128;128;132;175;151 05:39:06 INFO - PROCESS | 17844 | |12;stanford-crypto-pbkdf2;166;165;166;164;167;172;164;169;168;170 05:39:06 INFO - PROCESS | 17844 | |13;stanford-crypto-sha256-iterative;72;75;68;68;68;67;67;70;66;65 05:39:06 INFO - PROCESS | 17844 | __end_tp_report 05:39:06 INFO - PROCESS | 17844 | __start_cc_report 05:39:06 INFO - PROCESS | 17844 | _x_x_mozilla_cycle_collect,1938 05:39:06 INFO - PROCESS | 17844 | __end_cc_report 05:39:06 INFO - PROCESS | 17844 | __startTimestamp1467635946648__endTimestamp 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | ------- Summary: start ------- 05:39:06 INFO - PROCESS | 17844 | Number of tests: 14 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.25 (2.9%) stddev-sans-first:0.60 05:39:06 INFO - PROCESS | 17844 | Values: 103.0 113.0 113.0 112.0 113.0 114.0 113.0 113.0 113.0 114.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:137.00 stddev:19.36 (14.1%) stddev-sans-first:19.94 05:39:06 INFO - PROCESS | 17844 | Values: 150.0 121.0 125.0 175.0 124.0 123.0 149.0 121.0 157.0 123.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:3.33 (2.1%) stddev-sans-first:3.54 05:39:06 INFO - PROCESS | 17844 | Values: 163.0 160.0 163.0 161.0 161.0 170.0 162.0 160.0 160.0 167.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#3] audio-fft Cycles:10 Average:85.00 Median:76.50 stddev:18.39 (24.0%) stddev-sans-first:19.28 05:39:06 INFO - PROCESS | 17844 | Values: 77.0 77.0 78.0 125.0 77.0 76.0 75.0 75.0 114.0 76.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:85.00 stddev:19.99 (23.5%) stddev-sans-first:20.72 05:39:06 INFO - PROCESS | 17844 | Values: 85.0 86.0 113.0 85.0 85.0 85.0 134.0 84.0 85.0 128.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:39:06 INFO - PROCESS | 17844 | Values: 117.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 05:39:06 INFO - PROCESS | 17844 | Values: 147.0 147.0 148.0 146.0 146.0 145.0 147.0 147.0 147.0 146.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:39:06 INFO - PROCESS | 17844 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 05:39:06 INFO - PROCESS | 17844 | Values: 64.0 64.0 64.0 64.0 65.0 66.0 63.0 65.0 64.0 64.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 05:39:06 INFO - PROCESS | 17844 | Values: 64.0 63.0 64.0 64.0 64.0 65.0 65.0 65.0 66.0 65.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:4.65 (5.6%) stddev-sans-first:4.76 05:39:06 INFO - PROCESS | 17844 | Values: 86.0 78.0 80.0 85.0 83.0 80.0 79.0 78.0 93.0 83.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:136.50 stddev:15.40 (11.3%) stddev-sans-first:15.75 05:39:06 INFO - PROCESS | 17844 | Values: 151.0 129.0 138.0 135.0 127.0 128.0 128.0 132.0 175.0 151.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.50 stddev:2.64 (1.6%) stddev-sans-first:2.77 05:39:06 INFO - PROCESS | 17844 | Values: 166.0 165.0 166.0 164.0 167.0 172.0 164.0 169.0 168.0 170.0 05:39:06 INFO - PROCESS | 17844 | 05:39:06 INFO - PROCESS | 17844 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:2.99 (4.4%) stddev-sans-first:2.91 05:39:06 INFO - PROCESS | 17844 | Values: 72.0 75.0 68.0 68.0 68.0 67.0 67.0 70.0 66.0 65.0 05:39:06 INFO - PROCESS | 17844 | -------- Summary: end -------- 05:39:06 INFO - PROCESS | 17844 | 05:39:07 INFO - TEST-INFO | 17844: exit 0 05:39:07 INFO - TEST-OK | kraken | took 63334ms 05:39:07 INFO - SUITE-END | took 1182s 05:39:07 INFO - Completed test suite (00:19:42) 05:39:07 INFO - javascript benchmark 05:39:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.7235640257773, 2663.920082397526, 2675.9331016724577, 2697.2717366311094, 2706.5804800255955, 4754.7860346284415, 4806.182948898687, 4820.493848145947, 4898.26526021097, 4955.430125535565, 4813.3983252093485, 4861.635377346695, 4879.43886453058, 4898.26526021097, 4903.803847846091, 4378.890527736816, 4397.406350142738, 4414.117176564684, 4462.73223606583, 4546.113507865967, 4441.62246209071, 4456.0, 4544.7273163610125, 4572.177008138534, 4598.839040633578, 4322.330038843953, 4496.303073023687, 4529.977350113245, 4546.340780586796, 4554.590086892179, 4338.457692788402, 4386.144701783153, 4414.227510185737, 4418.911621767579, 4423.557644235583, 4383.736975781463, 4448.1770872388715, 4460.710053846489, 4461.821527138911, 4511.390962220091, 4749.952500474986, 4916.041371932474, 4936.4076310842565, 4948.628852836052, 4979.253112033188, 5124.92312615311, 5208.921866172011, 5209.791608335662, 5286.15421532553, 5286.471352864683, 5275.815346462856, 5277.0, 5288.947110528922, 5301.416844147141, 5306.8407947761625, 4800.303955926371, 4921.212605983062, 4933.358663373739, 4940.357753492023, 4940.6788558743565, 5303.602229832778, 5342.412334643263, 5367.221752845816, 5421.972890135524, 5422.349318081855, 5146.87132821675, 5187.559057480081, 5201.661891977085, 5207.661502002434, 5210.296609957607, 5230.424653288135, 5236.502532259429, 5281.313429254173, 5286.07493688603, 5292.073887069748, 5042.773075211624, 5091.87270318245, 5127.2052831811125, 5152.098382782998, 5173.534381905646, 5141.2288156776785, 5160.509751573594, 5163.096458119814, 5171.172612382001, 5219.217117432416, 4357.651387888961, 4435.534268901719, 4443.955560444419, 4453.643708503312, 4490.259107247333, 3844.1927195289304, 3852.056246219638, 3858.421236814444, 3923.136909879822, 3924.7645141291614, 4500.662450316174, 4513.571210734975, 4531.478879928784, 4545.499995000548, 4557.043020965568, 5248.501392367719, 5272.051030814414, 5272.6836389816735, 5275.129603615437, 5326.813561525328, 4356.28121359972, 4456.487503937024, 4474.463064432224, 4489.416375871116, 4501.459824821042, 4712.316714076508, 4713.3872596562915, 4719.5752382285755, 4719.646026548023, 4768.713877167312, 4842.661013729005, 4889.65772395936, 4899.216125419915, 4899.338589290543, 4934.087193869145, 5103.948960510347, 5150.639455238097, 5185.9222111667605, 5204.0892843752945, 5247.763850626655, 4886.315915771866, 4897.265410188358, 4903.95096049035, 4919.581835543876, 4969.652124351261, 5157.149070403341, 5164.225366195101, 5167.560757335668, 5171.405288391883, 5171.715555644476, 5035.295058691713, 5133.050385678662, 5166.070107380708, 5175.404828444777, 5195.090859099567, 5038.093143234253, 5047.369078865142, 5049.469805670352, 5056.6207534434325, 5104.183330667075, 4952.430470495795, 5026.44709082008, 5035.924461133012, 5047.646664733434, 5050.419201791841, 4893.339399181207, 4952.306677065286, 4961.330220420197, 4972.129877271391, 5011.0, 5080.618953578422, 5088.414832294334, 5091.6181286402925, 5093.898122037613, 5145.07388670043, 4906.092372911023, 4965.726885021359, 4990.72551009698, 4998.925016124688, 4999.475055119306], "value": 4780.160538638919, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.0515996026576, 576.1818218130256, 577.2956992469188, 581.2240658720608, 587.5593305021234, 27184.728152718468, 40131.39802902959, 41144.38283425751, 41562.7921860391, 45152.322715159215, 41608.79195604025, 41764.37353439693, 41984.16031679372, 42018.0, 42107.78946105273, 7838.999999999985, 7986.241307075818, 7986.720464783704, 7990.720324788634, 7993.320567751748, 7821.5307081575, 7885.172056934025, 7908.683652653887, 7908.9604551977445, 7911.485753426037, 7958.323542498894, 7961.7611471655655, 7964.442489025741, 7975.4815936964205, 8010.599470026505, 7903.723369682062, 7931.206879312081, 7932.682692692285, 7941.682332706685, 7950.920490795076, 7855.0, 7914.445988780788, 7932.0, 7932.286094251545, 7932.920670793276, 39521.80239098786, 39900.800495997624, 39933.60066399328, 39943.20113597741, 39948.40077398841, 2831.773458123366, 2841.346490307241, 2982.5078861987963, 3123.1879711275233, 3439.673231043072, 29723.554146687817, 29830.85084574585, 29971.850140749375, 30219.848900755576, 30275.554225580367, 3501.9474707879403, 3560.181158333572, 3571.39286321326, 3581.623929487392, 3621.5473065866768, 256358.0, 257267.0, 257318.0, 258465.0, 258479.0, 32645.67354326474, 54119.94100442483, 54543.45456545463, 54576.72711636416, 54631.72684136554, 34542.13644658904, 34714.479282810775, 34722.826385868415, 34729.13177170591, 34749.47875781865, 13745.24401157926, 13956.790648140286, 13957.58127256184, 13958.930205348908, 13963.58109256724, 11268.380239086766, 11304.208705390543, 11360.147988900866, 11370.488328025258, 11393.886061139283, 8088.555129467935, 8099.0, 8108.067572229151, 8151.307138893142, 8168.224018718212, 3120.7659425543175, 3122.9063128106195, 3172.191091271711, 3189.744820414361, 3204.230984563688, 843.0936743001175, 878.6134100995541, 889.0575989451203, 939.8919124300793, 1008.1884083312857, 28209.294767630563, 28709.56935645967, 28917.0, 29341.0, 29395.0, 957.2437774158476, 964.3876138652007, 981.2934687025473, 1016.3139880580578, 1040.47976011994, 14983.775243371358, 15349.923250383677, 15454.536363909101, 15542.222888855513, 15670.216489175496, 389941.0, 391800.0, 393074.0, 393532.0, 394723.0, 49507.25739113916, 49982.50017499851, 50003.0, 50140.49859501358, 50230.49769502331, 1060.740118670915, 1141.5890279499374, 1179.162794415957, 1202.657242685848, 1215.3012018089635, 28832.567511487763, 29492.0, 29686.554701679925, 29993.550096749004, 30125.69874301229, 42176.15647686968, 42616.57383426126, 42731.58147348267, 42799.78600107104, 42844.143117138105, 289319.0, 290398.0, 290553.0, 290742.0, 292112.0, 24890.253292401256, 26054.609180861924, 26192.214233573024, 26230.606540902285, 26263.343416414744, 41974.160516788885, 42313.365299519915, 42873.571264286955, 43635.127297454506, 43749.0, 36295.0, 37392.25215495621, 37500.812495937345, 37589.4361584571, 38022.0, 36187.27625447529, 36250.27499450049, 36332.4117871877, 36687.26625467529, 37425.62574374222, 32748.672513274563, 33139.83430082931, 33237.833810831755, 36617.267654646224, 37496.81251593724, 32290.192745181557, 33392.0, 33740.0, 33908.66091339055, 34069.318613627096, 25632.475101658358, 25873.22380328593, 25911.352216194748, 26016.479670406865, 26261.0], "value": 16718.46069744567, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.3500024953837, 378.7500249835109, 378.8503541101265, 385.9228154369126, 395.6755460522371, 12812.551560695378, 13185.472581096757, 17814.64370712588, 17864.196111174995, 17887.642247155065, 15274.465393711222, 15836.920815395935, 15972.84027159728, 16187.757183642254, 16195.676086478263, 3781.394976803712, 5114.3095682083, 5341.0, 5345.251664766935, 5348.358197016363, 5963.135345374918, 6357.046443033559, 6357.2371315442215, 6416.3262857400005, 6474.02889566564, 6087.391260873921, 6222.688865556704, 6238.4385405313515, 6379.776707815227, 6408.166938298014, 6287.811365659038, 6304.0, 6304.432601065881, 6311.589746666498, 6345.333739957307, 5331.333583302087, 5526.723663816833, 5531.9723401382735, 5533.059379905426, 5533.059379905426, 21942.451438714, 22218.777812221833, 22238.110475581117, 22370.77629223703, 23037.193698220482, 1975.7036444533292, 2011.0045527463853, 2016.6470867598111, 2028.4320390290743, 2454.0, 13478.797818032737, 13561.932190339085, 13670.52153174644, 13772.724545509134, 14392.568222953329, 1687.1817168673183, 1730.87018473615, 1732.4282986614387, 1847.4642353717406, 1868.2807119259182, 47025.29462058072, 60477.6976115121, 61843.38156618421, 63551.36448635501, 72946.63526682333, 9868.0, 10040.949795250977, 10122.848157277647, 10404.739881503023, 10540.0513953743, 14075.0, 14137.505187318395, 14159.504417345344, 14182.574522764333, 14188.361523731457, 7014.508984371045, 7095.9645201773665, 7121.537100088582, 7131.786046418616, 7210.639468026578, 6701.329867013357, 6713.429358504582, 6756.763513277012, 6887.965560172267, 6894.482913781386, 4368.628666563314, 4391.890202744957, 4405.383246345515, 4409.823607055746, 4421.661645457723, 1730.264637529045, 1798.3615816385256, 1817.2367605605677, 1817.5456135966008, 1818.1999920035141, 842.5197637346776, 849.6304107713041, 852.5098068610449, 854.5428195915156, 871.664409202449, 17215.65568688619, 17922.014289214218, 18104.90947545254, 18186.272549098154, 18647.81352186488, 818.3167055508717, 822.481836443049, 836.7740710008263, 845.7124577643631, 847.8134810341714, 8377.287930525974, 9998.250131240186, 10195.337303075275, 10198.541065652063, 10276.743081423025, 417572.0, 420397.0, 423319.0, 424274.0, 424497.0, 81707.59146204349, 81741.0, 82973.75539366914, 83069.0, 85263.14736852676, 885.3881050899871, 889.350773935031, 889.3818795936762, 903.9502827344559, 904.1184844776421, 15871.28579213915, 16088.356465741239, 16344.0, 16463.34146634169, 16663.83336166671, 31456.0, 41235.38146927858, 41370.1725965485, 41595.7920210397, 42399.57600423956, 53054.204186936455, 55623.0, 56172.43827561672, 56455.71772141113, 58120.4187958115, 7676.15562288159, 7831.17772633888, 7950.24472675095, 8061.717839875576, 8112.1076681566165, 11175.21773475849, 11695.415229238673, 11735.0, 11741.47163377633, 12039.699007524881, 10410.27128101056, 10604.840927386249, 10682.57269709203, 10874.456277185951, 10890.401027943539, 10707.625233116803, 10779.461026948778, 10914.890851091704, 11058.889411105785, 11066.114710823276, 10413.323133996266, 10519.21105917044, 10586.311889727143, 10586.735331616772, 10861.185411094042, 7618.276263754934, 7855.764327070197, 7859.84280314402, 7964.561949092856, 8168.141150597244, 10310.690679279634, 10345.63790267337, 10556.208284378548, 10576.471176440993, 10975.28660637056], "value": 8542.047440178389, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.4341546304165, 1388.2850332078979, 1400.0759498730836, 1503.9398424063038, 1675.9832401675988, 6956.130483689539, 7608.581528015964, 7849.293563579276, 7907.8418431631335, 7909.4067944904145, 7549.924500754991, 7799.844003119934, 7800.531968081905, 8016.95991520043, 8026.43814932955, 2267.24047444106, 2311.895964681585, 2313.6992191015142, 2315.8305055946726, 2317.571249318881, 2251.7860803223666, 2261.4007288068674, 2315.0392587076344, 2316.930492085232, 2319.8376113671966, 2246.4945387287894, 2277.0436416704943, 2283.1552325639454, 2303.9078436862505, 2306.123673004264, 2243.517643706611, 2246.6742322363248, 2256.2216035467736, 2259.288324177887, 2259.751427342991, 2243.32700189944, 2248.9212877549207, 2249.2352600116037, 2257.6952111464907, 2258.559580881729, 7932.04815422153, 7947.483413578157, 7955.840883182362, 8027.317677997377, 8137.79655508617, 4791.0, 4859.635527335464, 4865.732384718839, 4870.025994801019, 4878.195097808857, 3042.9695703042908, 3157.068664743906, 3189.5853539039776, 3200.7119359257545, 3205.406999705062, 939.567798812547, 943.3349488610513, 957.7031120352643, 967.0909345215546, 972.246508955558, 10953.233273670847, 11103.05624021951, 11133.276337038067, 11155.665330040112, 11216.775664486746, 4368.956310436855, 4459.219636563588, 4617.746023968714, 4643.442786865598, 4644.442666879996, 9574.904250957401, 9619.18236949867, 9633.951830240803, 9635.421874687541, 9638.132568068908, 4849.224124140192, 4850.0, 4850.248211527219, 4851.902961940741, 4855.344528488608, 3893.2213557288655, 4255.936160957588, 4370.038591509863, 4442.73343599385, 4454.643628509712, 3831.1571454280015, 3846.9230615387537, 3938.606139386096, 3977.343738283209, 3979.4030895365927, 1253.4798058805675, 1285.7749893768553, 1290.0840403313564, 1294.6310301564008, 1299.9610011699665, 712.2592503796097, 720.0243669827413, 835.2065537739172, 855.7047818502607, 858.5020688000944, 5349.090654588651, 5482.231483047013, 5516.834494965157, 5614.550835933115, 5627.268455100811, 439.7075944496938, 441.5143342323483, 441.55182489772903, 459.9793009314589, 594.7918228620035, 3700.130469339703, 3826.559945606291, 3872.7482713623526, 3874.7093967952515, 3885.825137868746, 9469.715908522756, 9833.065858743408, 9841.45871977048, 9927.305088643725, 9946.154576861049, 9739.318247722733, 9789.314747967715, 9854.556544955494, 9963.750906227402, 9990.200783937267, 7452.888206676904, 7475.850482990419, 7480.47636665439, 7507.662155203029, 7595.468317217742, 5206.739663016759, 5227.477252274742, 5374.865628359323, 5400.162974738922, 5450.727463626724, 8935.776605584653, 9295.581698823704, 9358.29812764059, 9386.859197112186, 9391.342606017786, 9055.36612437123, 9372.203362714246, 9390.530473476163, 9403.764905877408, 9492.620295188115, 6924.480663950325, 6961.338672826073, 6961.408280296231, 6992.0560724303605, 7000.159980802133, 7469.215732348242, 7801.531908085533, 7802.102758182881, 8060.31487323584, 8065.354771618374, 6955.791326260221, 7183.964080179566, 7195.352418282379, 7211.314925082109, 7285.0, 6896.7586134485055, 6935.791926242221, 6992.265812089658, 7019.157701075904, 7021.789346319619, 6429.4856411486035, 6429.7106630200815, 6495.772647957298, 6546.509011824037, 6559.704813283318, 4548.88627784308, 4657.767111644472, 4689.976550117364, 4707.929381059355, 4823.131836269365, 4769.76151192432, 4908.214685650279, 4938.678985865908, 5026.59787217029, 5042.042012017705], "value": 4228.538391718719, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.5568697545072, 308.3124632070483, 308.71289700578467, 313.351362679254, 313.995290070649, 4796.11271914696, 4850.054239423313, 4852.199387101124, 4866.513348665132, 4869.561739443449, 4804.351412559304, 4814.879628009301, 4815.614750819935, 4818.229083346665, 4826.3001864729595, 3598.118460977051, 3678.2275722098393, 3695.9836045087545, 3756.1736417988, 3813.970228038428, 3765.9435108473394, 3780.10821721382, 3797.3924172132465, 3798.4112462568346, 3812.1232116613196, 3598.208394153295, 3745.382011968036, 3764.1154328732728, 3765.642263984917, 3768.5100936878166, 3626.1841085755627, 3730.291244663505, 3732.850685972558, 3734.495843061179, 3763.4919285896326, 3304.686054824788, 3309.652486488908, 3310.1062713067336, 3315.1214928044087, 3317.668233176687, 4718.834840780556, 4729.9763501182615, 4733.408323959505, 4736.9526304736855, 4741.478437371887, 4185.707000509966, 4270.6156445919705, 4285.828566857322, 4298.957010429887, 4333.1766964277, 4976.701397916137, 5000.0999820032375, 5004.798848276424, 5009.974950125263, 5024.171011783052, 3609.8014609196484, 3625.9456108158397, 3626.782393056425, 3635.0912271932016, 3635.4001589737663, 5056.898862022739, 5261.973690131525, 5272.839975205448, 5277.525022747933, 5326.999999999961, 3596.964030359663, 3608.1160115771804, 3628.4738712886483, 3633.509476220729, 3644.9453258201147, 3652.908677283089, 3655.469956856241, 3657.579378371468, 3667.94498082529, 3669.449582562637, 4236.533981262059, 4236.872893813191, 4243.215005224043, 4243.42713733642, 4243.427137336482, 4851.56335929768, 5056.519630635084, 5056.519630635084, 5076.949230507647, 5111.463296353903, 1262.8295180150747, 1273.3633183408297, 1283.2108253424265, 1285.1839082182694, 1285.3444743180858, 799.1089934722743, 820.8481430935296, 854.3848429131016, 875.5840975536696, 884.3720958119678, 4488.236999710057, 4492.393526873896, 4493.842715505007, 4508.887277818081, 4519.819207231674, 5178.559822415137, 5192.273081768555, 5197.818076367309, 5210.921836172461, 5228.607854410934, 4298.720583162147, 4403.427554417969, 4433.578810013044, 4454.354118652777, 4534.571609942924, 2750.0237415717534, 2783.2067860660018, 2785.206216228365, 2786.7073957234197, 2820.1116648255734, 4909.459959404463, 4921.606271498272, 4931.679440836406, 4943.604511639061, 4949.554540091337, 5063.822766203165, 5331.280277162611, 5362.249285100089, 5377.596680248997, 5380.219868119179, 4928.507149285043, 4945.8021679132435, 4948.802047918187, 4953.67801092935, 4960.222275525717, 5255.894882102413, 5256.316678831728, 5263.7894484220205, 5264.763085661231, 5282.392524859691, 4930.115882208948, 5194.3766747990485, 5207.739613019258, 5220.694826293427, 5238.5023422774775, 4910.729909854992, 4961.776720047535, 4975.303457515878, 4977.153883839684, 4977.377827771528, 3687.0966613179944, 3725.776453412804, 3727.3849814781343, 3731.776093434403, 3731.813409329577, 5107.233914912793, 5223.138182200047, 5240.240165176105, 5279.1817268323475, 5287.576993840406, 4994.725290109079, 5020.682213296489, 5042.520960508746, 5089.720065396439, 5091.159958606937, 5103.336566246513, 5110.259012443249, 5114.4118426379955, 5116.1046816806165, 5117.795288188431, 4780.498047704941, 4792.664513484023, 4967.180415231446, 4984.978079493622, 5034.270030845581, 5028.145215313479, 5029.27075574047, 5036.597072234139, 5039.899202016012, 5054.418741844588, 4890.706557606555, 4997.200447928314, 5007.624428167829, 5008.123578373843, 5025.41699364699], "value": 3814.935217762551, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.435860801103, 654.0385633119314, 710.6659869861163, 714.8320144765979, 742.8922806193106, 13133.212007279559, 13676.452941882337, 13679.658008549792, 13686.589402317946, 13688.452461901525, 12928.418221180045, 13801.993554672857, 14592.0, 14598.927005364985, 15117.092974421543, 630.7603110817882, 774.9070111586617, 798.2815466080544, 801.2308184143229, 801.2468279816983, 748.621945917311, 755.5051441305953, 759.1725019728494, 796.8087658961865, 796.9601519923981, 839.0, 839.0644431458941, 840.3991146330403, 841.0916210492653, 843.5529169540154, 650.847050943028, 656.0585559721767, 828.4449418889328, 829.4898637338024, 829.5230242610493, 494.12786431947643, 494.29069285575315, 555.6443875919415, 576.7664096041068, 581.0122791254884, 13353.465861365534, 13383.866161338457, 13406.0, 13430.529931452353, 13487.055906086578, 12675.873241267562, 13439.26084065376, 13464.932675336659, 13577.796333055012, 13955.232462214573, 10036.498175091288, 11443.370614616193, 11855.525778968831, 12007.45966431504, 12236.81644775329, 4321.2005778931, 4335.826566937319, 4376.168527979706, 4401.141777353385, 4474.910501789978, 61680.69159654218, 61916.380836191965, 62539.6873015632, 62546.68726656383, 62677.0, 9968.152707019839, 10118.139958103497, 10183.18534517237, 10373.688789336333, 10602.787944241072, 18946.0, 19173.137208825636, 19173.520661983563, 19192.904035479733, 19207.51981200481, 7301.744438944717, 7308.086489188851, 7328.706851725978, 7338.816529586697, 7347.8530429392185, 3686.7972261525338, 3750.662440380379, 3858.5176852893387, 3885.378339465672, 3962.9405558916637, 2844.8008639395043, 2932.252275669733, 2940.0738767288235, 2942.4262268857797, 2950.5279155335043, 502.09622679177335, 506.42773665758193, 518.5618152660995, 520.5783315514445, 523.2360753300225, 545.5281181777734, 550.3698265485996, 550.4907960136858, 558.2686680448626, 605.452065880379, 8398.454100483448, 8473.49159050459, 8477.788055298666, 8560.571971401405, 9425.104615061558, 600.3096439094988, 624.6064979063252, 634.7619642634012, 636.7548493829909, 647.8288776439397, 4263.488381394252, 4289.378040184156, 4312.7627980461375, 4315.762633055212, 4377.190219809346, 55580.72209639007, 79821.20178798254, 82063.0, 83076.0, 93185.53407233056, 50214.24678629824, 55408.16887746687, 74563.25436745671, 83180.36711891388, 83571.0, 46736.0, 62127.9999999991, 71751.0, 72233.0, 73664.63167684234, 8588.570571471277, 9382.0, 9384.390014649027, 9395.2953528487, 9524.904750952679, 38858.41712374373, 41696.79151604344, 43617.345739813296, 44419.77790111029, 44657.55342446534, 40078.79960600178, 47858.282125767444, 61451.07823382563, 61471.385286148354, 62100.37899620946, 11288.548458061585, 11291.322520648788, 11384.715382115182, 11598.0, 11760.88239117598, 13180.275084870424, 13375.0, 13440.327983600586, 14108.0, 14429.062110962754, 11531.711707207387, 11912.285262884254, 12188.756224875275, 13224.537141200397, 13393.799093013808, 12332.630021099381, 12337.753244935231, 12600.495980160691, 12716.809247861105, 13519.459221631025, 12381.442835072623, 13012.41444135035, 13085.214887106804, 13726.45094196221, 13882.0, 10648.0, 11164.162687798285, 11186.552537898719, 11250.606228781953, 11676.357800321064, 9814.85277720849, 10644.254902156774, 10703.250772445854, 10744.247902646739, 10747.785044298915], "value": 6684.2264589410615, "unit": "score"}], "name": "dromaeo_css", "value": 6473.850563005826, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 112.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 125.0, 175.0, 124.0, 123.0, 149.0, 121.0, 157.0, 123.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 163.0, 161.0, 161.0, 170.0, 162.0, 160.0, 160.0, 167.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 125.0, 77.0, 76.0, 75.0, 75.0, 114.0, 76.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 113.0, 85.0, 85.0, 85.0, 134.0, 84.0, 85.0, 128.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 146.0, 145.0, 147.0, 147.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 66.0, 63.0, 65.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 78.0, 80.0, 85.0, 83.0, 80.0, 79.0, 78.0, 93.0, 83.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 138.0, 135.0, 127.0, 128.0, 128.0, 132.0, 175.0, 151.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 166.0, 164.0, 167.0, 172.0, 164.0, 169.0, 168.0, 170.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 68.0, 68.0, 68.0, 67.0, 67.0, 70.0, 66.0, 65.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1538.1999999999998, "alertThreshold": 2.0}]} 05:39:07 INFO - Return code: 0 05:39:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:39:07 INFO - # TBPL SUCCESS # 05:39:07 INFO - Running post-action listener: _resource_record_post_action 05:39:07 INFO - ##### 05:39:07 INFO - ##### Finished run-tests step (success) 05:39:07 INFO - ##### 05:39:07 INFO - Running post-run listener: _resource_record_post_run 05:39:08 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533942272; Read time: 16; Write time: 430444 05:39:08 INFO - TinderboxPrint: CPU usage
12.9% 05:39:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:39:08 INFO - TinderboxPrint: I/O write bytes / time
533,942,272 / 430,444 05:39:08 INFO - TinderboxPrint: CPU idle
8,330.7 (87.0%) 05:39:08 INFO - TinderboxPrint: CPU user
1,199.3 (12.5%) 05:39:08 INFO - TinderboxPrint: Swap in / out
0 / 0 05:39:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245354496; Read time: 0; Write time: 213952 05:39:08 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288075776; Read time: 0; Write time: 216468 05:39:08 INFO - Running post-run listener: _upload_blobber_files 05:39:08 INFO - Blob upload gear active. 05:39:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:39:08 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 05:39:08 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:39:08 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:39:09 INFO - (blobuploader) - INFO - Open directory for files ... 05:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:39:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:39:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:09 INFO - (blobuploader) - INFO - Done attempting. 05:39:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:39:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:39:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:10 INFO - (blobuploader) - INFO - Done attempting. 05:39:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:39:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:39:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:13 INFO - (blobuploader) - INFO - Done attempting. 05:39:13 INFO - (blobuploader) - INFO - Iteration through files over. 05:39:13 INFO - Return code: 0 05:39:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:39:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:39:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ef9df54eeda7ecfc5fdd886a59215f526e08d443ba19a727ebe9c98a6155e4637e171623269427caaf7a7ebf20f2fc8ae51c64b793708538e4a523dce4f061", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e65d4dfd157e3b6fa9024d7e709cfc6c7692fb18445fa483ffb3cb4ec32fca9e195f9edb407dc5f4e7e1387b3de914016eb9a60df8af13470d103439e2becbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cd9687657191ff7e7b80027845ddfaf43da968e7a632b7c15c30fdcece1f6bb4caf44b28e883980fac9cad30a4cbdfe9352f1a98453624c24d847c710ad5edc"} 05:39:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:39:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:39:13 INFO - Contents: 05:39:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ef9df54eeda7ecfc5fdd886a59215f526e08d443ba19a727ebe9c98a6155e4637e171623269427caaf7a7ebf20f2fc8ae51c64b793708538e4a523dce4f061", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e65d4dfd157e3b6fa9024d7e709cfc6c7692fb18445fa483ffb3cb4ec32fca9e195f9edb407dc5f4e7e1387b3de914016eb9a60df8af13470d103439e2becbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cd9687657191ff7e7b80027845ddfaf43da968e7a632b7c15c30fdcece1f6bb4caf44b28e883980fac9cad30a4cbdfe9352f1a98453624c24d847c710ad5edc"} 05:39:13 INFO - Running post-run listener: copy_logs_to_upload_dir 05:39:13 INFO - Copying logs to upload dir... 05:39:13 INFO - mkdir: /builds/slave/test/build/upload/logs 05:39:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.988378 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-04 05:39:11.966480) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 05:39:11.969791) ========= 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=41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/64ef9df54eeda7ecfc5fdd886a59215f526e08d443ba19a727ebe9c98a6155e4637e171623269427caaf7a7ebf20f2fc8ae51c64b793708538e4a523dce4f061", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e65d4dfd157e3b6fa9024d7e709cfc6c7692fb18445fa483ffb3cb4ec32fca9e195f9edb407dc5f4e7e1387b3de914016eb9a60df8af13470d103439e2becbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cd9687657191ff7e7b80027845ddfaf43da968e7a632b7c15c30fdcece1f6bb4caf44b28e883980fac9cad30a4cbdfe9352f1a98453624c24d847c710ad5edc"} build_url:https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011527 build_url: 'https://queue.taskcluster.net/v1/task/FsG-fWAmQ-SktTel3yvXjQ/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/Firefox-Non-PGO/sha512/64ef9df54eeda7ecfc5fdd886a59215f526e08d443ba19a727ebe9c98a6155e4637e171623269427caaf7a7ebf20f2fc8ae51c64b793708538e4a523dce4f061", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4e65d4dfd157e3b6fa9024d7e709cfc6c7692fb18445fa483ffb3cb4ec32fca9e195f9edb407dc5f4e7e1387b3de914016eb9a60df8af13470d103439e2becbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cd9687657191ff7e7b80027845ddfaf43da968e7a632b7c15c30fdcece1f6bb4caf44b28e883980fac9cad30a4cbdfe9352f1a98453624c24d847c710ad5edc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 05:39:11.996316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:39:11.996691) ========= 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=41bf3e9aed84707956354da8000001c5-1467633710.50943-1530719919 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:39:12.080631) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 05:39:12.080996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 05:39:12.081359) ========= ========= Total master_lag: 0.18 =========