builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1468940458.31 results: success (0) buildid: 20160719072820 builduid: d154aa9f687f457f9fe02d9ab062e41c revision: c0ab769be276bf670f47d77ab470708beba15488 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:58.306311) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:58.306806) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:58.307078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:58.322529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:58.322976) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 08:00:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-07-19 08:00:58 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122701 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:58.460169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:58.460679) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014255 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:58.511420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:58.511775) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c0ab769be276bf670f47d77ab470708beba15488 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c0ab769be276bf670f47d77ab470708beba15488 --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=9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 08:00:58,559 truncating revision to first 12 chars 2016-07-19 08:00:58,559 Setting DEBUG logging. 2016-07-19 08:00:58,559 attempt 1/10 2016-07-19 08:00:58,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c0ab769be276?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 08:00:58,877 unpacking tar archive at: fx-team-c0ab769be276/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661286 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:59.186919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:59.187265) ========= script_repo_revision: c0ab769be276bf670f47d77ab470708beba15488 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:59.187660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:59.187993) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 08:00:59.199135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-19 08:00:59.199479) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:59 INFO - MultiFileLogger online at 20160719 08:00:59 in /builds/slave/test 08:00:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:00:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:00:59 INFO - {'append_to_log': False, 08:00:59 INFO - 'base_work_dir': '/builds/slave/test', 08:00:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:00:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:00:59 INFO - 'branch': 'Fx-Team-Non-PGO', 08:00:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:59 INFO - 'config_files': ('talos/linux_config.py',), 08:00:59 INFO - 'default_actions': ('clobber', 08:00:59 INFO - 'read-buildbot-config', 08:00:59 INFO - 'download-and-extract', 08:00:59 INFO - 'populate-webroot', 08:00:59 INFO - 'create-virtualenv', 08:00:59 INFO - 'install', 08:00:59 INFO - 'run-tests'), 08:00:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:59 INFO - 'download_minidump_stackwalk': True, 08:00:59 INFO - 'download_symbols': 'ondemand', 08:00:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:59 INFO - 'installer_path': 'installer.exe', 08:00:59 INFO - 'log_level': 'info', 08:00:59 INFO - 'log_name': 'talos', 08:00:59 INFO - 'log_to_console': True, 08:00:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:59 INFO - 'opt_config_files': (), 08:00:59 INFO - 'pip_index': False, 08:00:59 INFO - 'sps_profile': False, 08:00:59 INFO - 'sps_profile_interval': 0, 08:00:59 INFO - 'suite': 'dromaeojs', 08:00:59 INFO - 'system_bits': '32', 08:00:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:59 INFO - 'title': 'talos-linux64-ix-022', 08:00:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:59 INFO - 'use_talos_json': True, 08:00:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:00:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:59 INFO - 'work_dir': 'build'} 08:00:59 INFO - ##### 08:00:59 INFO - ##### Running clobber step. 08:00:59 INFO - ##### 08:00:59 INFO - Running pre-action listener: _resource_record_pre_action 08:00:59 INFO - Running main action method: clobber 08:00:59 INFO - rmtree: /builds/slave/test/build 08:00:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:01:00 INFO - Running post-action listener: _resource_record_post_action 08:01:00 INFO - ##### 08:01:00 INFO - ##### Finished clobber step (success) 08:01:00 INFO - ##### 08:01:00 INFO - ##### 08:01:00 INFO - ##### Running read-buildbot-config step. 08:01:00 INFO - ##### 08:01:00 INFO - Running pre-action listener: _resource_record_pre_action 08:01:00 INFO - Running main action method: read_buildbot_config 08:01:00 INFO - Using buildbot properties: 08:01:00 INFO - { 08:01:00 INFO - "project": "", 08:01:00 INFO - "product": "firefox", 08:01:00 INFO - "script_repo_revision": "production", 08:01:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:01:00 INFO - "repository": "", 08:01:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:01:00 INFO - "buildid": "20160719072820", 08:01:00 INFO - "pgo_build": "False", 08:01:00 INFO - "basedir": "/builds/slave/test", 08:01:00 INFO - "buildnumber": 3179, 08:01:00 INFO - "slavename": "talos-linux64-ix-022", 08:01:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:01:00 INFO - "platform": "ubuntu64_hw", 08:01:00 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:01:00 INFO - "branch": "fx-team", 08:01:00 INFO - "repo_path": "integration/fx-team", 08:01:00 INFO - "revision": "c0ab769be276bf670f47d77ab470708beba15488", 08:01:00 INFO - "stage_platform": "linux64", 08:01:00 INFO - "builduid": "d154aa9f687f457f9fe02d9ab062e41c", 08:01:00 INFO - "slavebuilddir": "test" 08:01:00 INFO - } 08:01:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:01:00 INFO - Running post-action listener: _resource_record_post_action 08:01:00 INFO - ##### 08:01:00 INFO - ##### Finished read-buildbot-config step (success) 08:01:00 INFO - ##### 08:01:00 INFO - ##### 08:01:00 INFO - ##### Running download-and-extract step. 08:01:00 INFO - ##### 08:01:00 INFO - Running pre-action listener: _resource_record_pre_action 08:01:00 INFO - Running main action method: download_and_extract 08:01:00 INFO - mkdir: /builds/slave/test/build/tests 08:01: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')]} 08:01:00 INFO - https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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 08:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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 08:01:02 INFO - Downloaded 1361 bytes. 08:01:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:01:02 INFO - Using the following test package requirements: 08:01:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:01:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:01:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:02 INFO - u'jsshell-linux-x86_64.zip'], 08:01:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:01:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:01:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:01:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:01:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:01:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:02 INFO - https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:01:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:01:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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 08:01:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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 08:01:03 INFO - Downloaded 22763363 bytes. 08:01:03 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'] 08:01:03 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 08:01:04 INFO - Return code: 0 08:01:04 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 08:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:04 INFO - https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:01:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:01:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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 08:01:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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 08:01:10 INFO - Downloaded 22763363 bytes. 08:01:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:01:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:01:12 INFO - Return code: 0 08:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:12 INFO - https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:01:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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 08:01:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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 08:01:13 INFO - Downloaded 14403317 bytes. 08:01:13 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'] 08:01:13 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 08:01:13 INFO - Return code: 0 08:01:13 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')]} 08:01:13 INFO - https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:01:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:01:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:01:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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 08:01:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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 08:01:14 INFO - Downloaded 57120542 bytes. 08:01:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:01:14 INFO - mkdir: /builds/slave/test/properties 08:01:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:01:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:01:14 INFO - Contents: 08:01:14 INFO - build_url:https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:01:15 INFO - Running post-action listener: _resource_record_post_action 08:01:15 INFO - Running post-action listener: set_extra_try_arguments 08:01:15 INFO - ##### 08:01:15 INFO - ##### Finished download-and-extract step (success) 08:01:15 INFO - ##### 08:01:15 INFO - ##### 08:01:15 INFO - ##### Running populate-webroot step. 08:01:15 INFO - ##### 08:01:15 INFO - Running pre-action listener: _resource_record_pre_action 08:01:15 INFO - Running main action method: populate_webroot 08:01:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:01:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:01:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:01:15 INFO - '--tppagecycles', 08:01:15 INFO - '7'], 08:01:15 INFO - 'tests': ['tsvgm']}}, 08:01:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:01:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:01:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:01:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:01:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:15 INFO - 'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:15 INFO - 'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['damp', 'tps']}, 08:01:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:15 INFO - 'tests': ['damp', 'tps']}, 08:01:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['dromaeo_dom']}, 08:01:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:01:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['basic_compositor_video']}, 08:01:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:01:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['a11yr', 08:01:15 INFO - 'ts_paint', 08:01:15 INFO - 'tpaint', 08:01:15 INFO - 'sessionrestore', 08:01:15 INFO - 'sessionrestore_no_auto_restore', 08:01:15 INFO - 'tabpaint']}, 08:01:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:01:15 INFO - 'ts_paint', 08:01:15 INFO - 'tpaint', 08:01:15 INFO - 'sessionrestore', 08:01:15 INFO - 'sessionrestore_no_auto_restore', 08:01:15 INFO - 'tabpaint']}, 08:01:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:01:15 INFO - 'ts_paint', 08:01:15 INFO - 'tpaint', 08:01:15 INFO - 'sessionrestore', 08:01:15 INFO - 'sessionrestore_no_auto_restore', 08:01:15 INFO - 'tabpaint']}, 08:01:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:01:15 INFO - 'ts_paint', 08:01:15 INFO - 'tpaint', 08:01:15 INFO - 'sessionrestore', 08:01:15 INFO - 'sessionrestore_no_auto_restore', 08:01:15 INFO - 'tabpaint']}, 08:01:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['a11yr', 08:01:15 INFO - 'ts_paint', 08:01:15 INFO - 'tpaint', 08:01:15 INFO - 'sessionrestore', 08:01:15 INFO - 'sessionrestore_no_auto_restore', 08:01:15 INFO - 'tabpaint']}, 08:01:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['a11yr', 08:01:15 INFO - 'ts_paint', 08:01:15 INFO - 'tpaint', 08:01:15 INFO - 'sessionrestore', 08:01:15 INFO - 'sessionrestore_no_auto_restore', 08:01:15 INFO - 'tabpaint']}, 08:01:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['tsvgx', 08:01:15 INFO - 'tsvgr_opacity', 08:01:15 INFO - 'tart', 08:01:15 INFO - 'tscrollx', 08:01:15 INFO - 'cart']}, 08:01:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:01:15 INFO - 'tsvgr_opacity', 08:01:15 INFO - 'tart', 08:01:15 INFO - 'tscrollx', 08:01:15 INFO - 'cart']}, 08:01:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:15 INFO - 'talos_options': ['--disable-e10s'], 08:01:15 INFO - 'tests': ['tp5o']}, 08:01:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:15 INFO - 'tests': ['tp5o']}, 08:01:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:15 INFO - 'talos_options': ['--disable-e10s', 08:01:15 INFO - '--xperf_path', 08:01:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:15 INFO - 'tests': ['tp5n']}, 08:01:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:15 INFO - 'talos_options': ['--xperf_path', 08:01:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:15 INFO - 'tests': ['tp5n']}}, 08:01:15 INFO - 'talos.zip': {'path': '', 08:01:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:01:15 INFO - Running post-action listener: _resource_record_post_action 08:01:15 INFO - ##### 08:01:15 INFO - ##### Finished populate-webroot step (success) 08:01:15 INFO - ##### 08:01:15 INFO - ##### 08:01:15 INFO - ##### Running create-virtualenv step. 08:01:15 INFO - ##### 08:01:15 INFO - Running pre-action listener: _resource_record_pre_action 08:01:15 INFO - Running main action method: create_virtualenv 08:01:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:01:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:01:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:01:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:01:15 INFO - Using real prefix '/usr' 08:01:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:01:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:01:18 INFO - Installing pip.................done. 08:01:18 INFO - Return code: 0 08:01:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16983b0>, '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 0x16992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1699740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', '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 08:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:01:18 INFO - Using env: {'DISPLAY': ':0', 08:01:18 INFO - 'HOME': '/home/cltbld', 08:01:18 INFO - 'LANG': 'en_US.UTF-8', 08:01:18 INFO - 'LANGUAGE': 'en_US:en', 08:01:18 INFO - 'LOGNAME': 'cltbld', 08:01:18 INFO - 'MAIL': '/var/mail/cltbld', 08:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:18 INFO - 'MOZ_NO_REMOTE': '1', 08:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:18 INFO - 'NO_EM_RESTART': '1', 08:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:18 INFO - 'PWD': '/builds/slave/test', 08:01:18 INFO - 'SHELL': '/bin/bash', 08:01:18 INFO - 'SHLVL': '1', 08:01:18 INFO - 'TERM': 'linux', 08:01:18 INFO - 'TMOUT': '86400', 08:01:18 INFO - 'USER': 'cltbld', 08:01:18 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', 08:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:18 INFO - '_': '/tools/buildbot/bin/python'} 08:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:01:18 INFO - Cleaning up... 08:01:18 INFO - Return code: 0 08:01:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16983b0>, '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 0x16992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1699740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', '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 08:01:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:01:18 INFO - Using env: {'DISPLAY': ':0', 08:01:18 INFO - 'HOME': '/home/cltbld', 08:01:18 INFO - 'LANG': 'en_US.UTF-8', 08:01:18 INFO - 'LANGUAGE': 'en_US:en', 08:01:18 INFO - 'LOGNAME': 'cltbld', 08:01:18 INFO - 'MAIL': '/var/mail/cltbld', 08:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:18 INFO - 'MOZ_NO_REMOTE': '1', 08:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:18 INFO - 'NO_EM_RESTART': '1', 08:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:18 INFO - 'PWD': '/builds/slave/test', 08:01:18 INFO - 'SHELL': '/bin/bash', 08:01:18 INFO - 'SHLVL': '1', 08:01:18 INFO - 'TERM': 'linux', 08:01:18 INFO - 'TMOUT': '86400', 08:01:18 INFO - 'USER': 'cltbld', 08:01:18 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', 08:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:18 INFO - '_': '/tools/buildbot/bin/python'} 08:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:18 INFO - Downloading/unpacking psutil>=3.1.1 08:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:01:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:20 INFO - Installing collected packages: psutil 08:01:20 INFO - Running setup.py install for psutil 08:01:20 INFO - building 'psutil._psutil_linux' extension 08:01:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:01:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:01:20 INFO - building 'psutil._psutil_posix' extension 08:01:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:01:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:01:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:21 INFO - Successfully installed psutil 08:01:21 INFO - Cleaning up... 08:01:21 INFO - Return code: 0 08:01:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:01: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')]} 08:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01: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')]} 08:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16983b0>, '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 0x16992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1699740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', '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 08:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:01:21 INFO - Using env: {'DISPLAY': ':0', 08:01:21 INFO - 'HOME': '/home/cltbld', 08:01:21 INFO - 'LANG': 'en_US.UTF-8', 08:01:21 INFO - 'LANGUAGE': 'en_US:en', 08:01:21 INFO - 'LOGNAME': 'cltbld', 08:01:21 INFO - 'MAIL': '/var/mail/cltbld', 08:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:21 INFO - 'MOZ_NO_REMOTE': '1', 08:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:21 INFO - 'NO_EM_RESTART': '1', 08:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:21 INFO - 'PWD': '/builds/slave/test', 08:01:21 INFO - 'SHELL': '/bin/bash', 08:01:21 INFO - 'SHLVL': '1', 08:01:21 INFO - 'TERM': 'linux', 08:01:21 INFO - 'TMOUT': '86400', 08:01:21 INFO - 'USER': 'cltbld', 08:01:21 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', 08:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:21 INFO - '_': '/tools/buildbot/bin/python'} 08:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:01:23 INFO - Installing collected packages: mozsystemmonitor 08:01:23 INFO - Running setup.py install for mozsystemmonitor 08:01:23 INFO - Successfully installed mozsystemmonitor 08:01:23 INFO - Cleaning up... 08:01:23 INFO - Return code: 0 08:01:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16983b0>, '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 0x16992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1699740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', '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 08:01:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:01:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:01:23 INFO - Using env: {'DISPLAY': ':0', 08:01:23 INFO - 'HOME': '/home/cltbld', 08:01:23 INFO - 'LANG': 'en_US.UTF-8', 08:01:23 INFO - 'LANGUAGE': 'en_US:en', 08:01:23 INFO - 'LOGNAME': 'cltbld', 08:01:23 INFO - 'MAIL': '/var/mail/cltbld', 08:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:23 INFO - 'MOZ_NO_REMOTE': '1', 08:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:23 INFO - 'NO_EM_RESTART': '1', 08:01:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:23 INFO - 'PWD': '/builds/slave/test', 08:01:23 INFO - 'SHELL': '/bin/bash', 08:01:23 INFO - 'SHLVL': '1', 08:01:23 INFO - 'TERM': 'linux', 08:01:23 INFO - 'TMOUT': '86400', 08:01:23 INFO - 'USER': 'cltbld', 08:01:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', 08:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:23 INFO - '_': '/tools/buildbot/bin/python'} 08:01:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:01:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:01:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:01:25 INFO - warning: no files found matching '*.txt' 08:01:25 INFO - no previously-included directories found matching 'build' 08:01:25 INFO - no previously-included directories found matching 'dist' 08:01:25 INFO - no previously-included directories found matching '.git*' 08:01:25 INFO - Installing collected packages: jsonschema, functools32 08:01:25 INFO - Running setup.py install for functools32 08:01:25 INFO - warning: no files found matching '*.txt' 08:01:25 INFO - no previously-included directories found matching 'build' 08:01:25 INFO - no previously-included directories found matching 'dist' 08:01:25 INFO - no previously-included directories found matching '.git*' 08:01:25 INFO - Successfully installed jsonschema functools32 08:01:25 INFO - Cleaning up... 08:01:26 INFO - Return code: 0 08:01:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16983b0>, '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 0x16992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1699740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', '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 08:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:01:26 INFO - Using env: {'DISPLAY': ':0', 08:01:26 INFO - 'HOME': '/home/cltbld', 08:01:26 INFO - 'LANG': 'en_US.UTF-8', 08:01:26 INFO - 'LANGUAGE': 'en_US:en', 08:01:26 INFO - 'LOGNAME': 'cltbld', 08:01:26 INFO - 'MAIL': '/var/mail/cltbld', 08:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:26 INFO - 'MOZ_NO_REMOTE': '1', 08:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:26 INFO - 'NO_EM_RESTART': '1', 08:01:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:26 INFO - 'PWD': '/builds/slave/test', 08:01:26 INFO - 'SHELL': '/bin/bash', 08:01:26 INFO - 'SHLVL': '1', 08:01:26 INFO - 'TERM': 'linux', 08:01:26 INFO - 'TMOUT': '86400', 08:01:26 INFO - 'USER': 'cltbld', 08:01:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', 08:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:26 INFO - '_': '/tools/buildbot/bin/python'} 08:01:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:01:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:01:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:28 INFO - Downloading docopt-0.6.1.tar.gz 08:01:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:01:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:01:28 INFO - Running setup.py install for blobuploader 08:01:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:01:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:01:29 INFO - Running setup.py install for requests 08:01:29 INFO - Running setup.py install for docopt 08:01:29 INFO - Successfully installed blobuploader requests docopt 08:01:29 INFO - Cleaning up... 08:01:29 INFO - Return code: 0 08:01:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16983b0>, '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 0x16992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1699740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', '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 08:01:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:01:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:01:29 INFO - Using env: {'DISPLAY': ':0', 08:01:29 INFO - 'HOME': '/home/cltbld', 08:01:29 INFO - 'LANG': 'en_US.UTF-8', 08:01:29 INFO - 'LANGUAGE': 'en_US:en', 08:01:29 INFO - 'LOGNAME': 'cltbld', 08:01:29 INFO - 'MAIL': '/var/mail/cltbld', 08:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:29 INFO - 'MOZ_NO_REMOTE': '1', 08:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:29 INFO - 'NO_EM_RESTART': '1', 08:01:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:29 INFO - 'PWD': '/builds/slave/test', 08:01:29 INFO - 'SHELL': '/bin/bash', 08:01:29 INFO - 'SHLVL': '1', 08:01:29 INFO - 'TERM': 'linux', 08:01:29 INFO - 'TMOUT': '86400', 08:01:29 INFO - 'USER': 'cltbld', 08:01:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', 08:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:29 INFO - '_': '/tools/buildbot/bin/python'} 08:01:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:29 INFO - Running setup.py (path:/tmp/pip-G2SDVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:29 INFO - Running setup.py (path:/tmp/pip-zwMD2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:29 INFO - Running setup.py (path:/tmp/pip-OjMikU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:29 INFO - Running setup.py (path:/tmp/pip-1iJw3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:30 INFO - Running setup.py (path:/tmp/pip-D6r6ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:30 INFO - Running setup.py (path:/tmp/pip-ePCJPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:30 INFO - Running setup.py (path:/tmp/pip-jkS634-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:30 INFO - Running setup.py (path:/tmp/pip-8HEYZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:30 INFO - Running setup.py (path:/tmp/pip-wb4LSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:30 INFO - Running setup.py (path:/tmp/pip-FCWYjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:30 INFO - Running setup.py (path:/tmp/pip-fdGhPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:30 INFO - Running setup.py (path:/tmp/pip-lqTpQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:30 INFO - Running setup.py (path:/tmp/pip-LmJ4z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:30 INFO - Running setup.py (path:/tmp/pip-ECKvDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:30 INFO - Running setup.py (path:/tmp/pip-rstycc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:30 INFO - Running setup.py (path:/tmp/pip-M3gw8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:30 INFO - Running setup.py (path:/tmp/pip-W1YgX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:01:30 INFO - Running setup.py install for manifestparser 08:01:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:01:31 INFO - Running setup.py install for mozcrash 08:01:31 INFO - Running setup.py install for mozdebug 08:01:31 INFO - Running setup.py install for mozdevice 08:01:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:01:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:01:31 INFO - Running setup.py install for mozfile 08:01:31 INFO - Running setup.py install for mozhttpd 08:01:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:01:31 INFO - Running setup.py install for mozinfo 08:01:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:01:31 INFO - Running setup.py install for mozInstall 08:01:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:01:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:01:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:01:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:01:31 INFO - Running setup.py install for mozleak 08:01:31 INFO - Running setup.py install for mozlog 08:01:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:01:31 INFO - Running setup.py install for moznetwork 08:01:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:01:32 INFO - Running setup.py install for mozprocess 08:01:32 INFO - Running setup.py install for mozprofile 08:01:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:01:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:01:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:01:32 INFO - Running setup.py install for mozrunner 08:01:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:01:32 INFO - Running setup.py install for mozscreenshot 08:01:32 INFO - Running setup.py install for moztest 08:01:32 INFO - Running setup.py install for mozversion 08:01:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:01:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:01:32 INFO - Cleaning up... 08:01:32 INFO - Return code: 0 08:01:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16983b0>, '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 0x16992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1699740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', '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 08:01:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:01:32 INFO - Using env: {'DISPLAY': ':0', 08:01:32 INFO - 'HOME': '/home/cltbld', 08:01:32 INFO - 'LANG': 'en_US.UTF-8', 08:01:32 INFO - 'LANGUAGE': 'en_US:en', 08:01:32 INFO - 'LOGNAME': 'cltbld', 08:01:32 INFO - 'MAIL': '/var/mail/cltbld', 08:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:32 INFO - 'MOZ_NO_REMOTE': '1', 08:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:32 INFO - 'NO_EM_RESTART': '1', 08:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:32 INFO - 'PWD': '/builds/slave/test', 08:01:32 INFO - 'SHELL': '/bin/bash', 08:01:32 INFO - 'SHLVL': '1', 08:01:32 INFO - 'TERM': 'linux', 08:01:32 INFO - 'TMOUT': '86400', 08:01:32 INFO - 'USER': 'cltbld', 08:01:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', 08:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:32 INFO - '_': '/tools/buildbot/bin/python'} 08:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:01:32 INFO - Running setup.py (path:/tmp/pip-0UPxcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:01:33 INFO - Running setup.py (path:/tmp/pip-p2lEyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:01:33 INFO - Running setup.py (path:/tmp/pip-uuMUIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:01:33 INFO - Running setup.py (path:/tmp/pip-Lt87ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:01:33 INFO - Running setup.py (path:/tmp/pip-2xfmzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:01:33 INFO - Running setup.py (path:/tmp/pip-JElU1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:01:33 INFO - Running setup.py (path:/tmp/pip-wiAN9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:01:33 INFO - Running setup.py (path:/tmp/pip-LCshk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:01:33 INFO - Running setup.py (path:/tmp/pip-eds_jV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:01:33 INFO - Running setup.py (path:/tmp/pip-5jLYf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:01:33 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)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:01:33 INFO - Running setup.py (path:/tmp/pip-eEvWu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:01:33 INFO - Running setup.py (path:/tmp/pip-rs6JHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:01:33 INFO - Running setup.py (path:/tmp/pip-77G3lX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:01:33 INFO - Running setup.py (path:/tmp/pip-1H56Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:01:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:01:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:33 INFO - Running setup.py (path:/tmp/pip-merV5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:01:34 INFO - Running setup.py (path:/tmp/pip-G39jXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:01:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:01:34 INFO - Running setup.py (path:/tmp/pip-IXflN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:01:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:01:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:01:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:01:36 INFO - Downloading blessings-1.6.tar.gz 08:01:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:01:36 INFO - Installing collected packages: blessings 08:01:36 INFO - Running setup.py install for blessings 08:01:36 INFO - Successfully installed blessings 08:01:36 INFO - Cleaning up... 08:01:36 INFO - Return code: 0 08:01:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:01:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:36 INFO - Reading from file tmpfile_stdout 08:01:36 INFO - Current package versions: 08:01:36 INFO - argparse == 1.2.1 08:01:36 INFO - blessings == 1.6 08:01:36 INFO - blobuploader == 1.2.4 08:01:36 INFO - docopt == 0.6.1 08:01:36 INFO - functools32 == 3.2.3-2 08:01:36 INFO - jsonschema == 2.5.1 08:01:36 INFO - manifestparser == 1.1 08:01:36 INFO - mozInstall == 1.12 08:01:36 INFO - mozcrash == 0.17 08:01:36 INFO - mozdebug == 0.1 08:01:36 INFO - mozdevice == 0.48 08:01:36 INFO - mozfile == 1.2 08:01:36 INFO - mozhttpd == 0.7 08:01:36 INFO - mozinfo == 0.9 08:01:36 INFO - mozleak == 0.1 08:01:36 INFO - mozlog == 3.2 08:01:36 INFO - moznetwork == 0.27 08:01:36 INFO - mozprocess == 0.23 08:01:36 INFO - mozprofile == 0.28 08:01:36 INFO - mozrunner == 6.12 08:01:36 INFO - mozscreenshot == 0.1 08:01:36 INFO - mozsystemmonitor == 0.3 08:01:36 INFO - moztest == 0.7 08:01:36 INFO - mozversion == 1.4 08:01:36 INFO - psutil == 3.1.1 08:01:36 INFO - requests == 1.2.3 08:01:36 INFO - wsgiref == 0.1.2 08:01:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16983b0>, '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 0x16992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1699740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', '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 08:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:01:36 INFO - Using env: {'DISPLAY': ':0', 08:01:36 INFO - 'HOME': '/home/cltbld', 08:01:36 INFO - 'LANG': 'en_US.UTF-8', 08:01:36 INFO - 'LANGUAGE': 'en_US:en', 08:01:36 INFO - 'LOGNAME': 'cltbld', 08:01:36 INFO - 'MAIL': '/var/mail/cltbld', 08:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:36 INFO - 'MOZ_NO_REMOTE': '1', 08:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:36 INFO - 'NO_EM_RESTART': '1', 08:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:36 INFO - 'PWD': '/builds/slave/test', 08:01:36 INFO - 'SHELL': '/bin/bash', 08:01:36 INFO - 'SHLVL': '1', 08:01:36 INFO - 'TERM': 'linux', 08:01:36 INFO - 'TMOUT': '86400', 08:01:36 INFO - 'USER': 'cltbld', 08:01:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', 08:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:36 INFO - '_': '/tools/buildbot/bin/python'} 08:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:01:36 INFO - Cleaning up... 08:01:36 INFO - Return code: 0 08:01:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x169a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16983b0>, '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 0x16992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1699740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', '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 08:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:01:36 INFO - Using env: {'DISPLAY': ':0', 08:01:36 INFO - 'HOME': '/home/cltbld', 08:01:36 INFO - 'LANG': 'en_US.UTF-8', 08:01:36 INFO - 'LANGUAGE': 'en_US:en', 08:01:36 INFO - 'LOGNAME': 'cltbld', 08:01:36 INFO - 'MAIL': '/var/mail/cltbld', 08:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:36 INFO - 'MOZ_NO_REMOTE': '1', 08:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:36 INFO - 'NO_EM_RESTART': '1', 08:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:36 INFO - 'PWD': '/builds/slave/test', 08:01:36 INFO - 'SHELL': '/bin/bash', 08:01:36 INFO - 'SHLVL': '1', 08:01:36 INFO - 'TERM': 'linux', 08:01:36 INFO - 'TMOUT': '86400', 08:01:36 INFO - 'USER': 'cltbld', 08:01:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', 08:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:36 INFO - '_': '/tools/buildbot/bin/python'} 08:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:01:36 INFO - Cleaning up... 08:01:36 INFO - Return code: 0 08:01:36 INFO - Running post-action listener: _resource_record_post_action 08:01:36 INFO - Running post-action listener: _start_resource_monitoring 08:01:37 INFO - Starting resource monitoring. 08:01:37 INFO - ##### 08:01:37 INFO - ##### Finished create-virtualenv step (success) 08:01:37 INFO - ##### 08:01:37 INFO - ##### 08:01:37 INFO - ##### Running install step. 08:01:37 INFO - ##### 08:01:37 INFO - Running pre-action listener: _resource_record_pre_action 08:01:37 INFO - Running main action method: install 08:01:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:01:37 INFO - Reading from file tmpfile_stdout 08:01:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:01:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:01:37 INFO - Reading from file tmpfile_stdout 08:01:37 INFO - Output received: 08:01:37 INFO - Usage: mozinstall [options] installer 08:01:37 INFO - Options: 08:01:37 INFO - -h, --help show this help message and exit 08:01:37 INFO - -d DEST, --destination=DEST 08:01:37 INFO - Directory to install application into. [default: 08:01:37 INFO - "/builds/slave/test"] 08:01:37 INFO - --app=APP Application being installed. [default: firefox] 08:01:37 INFO - mkdir: /builds/slave/test/build/application 08:01:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:01:53 INFO - Reading from file tmpfile_stdout 08:01:53 INFO - Output received: 08:01:53 INFO - /builds/slave/test/build/application/firefox/firefox 08:01:53 INFO - Running post-action listener: _resource_record_post_action 08:01:53 INFO - ##### 08:01:53 INFO - ##### Finished install step (success) 08:01:53 INFO - ##### 08:01:53 INFO - ##### 08:01:53 INFO - ##### Running run-tests step. 08:01:53 INFO - ##### 08:01:53 INFO - Running pre-action listener: _resource_record_pre_action 08:01:53 INFO - Running main action method: run_tests 08:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:01:53 INFO - Python 2.7.3 08:01:53 INFO - Return code: 0 08:01:53 INFO - grabbing minidump binary from tooltool 08:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16983b0>, '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 0x16992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1699740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:01:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:01:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:01:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:01:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:01:53 INFO - Return code: 0 08:01:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:01:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:01:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:01:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:01:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 08:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 08:01:53 INFO - Using env: {'DISPLAY': ':0', 08:01:53 INFO - 'HOME': '/home/cltbld', 08:01:53 INFO - 'LANG': 'en_US.UTF-8', 08:01:53 INFO - 'LANGUAGE': 'en_US:en', 08:01:53 INFO - 'LOGNAME': 'cltbld', 08:01:53 INFO - 'MAIL': '/var/mail/cltbld', 08:01:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:01:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:53 INFO - 'MOZ_NO_REMOTE': '1', 08:01:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:53 INFO - 'NO_EM_RESTART': '1', 08:01:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:53 INFO - 'PWD': '/builds/slave/test', 08:01:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:01:53 INFO - 'SHELL': '/bin/bash', 08:01:53 INFO - 'SHLVL': '1', 08:01:53 INFO - 'TERM': 'linux', 08:01:53 INFO - 'TMOUT': '86400', 08:01:53 INFO - 'USER': 'cltbld', 08:01:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392', 08:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:53 INFO - '_': '/tools/buildbot/bin/python'} 08:01:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 08:01:53 INFO - mozversion application_buildid: 20160719072820 08:01:53 INFO - mozversion application_changeset: c0ab769be276bf670f47d77ab470708beba15488 08:01:53 INFO - mozversion application_display_name: Nightly 08:01:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:01:53 INFO - mozversion application_name: Firefox 08:01:53 INFO - mozversion application_remotingname: firefox 08:01:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:01:53 INFO - mozversion application_vendor: Mozilla 08:01:53 INFO - mozversion application_version: 50.0a1 08:01:53 INFO - mozversion platform_buildid: 20160719072820 08:01:53 INFO - mozversion platform_changeset: c0ab769be276bf670f47d77ab470708beba15488 08:01:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:01:53 INFO - mozversion platform_version: 50.0a1 08:01:53 INFO - using testdate: 1468940513 08:01:53 INFO - actual date: 1468940513 08:01:53 INFO - starting webserver on 'localhost:37196' 08:01:53 INFO - SUITE-START | Running 2 tests 08:01:53 INFO - TEST-START | dromaeo_css 08:01:53 INFO - operating with platform_type : linux_ 08:01:53 INFO - Initialising browser for dromaeo_css test... 08:01:53 INFO - TEST-INFO | started process 26011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeGspec/profile http://localhost:37196/getInfo.html) 08:01:58 INFO - PROCESS | 26011 | __metrics Screen width/height:1600/1200 08:01:58 INFO - PROCESS | 26011 | colorDepth:24 08:01:58 INFO - PROCESS | 26011 | Browser inner width/height: 1024/697 08:01:58 INFO - PROCESS | 26011 | __metrics 08:01:59 INFO - PROCESS | 26011 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:01:59 INFO - PROCESS | 26011 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:02:00 INFO - TEST-INFO | 26011: exit 0 08:02:00 INFO - Browser initialized. 08:02:00 INFO - Running cycle 1/1 for dromaeo_css test... 08:02:00 INFO - TEST-INFO | started process 26091 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeGspec/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:12 INFO - PROCESS | 26091 | RSS: Main: 159166464 08:02:12 INFO - PROCESS | 26091 | 08:03:03 INFO - PROCESS | 26091 | 1468940583440 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] 08:05:16 INFO - PROCESS | 26091 | Cycle 1(1): loaded http://localhost:37196/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37196/tests/dromaeo/cssquery-ext.html) 08:05:17 INFO - PROCESS | 26091 | RSS: Main: 247373824 08:05:17 INFO - PROCESS | 26091 | 08:08:19 INFO - PROCESS | 26091 | Cycle 1(1): loaded http://localhost:37196/tests/dromaeo/cssquery-ext.html (next: http://localhost:37196/tests/dromaeo/cssquery-jquery.html) 08:08:20 INFO - PROCESS | 26091 | RSS: Main: 249229312 08:08:20 INFO - PROCESS | 26091 | 08:11:22 INFO - PROCESS | 26091 | Cycle 1(1): loaded http://localhost:37196/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37196/tests/dromaeo/cssquery-mootools.html) 08:11:23 INFO - PROCESS | 26091 | RSS: Main: 240529408 08:11:23 INFO - PROCESS | 26091 | 08:14:25 INFO - PROCESS | 26091 | Cycle 1(1): loaded http://localhost:37196/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37196/tests/dromaeo/cssquery-prototype.html) 08:14:25 INFO - PROCESS | 26091 | RSS: Main: 240111616 08:14:25 INFO - PROCESS | 26091 | 08:17:28 INFO - PROCESS | 26091 | Cycle 1(1): loaded http://localhost:37196/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37196/tests/dromaeo/cssquery-yui.html) 08:17:29 INFO - PROCESS | 26091 | RSS: Main: 216817664 08:17:29 INFO - PROCESS | 26091 | 08:20:32 INFO - PROCESS | 26091 | Cycle 1(1): loaded http://localhost:37196/tests/dromaeo/cssquery-yui.html (next: http://localhost:37196/tests/dromaeo/cssquery-dojo.html) 08:20:32 INFO - PROCESS | 26091 | RSS: Main: 279924736 08:20:32 INFO - PROCESS | 26091 | 08:20:32 INFO - PROCESS | 26091 | __start_tp_report 08:20:32 INFO - PROCESS | 26091 | _x_x_mozilla_page_load 08:20:32 INFO - PROCESS | 26091 | _x_x_mozilla_page_load_details 08:20:32 INFO - PROCESS | 26091 | |i|pagename|runs| 08:20:32 INFO - PROCESS | 26091 | |0;dojo.html;2639.604059391091;2647.655804745385;2650.1387049209006;2686.3149896776317;2695.083671551672;4598.563136502035;4664.463586687523;4702.694324868886;4738.763061846907;4797.040591881624;4656.8602941911795;4706.199946009178;4712.057588482308;4712.90574188516;4716.787744551495;4293.8711838644895;4313.503947046099;4387.451568553931;4411.073674528353;4516.345129956155;4441.200583894898;4463.308187230984;4463.33050042493;4488.618467430272;4513.977430112845;4269.914601707948;4289.2922667759785;4297.140571885604;4306.289462238727;4329.177456283328;4242.957570424287;4254.149170165979;4256.87229383119;4302.397664326997;4345.239583072981;4278.7860606969525;4290.14197160566;4293.978530107361;4333.4799824021;4339.414179085846;4518.638508919312;4644.767761611906;4676.836310729108;4702.130105930414;4720.457147428056;5093.312402825608;5130.281760553526;5156.458571849977;5175.404828444739;5177.637565370425;5184.274201611777;5191.922121168185;5193.792248310063;5208.401033881077;5208.843734687927;4663.440387153495;4692.155412025868;4734.28985652148;4812.422509298906;4850.708957462563;5149.201873709581;5225.817096401608;5230.34620672416;5231.372235331784;5237.895242095213;4962.7022378656675;4970.602351811846;5008.273800298936;5019.6737212081825;5029.2958985742025;4857.562819346276;4887.413510378778;4923.433805112386;4938.678985865908;5089.643724939293;4896.730679812573;4901.166801643729;4923.556879880756;4925.187344088257;4968.652194346433;4888.413390393175;4901.730404827697;4903.362562866804;4906.582940450102;4943.209086546135;4201.2017716633745;4226.4716910386205;4229.942514371407;4273.87178384649;4281.12236991416;3775.8300876460626;3790;3800.6959443244473;3801.7718936863876;3802.068493219124;4263.317869140985;4332.805023773938;4337.240982827992;4375.387445757597;4414.1171765647;5088.77100530477;5099.209622508517;5106.208537676666;5119.0529751996;5149.845504634867;4377.474703035656;4381.38660587518;4396.670249731219;4410.933835992462;4438.755868427267;4462.732236065846;4539.0694907543875;4584.426946631671;4601.3558101865765;4604.562566556172;4802.351682522884;4805.111054454937;4812.470628230892;4814.855554333376;4872.902541949212;5040;5087.796488140581;5098.286239926488;5105.259737337991;5107.616928730435;4666.650001249987;4730.97634511839;4766.046790641816;4787.40157480315;4791.353167322367;4933.9013219736125;4950.950490495193;4953.455119936876;4971.8011279549855;5002.2496625506465;4828.975855120702;5023.296738456546;5046.3439752833365;5048.924266136084;5095.286659867547;4876.244182151772;4890.413150421972;4919.3604831371695;4925.852224433273;4937.8271760488215;4919.778609962632;4928.8767780805765;4939.382577177853;4942.406911170682;4996.050750357421;4749.952500474951;4854.344663470528;4860.416749990024;4882.072406242803;4911.950880491149;4965.826196083264;5005.874853128701;5030.320906677698;5031.094403007347;5081.18701007837;4913.263010548446;4915.582175514978;4920.803167873245;4923.0646177227645;4964 08:20:32 INFO - PROCESS | 26091 | |1;ext.html;558.5504286494572;570.2899889637399;583.8131797824697;587.2805812879221;596.7851573433564;26284.4743105138;37320;38059.429108563396;38172.99999999996;38196.42705359422;39648.801755991255;40149.79925100371;40158.79920600393;40202.59797402025;40215;7749.612519374037;7890.368770498375;7890.960545197295;7896.486728362666;7897.842043159133;7777;7878.251566101211;7881.684732610689;7886;7886.802829929269;7906.762797116067;7938.6824527019135;7942.848286998382;7944.165862584432;7959.920400795976;7847.6468558914985;7866.724664636738;7905.802354941173;7913.366930645535;7918.802029949268;7764.262395072459;7839.686412543491;7842.451028428012;7844.529328240324;7850.018747656543;36765.264694706224;36824.44763328552;36939.4459083114;36962.81518592417;37194.44208336877;3023.516237402005;3173.4446471867564;3175.904722858318;3323.4350160472536;3443.724502039831;28221.576676349872;28467.857660711772;28714.569281460794;29156.562651560245;29426.70573294261;3513.5608048993877;3562.8040457774814;3563;3581.659742324501;3641.417373220272;257476;257631.99999999814;258333;258706;259054;51095;51521;51523.16622585719;51605.741971289906;51649;32609.88035777667;33540.32919341599;33657.32685346328;35378;35529.46705799415;14482;14533.491327803476;14594.927025364805;14608.415663373346;14616.488422905148;11612.76774464506;11749.060075193964;11769.352685602375;11769.941150294193;11778.823317650242;18218.45344639663;18492.815071849378;18502.537436564195;18534.907325463555;18571.628567428575;6696;6728.495362847806;6916.930830691729;7047.788566343018;7051.259617740166;784.3411534311092;861.1775754154767;891.7458524320538;936.8126374725082;1011.2264117949775;26331.736682632927;26553.734462655128;26687.19938401851;26874.865625671748;26921.326966825985;759.783461713409;902.228594551662;928.1924725488868;937.9390339627903;1077.6389909380446;14130.85869141316;14460.493882714054;14558.708825823423;14663.780043299359;14764.40942362315;369764;369792;373634;374167;375292.9765618744;44238;45755;45765.77117114393;45932;45966.310505342444;1075.6504136155625;1164.778692048525;1166.7783121206944;1209.8608660004036;1211.8121691138065;27150.45699085968;27557;27684.584731228646;28239;28612.141635750962;37974.62025379711;38178.80910595429;38521.807390962866;38589.80705096456;38621.80689096537;292561;294982;295160;295738;296816;21861.672074919206;24005.51988960176;24718.505629886942;24745.62881556742;26112.73887261103;39547.2090558193;39556.80221598873;40290.798546007085;41030.38454423246;41194.38208426816;34688.29548290492;35258;35441.82279088588;35614.28771424505;35663.10842228965;35233.82383088171;35349.29301414009;35371.29257414889;35802.820985894905;35930;33909;34514.48228276628;34590.48114278237;34832.47751283783;34906.65093349034;31003.68996310008;31552.564307397275;31921.521177182825;32127.67872321247;32422.83788581042;24195.879020605487;24288.757112428648;24419.26742197666;24842.254732357334;24868.37829054288 08:20:32 INFO - PROCESS | 26091 | |2;jquery.html;345.62672313900987;363.84900266389434;367.28746232309317;372.35210733324016;388.1790014120135;13155.342232888353;16031.67936641268;16710.415135470263;17624.911875440637;17626.559336016573;16309.429169979023;16721.414750483735;16968.575785605368;17048.318067277294;17336.393226237084;4473.373727678128;5056.443791182967;5346.4118946915805;5353.518183363496;5360.463953604628;5245.816396426126;5301.602379821509;5303.416624171338;5317.973410132944;5323;5292.735363231843;5304.098303288451;5595.720213989304;5599.1041433370665;5674.829755107354;5418.591166296752;5604.831855044335;5614.550835933136;5615.157726341041;5619.325680918275;5370;5392.352917649907;5400.135978243501;5400.648957817769;5403.891922161574;12156.635300940987;12180.512779488898;12206.328651924141;12336.568220112344;12564.874351256462;1845.5293900055399;1917.51103468616;1923.422973108062;1936.8160024797621;2228.0864845413466;8778.692745753931;8888.688895888678;8932.240759535447;9093.863592046124;9420.43477391352;1721.6470623522148;1779.9272074587452;1788.8211178882007;1813.6554054729559;1831.7527133837027;56012.439875601536;56455;67537;67677.66161169163;68529.65735171293;8783.560821958876;9254.305927055499;9562.66530671437;9820;10065.69802905914;12269.141160118706;13038.41327140281;13056.543020994219;13432.664183395493;13456.730865382637;6666.866662666719;6715.328467153246;6745.59526428406;7067.5052746307265;7085.185203701641;6297.748090076438;6338.683065846782;6380.425761681471;6384.936150638527;6667;4282.186384586918;4299.763513006815;4334.28484300087;4344.087741574304;4388;1824.5985883105695;1826.936057238017;1836.823364313293;1839.9356022539414;1902.7145928110895;808.333125171724;840.0717207485762;858.5578427110044;859.7592674051276;883.4566741453959;16507.91746041286;16729.83270167307;16902.40841570539;17008.914955425145;17456.5635859102;811.1645005644195;854.1885209051426;878.8989266234337;879.4064006795387;922.0733163171104;6592.736290548421;9185.770355741026;9300;9318.939356250907;9324.533773311307;285845;288869;289259;409026;412971;75327.62336188393;82387.5880620605;83699;85010.57494712487;85150.57424712837;896.2023798819056;907.5190149220923;934.4720233068294;937.2970272295778;941.5257699090334;15206.08763474195;15490.302936368116;15799.842001579837;15987.600309992344;16113.838861611233;28768;35196.12009699778;37017;37437.62562374341;39229.215415692095;48911;52194.21708674449;52311.215331769294;52333.21500177577;52575.47424525706;7150.213476517683;7182.676779544829;7254.129504459499;7309.122905251404;7327.596982166032;10126.493675316353;11532.769344612892;11659.591914282959;11716.648500544998;11767.352795596324;9754.122129008423;9807.313488055768;10218.642347517802;10238.795224095626;10765.569377224823;10073.899261007296;10078.8488172676;10250.846237306298;10261.692149235534;10404.68785936423;9638.373505722106;9640.903590964;9807.21542276602;10020.94989525077;10398.116160126474;7481.326680598772;7537.773866784005;7552.093748750185;7554.848903021799;7667.693292268247;7840.3335716464735;10045.146162576262;10120.696379108638;10257.846132307872;10296.691099267035 08:20:32 INFO - PROCESS | 26091 | |3;mootools.html;1288.613415975207;1386.9930650346746;1433.0613448191434;1513.7199618070658;1719.6818588561116;6680.532362734611;7214.170370407404;7440.702371905131;7457;7457.66440510177;7234.96382518088;7446.664900079496;7453.440991925614;7635.847283054336;7649.196834332384;2122.8407869409816;2172.0877231562704;2173.250228671106;2175.0647221694667;2179.7929196726286;2117.68234764785;2134.8505604607685;2164.967525487119;2168.3061420345416;2170.251263314154;2135.765065842756;2143.8284937204985;2150.5376344086017;2153.946151346221;2215.8338124640636;2134.7331583552054;2142.892855357226;2143.6709240270975;2147.8389120815846;2148.98925505373;2057.341650671786;2118.7075883710922;2127.6276651586063;2127.8722277193115;2128.98935505323;7485.663145158426;7658;7759.30166285037;7763.2236776321915;7769.3784497240085;4363.585459381354;4483.955160448419;4502.8874278142985;4504.459464864204;4516.164509565708;2760.875760590758;2832.7025662305573;2851.2729254040087;2859;2865.799394042418;933.5145724223433;936.1621348892771;938.3197182043033;941.6798288581847;960.1214888377126;10303.587856485732;10519.316244444086;10543.36739795607;10544.261901666887;10554.050135487767;4147.605977432139;4254.319308910622;4402.9559704402545;4411.580899814512;4420.204363214588;9081.727548173565;9130.543472826332;9148.8627670585;9151.405158664798;9165.083491650916;4782.665213435096;4795.352627395327;4796.472388037313;4797.808087676523;4798.616110711135;3632.6730594246646;3915.5105611798526;4368.213721530155;4380.868573942723;4383.7588932609015;3739.6821270191795;3783.9243215135543;3818.198178382571;3849.6920246380223;3877.2051729395407;1148.8161894096904;1240.7332423528985;1252.655519732081;1256.2525297448003;1272.166730791333;718.597585352194;803.1406395157126;851.7402192331275;881.7046289492963;884.0893879304198;5365.463453654604;5399.163129714901;5432.130859062531;5655.095184770417;5693.089105743061;396.5558574396694;397.5547386926603;419.2976763920482;419.7817135089736;426.31789137379945;3534.54050973377;3648.5074514940675;3742.7754334740002;3749.9812500937865;3758.1919887224376;9209.355345125778;9558.713238602853;9662.178714809179;9694.079062489052;9694.9030509694;9571.234301255883;9586.137247647745;9591.712248632552;9605.18355939753;9617.71146865595;7054.506184567031;7086.078809754699;7097.148342198866;7108.218096009331;7152.17749958751;5335.119705248746;5348.545373643284;5354.625176237626;5368.8389348319615;5548.334199896039;8645.827083458422;8908.73273801787;8923.330750193632;8991;8995.77510562215;8950.373473857027;9067.68263110788;9127.954360228156;9128.132827381389;9172.724818255463;6641.302663220292;6662.267150613332;6666.699998499982;6678.766243181465;6706.597604143767;7295.8540829184185;7425.665845036879;7432.922226277052;7456.067991501062;7460.4031677466755;6565.310642382672;6615.867682646224;6648.5346025777735;6682.599044057372;6735.696893639896;6567.671616419256;6577.704003319766;6620.073189753342;6670;6769.627670477974;6195;6214.689265536796;6245.500359971101;6247.718852651551;6248.875022499616;4594.747288899142;4628.583427491542;4641.419822522184;4681.321208424692;4799.184138696361;4590.862274131781;4607.815687372467;4608.539146085499;4662.650301227353;4676.275177347517 08:20:32 INFO - PROCESS | 26091 | |4;prototype.html;286.1955371383428;292.3349380160136;294.67291306649616;308.3693846084756;308.79310861722644;4701.788419521121;4705.905881882364;4724.551167639069;4733.526647335265;4740.644451666126;4642.698224615406;4686.1799185142545;4700.36545066416;4715.1512727709;4716.622670186385;3560.3413368526903;3669.2111196092833;3674.963250367502;3696.5009723687363;3705.666490015898;3669.5779985301765;3706.9620506258293;3763.56718977317;3797.563280222782;3803.296390167814;3687.0966613179808;3689.981550092246;3723.5531736191697;3744.7753134811996;3750.818492174956;3569.803660798655;3733.5519737631384;3733.7386382953205;3744.812759362021;3756.136088699601;3314.303996160809;3319.850606722703;3332.2502436951736;3340.365330587181;3350.2294472271515;4582.541745825424;4620.561046700558;4622.14490319292;4626.653001024903;4665.696729712592;4136.669066474675;4261.190373828994;4268.679849011305;4288.24955632763;4312.935305970413;4903.901921961541;4921.360223171001;4930.605551555867;4933.580645645125;4941.407031156285;3626.34725749365;3642.562892452923;3657.579378371468;3664.8534058637624;3671.834767435472;5061.544460998491;5135.974320128413;5164.173732202829;5164.612654050924;5188.9503646059975;3720.6465385788306;3732.4401339799247;3738.7662071516334;3746.213295208037;3746.925061498755;3724.404095344732;3781.9432708509394;3788.3749181384765;3808.961910380916;3813.56144043433;4313;4314;4321.503027151855;4325.718828276152;4330.155619654201;4810.903781924342;4910.926336104962;4940.184869496493;4948.158813001798;4966.850994470172;1319.3535167767916;1322.7420652972578;1323.3184909771476;1326.2639235224542;1331.8202042724108;851.9105493923173;852.5098068610574;861.2421069458961;882.6381183714647;891.790429249126;4266.658667306608;4361.193179261783;4374.956250437519;4408.889777755518;4410.610657642832;5080.491950804964;5083.491650834961;5090.160123579642;5102.719350435687;5116.258142569307;4379.510966271483;4387.298032314879;4392.2094023075515;4397.692161548661;4412.360207769855;2553.234029791055;2704.8647567621542;2711.3899372641;2713.8371697698203;2719.904803331874;4793.736344501016;4803.879903002453;4805.063012712558;4805.423349198119;4820.30105634681;4972.975135124301;5171.663841850343;5193.714345710947;5207.947920520746;5213.504717051874;4767.785449654704;4771.6898401603785;4773.63704966044;4796.424429068465;4802.6072438992305;5012.1980483122525;5059.380998080579;5071.568916642127;5076.416212135504;5118.232265160255;4724.291356296583;4961.841598904488;4963.305137280711;4966.367825052728;4982.252662100569;4777.4267087949665;4778.235482322812;4783.7129772213775;4789.592884604847;4789.736564488987;3710.6845918096183;3727.3849814781343;3736.9439458408688;3740.270647223765;3747.9063023424633;4992.475790042138;5017.799288028438;5027.32131162303;5044.470330615232;5079.263506791421;4702.717836929658;4886.828960986349;4909.1654418748185;4925.847457627193;4929.408470983505;4890.315355850113;4905.068037072945;4909.723471897404;4930.8767280818265;4947;4874.439439464507;4875.731834749123;4876.683015603974;4877.6829506081995;4878.902421951612;4695.976520117378;4961.603071754179;4975.800967961386;5007.624428167829;5009.298698182331;4869.537393947569;4879;4880.194767863263;4887.60899128076;4891 08:20:32 INFO - PROCESS | 26091 | |5;yui.html;612.8100288910438;614.2751553167262;672.5762769455246;677.7864972533652;719.3274288540218;12495.500179992801;13540.864591354084;13594.252316122622;13604.183748975069;13625.318734063294;13111.54109606164;13310.26793526358;13317.53388631398;13318.267495287755;13323.200607963505;613.4141894490773;743.7545609948704;748.9363404110644;764.9349805266559;767.1829501580827;754.7697952124599;756.6519401075512;758.6548120605112;760.9277118673717;761.4669731188163;803.3091541274499;805;805.3396215103618;805.4482679364654;806.4838503357855;647.9902801457982;666.0841343153188;667.3593350383637;669.504566620702;801.4750338528244;571.7770069672789;588.4292236530558;589.8967680655911;594.8839976204641;595.3480938372476;13057.934710326483;13073.15024523403;13078;13086.672833179151;13089.280089595068;11619.709507262301;12049.457774400173;12208.32854193019;12274.877251227463;12516.624501264976;9735.41587504752;9740.561674724655;10011.699649010468;10135.189184865194;11080.445977701163;3933.8229779659982;3939.9212015759813;3954.7429417088083;3959.1883663848844;4017.7790221537803;57768;57986.13020804691;59010.40989590092;59043;59118.70440647812;9724.513774311255;9898.554565044591;9941.801163976825;9980.301378903407;10040.347377420445;17052.31790728357;17191.57021074483;17197.226124824414;17215.741763873553;17235.138243087797;6419.903701444482;6478.060681201199;6481.4166724994975;6516.5112616553;6647.4349680276755;3613.9009954130306;3635.547800074785;3702.148505843671;3780.0549862534367;3804.562475315319;2736.6031925371108;2814.3667674773014;2815.338395477061;2818.957715634267;2819.5347767618114;501.75664802570725;508.24018092951275;522.0133946840474;523.0088981380263;524.5017233628068;437.0167123971065;446.2770312094363;524.1430261522438;538.1174873207942;538.8033367820717;7309.451791115687;7470.85058298831;7654.043244594426;7660.770176894702;7696.461247712607;466.65933868276346;488.5578551410979;531.4764956517827;541.4964083402394;571.1461365258964;3634.327649384872;3731.850725970985;3777.962220377816;3781;3897.4738410314812;54264;55505.72247138739;74333.25666743371;77591.2240877584;78118;81146.59426702946;83224.58387708144;84688.57655711805;84754.06721529557;85745.57127214324;50233;72812;73496;73892;74497;9162.26701863836;9304.72085837426;9305.860412093689;9387.671431499864;9468.431894086378;42184.156316872875;42761.786191068844;43438;43545.56454435415;43838.34242486429;58297.004359477134;66039.66980165069;66549.66725166343;66593.33406665872;66676;11437.885621143681;11480.368579727861;11544.538218471504;11594.942025290156;11837.171398002058;11424.885751142714;11618.186726929373;12998.80501792455;13077.084604077623;13399.464021439033;12348.38258087074;12438.19151755133;12661.493540258654;12732.490700371882;12768.170068945861;11928.880711192776;11962.46168922418;12522.561710340095;12948.482060717466;12971.805422918853;11496.942515287705;11617.88267039661;11787.174897757075;12956.676083097998;13042.739145216852;9370.39092458988;9488.33581649278;9650.517474126405;9832.31173817826;10176.18590512772;10306.33008854422;10696.197785165989;10759.13926885863;10787.67636970892;10792.622258220925 08:20:32 INFO - PROCESS | 26091 | __end_tp_report 08:20:32 INFO - PROCESS | 26091 | __start_cc_report 08:20:32 INFO - PROCESS | 26091 | _x_x_mozilla_cycle_collect,886 08:20:32 INFO - PROCESS | 26091 | __end_cc_report 08:20:32 INFO - PROCESS | 26091 | __startTimestamp1468941632481__endTimestamp 08:20:32 INFO - PROCESS | 26091 | 08:20:32 INFO - PROCESS | 26091 | ------- Summary: start ------- 08:20:32 INFO - PROCESS | 26091 | Number of tests: 6 08:20:32 INFO - PROCESS | 26091 | 08:20:32 INFO - PROCESS | 26091 | [#0] dojo.html Cycles:165 Average:4675.15 Median:4812.47 stddev:488.80 (10.2%) stddev-sans-first:463.48 08:20:32 INFO - PROCESS | 26091 | Values: 2639.6 2647.7 2650.1 2686.3 2695.1 4598.6 4664.5 4702.7 4738.8 4797.0 4656.9 4706.2 4712.1 4712.9 4716.8 4293.9 4313.5 4387.5 4411.1 4516.3 4441.2 4463.3 4463.3 4488.6 4514.0 4269.9 4289.3 4297.1 4306.3 4329.2 4243.0 4254.1 4256.9 4302.4 4345.2 4278.8 4290.1 4294.0 4333.5 4339.4 4518.6 4644.8 4676.8 4702.1 4720.5 5093.3 5130.3 5156.5 5175.4 5177.6 5184.3 5191.9 5193.8 5208.4 5208.8 4663.4 4692.2 4734.3 4812.4 4850.7 5149.2 5225.8 5230.3 5231.4 5237.9 4962.7 4970.6 5008.3 5019.7 5029.3 4857.6 4887.4 4923.4 4938.7 5089.6 4896.7 4901.2 4923.6 4925.2 4968.7 4888.4 4901.7 4903.4 4906.6 4943.2 4201.2 4226.5 4229.9 4273.9 4281.1 3775.8 3790.0 3800.7 3801.8 3802.1 4263.3 4332.8 4337.2 4375.4 4414.1 5088.8 5099.2 5106.2 5119.1 5149.8 4377.5 4381.4 4396.7 4410.9 4438.8 4462.7 4539.1 4584.4 4601.4 4604.6 4802.4 4805.1 4812.5 4814.9 4872.9 5040.0 5087.8 5098.3 5105.3 5107.6 4666.7 4731.0 4766.0 4787.4 4791.4 4933.9 4951.0 4953.5 4971.8 5002.2 4829.0 5023.3 5046.3 5048.9 5095.3 4876.2 4890.4 4919.4 4925.9 4937.8 4919.8 4928.9 4939.4 4942.4 4996.1 4750.0 4854.3 4860.4 4882.1 4912.0 4965.8 5005.9 5030.3 5031.1 5081.2 4913.3 4915.6 4920.8 4923.1 4964.0 08:20:32 INFO - PROCESS | 26091 | 08:20:32 INFO - PROCESS | 26091 | [#1] ext.html Cycles:180 Average:45377.01 Median:19588.55 stddev:82076.14 (419.0%) stddev-sans-first:82237.41 08:20:32 INFO - PROCESS | 26091 | Values: 558.6 570.3 583.8 587.3 596.8 26284.5 37320.0 38059.4 38173.0 38196.4 39648.8 40149.8 40158.8 40202.6 40215.0 7749.6 7890.4 7891.0 7896.5 7897.8 7777.0 7878.3 7881.7 7886.0 7886.8 7906.8 7938.7 7942.8 7944.2 7959.9 7847.6 7866.7 7905.8 7913.4 7918.8 7764.3 7839.7 7842.5 7844.5 7850.0 36765.3 36824.4 36939.4 36962.8 37194.4 3023.5 3173.4 3175.9 3323.4 3443.7 28221.6 28467.9 28714.6 29156.6 29426.7 3513.6 3562.8 3563.0 3581.7 3641.4 257476.0 257632.0 258333.0 258706.0 259054.0 51095.0 51521.0 51523.2 51605.7 51649.0 32609.9 33540.3 33657.3 35378.0 35529.5 14482.0 14533.5 14594.9 14608.4 14616.5 11612.8 11749.1 11769.4 11769.9 11778.8 18218.5 18492.8 18502.5 18534.9 18571.6 6696.0 6728.5 6916.9 7047.8 7051.3 784.3 861.2 891.7 936.8 1011.2 26331.7 26553.7 26687.2 26874.9 26921.3 759.8 902.2 928.2 937.9 1077.6 14130.9 14460.5 14558.7 14663.8 14764.4 369764.0 369792.0 373634.0 374167.0 375293.0 44238.0 45755.0 45765.8 45932.0 45966.3 1075.7 1164.8 1166.8 1209.9 1211.8 27150.5 27557.0 27684.6 28239.0 28612.1 37974.6 38178.8 38521.8 38589.8 38621.8 292561.0 294982.0 295160.0 295738.0 296816.0 21861.7 24005.5 24718.5 24745.6 26112.7 39547.2 39556.8 40290.8 41030.4 41194.4 34688.3 35258.0 35441.8 35614.3 35663.1 35233.8 35349.3 35371.3 35802.8 35930.0 33909.0 34514.5 34590.5 34832.5 34906.7 31003.7 31552.6 31921.5 32127.7 32422.8 24195.9 24288.8 24419.3 24842.3 24868.4 08:20:32 INFO - PROCESS | 26091 | 08:20:32 INFO - PROCESS | 26091 | [#2] jquery.html Cycles:180 Average:22431.57 Median:28789.52 stddev:57057.35 (198.2%) stddev-sans-first:57193.31 08:20:32 INFO - PROCESS | 26091 | Values: 345.6 363.8 367.3 372.4 388.2 13155.3 16031.7 16710.4 17624.9 17626.6 16309.4 16721.4 16968.6 17048.3 17336.4 4473.4 5056.4 5346.4 5353.5 5360.5 5245.8 5301.6 5303.4 5318.0 5323.0 5292.7 5304.1 5595.7 5599.1 5674.8 5418.6 5604.8 5614.6 5615.2 5619.3 5370.0 5392.4 5400.1 5400.6 5403.9 12156.6 12180.5 12206.3 12336.6 12564.9 1845.5 1917.5 1923.4 1936.8 2228.1 8778.7 8888.7 8932.2 9093.9 9420.4 1721.6 1779.9 1788.8 1813.7 1831.8 56012.4 56455.0 67537.0 67677.7 68529.7 8783.6 9254.3 9562.7 9820.0 10065.7 12269.1 13038.4 13056.5 13432.7 13456.7 6666.9 6715.3 6745.6 7067.5 7085.2 6297.7 6338.7 6380.4 6384.9 6667.0 4282.2 4299.8 4334.3 4344.1 4388.0 1824.6 1826.9 1836.8 1839.9 1902.7 808.3 840.1 858.6 859.8 883.5 16507.9 16729.8 16902.4 17008.9 17456.6 811.2 854.2 878.9 879.4 922.1 6592.7 9185.8 9300.0 9318.9 9324.5 285845.0 288869.0 289259.0 409026.0 412971.0 75327.6 82387.6 83699.0 85010.6 85150.6 896.2 907.5 934.5 937.3 941.5 15206.1 15490.3 15799.8 15987.6 16113.8 28768.0 35196.1 37017.0 37437.6 39229.2 48911.0 52194.2 52311.2 52333.2 52575.5 7150.2 7182.7 7254.1 7309.1 7327.6 10126.5 11532.8 11659.6 11716.6 11767.4 9754.1 9807.3 10218.6 10238.8 10765.6 10073.9 10078.8 10250.8 10261.7 10404.7 9638.4 9640.9 9807.2 10020.9 10398.1 7481.3 7537.8 7552.1 7554.8 7667.7 7840.3 10045.1 10120.7 10257.8 10296.7 08:20:32 INFO - PROCESS | 26091 | 08:20:32 INFO - PROCESS | 26091 | [#3] mootools.html Cycles:180 Average:5104.91 Median:5341.83 stddev:2854.92 (53.4%) stddev-sans-first:2848.52 08:20:32 INFO - PROCESS | 26091 | Values: 1288.6 1387.0 1433.1 1513.7 1719.7 6680.5 7214.2 7440.7 7457.0 7457.7 7235.0 7446.7 7453.4 7635.8 7649.2 2122.8 2172.1 2173.3 2175.1 2179.8 2117.7 2134.9 2165.0 2168.3 2170.3 2135.8 2143.8 2150.5 2153.9 2215.8 2134.7 2142.9 2143.7 2147.8 2149.0 2057.3 2118.7 2127.6 2127.9 2129.0 7485.7 7658.0 7759.3 7763.2 7769.4 4363.6 4484.0 4502.9 4504.5 4516.2 2760.9 2832.7 2851.3 2859.0 2865.8 933.5 936.2 938.3 941.7 960.1 10303.6 10519.3 10543.4 10544.3 10554.1 4147.6 4254.3 4403.0 4411.6 4420.2 9081.7 9130.5 9148.9 9151.4 9165.1 4782.7 4795.4 4796.5 4797.8 4798.6 3632.7 3915.5 4368.2 4380.9 4383.8 3739.7 3783.9 3818.2 3849.7 3877.2 1148.8 1240.7 1252.7 1256.3 1272.2 718.6 803.1 851.7 881.7 884.1 5365.5 5399.2 5432.1 5655.1 5693.1 396.6 397.6 419.3 419.8 426.3 3534.5 3648.5 3742.8 3750.0 3758.2 9209.4 9558.7 9662.2 9694.1 9694.9 9571.2 9586.1 9591.7 9605.2 9617.7 7054.5 7086.1 7097.1 7108.2 7152.2 5335.1 5348.5 5354.6 5368.8 5548.3 8645.8 8908.7 8923.3 8991.0 8995.8 8950.4 9067.7 9128.0 9128.1 9172.7 6641.3 6662.3 6666.7 6678.8 6706.6 7295.9 7425.7 7432.9 7456.1 7460.4 6565.3 6615.9 6648.5 6682.6 6735.7 6567.7 6577.7 6620.1 6670.0 6769.6 6195.0 6214.7 6245.5 6247.7 6248.9 4594.7 4628.6 4641.4 4681.3 4799.2 4590.9 4607.8 4608.5 4662.7 4676.3 08:20:32 INFO - PROCESS | 26091 | 08:20:32 INFO - PROCESS | 26091 | [#4] prototype.html Cycles:180 Average:4130.91 Median:4704.31 stddev:1173.16 (24.9%) stddev-sans-first:1140.40 08:20:32 INFO - PROCESS | 26091 | Values: 286.2 292.3 294.7 308.4 308.8 4701.8 4705.9 4724.6 4733.5 4740.6 4642.7 4686.2 4700.4 4715.2 4716.6 3560.3 3669.2 3675.0 3696.5 3705.7 3669.6 3707.0 3763.6 3797.6 3803.3 3687.1 3690.0 3723.6 3744.8 3750.8 3569.8 3733.6 3733.7 3744.8 3756.1 3314.3 3319.9 3332.3 3340.4 3350.2 4582.5 4620.6 4622.1 4626.7 4665.7 4136.7 4261.2 4268.7 4288.2 4312.9 4903.9 4921.4 4930.6 4933.6 4941.4 3626.3 3642.6 3657.6 3664.9 3671.8 5061.5 5136.0 5164.2 5164.6 5189.0 3720.6 3732.4 3738.8 3746.2 3746.9 3724.4 3781.9 3788.4 3809.0 3813.6 4313.0 4314.0 4321.5 4325.7 4330.2 4810.9 4910.9 4940.2 4948.2 4966.9 1319.4 1322.7 1323.3 1326.3 1331.8 851.9 852.5 861.2 882.6 891.8 4266.7 4361.2 4375.0 4408.9 4410.6 5080.5 5083.5 5090.2 5102.7 5116.3 4379.5 4387.3 4392.2 4397.7 4412.4 2553.2 2704.9 2711.4 2713.8 2719.9 4793.7 4803.9 4805.1 4805.4 4820.3 4973.0 5171.7 5193.7 5207.9 5213.5 4767.8 4771.7 4773.6 4796.4 4802.6 5012.2 5059.4 5071.6 5076.4 5118.2 4724.3 4961.8 4963.3 4966.4 4982.3 4777.4 4778.2 4783.7 4789.6 4789.7 3710.7 3727.4 3736.9 3740.3 3747.9 4992.5 5017.8 5027.3 5044.5 5079.3 4702.7 4886.8 4909.2 4925.8 4929.4 4890.3 4905.1 4909.7 4930.9 4947.0 4874.4 4875.7 4876.7 4877.7 4878.9 4696.0 4961.6 4975.8 5007.6 5009.3 4869.5 4879.0 4880.2 4887.6 4891.0 08:20:32 INFO - PROCESS | 26091 | 08:20:32 INFO - PROCESS | 26091 | [#5] yui.html Cycles:180 Average:16711.26 Median:25370.62 stddev:22704.83 (89.5%) stddev-sans-first:22736.35 08:20:32 INFO - PROCESS | 26091 | Values: 612.8 614.3 672.6 677.8 719.3 12495.5 13540.9 13594.3 13604.2 13625.3 13111.5 13310.3 13317.5 13318.3 13323.2 613.4 743.8 748.9 764.9 767.2 754.8 756.7 758.7 760.9 761.5 803.3 805.0 805.3 805.4 806.5 648.0 666.1 667.4 669.5 801.5 571.8 588.4 589.9 594.9 595.3 13057.9 13073.2 13078.0 13086.7 13089.3 11619.7 12049.5 12208.3 12274.9 12516.6 9735.4 9740.6 10011.7 10135.2 11080.4 3933.8 3939.9 3954.7 3959.2 4017.8 57768.0 57986.1 59010.4 59043.0 59118.7 9724.5 9898.6 9941.8 9980.3 10040.3 17052.3 17191.6 17197.2 17215.7 17235.1 6419.9 6478.1 6481.4 6516.5 6647.4 3613.9 3635.5 3702.1 3780.1 3804.6 2736.6 2814.4 2815.3 2819.0 2819.5 501.8 508.2 522.0 523.0 524.5 437.0 446.3 524.1 538.1 538.8 7309.5 7470.9 7654.0 7660.8 7696.5 466.7 488.6 531.5 541.5 571.1 3634.3 3731.9 3778.0 3781.0 3897.5 54264.0 55505.7 74333.3 77591.2 78118.0 81146.6 83224.6 84688.6 84754.1 85745.6 50233.0 72812.0 73496.0 73892.0 74497.0 9162.3 9304.7 9305.9 9387.7 9468.4 42184.2 42761.8 43438.0 43545.6 43838.3 58297.0 66039.7 66549.7 66593.3 66676.0 11437.9 11480.4 11544.5 11594.9 11837.2 11424.9 11618.2 12998.8 13077.1 13399.5 12348.4 12438.2 12661.5 12732.5 12768.2 11928.9 11962.5 12522.6 12948.5 12971.8 11496.9 11617.9 11787.2 12956.7 13042.7 9370.4 9488.3 9650.5 9832.3 10176.2 10306.3 10696.2 10759.1 10787.7 10792.6 08:20:32 INFO - PROCESS | 26091 | -------- Summary: end -------- 08:20:32 INFO - PROCESS | 26091 | 08:20:33 INFO - TEST-INFO | 26091: exit 0 08:20:33 INFO - TEST-OK | dromaeo_css | took 1119361ms 08:20:33 INFO - TEST-START | kraken 08:20:33 INFO - operating with platform_type : linux_ 08:20:33 INFO - Initialising browser for kraken test... 08:20:33 INFO - TEST-INFO | started process 26284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7CnV7F/profile http://localhost:37196/getInfo.html) 08:20:37 INFO - PROCESS | 26284 | __metrics Screen width/height:1600/1200 08:20:37 INFO - PROCESS | 26284 | colorDepth:24 08:20:37 INFO - PROCESS | 26284 | Browser inner width/height: 1024/697 08:20:37 INFO - PROCESS | 26284 | __metrics 08:20:38 INFO - PROCESS | 26284 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:20:38 INFO - PROCESS | 26284 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:20:39 INFO - PROCESS | 26284 | console.error: PushService: 08:20:39 INFO - PROCESS | 26284 | stateChangeProcessEnqueue: Error transitioning state 08:20:39 INFO - PROCESS | 26284 | UnknownError 08:20:39 INFO - TEST-INFO | 26284: exit 0 08:20:39 INFO - Browser initialized. 08:20:39 INFO - Running cycle 1/1 for kraken test... 08:20:39 INFO - TEST-INFO | started process 26363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7CnV7F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:51 INFO - PROCESS | 26363 | RSS: Main: 158932992 08:20:51 INFO - PROCESS | 26363 | 08:20:54 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37196/tests/kraken/driver.html?testName=audio-beat-detection) 08:20:55 INFO - PROCESS | 26363 | RSS: Main: 218378240 08:20:55 INFO - PROCESS | 26363 | 08:20:57 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37196/tests/kraken/driver.html?testName=audio-dft) 08:20:58 INFO - PROCESS | 26363 | RSS: Main: 206344192 08:20:58 INFO - PROCESS | 26363 | 08:21:01 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37196/tests/kraken/driver.html?testName=audio-fft) 08:21:02 INFO - PROCESS | 26363 | RSS: Main: 271380480 08:21:02 INFO - PROCESS | 26363 | 08:21:04 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37196/tests/kraken/driver.html?testName=audio-oscillator) 08:21:05 INFO - PROCESS | 26363 | RSS: Main: 182214656 08:21:05 INFO - PROCESS | 26363 | 08:21:07 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37196/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:21:08 INFO - PROCESS | 26363 | RSS: Main: 186114048 08:21:08 INFO - PROCESS | 26363 | 08:21:11 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37196/tests/kraken/driver.html?testName=imaging-darkroom) 08:21:11 INFO - PROCESS | 26363 | RSS: Main: 222801920 08:21:11 INFO - PROCESS | 26363 | 08:21:15 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37196/tests/kraken/driver.html?testName=imaging-desaturate) 08:21:15 INFO - PROCESS | 26363 | RSS: Main: 223219712 08:21:15 INFO - PROCESS | 26363 | 08:21:18 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37196/tests/kraken/driver.html?testName=json-parse-financial) 08:21:19 INFO - PROCESS | 26363 | RSS: Main: 223281152 08:21:19 INFO - PROCESS | 26363 | 08:21:21 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37196/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:21:21 INFO - PROCESS | 26363 | RSS: Main: 210587648 08:21:21 INFO - PROCESS | 26363 | 08:21:23 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37196/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:21:24 INFO - PROCESS | 26363 | RSS: Main: 214102016 08:21:24 INFO - PROCESS | 26363 | 08:21:26 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37196/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:21:27 INFO - PROCESS | 26363 | RSS: Main: 211881984 08:21:27 INFO - PROCESS | 26363 | 08:21:29 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:21:30 INFO - PROCESS | 26363 | RSS: Main: 226955264 08:21:30 INFO - PROCESS | 26363 | 08:21:33 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:21:33 INFO - PROCESS | 26363 | RSS: Main: 227954688 08:21:33 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | Cycle 1(1): loaded http://localhost:37196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37196/tests/kraken/driver.html?testName=ai-astar) 08:21:35 INFO - PROCESS | 26363 | RSS: Main: 269836288 08:21:35 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | __start_tp_report 08:21:35 INFO - PROCESS | 26363 | _x_x_mozilla_page_load 08:21:35 INFO - PROCESS | 26363 | _x_x_mozilla_page_load_details 08:21:35 INFO - PROCESS | 26363 | |i|pagename|runs| 08:21:35 INFO - PROCESS | 26363 | |0;ai-astar;105;114;113;114;115;114;113;114;114;114 08:21:35 INFO - PROCESS | 26363 | |1;audio-beat-detection;159;129;125;171;127;122;149;121;173;123 08:21:35 INFO - PROCESS | 26363 | |2;audio-dft;160;160;161;161;161;161;160;161;161;161 08:21:35 INFO - PROCESS | 26363 | |3;audio-fft;77;76;76;119;75;76;75;75;109;75 08:21:35 INFO - PROCESS | 26363 | |4;audio-oscillator;87;87;113;85;85;85;130;85;85;122 08:21:35 INFO - PROCESS | 26363 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;117 08:21:35 INFO - PROCESS | 26363 | |6;imaging-darkroom;146;147;146;146;146;147;146;146;146;147 08:21:35 INFO - PROCESS | 26363 | |7;imaging-desaturate;95;95;94;94;95;95;102;95;95;95 08:21:35 INFO - PROCESS | 26363 | |8;json-parse-financial;65;63;65;63;64;65;65;64;65;64 08:21:35 INFO - PROCESS | 26363 | |9;json-stringify-tinderbox;66;66;66;76;67;66;66;67;66;71 08:21:35 INFO - PROCESS | 26363 | |10;stanford-crypto-aes;85;78;77;78;77;78;77;78;78;82 08:21:35 INFO - PROCESS | 26363 | |11;stanford-crypto-ccm;142;144;130;138;140;128;135;138;216;129 08:21:35 INFO - PROCESS | 26363 | |12;stanford-crypto-pbkdf2;167;167;163;165;165;163;164;165;163;164 08:21:35 INFO - PROCESS | 26363 | |13;stanford-crypto-sha256-iterative;66;67;68;66;70;67;65;69;66;65 08:21:35 INFO - PROCESS | 26363 | __end_tp_report 08:21:35 INFO - PROCESS | 26363 | __start_cc_report 08:21:35 INFO - PROCESS | 26363 | _x_x_mozilla_cycle_collect,1936 08:21:35 INFO - PROCESS | 26363 | __end_cc_report 08:21:35 INFO - PROCESS | 26363 | __startTimestamp1468941695985__endTimestamp 08:21:35 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | ------- Summary: start ------- 08:21:35 INFO - PROCESS | 26363 | Number of tests: 14 08:21:35 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.87 (2.5%) stddev-sans-first:0.60 08:21:35 INFO - PROCESS | 26363 | Values: 105.0 114.0 113.0 114.0 115.0 114.0 113.0 114.0 114.0 114.0 08:21:35 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:139.00 stddev:21.03 (15.1%) stddev-sans-first:21.14 08:21:35 INFO - PROCESS | 26363 | Values: 159.0 129.0 125.0 171.0 127.0 122.0 149.0 121.0 173.0 123.0 08:21:35 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:21:35 INFO - PROCESS | 26363 | Values: 160.0 160.0 161.0 161.0 161.0 161.0 160.0 161.0 161.0 161.0 08:21:35 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.50 stddev:16.36 (21.7%) stddev-sans-first:17.20 08:21:35 INFO - PROCESS | 26363 | Values: 77.0 76.0 76.0 119.0 75.0 76.0 75.0 75.0 109.0 75.0 08:21:35 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:85.00 stddev:17.91 (21.1%) stddev-sans-first:18.67 08:21:35 INFO - PROCESS | 26363 | Values: 87.0 87.0 113.0 85.0 85.0 85.0 130.0 85.0 85.0 122.0 08:21:35 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:21:35 INFO - PROCESS | 26363 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 08:21:35 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:21:35 INFO - PROCESS | 26363 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 08:21:35 INFO - PROCESS | 26363 | 08:21:35 INFO - PROCESS | 26363 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.32 (2.4%) stddev-sans-first:2.46 08:21:35 INFO - PROCESS | 26363 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 102.0 95.0 95.0 95.0 08:21:35 INFO - PROCESS | 26363 | 08:21:36 INFO - PROCESS | 26363 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 08:21:36 INFO - PROCESS | 26363 | Values: 65.0 63.0 65.0 63.0 64.0 65.0 65.0 64.0 65.0 64.0 08:21:36 INFO - PROCESS | 26363 | 08:21:36 INFO - PROCESS | 26363 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:66.50 stddev:3.30 (5.0%) stddev-sans-first:3.44 08:21:36 INFO - PROCESS | 26363 | Values: 66.0 66.0 66.0 76.0 67.0 66.0 66.0 67.0 66.0 71.0 08:21:36 INFO - PROCESS | 26363 | 08:21:36 INFO - PROCESS | 26363 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:2.62 (3.4%) stddev-sans-first:1.54 08:21:36 INFO - PROCESS | 26363 | Values: 85.0 78.0 77.0 78.0 77.0 78.0 77.0 78.0 78.0 82.0 08:21:36 INFO - PROCESS | 26363 | 08:21:36 INFO - PROCESS | 26363 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:139.00 stddev:25.89 (18.6%) stddev-sans-first:27.45 08:21:36 INFO - PROCESS | 26363 | Values: 142.0 144.0 130.0 138.0 140.0 128.0 135.0 138.0 216.0 129.0 08:21:36 INFO - PROCESS | 26363 | 08:21:36 INFO - PROCESS | 26363 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.00 stddev:1.51 (0.9%) stddev-sans-first:1.32 08:21:36 INFO - PROCESS | 26363 | Values: 167.0 167.0 163.0 165.0 165.0 163.0 164.0 165.0 163.0 164.0 08:21:36 INFO - PROCESS | 26363 | 08:21:36 INFO - PROCESS | 26363 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.66 (2.5%) stddev-sans-first:1.73 08:21:36 INFO - PROCESS | 26363 | Values: 66.0 67.0 68.0 66.0 70.0 67.0 65.0 69.0 66.0 65.0 08:21:36 INFO - PROCESS | 26363 | -------- Summary: end -------- 08:21:36 INFO - PROCESS | 26363 | 08:21:37 INFO - TEST-INFO | 26363: exit 0 08:21:37 INFO - TEST-OK | kraken | took 63755ms 08:21:37 INFO - SUITE-END | took 1183s 08:21:37 INFO - Completed test suite (00:19:43) 08:21:37 INFO - javascript benchmark 08:21:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.604059391091, 2647.655804745385, 2650.1387049209006, 2686.3149896776317, 2695.083671551672, 4598.563136502035, 4664.463586687523, 4702.694324868886, 4738.763061846907, 4797.040591881624, 4656.8602941911795, 4706.199946009178, 4712.057588482308, 4712.90574188516, 4716.787744551495, 4293.8711838644895, 4313.503947046099, 4387.451568553931, 4411.073674528353, 4516.345129956155, 4441.200583894898, 4463.308187230984, 4463.33050042493, 4488.618467430272, 4513.977430112845, 4269.914601707948, 4289.2922667759785, 4297.140571885604, 4306.289462238727, 4329.177456283328, 4242.957570424287, 4254.149170165979, 4256.87229383119, 4302.397664326997, 4345.239583072981, 4278.7860606969525, 4290.14197160566, 4293.978530107361, 4333.4799824021, 4339.414179085846, 4518.638508919312, 4644.767761611906, 4676.836310729108, 4702.130105930414, 4720.457147428056, 5093.312402825608, 5130.281760553526, 5156.458571849977, 5175.404828444739, 5177.637565370425, 5184.274201611777, 5191.922121168185, 5193.792248310063, 5208.401033881077, 5208.843734687927, 4663.440387153495, 4692.155412025868, 4734.28985652148, 4812.422509298906, 4850.708957462563, 5149.201873709581, 5225.817096401608, 5230.34620672416, 5231.372235331784, 5237.895242095213, 4962.7022378656675, 4970.602351811846, 5008.273800298936, 5019.6737212081825, 5029.2958985742025, 4857.562819346276, 4887.413510378778, 4923.433805112386, 4938.678985865908, 5089.643724939293, 4896.730679812573, 4901.166801643729, 4923.556879880756, 4925.187344088257, 4968.652194346433, 4888.413390393175, 4901.730404827697, 4903.362562866804, 4906.582940450102, 4943.209086546135, 4201.2017716633745, 4226.4716910386205, 4229.942514371407, 4273.87178384649, 4281.12236991416, 3775.8300876460626, 3790.0, 3800.6959443244473, 3801.7718936863876, 3802.068493219124, 4263.317869140985, 4332.805023773938, 4337.240982827992, 4375.387445757597, 4414.1171765647, 5088.77100530477, 5099.209622508517, 5106.208537676666, 5119.0529751996, 5149.845504634867, 4377.474703035656, 4381.38660587518, 4396.670249731219, 4410.933835992462, 4438.755868427267, 4462.732236065846, 4539.0694907543875, 4584.426946631671, 4601.3558101865765, 4604.562566556172, 4802.351682522884, 4805.111054454937, 4812.470628230892, 4814.855554333376, 4872.902541949212, 5040.0, 5087.796488140581, 5098.286239926488, 5105.259737337991, 5107.616928730435, 4666.650001249987, 4730.97634511839, 4766.046790641816, 4787.40157480315, 4791.353167322367, 4933.9013219736125, 4950.950490495193, 4953.455119936876, 4971.8011279549855, 5002.2496625506465, 4828.975855120702, 5023.296738456546, 5046.3439752833365, 5048.924266136084, 5095.286659867547, 4876.244182151772, 4890.413150421972, 4919.3604831371695, 4925.852224433273, 4937.8271760488215, 4919.778609962632, 4928.8767780805765, 4939.382577177853, 4942.406911170682, 4996.050750357421, 4749.952500474951, 4854.344663470528, 4860.416749990024, 4882.072406242803, 4911.950880491149, 4965.826196083264, 5005.874853128701, 5030.320906677698, 5031.094403007347, 5081.18701007837, 4913.263010548446, 4915.582175514978, 4920.803167873245, 4923.0646177227645, 4964.0], "value": 4644.246052181703, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5504286494572, 570.2899889637399, 583.8131797824697, 587.2805812879221, 596.7851573433564, 26284.4743105138, 37320.0, 38059.429108563396, 38172.99999999996, 38196.42705359422, 39648.801755991255, 40149.79925100371, 40158.79920600393, 40202.59797402025, 40215.0, 7749.612519374037, 7890.368770498375, 7890.960545197295, 7896.486728362666, 7897.842043159133, 7777.0, 7878.251566101211, 7881.684732610689, 7886.0, 7886.802829929269, 7906.762797116067, 7938.6824527019135, 7942.848286998382, 7944.165862584432, 7959.920400795976, 7847.6468558914985, 7866.724664636738, 7905.802354941173, 7913.366930645535, 7918.802029949268, 7764.262395072459, 7839.686412543491, 7842.451028428012, 7844.529328240324, 7850.018747656543, 36765.264694706224, 36824.44763328552, 36939.4459083114, 36962.81518592417, 37194.44208336877, 3023.516237402005, 3173.4446471867564, 3175.904722858318, 3323.4350160472536, 3443.724502039831, 28221.576676349872, 28467.857660711772, 28714.569281460794, 29156.562651560245, 29426.70573294261, 3513.5608048993877, 3562.8040457774814, 3563.0, 3581.659742324501, 3641.417373220272, 257476.0, 257631.99999999814, 258333.0, 258706.0, 259054.0, 51095.0, 51521.0, 51523.16622585719, 51605.741971289906, 51649.0, 32609.88035777667, 33540.32919341599, 33657.32685346328, 35378.0, 35529.46705799415, 14482.0, 14533.491327803476, 14594.927025364805, 14608.415663373346, 14616.488422905148, 11612.76774464506, 11749.060075193964, 11769.352685602375, 11769.941150294193, 11778.823317650242, 18218.45344639663, 18492.815071849378, 18502.537436564195, 18534.907325463555, 18571.628567428575, 6696.0, 6728.495362847806, 6916.930830691729, 7047.788566343018, 7051.259617740166, 784.3411534311092, 861.1775754154767, 891.7458524320538, 936.8126374725082, 1011.2264117949775, 26331.736682632927, 26553.734462655128, 26687.19938401851, 26874.865625671748, 26921.326966825985, 759.783461713409, 902.228594551662, 928.1924725488868, 937.9390339627903, 1077.6389909380446, 14130.85869141316, 14460.493882714054, 14558.708825823423, 14663.780043299359, 14764.40942362315, 369764.0, 369792.0, 373634.0, 374167.0, 375292.9765618744, 44238.0, 45755.0, 45765.77117114393, 45932.0, 45966.310505342444, 1075.6504136155625, 1164.778692048525, 1166.7783121206944, 1209.8608660004036, 1211.8121691138065, 27150.45699085968, 27557.0, 27684.584731228646, 28239.0, 28612.141635750962, 37974.62025379711, 38178.80910595429, 38521.807390962866, 38589.80705096456, 38621.80689096537, 292561.0, 294982.0, 295160.0, 295738.0, 296816.0, 21861.672074919206, 24005.51988960176, 24718.505629886942, 24745.62881556742, 26112.73887261103, 39547.2090558193, 39556.80221598873, 40290.798546007085, 41030.38454423246, 41194.38208426816, 34688.29548290492, 35258.0, 35441.82279088588, 35614.28771424505, 35663.10842228965, 35233.82383088171, 35349.29301414009, 35371.29257414889, 35802.820985894905, 35930.0, 33909.0, 34514.48228276628, 34590.48114278237, 34832.47751283783, 34906.65093349034, 31003.68996310008, 31552.564307397275, 31921.521177182825, 32127.67872321247, 32422.83788581042, 24195.879020605487, 24288.757112428648, 24419.26742197666, 24842.254732357334, 24868.37829054288], "value": 17009.045267356385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.62672313900987, 363.84900266389434, 367.28746232309317, 372.35210733324016, 388.1790014120135, 13155.342232888353, 16031.67936641268, 16710.415135470263, 17624.911875440637, 17626.559336016573, 16309.429169979023, 16721.414750483735, 16968.575785605368, 17048.318067277294, 17336.393226237084, 4473.373727678128, 5056.443791182967, 5346.4118946915805, 5353.518183363496, 5360.463953604628, 5245.816396426126, 5301.602379821509, 5303.416624171338, 5317.973410132944, 5323.0, 5292.735363231843, 5304.098303288451, 5595.720213989304, 5599.1041433370665, 5674.829755107354, 5418.591166296752, 5604.831855044335, 5614.550835933136, 5615.157726341041, 5619.325680918275, 5370.0, 5392.352917649907, 5400.135978243501, 5400.648957817769, 5403.891922161574, 12156.635300940987, 12180.512779488898, 12206.328651924141, 12336.568220112344, 12564.874351256462, 1845.5293900055399, 1917.51103468616, 1923.422973108062, 1936.8160024797621, 2228.0864845413466, 8778.692745753931, 8888.688895888678, 8932.240759535447, 9093.863592046124, 9420.43477391352, 1721.6470623522148, 1779.9272074587452, 1788.8211178882007, 1813.6554054729559, 1831.7527133837027, 56012.439875601536, 56455.0, 67537.0, 67677.66161169163, 68529.65735171293, 8783.560821958876, 9254.305927055499, 9562.66530671437, 9820.0, 10065.69802905914, 12269.141160118706, 13038.41327140281, 13056.543020994219, 13432.664183395493, 13456.730865382637, 6666.866662666719, 6715.328467153246, 6745.59526428406, 7067.5052746307265, 7085.185203701641, 6297.748090076438, 6338.683065846782, 6380.425761681471, 6384.936150638527, 6667.0, 4282.186384586918, 4299.763513006815, 4334.28484300087, 4344.087741574304, 4388.0, 1824.5985883105695, 1826.936057238017, 1836.823364313293, 1839.9356022539414, 1902.7145928110895, 808.333125171724, 840.0717207485762, 858.5578427110044, 859.7592674051276, 883.4566741453959, 16507.91746041286, 16729.83270167307, 16902.40841570539, 17008.914955425145, 17456.5635859102, 811.1645005644195, 854.1885209051426, 878.8989266234337, 879.4064006795387, 922.0733163171104, 6592.736290548421, 9185.770355741026, 9300.0, 9318.939356250907, 9324.533773311307, 285845.0, 288869.0, 289259.0, 409026.0, 412971.0, 75327.62336188393, 82387.5880620605, 83699.0, 85010.57494712487, 85150.57424712837, 896.2023798819056, 907.5190149220923, 934.4720233068294, 937.2970272295778, 941.5257699090334, 15206.08763474195, 15490.302936368116, 15799.842001579837, 15987.600309992344, 16113.838861611233, 28768.0, 35196.12009699778, 37017.0, 37437.62562374341, 39229.215415692095, 48911.0, 52194.21708674449, 52311.215331769294, 52333.21500177577, 52575.47424525706, 7150.213476517683, 7182.676779544829, 7254.129504459499, 7309.122905251404, 7327.596982166032, 10126.493675316353, 11532.769344612892, 11659.591914282959, 11716.648500544998, 11767.352795596324, 9754.122129008423, 9807.313488055768, 10218.642347517802, 10238.795224095626, 10765.569377224823, 10073.899261007296, 10078.8488172676, 10250.846237306298, 10261.692149235534, 10404.68785936423, 9638.373505722106, 9640.903590964, 9807.21542276602, 10020.94989525077, 10398.116160126474, 7481.326680598772, 7537.773866784005, 7552.093748750185, 7554.848903021799, 7667.693292268247, 7840.3335716464735, 10045.146162576262, 10120.696379108638, 10257.846132307872, 10296.691099267035], "value": 7937.629349367335, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1288.613415975207, 1386.9930650346746, 1433.0613448191434, 1513.7199618070658, 1719.6818588561116, 6680.532362734611, 7214.170370407404, 7440.702371905131, 7457.0, 7457.66440510177, 7234.96382518088, 7446.664900079496, 7453.440991925614, 7635.847283054336, 7649.196834332384, 2122.8407869409816, 2172.0877231562704, 2173.250228671106, 2175.0647221694667, 2179.7929196726286, 2117.68234764785, 2134.8505604607685, 2164.967525487119, 2168.3061420345416, 2170.251263314154, 2135.765065842756, 2143.8284937204985, 2150.5376344086017, 2153.946151346221, 2215.8338124640636, 2134.7331583552054, 2142.892855357226, 2143.6709240270975, 2147.8389120815846, 2148.98925505373, 2057.341650671786, 2118.7075883710922, 2127.6276651586063, 2127.8722277193115, 2128.98935505323, 7485.663145158426, 7658.0, 7759.30166285037, 7763.2236776321915, 7769.3784497240085, 4363.585459381354, 4483.955160448419, 4502.8874278142985, 4504.459464864204, 4516.164509565708, 2760.875760590758, 2832.7025662305573, 2851.2729254040087, 2859.0, 2865.799394042418, 933.5145724223433, 936.1621348892771, 938.3197182043033, 941.6798288581847, 960.1214888377126, 10303.587856485732, 10519.316244444086, 10543.36739795607, 10544.261901666887, 10554.050135487767, 4147.605977432139, 4254.319308910622, 4402.9559704402545, 4411.580899814512, 4420.204363214588, 9081.727548173565, 9130.543472826332, 9148.8627670585, 9151.405158664798, 9165.083491650916, 4782.665213435096, 4795.352627395327, 4796.472388037313, 4797.808087676523, 4798.616110711135, 3632.6730594246646, 3915.5105611798526, 4368.213721530155, 4380.868573942723, 4383.7588932609015, 3739.6821270191795, 3783.9243215135543, 3818.198178382571, 3849.6920246380223, 3877.2051729395407, 1148.8161894096904, 1240.7332423528985, 1252.655519732081, 1256.2525297448003, 1272.166730791333, 718.597585352194, 803.1406395157126, 851.7402192331275, 881.7046289492963, 884.0893879304198, 5365.463453654604, 5399.163129714901, 5432.130859062531, 5655.095184770417, 5693.089105743061, 396.5558574396694, 397.5547386926603, 419.2976763920482, 419.7817135089736, 426.31789137379945, 3534.54050973377, 3648.5074514940675, 3742.7754334740002, 3749.9812500937865, 3758.1919887224376, 9209.355345125778, 9558.713238602853, 9662.178714809179, 9694.079062489052, 9694.9030509694, 9571.234301255883, 9586.137247647745, 9591.712248632552, 9605.18355939753, 9617.71146865595, 7054.506184567031, 7086.078809754699, 7097.148342198866, 7108.218096009331, 7152.17749958751, 5335.119705248746, 5348.545373643284, 5354.625176237626, 5368.8389348319615, 5548.334199896039, 8645.827083458422, 8908.73273801787, 8923.330750193632, 8991.0, 8995.77510562215, 8950.373473857027, 9067.68263110788, 9127.954360228156, 9128.132827381389, 9172.724818255463, 6641.302663220292, 6662.267150613332, 6666.699998499982, 6678.766243181465, 6706.597604143767, 7295.8540829184185, 7425.665845036879, 7432.922226277052, 7456.067991501062, 7460.4031677466755, 6565.310642382672, 6615.867682646224, 6648.5346025777735, 6682.599044057372, 6735.696893639896, 6567.671616419256, 6577.704003319766, 6620.073189753342, 6670.0, 6769.627670477974, 6195.0, 6214.689265536796, 6245.500359971101, 6247.718852651551, 6248.875022499616, 4594.747288899142, 4628.583427491542, 4641.419822522184, 4681.321208424692, 4799.184138696361, 4590.862274131781, 4607.815687372467, 4608.539146085499, 4662.650301227353, 4676.275177347517], "value": 4051.567118221081, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.1955371383428, 292.3349380160136, 294.67291306649616, 308.3693846084756, 308.79310861722644, 4701.788419521121, 4705.905881882364, 4724.551167639069, 4733.526647335265, 4740.644451666126, 4642.698224615406, 4686.1799185142545, 4700.36545066416, 4715.1512727709, 4716.622670186385, 3560.3413368526903, 3669.2111196092833, 3674.963250367502, 3696.5009723687363, 3705.666490015898, 3669.5779985301765, 3706.9620506258293, 3763.56718977317, 3797.563280222782, 3803.296390167814, 3687.0966613179808, 3689.981550092246, 3723.5531736191697, 3744.7753134811996, 3750.818492174956, 3569.803660798655, 3733.5519737631384, 3733.7386382953205, 3744.812759362021, 3756.136088699601, 3314.303996160809, 3319.850606722703, 3332.2502436951736, 3340.365330587181, 3350.2294472271515, 4582.541745825424, 4620.561046700558, 4622.14490319292, 4626.653001024903, 4665.696729712592, 4136.669066474675, 4261.190373828994, 4268.679849011305, 4288.24955632763, 4312.935305970413, 4903.901921961541, 4921.360223171001, 4930.605551555867, 4933.580645645125, 4941.407031156285, 3626.34725749365, 3642.562892452923, 3657.579378371468, 3664.8534058637624, 3671.834767435472, 5061.544460998491, 5135.974320128413, 5164.173732202829, 5164.612654050924, 5188.9503646059975, 3720.6465385788306, 3732.4401339799247, 3738.7662071516334, 3746.213295208037, 3746.925061498755, 3724.404095344732, 3781.9432708509394, 3788.3749181384765, 3808.961910380916, 3813.56144043433, 4313.0, 4314.0, 4321.503027151855, 4325.718828276152, 4330.155619654201, 4810.903781924342, 4910.926336104962, 4940.184869496493, 4948.158813001798, 4966.850994470172, 1319.3535167767916, 1322.7420652972578, 1323.3184909771476, 1326.2639235224542, 1331.8202042724108, 851.9105493923173, 852.5098068610574, 861.2421069458961, 882.6381183714647, 891.790429249126, 4266.658667306608, 4361.193179261783, 4374.956250437519, 4408.889777755518, 4410.610657642832, 5080.491950804964, 5083.491650834961, 5090.160123579642, 5102.719350435687, 5116.258142569307, 4379.510966271483, 4387.298032314879, 4392.2094023075515, 4397.692161548661, 4412.360207769855, 2553.234029791055, 2704.8647567621542, 2711.3899372641, 2713.8371697698203, 2719.904803331874, 4793.736344501016, 4803.879903002453, 4805.063012712558, 4805.423349198119, 4820.30105634681, 4972.975135124301, 5171.663841850343, 5193.714345710947, 5207.947920520746, 5213.504717051874, 4767.785449654704, 4771.6898401603785, 4773.63704966044, 4796.424429068465, 4802.6072438992305, 5012.1980483122525, 5059.380998080579, 5071.568916642127, 5076.416212135504, 5118.232265160255, 4724.291356296583, 4961.841598904488, 4963.305137280711, 4966.367825052728, 4982.252662100569, 4777.4267087949665, 4778.235482322812, 4783.7129772213775, 4789.592884604847, 4789.736564488987, 3710.6845918096183, 3727.3849814781343, 3736.9439458408688, 3740.270647223765, 3747.9063023424633, 4992.475790042138, 5017.799288028438, 5027.32131162303, 5044.470330615232, 5079.263506791421, 4702.717836929658, 4886.828960986349, 4909.1654418748185, 4925.847457627193, 4929.408470983505, 4890.315355850113, 4905.068037072945, 4909.723471897404, 4930.8767280818265, 4947.0, 4874.439439464507, 4875.731834749123, 4876.683015603974, 4877.6829506081995, 4878.902421951612, 4695.976520117378, 4961.603071754179, 4975.800967961386, 5007.624428167829, 5009.298698182331, 4869.537393947569, 4879.0, 4880.194767863263, 4887.60899128076, 4891.0], "value": 3760.6950203619394, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.8100288910438, 614.2751553167262, 672.5762769455246, 677.7864972533652, 719.3274288540218, 12495.500179992801, 13540.864591354084, 13594.252316122622, 13604.183748975069, 13625.318734063294, 13111.54109606164, 13310.26793526358, 13317.53388631398, 13318.267495287755, 13323.200607963505, 613.4141894490773, 743.7545609948704, 748.9363404110644, 764.9349805266559, 767.1829501580827, 754.7697952124599, 756.6519401075512, 758.6548120605112, 760.9277118673717, 761.4669731188163, 803.3091541274499, 805.0, 805.3396215103618, 805.4482679364654, 806.4838503357855, 647.9902801457982, 666.0841343153188, 667.3593350383637, 669.504566620702, 801.4750338528244, 571.7770069672789, 588.4292236530558, 589.8967680655911, 594.8839976204641, 595.3480938372476, 13057.934710326483, 13073.15024523403, 13078.0, 13086.672833179151, 13089.280089595068, 11619.709507262301, 12049.457774400173, 12208.32854193019, 12274.877251227463, 12516.624501264976, 9735.41587504752, 9740.561674724655, 10011.699649010468, 10135.189184865194, 11080.445977701163, 3933.8229779659982, 3939.9212015759813, 3954.7429417088083, 3959.1883663848844, 4017.7790221537803, 57768.0, 57986.13020804691, 59010.40989590092, 59043.0, 59118.70440647812, 9724.513774311255, 9898.554565044591, 9941.801163976825, 9980.301378903407, 10040.347377420445, 17052.31790728357, 17191.57021074483, 17197.226124824414, 17215.741763873553, 17235.138243087797, 6419.903701444482, 6478.060681201199, 6481.4166724994975, 6516.5112616553, 6647.4349680276755, 3613.9009954130306, 3635.547800074785, 3702.148505843671, 3780.0549862534367, 3804.562475315319, 2736.6031925371108, 2814.3667674773014, 2815.338395477061, 2818.957715634267, 2819.5347767618114, 501.75664802570725, 508.24018092951275, 522.0133946840474, 523.0088981380263, 524.5017233628068, 437.0167123971065, 446.2770312094363, 524.1430261522438, 538.1174873207942, 538.8033367820717, 7309.451791115687, 7470.85058298831, 7654.043244594426, 7660.770176894702, 7696.461247712607, 466.65933868276346, 488.5578551410979, 531.4764956517827, 541.4964083402394, 571.1461365258964, 3634.327649384872, 3731.850725970985, 3777.962220377816, 3781.0, 3897.4738410314812, 54264.0, 55505.72247138739, 74333.25666743371, 77591.2240877584, 78118.0, 81146.59426702946, 83224.58387708144, 84688.57655711805, 84754.06721529557, 85745.57127214324, 50233.0, 72812.0, 73496.0, 73892.0, 74497.0, 9162.26701863836, 9304.72085837426, 9305.860412093689, 9387.671431499864, 9468.431894086378, 42184.156316872875, 42761.786191068844, 43438.0, 43545.56454435415, 43838.34242486429, 58297.004359477134, 66039.66980165069, 66549.66725166343, 66593.33406665872, 66676.0, 11437.885621143681, 11480.368579727861, 11544.538218471504, 11594.942025290156, 11837.171398002058, 11424.885751142714, 11618.186726929373, 12998.80501792455, 13077.084604077623, 13399.464021439033, 12348.38258087074, 12438.19151755133, 12661.493540258654, 12732.490700371882, 12768.170068945861, 11928.880711192776, 11962.46168922418, 12522.561710340095, 12948.482060717466, 12971.805422918853, 11496.942515287705, 11617.88267039661, 11787.174897757075, 12956.676083097998, 13042.739145216852, 9370.39092458988, 9488.33581649278, 9650.517474126405, 9832.31173817826, 10176.18590512772, 10306.33008854422, 10696.197785165989, 10759.13926885863, 10787.67636970892, 10792.622258220925], "value": 6395.096053790017, "unit": "score"}], "name": "dromaeo_css", "value": 6275.941516040269, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 129.0, 125.0, 171.0, 127.0, 122.0, 149.0, 121.0, 173.0, 123.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 119.0, 75.0, 76.0, 75.0, 75.0, 109.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 113.0, 85.0, 85.0, 85.0, 130.0, 85.0, 85.0, 122.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 102.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 63.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 76.0, 67.0, 66.0, 66.0, 67.0, 66.0, 71.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 77.0, 78.0, 77.0, 78.0, 77.0, 78.0, 78.0, 82.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 144.0, 130.0, 138.0, 140.0, 128.0, 135.0, 138.0, 216.0, 129.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 163.0, 165.0, 165.0, 163.0, 164.0, 165.0, 163.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 66.0, 70.0, 67.0, 65.0, 69.0, 66.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1538.3, "alertThreshold": 2.0}]} 08:21:37 INFO - Return code: 0 08:21:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:21:37 INFO - # TBPL SUCCESS # 08:21:37 INFO - Running post-action listener: _resource_record_post_action 08:21:37 INFO - ##### 08:21:37 INFO - ##### Finished run-tests step (success) 08:21:37 INFO - ##### 08:21:37 INFO - Running post-run listener: _resource_record_post_run 08:21:37 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553328640; Read time: 12; Write time: 460044 08:21:37 INFO - TinderboxPrint: CPU usage
13.0% 08:21:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:21:37 INFO - TinderboxPrint: I/O write bytes / time
553,328,640 / 460,044 08:21:37 INFO - TinderboxPrint: CPU idle
8,335.1 (87.0%) 08:21:37 INFO - TinderboxPrint: CPU user
1,200.2 (12.5%) 08:21:37 INFO - TinderboxPrint: Swap in / out
0 / 0 08:21:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263651328; Read time: 0; Write time: 261552 08:21:37 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 289394688; Read time: 0; Write time: 198472 08:21:37 INFO - Running post-run listener: _upload_blobber_files 08:21:37 INFO - Blob upload gear active. 08:21:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:21:37 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 08:21:37 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:21:37 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:21:38 INFO - (blobuploader) - INFO - Open directory for files ... 08:21:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:21:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:39 INFO - (blobuploader) - INFO - Done attempting. 08:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:21:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:44 INFO - (blobuploader) - INFO - Done attempting. 08:21:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:21:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:21:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:45 INFO - (blobuploader) - INFO - Done attempting. 08:21:45 INFO - (blobuploader) - INFO - Iteration through files over. 08:21:45 INFO - Return code: 0 08:21:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:21:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:21:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86acda63e587b1aec27e43b02489241f37927f7c05051526327352e4c314a0a8b635ad7bc9c3e6c102c464afad21ef14f2e42fe2e04a78fdfc5e0d5717dbdcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b4668e063c2a93156a2c63793dc13bc4130610cbb6a7c530f3a248bdb9579a4bd6f1950dbc6af44761e1f99b00fb19004240a4427cec8ff29b8bedaa4cf7b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b3f43546a73beb0e2fe88b6b456932ea9e6aa5952ee5561881a5d05661b5a042451b58e2d7cd7de446d111ca9d037a34812ed447dfdb56e77cd9ca62028d2ab"} 08:21:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:21:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:21:45 INFO - Contents: 08:21:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86acda63e587b1aec27e43b02489241f37927f7c05051526327352e4c314a0a8b635ad7bc9c3e6c102c464afad21ef14f2e42fe2e04a78fdfc5e0d5717dbdcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b4668e063c2a93156a2c63793dc13bc4130610cbb6a7c530f3a248bdb9579a4bd6f1950dbc6af44761e1f99b00fb19004240a4427cec8ff29b8bedaa4cf7b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b3f43546a73beb0e2fe88b6b456932ea9e6aa5952ee5561881a5d05661b5a042451b58e2d7cd7de446d111ca9d037a34812ed447dfdb56e77cd9ca62028d2ab"} 08:21:45 INFO - Running post-run listener: copy_logs_to_upload_dir 08:21:45 INFO - Copying logs to upload dir... 08:21:45 INFO - mkdir: /builds/slave/test/build/upload/logs 08:21:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.072910 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-19 08:21:45.285986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 08:21:45.289745) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a86acda63e587b1aec27e43b02489241f37927f7c05051526327352e4c314a0a8b635ad7bc9c3e6c102c464afad21ef14f2e42fe2e04a78fdfc5e0d5717dbdcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b4668e063c2a93156a2c63793dc13bc4130610cbb6a7c530f3a248bdb9579a4bd6f1950dbc6af44761e1f99b00fb19004240a4427cec8ff29b8bedaa4cf7b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b3f43546a73beb0e2fe88b6b456932ea9e6aa5952ee5561881a5d05661b5a042451b58e2d7cd7de446d111ca9d037a34812ed447dfdb56e77cd9ca62028d2ab"} build_url:https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://queue.taskcluster.net/v1/task/P8tIXoD4QUyoZZlbheo0Lw/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/Fx-Team-Non-PGO/sha512/a86acda63e587b1aec27e43b02489241f37927f7c05051526327352e4c314a0a8b635ad7bc9c3e6c102c464afad21ef14f2e42fe2e04a78fdfc5e0d5717dbdcb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b4668e063c2a93156a2c63793dc13bc4130610cbb6a7c530f3a248bdb9579a4bd6f1950dbc6af44761e1f99b00fb19004240a4427cec8ff29b8bedaa4cf7b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b3f43546a73beb0e2fe88b6b456932ea9e6aa5952ee5561881a5d05661b5a042451b58e2d7cd7de446d111ca9d037a34812ed447dfdb56e77cd9ca62028d2ab"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 08:21:45.314478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:21:45.314778) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1468939973.661990-2077510392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 08:21:45.399002) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 08:21:45.399307) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 08:21:45.399617) ========= ========= Total master_lag: 0.17 =========