builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1467867744.02 results: success (0) buildid: 20160706212122 builduid: 68a26aaddb1640da99369ab1290ad97e revision: e178424c2e2a702ff2c7738e639c59bbed5a17cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:24.019715) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:24.020200) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:24.020493) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:24.036509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:24.036812) ========= 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=0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 22:02:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-07-06 22:02:24 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084389 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:24.136315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:24.136616) ========= 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=0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016650 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:24.186830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 22:02:24.187271) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e178424c2e2a702ff2c7738e639c59bbed5a17cf --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 e178424c2e2a702ff2c7738e639c59bbed5a17cf --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=0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 22:02:24,779 truncating revision to first 12 chars 2016-07-06 22:02:24,780 Setting DEBUG logging. 2016-07-06 22:02:24,780 attempt 1/10 2016-07-06 22:02:24,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e178424c2e2a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 22:02:25,868 unpacking tar archive at: fx-team-e178424c2e2a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.484066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 22:02:25.686015) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:25.686380) ========= script_repo_revision: e178424c2e2a702ff2c7738e639c59bbed5a17cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:25.686791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:25.687080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 22:02:25.697725) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 48 secs) (at 2016-07-06 22:02:25.698102) ========= /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=0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:02:26 INFO - MultiFileLogger online at 20160706 22:02:26 in /builds/slave/test 22:02:26 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 22:02:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:02:26 INFO - {'append_to_log': False, 22:02:26 INFO - 'base_work_dir': '/builds/slave/test', 22:02:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:02:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:02:26 INFO - 'branch': 'Fx-Team-Non-PGO', 22:02:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:02:26 INFO - 'config_files': ('talos/linux_config.py',), 22:02:26 INFO - 'default_actions': ('clobber', 22:02:26 INFO - 'read-buildbot-config', 22:02:26 INFO - 'download-and-extract', 22:02:26 INFO - 'populate-webroot', 22:02:26 INFO - 'create-virtualenv', 22:02:26 INFO - 'install', 22:02:26 INFO - 'run-tests'), 22:02:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:02:26 INFO - 'download_minidump_stackwalk': True, 22:02:26 INFO - 'download_symbols': 'ondemand', 22:02:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:02:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:02:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:02:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:02:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:02:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:02:26 INFO - 'installer_path': 'installer.exe', 22:02:26 INFO - 'log_level': 'info', 22:02:26 INFO - 'log_name': 'talos', 22:02:26 INFO - 'log_to_console': True, 22:02:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:02:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:02:26 INFO - 'opt_config_files': (), 22:02:26 INFO - 'pip_index': False, 22:02:26 INFO - 'sps_profile': False, 22:02:26 INFO - 'sps_profile_interval': 0, 22:02:26 INFO - 'suite': 'dromaeojs', 22:02:26 INFO - 'system_bits': '32', 22:02:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:02:26 INFO - 'title': 'talos-linux64-ix-017', 22:02:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:02:26 INFO - 'use_talos_json': True, 22:02:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:02:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:02:26 INFO - 'work_dir': 'build'} 22:02:26 INFO - ##### 22:02:26 INFO - ##### Running clobber step. 22:02:26 INFO - ##### 22:02:26 INFO - Running pre-action listener: _resource_record_pre_action 22:02:26 INFO - Running main action method: clobber 22:02:26 INFO - rmtree: /builds/slave/test/build 22:02:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:02:27 INFO - Running post-action listener: _resource_record_post_action 22:02:27 INFO - ##### 22:02:27 INFO - ##### Finished clobber step (success) 22:02:27 INFO - ##### 22:02:27 INFO - ##### 22:02:27 INFO - ##### Running read-buildbot-config step. 22:02:27 INFO - ##### 22:02:27 INFO - Running pre-action listener: _resource_record_pre_action 22:02:27 INFO - Running main action method: read_buildbot_config 22:02:27 INFO - Using buildbot properties: 22:02:27 INFO - { 22:02:27 INFO - "project": "", 22:02:27 INFO - "product": "firefox", 22:02:27 INFO - "script_repo_revision": "production", 22:02:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:02:27 INFO - "repository": "", 22:02:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:02:27 INFO - "buildid": "20160706212122", 22:02:27 INFO - "pgo_build": "False", 22:02:27 INFO - "basedir": "/builds/slave/test", 22:02:27 INFO - "buildnumber": 3139, 22:02:27 INFO - "slavename": "talos-linux64-ix-017", 22:02:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:02:27 INFO - "platform": "ubuntu64_hw", 22:02:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:02:27 INFO - "branch": "fx-team", 22:02:27 INFO - "repo_path": "integration/fx-team", 22:02:27 INFO - "revision": "e178424c2e2a702ff2c7738e639c59bbed5a17cf", 22:02:27 INFO - "stage_platform": "linux64", 22:02:27 INFO - "builduid": "68a26aaddb1640da99369ab1290ad97e", 22:02:27 INFO - "slavebuilddir": "test" 22:02:27 INFO - } 22:02:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:02:27 INFO - Running post-action listener: _resource_record_post_action 22:02:27 INFO - ##### 22:02:27 INFO - ##### Finished read-buildbot-config step (success) 22:02:27 INFO - ##### 22:02:27 INFO - ##### 22:02:27 INFO - ##### Running download-and-extract step. 22:02:27 INFO - ##### 22:02:27 INFO - Running pre-action listener: _resource_record_pre_action 22:02:27 INFO - Running main action method: download_and_extract 22:02:27 INFO - mkdir: /builds/slave/test/build/tests 22:02:27 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')]} 22:02:27 INFO - https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:02:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:02:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:02:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:02:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:02:28 INFO - Downloaded 1361 bytes. 22:02:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:02:28 INFO - Using the following test package requirements: 22:02:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:02:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:02:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:02:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:28 INFO - u'jsshell-linux-x86_64.zip'], 22:02:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:02:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:02:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:02:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:02:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:02:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:02:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:28 INFO - https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:02:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:02:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:02:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:02:29 INFO - Downloaded 22733087 bytes. 22:02:29 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'] 22:02:29 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 22:02:30 INFO - Return code: 0 22:02:30 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 22:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:30 INFO - https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:02:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:02:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:02:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:02:31 INFO - Downloaded 22733087 bytes. 22:02:31 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'] 22:02:31 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 22:02:32 INFO - Return code: 0 22:02: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')]} 22:02:32 INFO - https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:02:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:02:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:02:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:02:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:02:33 INFO - Downloaded 14403333 bytes. 22:02:33 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'] 22:02:33 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 22:02:33 INFO - Return code: 0 22:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:33 INFO - https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:02:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:02:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:02:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:02:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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 22:02:35 INFO - Downloaded 56585515 bytes. 22:02:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:02:35 INFO - mkdir: /builds/slave/test/properties 22:02:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:02:35 INFO - Writing to file /builds/slave/test/properties/build_url 22:02:35 INFO - Contents: 22:02:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:02:36 INFO - Running post-action listener: _resource_record_post_action 22:02:36 INFO - Running post-action listener: set_extra_try_arguments 22:02:36 INFO - ##### 22:02:36 INFO - ##### Finished download-and-extract step (success) 22:02:36 INFO - ##### 22:02:36 INFO - ##### 22:02:36 INFO - ##### Running populate-webroot step. 22:02:36 INFO - ##### 22:02:36 INFO - Running pre-action listener: _resource_record_pre_action 22:02:36 INFO - Running main action method: populate_webroot 22:02:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:02:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:02:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:02:36 INFO - '--tppagecycles', 22:02:36 INFO - '7'], 22:02:36 INFO - 'tests': ['tsvgm']}}, 22:02:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:02:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:02:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:02:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:02:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:36 INFO - 'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:02:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:02:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:36 INFO - 'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['damp', 'tps']}, 22:02:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:36 INFO - 'tests': ['damp', 'tps']}, 22:02:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['dromaeo_dom']}, 22:02:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:02:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['basic_compositor_video']}, 22:02:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:02:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['a11yr', 22:02:36 INFO - 'ts_paint', 22:02:36 INFO - 'tpaint', 22:02:36 INFO - 'sessionrestore', 22:02:36 INFO - 'sessionrestore_no_auto_restore', 22:02:36 INFO - 'tabpaint']}, 22:02:36 INFO - 'other-e10s': {'tests': ['a11yr', 22:02:36 INFO - 'ts_paint', 22:02:36 INFO - 'tpaint', 22:02:36 INFO - 'sessionrestore', 22:02:36 INFO - 'sessionrestore_no_auto_restore', 22:02:36 INFO - 'tabpaint']}, 22:02:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:02:36 INFO - 'ts_paint', 22:02:36 INFO - 'tpaint', 22:02:36 INFO - 'sessionrestore', 22:02:36 INFO - 'sessionrestore_no_auto_restore', 22:02:36 INFO - 'tabpaint']}, 22:02:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:02:36 INFO - 'ts_paint', 22:02:36 INFO - 'tpaint', 22:02:36 INFO - 'sessionrestore', 22:02:36 INFO - 'sessionrestore_no_auto_restore', 22:02:36 INFO - 'tabpaint']}, 22:02:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['a11yr', 22:02:36 INFO - 'ts_paint', 22:02:36 INFO - 'tpaint', 22:02:36 INFO - 'sessionrestore', 22:02:36 INFO - 'sessionrestore_no_auto_restore', 22:02:36 INFO - 'tabpaint']}, 22:02:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['a11yr', 22:02:36 INFO - 'ts_paint', 22:02:36 INFO - 'tpaint', 22:02:36 INFO - 'sessionrestore', 22:02:36 INFO - 'sessionrestore_no_auto_restore', 22:02:36 INFO - 'tabpaint']}, 22:02:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['tsvgx', 22:02:36 INFO - 'tsvgr_opacity', 22:02:36 INFO - 'tart', 22:02:36 INFO - 'tscrollx', 22:02:36 INFO - 'cart']}, 22:02:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:02:36 INFO - 'tsvgr_opacity', 22:02:36 INFO - 'tart', 22:02:36 INFO - 'tscrollx', 22:02:36 INFO - 'cart']}, 22:02:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:36 INFO - 'talos_options': ['--disable-e10s'], 22:02:36 INFO - 'tests': ['tp5o']}, 22:02:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:36 INFO - 'tests': ['tp5o']}, 22:02:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:36 INFO - 'talos_options': ['--disable-e10s', 22:02:36 INFO - '--xperf_path', 22:02:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:02:36 INFO - 'tests': ['tp5n']}, 22:02:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:02:36 INFO - 'talos_options': ['--xperf_path', 22:02:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:02:36 INFO - 'tests': ['tp5n']}}, 22:02:36 INFO - 'talos.zip': {'path': '', 22:02:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:02:36 INFO - Running post-action listener: _resource_record_post_action 22:02:36 INFO - ##### 22:02:36 INFO - ##### Finished populate-webroot step (success) 22:02:36 INFO - ##### 22:02:36 INFO - ##### 22:02:36 INFO - ##### Running create-virtualenv step. 22:02:36 INFO - ##### 22:02:36 INFO - Running pre-action listener: _resource_record_pre_action 22:02:36 INFO - Running main action method: create_virtualenv 22:02:36 INFO - Creating virtualenv /builds/slave/test/build/venv 22:02:36 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 22:02:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:02:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:02:36 INFO - Using real prefix '/usr' 22:02:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:02:36 INFO - Installing distribute.............................................................................................................................................................................................done. 22:02:38 INFO - Installing pip.................done. 22:02:38 INFO - Return code: 0 22:02:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:38 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 0x24c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2784180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27823b0>, '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 0x27832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2783740>, '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': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', '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 22:02:38 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 22:02:38 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 22:02:38 INFO - Using env: {'DISPLAY': ':0', 22:02:38 INFO - 'HOME': '/home/cltbld', 22:02:38 INFO - 'LANG': 'en_US.UTF-8', 22:02:38 INFO - 'LANGUAGE': 'en_US:en', 22:02:38 INFO - 'LOGNAME': 'cltbld', 22:02:38 INFO - 'MAIL': '/var/mail/cltbld', 22:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:38 INFO - 'MOZ_NO_REMOTE': '1', 22:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:38 INFO - 'NO_EM_RESTART': '1', 22:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:38 INFO - 'PWD': '/builds/slave/test', 22:02:38 INFO - 'SHELL': '/bin/bash', 22:02:38 INFO - 'SHLVL': '1', 22:02:38 INFO - 'TERM': 'linux', 22:02:38 INFO - 'TMOUT': '86400', 22:02:38 INFO - 'USER': 'cltbld', 22:02:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', 22:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:38 INFO - '_': '/tools/buildbot/bin/python'} 22:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:38 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 22:02:38 INFO - Cleaning up... 22:02:38 INFO - Return code: 0 22:02:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:38 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 0x24c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2784180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27823b0>, '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 0x27832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2783740>, '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': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', '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 22:02:38 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 22:02:38 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 22:02:38 INFO - Using env: {'DISPLAY': ':0', 22:02:38 INFO - 'HOME': '/home/cltbld', 22:02:38 INFO - 'LANG': 'en_US.UTF-8', 22:02:38 INFO - 'LANGUAGE': 'en_US:en', 22:02:38 INFO - 'LOGNAME': 'cltbld', 22:02:38 INFO - 'MAIL': '/var/mail/cltbld', 22:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:38 INFO - 'MOZ_NO_REMOTE': '1', 22:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:38 INFO - 'NO_EM_RESTART': '1', 22:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:38 INFO - 'PWD': '/builds/slave/test', 22:02:38 INFO - 'SHELL': '/bin/bash', 22:02:38 INFO - 'SHLVL': '1', 22:02:38 INFO - 'TERM': 'linux', 22:02:38 INFO - 'TMOUT': '86400', 22:02:38 INFO - 'USER': 'cltbld', 22:02:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', 22:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:38 INFO - '_': '/tools/buildbot/bin/python'} 22:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:39 INFO - Downloading/unpacking psutil>=3.1.1 22:02:39 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 22:02:39 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 22:02:39 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 22:02:39 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 22:02:39 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 22:02:39 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 22:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:02:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:02:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:02:41 INFO - Installing collected packages: psutil 22:02:41 INFO - Running setup.py install for psutil 22:02:41 INFO - building 'psutil._psutil_linux' extension 22:02:41 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 22:02:41 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 22:02:41 INFO - building 'psutil._psutil_posix' extension 22:02:41 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 22:02:41 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 22:02:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:02:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:02:41 INFO - Successfully installed psutil 22:02:41 INFO - Cleaning up... 22:02:41 INFO - Return code: 0 22:02:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:02:41 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')]} 22:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:41 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')]} 22:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:41 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 0x24c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2784180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27823b0>, '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 0x27832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2783740>, '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': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', '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 22:02:41 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 22:02:41 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 22:02:41 INFO - Using env: {'DISPLAY': ':0', 22:02:41 INFO - 'HOME': '/home/cltbld', 22:02:41 INFO - 'LANG': 'en_US.UTF-8', 22:02:41 INFO - 'LANGUAGE': 'en_US:en', 22:02:41 INFO - 'LOGNAME': 'cltbld', 22:02:41 INFO - 'MAIL': '/var/mail/cltbld', 22:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:41 INFO - 'MOZ_NO_REMOTE': '1', 22:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:41 INFO - 'NO_EM_RESTART': '1', 22:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:41 INFO - 'PWD': '/builds/slave/test', 22:02:41 INFO - 'SHELL': '/bin/bash', 22:02:41 INFO - 'SHLVL': '1', 22:02:41 INFO - 'TERM': 'linux', 22:02:41 INFO - 'TMOUT': '86400', 22:02:41 INFO - 'USER': 'cltbld', 22:02:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', 22:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:41 INFO - '_': '/tools/buildbot/bin/python'} 22:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:02:41 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 22:02:41 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 22:02:41 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 22:02:41 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 22:02:41 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 22:02:41 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 22:02:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:02:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:02:43 INFO - Installing collected packages: mozsystemmonitor 22:02:43 INFO - Running setup.py install for mozsystemmonitor 22:02:43 INFO - Successfully installed mozsystemmonitor 22:02:43 INFO - Cleaning up... 22:02:44 INFO - Return code: 0 22:02:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:44 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 0x24c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2784180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27823b0>, '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 0x27832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2783740>, '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': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', '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 22:02:44 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 22:02:44 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 22:02:44 INFO - Using env: {'DISPLAY': ':0', 22:02:44 INFO - 'HOME': '/home/cltbld', 22:02:44 INFO - 'LANG': 'en_US.UTF-8', 22:02:44 INFO - 'LANGUAGE': 'en_US:en', 22:02:44 INFO - 'LOGNAME': 'cltbld', 22:02:44 INFO - 'MAIL': '/var/mail/cltbld', 22:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:44 INFO - 'MOZ_NO_REMOTE': '1', 22:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:44 INFO - 'NO_EM_RESTART': '1', 22:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:44 INFO - 'PWD': '/builds/slave/test', 22:02:44 INFO - 'SHELL': '/bin/bash', 22:02:44 INFO - 'SHLVL': '1', 22:02:44 INFO - 'TERM': 'linux', 22:02:44 INFO - 'TMOUT': '86400', 22:02:44 INFO - 'USER': 'cltbld', 22:02:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', 22:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:44 INFO - '_': '/tools/buildbot/bin/python'} 22:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:44 INFO - Downloading/unpacking jsonschema==2.5.1 22:02:44 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 22:02:44 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 22:02:44 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 22:02:44 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 22:02:44 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 22:02:44 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 22:02:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:02:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:02:46 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 22:02:46 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 22:02:46 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 22:02:46 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 22:02:46 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 22:02:46 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 22:02:46 INFO - Downloading functools32-3.2.3-2.tar.gz 22:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:02:46 INFO - warning: no files found matching '*.txt' 22:02:46 INFO - no previously-included directories found matching 'build' 22:02:46 INFO - no previously-included directories found matching 'dist' 22:02:46 INFO - no previously-included directories found matching '.git*' 22:02:46 INFO - Installing collected packages: jsonschema, functools32 22:02:46 INFO - Running setup.py install for functools32 22:02:46 INFO - warning: no files found matching '*.txt' 22:02:46 INFO - no previously-included directories found matching 'build' 22:02:46 INFO - no previously-included directories found matching 'dist' 22:02:46 INFO - no previously-included directories found matching '.git*' 22:02:46 INFO - Successfully installed jsonschema functools32 22:02:46 INFO - Cleaning up... 22:02:46 INFO - Return code: 0 22:02:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:02:46 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')]} 22:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:46 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')]} 22:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:46 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 0x24c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2784180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27823b0>, '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 0x27832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2783740>, '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': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', '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 22:02:46 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 22:02:46 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 22:02:46 INFO - Using env: {'DISPLAY': ':0', 22:02:46 INFO - 'HOME': '/home/cltbld', 22:02:46 INFO - 'LANG': 'en_US.UTF-8', 22:02:46 INFO - 'LANGUAGE': 'en_US:en', 22:02:46 INFO - 'LOGNAME': 'cltbld', 22:02:46 INFO - 'MAIL': '/var/mail/cltbld', 22:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:46 INFO - 'MOZ_NO_REMOTE': '1', 22:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:46 INFO - 'NO_EM_RESTART': '1', 22:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:46 INFO - 'PWD': '/builds/slave/test', 22:02:46 INFO - 'SHELL': '/bin/bash', 22:02:46 INFO - 'SHLVL': '1', 22:02:46 INFO - 'TERM': 'linux', 22:02:46 INFO - 'TMOUT': '86400', 22:02:46 INFO - 'USER': 'cltbld', 22:02:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', 22:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:46 INFO - '_': '/tools/buildbot/bin/python'} 22:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:46 INFO - Downloading/unpacking blobuploader==1.2.4 22:02:46 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 22:02:46 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 22:02:46 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 22:02:46 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 22:02:46 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 22:02:46 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 22:02:48 INFO - Downloading blobuploader-1.2.4.tar.gz 22:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:02:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:02:48 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 22:02:48 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 22:02:48 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 22:02:48 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 22:02:48 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 22:02:48 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 22:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:02:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:49 INFO - Downloading docopt-0.6.1.tar.gz 22:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:02:49 INFO - Installing collected packages: blobuploader, requests, docopt 22:02:49 INFO - Running setup.py install for blobuploader 22:02:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:02:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:02:49 INFO - Running setup.py install for requests 22:02:49 INFO - Running setup.py install for docopt 22:02:50 INFO - Successfully installed blobuploader requests docopt 22:02:50 INFO - Cleaning up... 22:02:50 INFO - Return code: 0 22:02:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02:50 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')]} 22:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:50 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')]} 22:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:50 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 0x24c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2784180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27823b0>, '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 0x27832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2783740>, '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': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', '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 22:02:50 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 22:02:50 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 22:02:50 INFO - Using env: {'DISPLAY': ':0', 22:02:50 INFO - 'HOME': '/home/cltbld', 22:02:50 INFO - 'LANG': 'en_US.UTF-8', 22:02:50 INFO - 'LANGUAGE': 'en_US:en', 22:02:50 INFO - 'LOGNAME': 'cltbld', 22:02:50 INFO - 'MAIL': '/var/mail/cltbld', 22:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:50 INFO - 'MOZ_NO_REMOTE': '1', 22:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:50 INFO - 'NO_EM_RESTART': '1', 22:02:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:50 INFO - 'PWD': '/builds/slave/test', 22:02:50 INFO - 'SHELL': '/bin/bash', 22:02:50 INFO - 'SHLVL': '1', 22:02:50 INFO - 'TERM': 'linux', 22:02:50 INFO - 'TMOUT': '86400', 22:02:50 INFO - 'USER': 'cltbld', 22:02:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', 22:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:50 INFO - '_': '/tools/buildbot/bin/python'} 22:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:02:50 INFO - Running setup.py (path:/tmp/pip-UtI9Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:02:50 INFO - Running setup.py (path:/tmp/pip-7HCxIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:02:50 INFO - Running setup.py (path:/tmp/pip-tMWg1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:02:50 INFO - Running setup.py (path:/tmp/pip-TDS5oO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:02:50 INFO - Running setup.py (path:/tmp/pip-TJBqmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:02:50 INFO - Running setup.py (path:/tmp/pip-CENcaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:02:50 INFO - Running setup.py (path:/tmp/pip-OZ8jBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:02:50 INFO - Running setup.py (path:/tmp/pip-mwYTIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:02:50 INFO - Running setup.py (path:/tmp/pip-O_443n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:02:50 INFO - Running setup.py (path:/tmp/pip-MvnY1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:02:50 INFO - Running setup.py (path:/tmp/pip-WcgYJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:02:51 INFO - Running setup.py (path:/tmp/pip-RZsy2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:02:51 INFO - Running setup.py (path:/tmp/pip-VZeVCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:02:51 INFO - Running setup.py (path:/tmp/pip-us5rWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:51 INFO - Running setup.py (path:/tmp/pip-1f9T_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:02:51 INFO - Running setup.py (path:/tmp/pip-bpdcdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:02:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:02:51 INFO - Running setup.py (path:/tmp/pip-temxyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:02:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:02:51 INFO - Running setup.py install for manifestparser 22:02:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:02:51 INFO - Running setup.py install for mozcrash 22:02:51 INFO - Running setup.py install for mozdebug 22:02:51 INFO - Running setup.py install for mozdevice 22:02:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:02:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:02:51 INFO - Running setup.py install for mozfile 22:02:52 INFO - Running setup.py install for mozhttpd 22:02:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Running setup.py install for mozinfo 22:02:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Running setup.py install for mozInstall 22:02:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Running setup.py install for mozleak 22:02:52 INFO - Running setup.py install for mozlog 22:02:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Running setup.py install for moznetwork 22:02:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Running setup.py install for mozprocess 22:02:52 INFO - Running setup.py install for mozprofile 22:02:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Running setup.py install for mozrunner 22:02:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:02:52 INFO - Running setup.py install for mozscreenshot 22:02:53 INFO - Running setup.py install for moztest 22:02:53 INFO - Running setup.py install for mozversion 22:02:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:02:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:02:53 INFO - Cleaning up... 22:02:53 INFO - Return code: 0 22:02:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02: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')]} 22:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02: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')]} 22:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:53 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 0x24c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2784180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27823b0>, '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 0x27832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2783740>, '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': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', '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 22:02:53 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 22:02:53 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 22:02:53 INFO - Using env: {'DISPLAY': ':0', 22:02:53 INFO - 'HOME': '/home/cltbld', 22:02:53 INFO - 'LANG': 'en_US.UTF-8', 22:02:53 INFO - 'LANGUAGE': 'en_US:en', 22:02:53 INFO - 'LOGNAME': 'cltbld', 22:02:53 INFO - 'MAIL': '/var/mail/cltbld', 22:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:53 INFO - 'MOZ_NO_REMOTE': '1', 22:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:53 INFO - 'NO_EM_RESTART': '1', 22:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:53 INFO - 'PWD': '/builds/slave/test', 22:02:53 INFO - 'SHELL': '/bin/bash', 22:02:53 INFO - 'SHLVL': '1', 22:02:53 INFO - 'TERM': 'linux', 22:02:53 INFO - 'TMOUT': '86400', 22:02:53 INFO - 'USER': 'cltbld', 22:02:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', 22:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:53 INFO - '_': '/tools/buildbot/bin/python'} 22:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:02:53 INFO - Running setup.py (path:/tmp/pip-PEAGFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:02:53 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)) 22:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:02:53 INFO - Running setup.py (path:/tmp/pip-q6dMKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:02:53 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)) 22:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:02:53 INFO - Running setup.py (path:/tmp/pip-hyAwIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:02:53 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)) 22:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:02:53 INFO - Running setup.py (path:/tmp/pip-j7kUEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:02:53 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)) 22:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:02:53 INFO - Running setup.py (path:/tmp/pip-52mWUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:02:53 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)) 22:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:02:53 INFO - Running setup.py (path:/tmp/pip-2Uqs6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:02:53 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)) 22:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:02:53 INFO - Running setup.py (path:/tmp/pip-p9qAZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:02:54 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)) 22:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:02:54 INFO - Running setup.py (path:/tmp/pip-5U758f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:02:54 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)) 22:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:02:54 INFO - Running setup.py (path:/tmp/pip-qXhNq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:02:54 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)) 22:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:02:54 INFO - Running setup.py (path:/tmp/pip-DR_Xq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:02:54 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)) 22:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:02:54 INFO - Running setup.py (path:/tmp/pip-6lZyzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:02:54 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)) 22:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:02:54 INFO - Running setup.py (path:/tmp/pip-3YmHq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:02:54 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)) 22:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:02:54 INFO - Running setup.py (path:/tmp/pip-Kb3Ufr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:02:54 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)) 22:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:02:54 INFO - Running setup.py (path:/tmp/pip-8lWj1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:02:54 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)) 22:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:54 INFO - Running setup.py (path:/tmp/pip-HS0Cf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:02:54 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)) 22:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:02:54 INFO - Running setup.py (path:/tmp/pip-S7HTTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:02:54 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)) 22:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:02:54 INFO - Running setup.py (path:/tmp/pip-gXpZI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:02:54 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)) 22:02:54 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)) 22:02:54 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)) 22:02:54 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)) 22:02:54 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)) 22:02:54 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)) 22:02:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:56 INFO - Downloading blessings-1.6.tar.gz 22:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:02:56 INFO - Installing collected packages: blessings 22:02:56 INFO - Running setup.py install for blessings 22:02:56 INFO - Successfully installed blessings 22:02:56 INFO - Cleaning up... 22:02:56 INFO - Return code: 0 22:02:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:02:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:02:57 INFO - Reading from file tmpfile_stdout 22:02:57 INFO - Current package versions: 22:02:57 INFO - argparse == 1.2.1 22:02:57 INFO - blessings == 1.6 22:02:57 INFO - blobuploader == 1.2.4 22:02:57 INFO - docopt == 0.6.1 22:02:57 INFO - functools32 == 3.2.3-2 22:02:57 INFO - jsonschema == 2.5.1 22:02:57 INFO - manifestparser == 1.1 22:02:57 INFO - mozInstall == 1.12 22:02:57 INFO - mozcrash == 0.17 22:02:57 INFO - mozdebug == 0.1 22:02:57 INFO - mozdevice == 0.48 22:02:57 INFO - mozfile == 1.2 22:02:57 INFO - mozhttpd == 0.7 22:02:57 INFO - mozinfo == 0.9 22:02:57 INFO - mozleak == 0.1 22:02:57 INFO - mozlog == 3.2 22:02:57 INFO - moznetwork == 0.27 22:02:57 INFO - mozprocess == 0.23 22:02:57 INFO - mozprofile == 0.28 22:02:57 INFO - mozrunner == 6.12 22:02:57 INFO - mozscreenshot == 0.1 22:02:57 INFO - mozsystemmonitor == 0.3 22:02:57 INFO - moztest == 0.7 22:02:57 INFO - mozversion == 1.4 22:02:57 INFO - psutil == 3.1.1 22:02:57 INFO - requests == 1.2.3 22:02:57 INFO - wsgiref == 0.1.2 22:02:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:57 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 0x24c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2784180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27823b0>, '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 0x27832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2783740>, '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': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', '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 22:02:57 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 22:02:57 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 22:02:57 INFO - Using env: {'DISPLAY': ':0', 22:02:57 INFO - 'HOME': '/home/cltbld', 22:02:57 INFO - 'LANG': 'en_US.UTF-8', 22:02:57 INFO - 'LANGUAGE': 'en_US:en', 22:02:57 INFO - 'LOGNAME': 'cltbld', 22:02:57 INFO - 'MAIL': '/var/mail/cltbld', 22:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:57 INFO - 'MOZ_NO_REMOTE': '1', 22:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:57 INFO - 'NO_EM_RESTART': '1', 22:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:57 INFO - 'PWD': '/builds/slave/test', 22:02:57 INFO - 'SHELL': '/bin/bash', 22:02:57 INFO - 'SHLVL': '1', 22:02:57 INFO - 'TERM': 'linux', 22:02:57 INFO - 'TMOUT': '86400', 22:02:57 INFO - 'USER': 'cltbld', 22:02:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', 22:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:57 INFO - '_': '/tools/buildbot/bin/python'} 22:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:57 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)) 22:02:57 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)) 22:02:57 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)) 22:02:57 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)) 22:02:57 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)) 22:02:57 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)) 22:02:57 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)) 22:02:57 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)) 22:02:57 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)) 22:02:57 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)) 22:02:57 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)) 22:02:57 INFO - Cleaning up... 22:02:57 INFO - Return code: 0 22:02:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2784180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27823b0>, '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 0x27832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2783740>, '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': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', '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 22:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:02:57 INFO - Using env: {'DISPLAY': ':0', 22:02:57 INFO - 'HOME': '/home/cltbld', 22:02:57 INFO - 'LANG': 'en_US.UTF-8', 22:02:57 INFO - 'LANGUAGE': 'en_US:en', 22:02:57 INFO - 'LOGNAME': 'cltbld', 22:02:57 INFO - 'MAIL': '/var/mail/cltbld', 22:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:57 INFO - 'MOZ_NO_REMOTE': '1', 22:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:57 INFO - 'NO_EM_RESTART': '1', 22:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:02:57 INFO - 'PWD': '/builds/slave/test', 22:02:57 INFO - 'SHELL': '/bin/bash', 22:02:57 INFO - 'SHLVL': '1', 22:02:57 INFO - 'TERM': 'linux', 22:02:57 INFO - 'TMOUT': '86400', 22:02:57 INFO - 'USER': 'cltbld', 22:02:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', 22:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:57 INFO - '_': '/tools/buildbot/bin/python'} 22:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:02:57 INFO - Cleaning up... 22:02:57 INFO - Return code: 0 22:02:57 INFO - Running post-action listener: _resource_record_post_action 22:02:57 INFO - Running post-action listener: _start_resource_monitoring 22:02:57 INFO - Starting resource monitoring. 22:02:57 INFO - ##### 22:02:57 INFO - ##### Finished create-virtualenv step (success) 22:02:57 INFO - ##### 22:02:57 INFO - ##### 22:02:57 INFO - ##### Running install step. 22:02:57 INFO - ##### 22:02:57 INFO - Running pre-action listener: _resource_record_pre_action 22:02:57 INFO - Running main action method: install 22:02:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:02:57 INFO - Reading from file tmpfile_stdout 22:02:57 INFO - Detecting whether we're running mozinstall >=1.0... 22:02:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:02:57 INFO - Reading from file tmpfile_stdout 22:02:57 INFO - Output received: 22:02:57 INFO - Usage: mozinstall [options] installer 22:02:57 INFO - Options: 22:02:57 INFO - -h, --help show this help message and exit 22:02:57 INFO - -d DEST, --destination=DEST 22:02:57 INFO - Directory to install application into. [default: 22:02:57 INFO - "/builds/slave/test"] 22:02:57 INFO - --app=APP Application being installed. [default: firefox] 22:02:57 INFO - mkdir: /builds/slave/test/build/application 22:02:57 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'] 22:02:57 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 22:03:14 INFO - Reading from file tmpfile_stdout 22:03:14 INFO - Output received: 22:03:14 INFO - /builds/slave/test/build/application/firefox/firefox 22:03:14 INFO - Running post-action listener: _resource_record_post_action 22:03:14 INFO - ##### 22:03:14 INFO - ##### Finished install step (success) 22:03:14 INFO - ##### 22:03:14 INFO - ##### 22:03:14 INFO - ##### Running run-tests step. 22:03:14 INFO - ##### 22:03:14 INFO - Running pre-action listener: _resource_record_pre_action 22:03:14 INFO - Running main action method: run_tests 22:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:03:14 INFO - Python 2.7.3 22:03:14 INFO - Return code: 0 22:03:14 INFO - grabbing minidump binary from tooltool 22:03:14 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')]} 22:03:14 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 0x27823b0>, '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 0x27832b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2783740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:03:14 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 22:03:14 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 22:03:14 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 22:03:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:03:14 INFO - Return code: 0 22:03:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:03:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:03:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:03:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:03:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:03:14 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/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 22:03:14 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/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 22:03:14 INFO - Using env: {'DISPLAY': ':0', 22:03:14 INFO - 'HOME': '/home/cltbld', 22:03:14 INFO - 'LANG': 'en_US.UTF-8', 22:03:14 INFO - 'LANGUAGE': 'en_US:en', 22:03:14 INFO - 'LOGNAME': 'cltbld', 22:03:14 INFO - 'MAIL': '/var/mail/cltbld', 22:03:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:03:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:03:14 INFO - 'MOZ_NO_REMOTE': '1', 22:03:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:03:14 INFO - 'NO_EM_RESTART': '1', 22:03:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:03:14 INFO - 'PWD': '/builds/slave/test', 22:03:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:03:14 INFO - 'SHELL': '/bin/bash', 22:03:14 INFO - 'SHLVL': '1', 22:03:14 INFO - 'TERM': 'linux', 22:03:14 INFO - 'TMOUT': '86400', 22:03:14 INFO - 'USER': 'cltbld', 22:03:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030', 22:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:03:14 INFO - '_': '/tools/buildbot/bin/python'} 22:03:14 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/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 22:03:14 INFO - mozversion application_buildid: 20160706212122 22:03:14 INFO - mozversion application_changeset: e178424c2e2a702ff2c7738e639c59bbed5a17cf 22:03:14 INFO - mozversion application_display_name: Nightly 22:03:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:03:14 INFO - mozversion application_name: Firefox 22:03:14 INFO - mozversion application_remotingname: firefox 22:03:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:03:14 INFO - mozversion application_vendor: Mozilla 22:03:14 INFO - mozversion application_version: 50.0a1 22:03:14 INFO - mozversion platform_buildid: 20160706212122 22:03:14 INFO - mozversion platform_changeset: e178424c2e2a702ff2c7738e639c59bbed5a17cf 22:03:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:03:14 INFO - mozversion platform_version: 50.0a1 22:03:14 INFO - using testdate: 1467867794 22:03:14 INFO - actual date: 1467867794 22:03:14 INFO - starting webserver on 'localhost:38659' 22:03:14 INFO - SUITE-START | Running 2 tests 22:03:14 INFO - TEST-START | dromaeo_css 22:03:14 INFO - operating with platform_type : linux_ 22:03:14 INFO - Initialising browser for dromaeo_css test... 22:03:14 INFO - TEST-INFO | started process 2127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwVPnle/profile http://localhost:38659/getInfo.html) 22:03:18 INFO - PROCESS | 2127 | __metrics Screen width/height:1600/1200 22:03:18 INFO - PROCESS | 2127 | colorDepth:24 22:03:18 INFO - PROCESS | 2127 | Browser inner width/height: 1024/697 22:03:18 INFO - PROCESS | 2127 | __metrics 22:03:19 INFO - PROCESS | 2127 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:03:20 INFO - TEST-INFO | 2127: exit 0 22:03:20 INFO - Browser initialized. 22:03:20 INFO - Running cycle 1/1 for dromaeo_css test... 22:03:20 INFO - TEST-INFO | started process 2211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwVPnle/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:03:32 INFO - PROCESS | 2211 | RSS: Main: 159006720 22:03:32 INFO - PROCESS | 2211 | 22:04:23 INFO - PROCESS | 2211 | 1467867863376 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] 22:06:36 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:38659/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38659/tests/dromaeo/cssquery-ext.html) 22:06:37 INFO - PROCESS | 2211 | RSS: Main: 280571904 22:06:37 INFO - PROCESS | 2211 | 22:09:40 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:38659/tests/dromaeo/cssquery-ext.html (next: http://localhost:38659/tests/dromaeo/cssquery-jquery.html) 22:09:41 INFO - PROCESS | 2211 | RSS: Main: 242388992 22:09:41 INFO - PROCESS | 2211 | 22:12:43 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:38659/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38659/tests/dromaeo/cssquery-mootools.html) 22:12:43 INFO - PROCESS | 2211 | RSS: Main: 237850624 22:12:43 INFO - PROCESS | 2211 | 22:15:45 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:38659/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38659/tests/dromaeo/cssquery-prototype.html) 22:15:46 INFO - PROCESS | 2211 | RSS: Main: 239439872 22:15:46 INFO - PROCESS | 2211 | 22:18:49 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:38659/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38659/tests/dromaeo/cssquery-yui.html) 22:18:50 INFO - PROCESS | 2211 | RSS: Main: 230785024 22:18:50 INFO - PROCESS | 2211 | 22:21:52 INFO - PROCESS | 2211 | Cycle 1(1): loaded http://localhost:38659/tests/dromaeo/cssquery-yui.html (next: http://localhost:38659/tests/dromaeo/cssquery-dojo.html) 22:21:53 INFO - PROCESS | 2211 | RSS: Main: 280408064 22:21:53 INFO - PROCESS | 2211 | 22:21:53 INFO - PROCESS | 2211 | __start_tp_report 22:21:53 INFO - PROCESS | 2211 | _x_x_mozilla_page_load 22:21:53 INFO - PROCESS | 2211 | _x_x_mozilla_page_load_details 22:21:53 INFO - PROCESS | 2211 | |i|pagename|runs| 22:21:53 INFO - PROCESS | 2211 | |0;dojo.html;2667.653205083339;2685.3555146764784;2708.498927698376;2720.1159623122476;2725.8500782456967;4691.43702755669;4783.521647835215;4855.80576776929;4884.340614017106;4933.58064564512;4791.928121078178;4804.567588916997;4815.0610630926985;4858.5384388483035;4862.0275944811;4355.607995280432;4388.97805510972;4458.66560007999;4475.395821564096;4602.815887364502;4501.819927202924;4539.59143677069;4558.202314594932;4572.382728331666;4592.724436533818;4301.548337424588;4336.6530677545725;4374.431323927901;4410.889727756799;4428.490723566799;4367.71609845359;4378.824847006116;4390.912181756347;4428;4429.092036132617;4387.780610969438;4418.80115394808;4421.182081314967;4428.579284967923;4460.754658493782;4700.529947005306;4732.455767586737;4766.904661906777;4793.808247670089;4798.112349215371;5149.201873709581;5160.612954028463;5205.791768329263;5218.739063046833;5226.216067589892;5202.3497062867145;5223;5234.241035049935;5241.42344342122;5250.553702935255;4716.268978308368;4767.165745994437;4834.444038935568;4834.95165048352;4843.56407923285;5318.760655770499;5354.892902142014;5360.16917377807;5396.7571459283645;5421.810236641778;5126.87182820425;5163.432022477525;5165.638405311592;5172;5172.922406163911;5035.949640503622;5156.948430515722;5213.113770658997;5218.712970786567;5261.447548007404;5123.923141152885;5128.230765385148;5151.871203219875;5180.9740951295;5185.455527169668;4930.950690493121;5093.821716239914;5100.438951715309;5105;5105.821296254613;4267.359896015622;4278.828846846153;4314.288142456522;4318.3090705486975;4356.194104090753;3781.1681430085337;3787.3182827090836;3794.165283637595;3831.8084095795098;3833.271678381099;4424.446944131983;4428.712133711363;4434.800433980478;4440.200763862471;4481.126180394792;5070.949290507047;5102.668326558762;5125.846224613193;5139.640225184276;5162.380514338303;4411.889702757457;4424.181526417623;4427.579379958899;4430.667699922518;4483.125790470892;4518.983228773565;4631.675782695179;4641.002184530342;4643.3731446255;4696.365990591295;4808.855734328045;4871.123197824284;4890.046440944124;4893.877653058702;4898.118338698926;5181;5186.662866913639;5219.582433405394;5224.947750522446;5286.947130528645;4759.6430267729365;4839.830605928775;4904.558589726942;4917.041176970456;4928.162212423825;4972.552470277692;5034.974825125851;5041.395032596112;5057.848264552069;5085.110105731556;5131.179011358165;5146.485351464824;5150.253213284128;5153.149730294459;5195.74021298926;4839.443464001685;4969.35398398206;4987.650864439454;5005.074061298671;5021.1213037717525;5039.395272567315;5060.468650791614;5062.417821950523;5064.518870707424;5096.821611243588;4963.925541116959;4967.4535801062575;4969.503049695001;5018.824341148188;5020.472850350807;4846.709197448165;4850.223964165716;4994.32576602154;5054.620903432331;5058.519440653132;4780.95219047805;4832.34763306949;4881.463039065771;4882.95117048825;4936.777844996912 22:21:53 INFO - PROCESS | 2211 | |1;ext.html;574.2506029631331;583.4224118123057;585.0843430032003;588.4938952500851;589.8938191125598;27285.45429091417;39591;40114;40839.59160408395;41044;38221.617783822156;38738.22523549527;41789.37315940256;41880.37179442303;41995.79002104993;7538.811529711774;7816.765497035098;8002.599870006506;8011.439199256054;8012.318952889012;10009.849852252222;10231.232657550676;10235.488225588728;10538.947305263462;10547.947260263689;10247.23145764067;10352.948235258851;10354.17166626668;10362.844557331646;10371.11845493134;10134.746631334201;10197.235207359403;10200.693979180636;10209.846852297147;10211.285210035263;10089.798204035878;10148.188144948386;10161.441120738356;10165;10165.644202452953;39142.80428597839;39390.60609393898;39417.211655766725;39438.40842387366;39453.60546394528;2751.2159034675224;2841.2044627504333;2842.4173044525824;2992;3258.9245548968784;29684.8515757422;30275.848620756755;30700.8464957676;30789;31292;3514.420120680085;3516.314318707853;3551.5027896094307;3578.1233597768455;3583.050491619723;248525;249030;249167;249689;249907;52272;52548.05889558298;52726.47273527215;52743.47256527462;52849.471505284455;55533.72233138808;55597.722011389684;55649.165262520284;55676;55772.58615259216;13504.257265850472;13934.651633709238;13946.721065578631;13957.511487097903;13965.23191224472;9632.9036709632;10315.071643552117;10462.26764126519;10581.523831427605;10612.57549698019;15325.770113448307;15549.844501555066;15566.143862087467;15581.220938953007;15671.216439177995;4875.966606775929;5578.944210557924;5702.201691763156;5727.5990680652785;5802.158686990447;797.6011994002998;872.9738107856774;917.2845180759018;921.953902304882;982.7641366072091;26779.598306025426;27981.951641191317;28157.71842281592;28449.857750711115;28622.427551448855;888.8888888888889;963.2149797914677;973.3575839945602;983.6065573770549;1020.4489575629226;14392;14859.70280594382;15025.323860426308;15259.694806103817;15297.388104475918;366349;368094;370868;371562;371890;48190.27714584284;48333.5166648336;48427.515724843004;48466.27300590494;48470.5152948466;1061.6072053340313;1120.8486854274568;1123.342844436014;1164.7321116143335;1203.1096988228649;26253.34366640849;29176.562351565168;29954;29987.250318742204;29997;43353.13293734171;43699;44114.55885441104;44175.77912110419;44219.55780442283;370450;371599;372945;373859;375559;32891.8355408231;37027;38094;38168.2366352677;41068.383974241005;42372.57627423686;42821.78589107034;43273.78363108164;43400.56599433965;43503.78248108866;35946;36769;37269.6273037277;37318;37606.62393376031;36614.26771464609;36620.63379366279;36887.63112368842;37383.626163738016;37776;36076;36249;36552;36601.45097823482;37033.259334813694;32344;33188.33623327568;33532.66467335393;33786.83106584451;33804.83097584496;23273.185438509572;23526.294211173692;23543;23764.64353034671;23795.167169148997 22:21:53 INFO - PROCESS | 2211 | |2;jquery.html;342.326430577192;367.2050011724616;367.5148803579275;370.3722190886448;381.990450238744;13102.082854200198;14028.368723407446;15467.458638947654;17419.82580174198;17449.73825392617;16603.584910377216;16736.079515626636;16760.32958681651;16785.91607041963;16799.0760508172;4047.433359329696;4970.4284007339165;6034.788782392618;6038.939610603904;6154.3537928517535;6043.516518678495;6101.115338275948;6101.847453813646;6107.603005804608;6108.8472788180425;6073.60521566099;6080.635161890279;6083.239595050619;6083.48290395317;6087.2999605045325;5063.18988961768;5322.281491998569;6057.363976782441;6057.787977420791;6062.575619706622;5220.556252718486;5307.28351672527;5310.468953104697;5311.468853114697;5313.442088580682;11716.882831171664;11751.7062073448;11780.941095294555;11954.462049207807;12173.573924912675;1769.186174359796;1881.520212345843;1892.9053547322578;2067.886266255355;2215.8892055397328;8793.340499462565;8811;8811.867821982676;9204.631814727403;9408.905910940872;1773.1488885334982;1887.8206570375792;1918.0505649703346;1974.5853370792152;1975.1111999600093;64979;67920.6603966977;72476;72865.90701139487;72979;9944.602215911427;10067.597296108073;10103.595856165817;10336.328138670962;10409.167266618653;13813;13866.237356945263;13884.791728123884;13889.166650001032;13900.235487048107;7100.644967751592;7166.570005799668;7232.240614735482;7233;7238.674259658328;6711.161104861892;6758;6816.147981502312;6835.487338449636;6958.512904096766;4305.547917468683;4353.390525326457;4361.760103194355;4363.192809330284;4431.667624928079;1761.3571046568168;1795;1826.8173182681626;1830.3410772122024;1853.8609604279734;846.1200351634354;846.504794695098;900.7207765592556;904.1500989070253;909.5452273863068;16335.346586136659;16852.325906963582;17205.397811076553;17445.21496532659;17890;840.5881118252013;865.1262225152516;880.9559522023873;888.138505649519;903.2683526343683;8797.560121993874;9927.80144397108;9950.104490595737;9970.102690757722;10056.145227655585;398671;402716;438683;443590;444473;82739.5863020681;89051.55474222587;89086.55456722675;90504.5474772622;90826.54586727024;842.0568962761746;873.5588527793424;874.2612492443875;874.873143394217;917.0645941140133;16148.757768633715;16520.75218871742;16638.75041874397;16773.91613041976;16982;38861.41707874441;38937.63718269847;39092.804535977135;39460;39902.80048599738;56109.43890561042;56763;57547;57868.421315786305;58021;7211.278872112747;7432.851342973218;7529.8117547061765;7620.123685776207;7647.082350117799;11301.830472542753;11910.464029118537;12121.333326667118;12181.756364872475;12229.633111006684;10520.105791007543;10696.946515267375;10762.515686793957;10770.623028193975;10996.28524145928;10519.947400263256;10548.525316360628;10621;10625.415602141647;10746;10623.36259824413;10665.200109991936;10819;10847.728806779895;10880.238383313092;7426.257374262531;7625.733099341496;7627.656755446129;7639.04511936008;7738.303552680286;9927.702168934944;10056.69829905104;10183.79632407333;10240.846387304346;10562.735931601772 22:21:53 INFO - PROCESS | 2211 | |3;mootools.html;1155.1451925575066;1369.2263870912936;1410.1468611490047;1498.3557070459706;1729.481155653303;6756.797296081113;7422.814429639262;7692.4999875008225;7697.5766332851745;7878.172791856844;7817.335526480256;7940.086890007651;7960.641771120299;7964.123946365895;7966.083900351461;2227.543353612514;2249.460129568908;2256.0524579676576;2256.717910261217;2256.8645881247176;2138.433315171481;2144.828413726898;2154.1060459909118;2162.1675654872906;2188.2341180586745;2148.709924160242;2165.8808765517892;2175.2930297653324;2180.8364372672036;2210.502636906699;2126.521532655148;2131.190147743863;2132.029926383492;2132.6374516332185;2132.8507004509693;2083.270855200683;2126.3939777163587;2127.2022991378235;2128.0849234829016;2128.4572434029224;7747.380209583276;7906.130325664172;7964.323032542241;7972.760817175494;7983.72056978003;4462.062966776981;4534.659900507475;4547.226971414834;4560.908781824378;4563.064571762814;2806.2843974786297;2870.7846911481724;2912.4757543642136;2912.7961042727015;2917.416516696669;905.97282081537;924.1820988425292;925.2644147902433;936.9953150234273;946.2288235088381;10669.413182274971;10713.785724285548;10729.356238625707;10766.24636275461;10772.08437282832;3947.9605203948167;4085.632293093576;4167.333226683777;4191.8532851350665;4195.58044195578;8511.74464766058;8545.871811922827;8563.657453701782;8563.871541926876;8568.742937711879;4486.147631949919;4487.573680500347;4511.503734589192;4522.954770452254;4528.252838281646;3588.8385022674042;3879.8642047528765;4044.393340998815;4164.5210800757695;4166.416701661769;3469.913252168716;3498.8950331490096;3547.308274886424;3587.874424395186;3600.477930700034;1051.6529545250048;1075.9664234596619;1080.5569716416232;1082.2640604388935;1087.4127970895786;724.822418507469;773.5745340062942;774.82953750176;777.4208214879951;790.1348023913805;5152.613553983466;5238.319018527567;5380.139177731544;5512.090505066619;5642.971785141048;794.8171920458327;806.2139414071233;810.9675612975533;815.6696537902159;822.6832669422196;3363.4954756786187;3415.692587667122;3456.412409890325;3476.11359103427;3501.6148223695373;9671.613135474503;9852.310338276395;10015.69952901414;10144.137748291478;10173.389596624227;9909.950450247703;9934.205263578897;9943.45311007887;9950.552225149886;9973.750656233507;7162.964185179041;7271.34557889803;7289.2346303638415;7290.307420795016;7300.926990730131;5085.262636917552;5176.741162941913;5189.948100519097;5222.947770522246;5272.209168624737;8983.775405614912;9200.861987070333;9249.768755781159;9315.208207302185;9356.391834530734;9242.537873106183;9310.301727370339;9530.809383812424;9548.522573871418;9549.713508594754;5789.884202316014;6145.170401995673;6339.746410143543;6503.154589903283;6620;7567.962160189164;7632.847343052997;7638.847223055619;7668.731594394169;7732.536047837148;6792.117024786944;6875;6927.099477068151;7013.123359580052;7066.364027237573;6787.389134977876;6793.048973143665;6802.897956530755;6875.759348422781;6918.584884906922;6179.721912513858;6440.2915679276175;6543.803685889431;6604.9009264862025;6618.371254730793;4572.4055872736335;4615.515370886009;4670.78981445829;4691.765411729468;4764.737939413366;4462.419885414875;4501.504834468271;4516.661250406167;4576.58810707038;4585.633149348111 22:21:53 INFO - PROCESS | 2211 | |4;prototype.html;290.98981535646254;291.6165242705842;298.11905818306906;302.9910398373416;309.64081665268293;4606.33208184813;4761.666683332168;4800.8319708810195;4858.149823780837;4859.295402166684;4576.405067341241;4738.123447162277;4741.814546363409;4758.52414758524;4769.546893045163;3772.7547709398937;3782.7919464429447;3793.298239825627;3800.6579407853287;3820.319059613768;3581.459972211948;3641.7268704847243;3799.886003419902;3804.695624350059;3818.8663396781117;3744.9438258426144;3752.287065457568;3753.7935413552245;3755.887323380289;3760.210355825266;3717.34946384383;3730.160713839378;3737.364648009845;3745.6628903398823;3752.549694036733;3300.092474569489;3310.0400883743687;3310.6825222344214;3320.4853247746637;3350.2294472271515;4617.561331673519;4668.346431499593;4678.596421073698;4696.812127514895;4750.4299484061785;4270.615644592001;4302.333138363559;4302.397664326997;4305.203537345601;4310.4611923509565;4843.443004054544;4949.604031677457;4989.625778066623;5061.670991385585;5066.189409694432;3535.681788639035;3551.5205447264807;3554.7689400188906;3566.144125409909;3566.4828599853136;5230.750777165817;5266.815661451869;5275.155975044013;5291.259223708646;5306.6550674206055;3644.7448678592245;3646.3983442732183;3653.12325041988;3682.6869716073898;3682.8710995115043;3558.5907620623443;3685.668289853926;3687.709301744368;3693;3700.703943684499;4185.330347144503;4222.704410691284;4235.9621892636505;4237.512686041145;4254.29804082323;5032.496750324938;5037.471065538139;5046.520580544842;5087.338645976073;5103.489651034941;1193.3376975778353;1204.265398107154;1274.0381012335627;1284.7045179608742;1296.3971753134838;859.1837754133599;877.5656050255164;878.4597472554461;879.7096958003843;884.9955750221336;4418.4918734345965;4428.202923473741;4434.84478043267;4441.555844415532;4445.555444455528;5140.278006867667;5156.432792392834;5163.586913046947;5165.380154381498;5178.352705911761;4309.224339618899;4394.2749446340995;4406.008648054162;4424.646028317727;4424.867253982386;2438.5122975404634;2444.6821913151534;2449.8407603505716;2457.140000999636;2471.7033955925403;4345.587169218919;4368.628666563378;4370.169667763115;4374.884404476838;4395.582419670191;4359.17175736609;4668.719876807402;4682.297655351725;4696.225122854691;4732.787024583902;4342.89369655723;4357.0196705740955;4377.496587892433;4390.978045109818;4396.4064851244675;4526.8189272428735;4533.939590776279;4584.541545845389;4602.30965355186;4615.23848564983;4214.262504061839;4423.8276856633665;4443.289073748185;4459.777011149365;4537.410136682211;4393.494748103881;4412.852658308927;4423.668224883082;4437.312216606431;4438.35643831649;3303.207230264671;3317.3365326934227;3320.369129865318;3324.5870505035746;3435.230856109056;4980.576650984562;5136.434992150786;5143.974280128576;5147.433782284021;5162.9741851292;5014.991005396732;5020.42265139499;5020.598352131894;5023.949760502494;5024.949750502595;4826.203676393497;4986.8753281168265;4989.25161225819;5014.247862820606;5028.220625803006;4892.315075889307;4908.165611845923;4911.386076740408;4924.901501970012;4935.876603084808;5009.5491405773655;5024.522670346311;5024.824131155392;5030.37120359955;5038.244263360525;4654.790534425892;4888.315635810918;4894.314795928502;4898.853034408973;4902.803887844589 22:21:53 INFO - PROCESS | 2211 | |5;yui.html;570.4466667332691;603.1676286724321;633.8890694128529;645.8320836582487;697.2922483679064;12206.450709718061;12560.874391256084;12584.748305033894;12653.367331633415;12971.610851674464;15219.619509512268;15282.159481228528;15352.155631440295;15359.385624575032;15374.69250614987;557.8884223155364;617.4813156948163;774.2335088262622;790.5296348672531;790.9169537198597;764.4343186042345;765.1010063175775;765.4832987733286;765.4947734495234;776.9728059517918;806.0166596751953;810.096742132521;810.6473683947472;810.7446154461326;810.8905297784783;644.1497223664765;788.2669117720518;803.3974519110667;806.379088102161;807.6930766308824;591.624318557719;593.6022864680674;594.8275000249922;594.9583529152961;595.1013968906939;11974.34141122238;11986.820197697041;12046.15676902617;12050.276983381025;12051.698707532294;12185.878141218564;12737.490500379974;12790.872091279061;13057.020723445685;13213.075084744072;10510.527026283835;10550.103241224506;10589.36463812166;10686.893131068668;10995;3261.445554255782;3290.8190049547266;3300.8679652813858;3311.536384906115;3405.7786243894316;64625.3537464624;65233.3476665232;65853.3414665852;66337.66831165813;66355.00467492992;9439.716808495756;9511.619535218513;9601.37591056579;9919.40483570988;10286.022827831344;17459.738103928452;18016;18022.5494362642;18686.626267474574;18983.52541186454;6312.084747711556;6441.64570948593;6485.935140648628;6650.467962562983;6797.864042719118;3682.5212722345923;3694.224212915264;3785.8296376663116;3803.31540322739;3828.9617103828605;2902.8403437810703;2998.9550156747664;3005.0383877159097;3007.2331555453657;3007.6390833100168;526.7129414469124;538.3351560822381;547.9479449452296;550.7686771555956;551.2558046637008;373.54987240375283;493.22563575186615;517.3765612437004;585.265491807787;591.9023361145449;8460.407771456063;8549.187827156535;8637.136286371313;8850.690225842065;8903;537.4517991648497;580.587782674306;582.5252419278274;600.3456232706371;608.7260732670228;4095.5699651536756;4230.661547076226;4291.442112525414;4360.934585981149;4369.541198174146;90381.64427533593;91166.54416728007;91419.5429022864;92445;92514.53742731379;77308;80761.59619201867;80955.59522202352;83810;84362.15637843544;44140.77929610331;44937.55062449399;46215;58119.70940145357;75178.73748837638;7339.082614673166;7405.518641288299;7548.660310285941;7585.393168546393;7630.465867389229;41348;43551.744523988236;43778.562214378726;44948;45833.77083114563;54304;62367.6881615589;62593.68703156455;62722;63878;9322.207612353026;9604.231661467205;9727.513624318897;9962.50187490608;9968.152707019985;10811.945940270249;11007.724806879893;11231.989120979151;11573;12243.387830608612;10395.84406233892;10440.738981525219;10885.23803333759;10971.23201375896;11152.163587731115;10671.039606435148;10740.409277489813;10921.344719316867;10946.124310055016;11132.1650876183;10469.214808889212;10502.632407865687;10608.098311643596;10983.945080274867;11331.376774277494;9253.86119208199;9276.768080798034;9430.52847357643;9447.763805904908;9564.378315409476;9163.175314221751;9238.538073096453;9398.436093834393;9447;9634.566444509874 22:21:53 INFO - PROCESS | 2211 | __end_tp_report 22:21:53 INFO - PROCESS | 2211 | __start_cc_report 22:21:53 INFO - PROCESS | 2211 | _x_x_mozilla_cycle_collect,1095 22:21:53 INFO - PROCESS | 2211 | __end_cc_report 22:21:53 INFO - PROCESS | 2211 | __startTimestamp1467868913186__endTimestamp 22:21:53 INFO - PROCESS | 2211 | 22:21:53 INFO - PROCESS | 2211 | ------- Summary: start ------- 22:21:53 INFO - PROCESS | 2211 | Number of tests: 6 22:21:53 INFO - PROCESS | 2211 | 22:21:53 INFO - PROCESS | 2211 | [#0] dojo.html Cycles:165 Average:4763.70 Median:4881.46 stddev:505.80 (10.4%) stddev-sans-first:479.88 22:21:53 INFO - PROCESS | 2211 | Values: 2667.7 2685.4 2708.5 2720.1 2725.9 4691.4 4783.5 4855.8 4884.3 4933.6 4791.9 4804.6 4815.1 4858.5 4862.0 4355.6 4389.0 4458.7 4475.4 4602.8 4501.8 4539.6 4558.2 4572.4 4592.7 4301.5 4336.7 4374.4 4410.9 4428.5 4367.7 4378.8 4390.9 4428.0 4429.1 4387.8 4418.8 4421.2 4428.6 4460.8 4700.5 4732.5 4766.9 4793.8 4798.1 5149.2 5160.6 5205.8 5218.7 5226.2 5202.3 5223.0 5234.2 5241.4 5250.6 4716.3 4767.2 4834.4 4835.0 4843.6 5318.8 5354.9 5360.2 5396.8 5421.8 5126.9 5163.4 5165.6 5172.0 5172.9 5035.9 5156.9 5213.1 5218.7 5261.4 5123.9 5128.2 5151.9 5181.0 5185.5 4931.0 5093.8 5100.4 5105.0 5105.8 4267.4 4278.8 4314.3 4318.3 4356.2 3781.2 3787.3 3794.2 3831.8 3833.3 4424.4 4428.7 4434.8 4440.2 4481.1 5070.9 5102.7 5125.8 5139.6 5162.4 4411.9 4424.2 4427.6 4430.7 4483.1 4519.0 4631.7 4641.0 4643.4 4696.4 4808.9 4871.1 4890.0 4893.9 4898.1 5181.0 5186.7 5219.6 5224.9 5286.9 4759.6 4839.8 4904.6 4917.0 4928.2 4972.6 5035.0 5041.4 5057.8 5085.1 5131.2 5146.5 5150.3 5153.1 5195.7 4839.4 4969.4 4987.7 5005.1 5021.1 5039.4 5060.5 5062.4 5064.5 5096.8 4963.9 4967.5 4969.5 5018.8 5020.5 4846.7 4850.2 4994.3 5054.6 5058.5 4781.0 4832.3 4881.5 4883.0 4936.8 22:21:53 INFO - PROCESS | 2211 | 22:21:53 INFO - PROCESS | 2211 | [#1] ext.html Cycles:180 Average:49024.62 Median:36576.73 stddev:88285.02 (241.4%) stddev-sans-first:88457.74 22:21:53 INFO - PROCESS | 2211 | Values: 574.3 583.4 585.1 588.5 589.9 27285.5 39591.0 40114.0 40839.6 41044.0 38221.6 38738.2 41789.4 41880.4 41995.8 7538.8 7816.8 8002.6 8011.4 8012.3 10009.8 10231.2 10235.5 10538.9 10547.9 10247.2 10352.9 10354.2 10362.8 10371.1 10134.7 10197.2 10200.7 10209.8 10211.3 10089.8 10148.2 10161.4 10165.0 10165.6 39142.8 39390.6 39417.2 39438.4 39453.6 2751.2 2841.2 2842.4 2992.0 3258.9 29684.9 30275.8 30700.8 30789.0 31292.0 3514.4 3516.3 3551.5 3578.1 3583.1 248525.0 249030.0 249167.0 249689.0 249907.0 52272.0 52548.1 52726.5 52743.5 52849.5 55533.7 55597.7 55649.2 55676.0 55772.6 13504.3 13934.7 13946.7 13957.5 13965.2 9632.9 10315.1 10462.3 10581.5 10612.6 15325.8 15549.8 15566.1 15581.2 15671.2 4876.0 5578.9 5702.2 5727.6 5802.2 797.6 873.0 917.3 922.0 982.8 26779.6 27982.0 28157.7 28449.9 28622.4 888.9 963.2 973.4 983.6 1020.4 14392.0 14859.7 15025.3 15259.7 15297.4 366349.0 368094.0 370868.0 371562.0 371890.0 48190.3 48333.5 48427.5 48466.3 48470.5 1061.6 1120.8 1123.3 1164.7 1203.1 26253.3 29176.6 29954.0 29987.3 29997.0 43353.1 43699.0 44114.6 44175.8 44219.6 370450.0 371599.0 372945.0 373859.0 375559.0 32891.8 37027.0 38094.0 38168.2 41068.4 42372.6 42821.8 43273.8 43400.6 43503.8 35946.0 36769.0 37269.6 37318.0 37606.6 36614.3 36620.6 36887.6 37383.6 37776.0 36076.0 36249.0 36552.0 36601.5 37033.3 32344.0 33188.3 33532.7 33786.8 33804.8 23273.2 23526.3 23543.0 23764.6 23795.2 22:21:53 INFO - PROCESS | 2211 | 22:21:53 INFO - PROCESS | 2211 | [#2] jquery.html Cycles:180 Average:25737.12 Median:221523.10 stddev:70519.78 (31.8%) stddev-sans-first:70691.83 22:21:53 INFO - PROCESS | 2211 | Values: 342.3 367.2 367.5 370.4 382.0 13102.1 14028.4 15467.5 17419.8 17449.7 16603.6 16736.1 16760.3 16785.9 16799.1 4047.4 4970.4 6034.8 6038.9 6154.4 6043.5 6101.1 6101.8 6107.6 6108.8 6073.6 6080.6 6083.2 6083.5 6087.3 5063.2 5322.3 6057.4 6057.8 6062.6 5220.6 5307.3 5310.5 5311.5 5313.4 11716.9 11751.7 11780.9 11954.5 12173.6 1769.2 1881.5 1892.9 2067.9 2215.9 8793.3 8811.0 8811.9 9204.6 9408.9 1773.1 1887.8 1918.1 1974.6 1975.1 64979.0 67920.7 72476.0 72865.9 72979.0 9944.6 10067.6 10103.6 10336.3 10409.2 13813.0 13866.2 13884.8 13889.2 13900.2 7100.6 7166.6 7232.2 7233.0 7238.7 6711.2 6758.0 6816.1 6835.5 6958.5 4305.5 4353.4 4361.8 4363.2 4431.7 1761.4 1795.0 1826.8 1830.3 1853.9 846.1 846.5 900.7 904.2 909.5 16335.3 16852.3 17205.4 17445.2 17890.0 840.6 865.1 881.0 888.1 903.3 8797.6 9927.8 9950.1 9970.1 10056.1 398671.0 402716.0 438683.0 443590.0 444473.0 82739.6 89051.6 89086.6 90504.5 90826.5 842.1 873.6 874.3 874.9 917.1 16148.8 16520.8 16638.8 16773.9 16982.0 38861.4 38937.6 39092.8 39460.0 39902.8 56109.4 56763.0 57547.0 57868.4 58021.0 7211.3 7432.9 7529.8 7620.1 7647.1 11301.8 11910.5 12121.3 12181.8 12229.6 10520.1 10696.9 10762.5 10770.6 10996.3 10519.9 10548.5 10621.0 10625.4 10746.0 10623.4 10665.2 10819.0 10847.7 10880.2 7426.3 7625.7 7627.7 7639.0 7738.3 9927.7 10056.7 10183.8 10240.8 10562.7 22:21:53 INFO - PROCESS | 2211 | 22:21:53 INFO - PROCESS | 2211 | [#3] mootools.html Cycles:180 Average:5145.36 Median:5183.34 stddev:2944.37 (56.8%) stddev-sans-first:2937.36 22:21:53 INFO - PROCESS | 2211 | Values: 1155.1 1369.2 1410.1 1498.4 1729.5 6756.8 7422.8 7692.5 7697.6 7878.2 7817.3 7940.1 7960.6 7964.1 7966.1 2227.5 2249.5 2256.1 2256.7 2256.9 2138.4 2144.8 2154.1 2162.2 2188.2 2148.7 2165.9 2175.3 2180.8 2210.5 2126.5 2131.2 2132.0 2132.6 2132.9 2083.3 2126.4 2127.2 2128.1 2128.5 7747.4 7906.1 7964.3 7972.8 7983.7 4462.1 4534.7 4547.2 4560.9 4563.1 2806.3 2870.8 2912.5 2912.8 2917.4 906.0 924.2 925.3 937.0 946.2 10669.4 10713.8 10729.4 10766.2 10772.1 3948.0 4085.6 4167.3 4191.9 4195.6 8511.7 8545.9 8563.7 8563.9 8568.7 4486.1 4487.6 4511.5 4523.0 4528.3 3588.8 3879.9 4044.4 4164.5 4166.4 3469.9 3498.9 3547.3 3587.9 3600.5 1051.7 1076.0 1080.6 1082.3 1087.4 724.8 773.6 774.8 777.4 790.1 5152.6 5238.3 5380.1 5512.1 5643.0 794.8 806.2 811.0 815.7 822.7 3363.5 3415.7 3456.4 3476.1 3501.6 9671.6 9852.3 10015.7 10144.1 10173.4 9910.0 9934.2 9943.5 9950.6 9973.8 7163.0 7271.3 7289.2 7290.3 7300.9 5085.3 5176.7 5189.9 5222.9 5272.2 8983.8 9200.9 9249.8 9315.2 9356.4 9242.5 9310.3 9530.8 9548.5 9549.7 5789.9 6145.2 6339.7 6503.2 6620.0 7568.0 7632.8 7638.8 7668.7 7732.5 6792.1 6875.0 6927.1 7013.1 7066.4 6787.4 6793.0 6802.9 6875.8 6918.6 6179.7 6440.3 6543.8 6604.9 6618.4 4572.4 4615.5 4670.8 4691.8 4764.7 4462.4 4501.5 4516.7 4576.6 4585.6 22:21:53 INFO - PROCESS | 2211 | 22:21:53 INFO - PROCESS | 2211 | [#4] prototype.html Cycles:180 Average:4058.63 Median:4424.76 stddev:1173.07 (26.5%) stddev-sans-first:1141.76 22:21:53 INFO - PROCESS | 2211 | Values: 291.0 291.6 298.1 303.0 309.6 4606.3 4761.7 4800.8 4858.1 4859.3 4576.4 4738.1 4741.8 4758.5 4769.5 3772.8 3782.8 3793.3 3800.7 3820.3 3581.5 3641.7 3799.9 3804.7 3818.9 3744.9 3752.3 3753.8 3755.9 3760.2 3717.3 3730.2 3737.4 3745.7 3752.5 3300.1 3310.0 3310.7 3320.5 3350.2 4617.6 4668.3 4678.6 4696.8 4750.4 4270.6 4302.3 4302.4 4305.2 4310.5 4843.4 4949.6 4989.6 5061.7 5066.2 3535.7 3551.5 3554.8 3566.1 3566.5 5230.8 5266.8 5275.2 5291.3 5306.7 3644.7 3646.4 3653.1 3682.7 3682.9 3558.6 3685.7 3687.7 3693.0 3700.7 4185.3 4222.7 4236.0 4237.5 4254.3 5032.5 5037.5 5046.5 5087.3 5103.5 1193.3 1204.3 1274.0 1284.7 1296.4 859.2 877.6 878.5 879.7 885.0 4418.5 4428.2 4434.8 4441.6 4445.6 5140.3 5156.4 5163.6 5165.4 5178.4 4309.2 4394.3 4406.0 4424.6 4424.9 2438.5 2444.7 2449.8 2457.1 2471.7 4345.6 4368.6 4370.2 4374.9 4395.6 4359.2 4668.7 4682.3 4696.2 4732.8 4342.9 4357.0 4377.5 4391.0 4396.4 4526.8 4533.9 4584.5 4602.3 4615.2 4214.3 4423.8 4443.3 4459.8 4537.4 4393.5 4412.9 4423.7 4437.3 4438.4 3303.2 3317.3 3320.4 3324.6 3435.2 4980.6 5136.4 5144.0 5147.4 5163.0 5015.0 5020.4 5020.6 5023.9 5024.9 4826.2 4986.9 4989.3 5014.2 5028.2 4892.3 4908.2 4911.4 4924.9 4935.9 5009.5 5024.5 5024.8 5030.4 5038.2 4654.8 4888.3 4894.3 4898.9 4902.8 22:21:53 INFO - PROCESS | 2211 | 22:21:53 INFO - PROCESS | 2211 | [#5] yui.html Cycles:180 Average:16781.27 Median:575.52 stddev:23717.82 (4121.1%) stddev-sans-first:23753.12 22:21:53 INFO - PROCESS | 2211 | Values: 570.4 603.2 633.9 645.8 697.3 12206.5 12560.9 12584.7 12653.4 12971.6 15219.6 15282.2 15352.2 15359.4 15374.7 557.9 617.5 774.2 790.5 790.9 764.4 765.1 765.5 765.5 777.0 806.0 810.1 810.6 810.7 810.9 644.1 788.3 803.4 806.4 807.7 591.6 593.6 594.8 595.0 595.1 11974.3 11986.8 12046.2 12050.3 12051.7 12185.9 12737.5 12790.9 13057.0 13213.1 10510.5 10550.1 10589.4 10686.9 10995.0 3261.4 3290.8 3300.9 3311.5 3405.8 64625.4 65233.3 65853.3 66337.7 66355.0 9439.7 9511.6 9601.4 9919.4 10286.0 17459.7 18016.0 18022.5 18686.6 18983.5 6312.1 6441.6 6485.9 6650.5 6797.9 3682.5 3694.2 3785.8 3803.3 3829.0 2902.8 2999.0 3005.0 3007.2 3007.6 526.7 538.3 547.9 550.8 551.3 373.5 493.2 517.4 585.3 591.9 8460.4 8549.2 8637.1 8850.7 8903.0 537.5 580.6 582.5 600.3 608.7 4095.6 4230.7 4291.4 4360.9 4369.5 90381.6 91166.5 91419.5 92445.0 92514.5 77308.0 80761.6 80955.6 83810.0 84362.2 44140.8 44937.6 46215.0 58119.7 75178.7 7339.1 7405.5 7548.7 7585.4 7630.5 41348.0 43551.7 43778.6 44948.0 45833.8 54304.0 62367.7 62593.7 62722.0 63878.0 9322.2 9604.2 9727.5 9962.5 9968.2 10811.9 11007.7 11232.0 11573.0 12243.4 10395.8 10440.7 10885.2 10971.2 11152.2 10671.0 10740.4 10921.3 10946.1 11132.2 10469.2 10502.6 10608.1 10983.9 11331.4 9253.9 9276.8 9430.5 9447.8 9564.4 9163.2 9238.5 9398.4 9447.0 9634.6 22:21:53 INFO - PROCESS | 2211 | -------- Summary: end -------- 22:21:53 INFO - PROCESS | 2211 | 22:21:53 INFO - TEST-INFO | 2211: exit 0 22:21:53 INFO - TEST-OK | dromaeo_css | took 1119512ms 22:21:53 INFO - TEST-START | kraken 22:21:53 INFO - operating with platform_type : linux_ 22:21:53 INFO - Initialising browser for kraken test... 22:21:54 INFO - TEST-INFO | started process 2490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIHMmd1/profile http://localhost:38659/getInfo.html) 22:21:57 INFO - PROCESS | 2490 | __metrics Screen width/height:1600/1200 22:21:57 INFO - PROCESS | 2490 | colorDepth:24 22:21:57 INFO - PROCESS | 2490 | Browser inner width/height: 1024/697 22:21:57 INFO - PROCESS | 2490 | __metrics 22:21:58 INFO - PROCESS | 2490 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:21:59 INFO - TEST-INFO | 2490: exit 0 22:21:59 INFO - Browser initialized. 22:21:59 INFO - Running cycle 1/1 for kraken test... 22:21:59 INFO - TEST-INFO | started process 2591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIHMmd1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:22:11 INFO - PROCESS | 2591 | RSS: Main: 159068160 22:22:11 INFO - PROCESS | 2591 | 22:22:14 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38659/tests/kraken/driver.html?testName=audio-beat-detection) 22:22:15 INFO - PROCESS | 2591 | RSS: Main: 217268224 22:22:15 INFO - PROCESS | 2591 | 22:22:17 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38659/tests/kraken/driver.html?testName=audio-dft) 22:22:18 INFO - PROCESS | 2591 | RSS: Main: 204791808 22:22:18 INFO - PROCESS | 2591 | 22:22:21 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38659/tests/kraken/driver.html?testName=audio-fft) 22:22:22 INFO - PROCESS | 2591 | RSS: Main: 271478784 22:22:22 INFO - PROCESS | 2591 | 22:22:24 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38659/tests/kraken/driver.html?testName=audio-oscillator) 22:22:25 INFO - PROCESS | 2591 | RSS: Main: 181178368 22:22:25 INFO - PROCESS | 2591 | 22:22:27 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38659/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:22:28 INFO - PROCESS | 2591 | RSS: Main: 185843712 22:22:28 INFO - PROCESS | 2591 | 22:22:31 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38659/tests/kraken/driver.html?testName=imaging-darkroom) 22:22:31 INFO - PROCESS | 2591 | RSS: Main: 221458432 22:22:31 INFO - PROCESS | 2591 | 22:22:35 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38659/tests/kraken/driver.html?testName=imaging-desaturate) 22:22:36 INFO - PROCESS | 2591 | RSS: Main: 217104384 22:22:36 INFO - PROCESS | 2591 | 22:22:38 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38659/tests/kraken/driver.html?testName=json-parse-financial) 22:22:39 INFO - PROCESS | 2591 | RSS: Main: 221036544 22:22:39 INFO - PROCESS | 2591 | 22:22:41 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38659/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:22:41 INFO - PROCESS | 2591 | RSS: Main: 205844480 22:22:41 INFO - PROCESS | 2591 | 22:22:43 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38659/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:22:44 INFO - PROCESS | 2591 | RSS: Main: 211443712 22:22:44 INFO - PROCESS | 2591 | 22:22:46 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38659/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:22:47 INFO - PROCESS | 2591 | RSS: Main: 210223104 22:22:47 INFO - PROCESS | 2591 | 22:22:49 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:22:50 INFO - PROCESS | 2591 | RSS: Main: 224808960 22:22:50 INFO - PROCESS | 2591 | 22:22:53 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:22:54 INFO - PROCESS | 2591 | RSS: Main: 224821248 22:22:54 INFO - PROCESS | 2591 | 22:22:55 INFO - PROCESS | 2591 | Cycle 1(1): loaded http://localhost:38659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38659/tests/kraken/driver.html?testName=ai-astar) 22:22:56 INFO - PROCESS | 2591 | RSS: Main: 268079104 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | __start_tp_report 22:22:56 INFO - PROCESS | 2591 | _x_x_mozilla_page_load 22:22:56 INFO - PROCESS | 2591 | _x_x_mozilla_page_load_details 22:22:56 INFO - PROCESS | 2591 | |i|pagename|runs| 22:22:56 INFO - PROCESS | 2591 | |0;ai-astar;106;115;112;113;111;113;111;113;114;112 22:22:56 INFO - PROCESS | 2591 | |1;audio-beat-detection;153;122;123;173;124;126;148;123;154;122 22:22:56 INFO - PROCESS | 2591 | |2;audio-dft;161;163;162;161;161;160;164;162;162;161 22:22:56 INFO - PROCESS | 2591 | |3;audio-fft;77;77;76;114;87;77;75;75;99;76 22:22:56 INFO - PROCESS | 2591 | |4;audio-oscillator;86;86;117;87;86;86;131;85;85;118 22:22:56 INFO - PROCESS | 2591 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;116 22:22:56 INFO - PROCESS | 2591 | |6;imaging-darkroom;147;148;147;146;147;146;146;147;146;148 22:22:56 INFO - PROCESS | 2591 | |7;imaging-desaturate;95;95;94;95;94;94;94;95;96;94 22:22:56 INFO - PROCESS | 2591 | |8;json-parse-financial;64;63;65;65;65;64;64;65;64;64 22:22:56 INFO - PROCESS | 2591 | |9;json-stringify-tinderbox;63;64;64;64;64;64;64;64;64;65 22:22:56 INFO - PROCESS | 2591 | |10;stanford-crypto-aes;78;78;81;84;78;77;84;78;78;78 22:22:56 INFO - PROCESS | 2591 | |11;stanford-crypto-ccm;140;136;126;129;127;128;127;128;202;130 22:22:56 INFO - PROCESS | 2591 | |12;stanford-crypto-pbkdf2;166;168;164;168;167;164;166;164;165;166 22:22:56 INFO - PROCESS | 2591 | |13;stanford-crypto-sha256-iterative;68;67;68;67;66;71;67;67;68;66 22:22:56 INFO - PROCESS | 2591 | __end_tp_report 22:22:56 INFO - PROCESS | 2591 | __start_cc_report 22:22:56 INFO - PROCESS | 2591 | _x_x_mozilla_cycle_collect,1914 22:22:56 INFO - PROCESS | 2591 | __end_cc_report 22:22:56 INFO - PROCESS | 2591 | __startTimestamp1467868976015__endTimestamp 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | ------- Summary: start ------- 22:22:56 INFO - PROCESS | 2591 | Number of tests: 14 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.45 (2.2%) stddev-sans-first:1.32 22:22:56 INFO - PROCESS | 2591 | Values: 106.0 115.0 112.0 113.0 111.0 113.0 111.0 113.0 114.0 112.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:137.00 stddev:18.54 (13.5%) stddev-sans-first:18.71 22:22:56 INFO - PROCESS | 2591 | Values: 153.0 122.0 123.0 173.0 124.0 126.0 148.0 123.0 154.0 122.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 22:22:56 INFO - PROCESS | 2591 | Values: 161.0 163.0 162.0 161.0 161.0 160.0 164.0 162.0 162.0 161.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#3] audio-fft Cycles:10 Average:83.30 Median:77.00 stddev:13.19 (17.1%) stddev-sans-first:13.79 22:22:56 INFO - PROCESS | 2591 | Values: 77.0 77.0 76.0 114.0 87.0 77.0 75.0 75.0 99.0 76.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:86.00 stddev:17.85 (20.8%) stddev-sans-first:18.51 22:22:56 INFO - PROCESS | 2591 | Values: 86.0 86.0 117.0 87.0 86.0 86.0 131.0 85.0 85.0 118.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:22:56 INFO - PROCESS | 2591 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 22:22:56 INFO - PROCESS | 2591 | Values: 147.0 148.0 147.0 146.0 147.0 146.0 146.0 147.0 146.0 148.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 22:22:56 INFO - PROCESS | 2591 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 96.0 94.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 22:22:56 INFO - PROCESS | 2591 | Values: 64.0 63.0 65.0 65.0 65.0 64.0 64.0 65.0 64.0 64.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 22:22:56 INFO - PROCESS | 2591 | Values: 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:78.00 stddev:2.63 (3.4%) stddev-sans-first:2.74 22:22:56 INFO - PROCESS | 2591 | Values: 78.0 78.0 81.0 84.0 78.0 77.0 84.0 78.0 78.0 78.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:129.50 stddev:23.17 (17.9%) stddev-sans-first:24.55 22:22:56 INFO - PROCESS | 2591 | Values: 140.0 136.0 126.0 129.0 127.0 128.0 127.0 128.0 202.0 130.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.00 stddev:1.55 (0.9%) stddev-sans-first:1.64 22:22:56 INFO - PROCESS | 2591 | Values: 166.0 168.0 164.0 168.0 167.0 164.0 166.0 164.0 165.0 166.0 22:22:56 INFO - PROCESS | 2591 | 22:22:56 INFO - PROCESS | 2591 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.43 (2.1%) stddev-sans-first:1.51 22:22:56 INFO - PROCESS | 2591 | Values: 68.0 67.0 68.0 67.0 66.0 71.0 67.0 67.0 68.0 66.0 22:22:56 INFO - PROCESS | 2591 | -------- Summary: end -------- 22:22:56 INFO - PROCESS | 2591 | 22:22:57 INFO - TEST-INFO | 2591: exit 0 22:22:57 INFO - TEST-OK | kraken | took 63096ms 22:22:57 INFO - SUITE-END | took 1182s 22:22:57 INFO - Completed test suite (00:19:42) 22:22:57 INFO - javascript benchmark 22:22:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2667.653205083339, 2685.3555146764784, 2708.498927698376, 2720.1159623122476, 2725.8500782456967, 4691.43702755669, 4783.521647835215, 4855.80576776929, 4884.340614017106, 4933.58064564512, 4791.928121078178, 4804.567588916997, 4815.0610630926985, 4858.5384388483035, 4862.0275944811, 4355.607995280432, 4388.97805510972, 4458.66560007999, 4475.395821564096, 4602.815887364502, 4501.819927202924, 4539.59143677069, 4558.202314594932, 4572.382728331666, 4592.724436533818, 4301.548337424588, 4336.6530677545725, 4374.431323927901, 4410.889727756799, 4428.490723566799, 4367.71609845359, 4378.824847006116, 4390.912181756347, 4428.0, 4429.092036132617, 4387.780610969438, 4418.80115394808, 4421.182081314967, 4428.579284967923, 4460.754658493782, 4700.529947005306, 4732.455767586737, 4766.904661906777, 4793.808247670089, 4798.112349215371, 5149.201873709581, 5160.612954028463, 5205.791768329263, 5218.739063046833, 5226.216067589892, 5202.3497062867145, 5223.0, 5234.241035049935, 5241.42344342122, 5250.553702935255, 4716.268978308368, 4767.165745994437, 4834.444038935568, 4834.95165048352, 4843.56407923285, 5318.760655770499, 5354.892902142014, 5360.16917377807, 5396.7571459283645, 5421.810236641778, 5126.87182820425, 5163.432022477525, 5165.638405311592, 5172.0, 5172.922406163911, 5035.949640503622, 5156.948430515722, 5213.113770658997, 5218.712970786567, 5261.447548007404, 5123.923141152885, 5128.230765385148, 5151.871203219875, 5180.9740951295, 5185.455527169668, 4930.950690493121, 5093.821716239914, 5100.438951715309, 5105.0, 5105.821296254613, 4267.359896015622, 4278.828846846153, 4314.288142456522, 4318.3090705486975, 4356.194104090753, 3781.1681430085337, 3787.3182827090836, 3794.165283637595, 3831.8084095795098, 3833.271678381099, 4424.446944131983, 4428.712133711363, 4434.800433980478, 4440.200763862471, 4481.126180394792, 5070.949290507047, 5102.668326558762, 5125.846224613193, 5139.640225184276, 5162.380514338303, 4411.889702757457, 4424.181526417623, 4427.579379958899, 4430.667699922518, 4483.125790470892, 4518.983228773565, 4631.675782695179, 4641.002184530342, 4643.3731446255, 4696.365990591295, 4808.855734328045, 4871.123197824284, 4890.046440944124, 4893.877653058702, 4898.118338698926, 5181.0, 5186.662866913639, 5219.582433405394, 5224.947750522446, 5286.947130528645, 4759.6430267729365, 4839.830605928775, 4904.558589726942, 4917.041176970456, 4928.162212423825, 4972.552470277692, 5034.974825125851, 5041.395032596112, 5057.848264552069, 5085.110105731556, 5131.179011358165, 5146.485351464824, 5150.253213284128, 5153.149730294459, 5195.74021298926, 4839.443464001685, 4969.35398398206, 4987.650864439454, 5005.074061298671, 5021.1213037717525, 5039.395272567315, 5060.468650791614, 5062.417821950523, 5064.518870707424, 5096.821611243588, 4963.925541116959, 4967.4535801062575, 4969.503049695001, 5018.824341148188, 5020.472850350807, 4846.709197448165, 4850.223964165716, 4994.32576602154, 5054.620903432331, 5058.519440653132, 4780.95219047805, 4832.34763306949, 4881.463039065771, 4882.95117048825, 4936.777844996912], "value": 4731.241099373188, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2506029631331, 583.4224118123057, 585.0843430032003, 588.4938952500851, 589.8938191125598, 27285.45429091417, 39591.0, 40114.0, 40839.59160408395, 41044.0, 38221.617783822156, 38738.22523549527, 41789.37315940256, 41880.37179442303, 41995.79002104993, 7538.811529711774, 7816.765497035098, 8002.599870006506, 8011.439199256054, 8012.318952889012, 10009.849852252222, 10231.232657550676, 10235.488225588728, 10538.947305263462, 10547.947260263689, 10247.23145764067, 10352.948235258851, 10354.17166626668, 10362.844557331646, 10371.11845493134, 10134.746631334201, 10197.235207359403, 10200.693979180636, 10209.846852297147, 10211.285210035263, 10089.798204035878, 10148.188144948386, 10161.441120738356, 10165.0, 10165.644202452953, 39142.80428597839, 39390.60609393898, 39417.211655766725, 39438.40842387366, 39453.60546394528, 2751.2159034675224, 2841.2044627504333, 2842.4173044525824, 2992.0, 3258.9245548968784, 29684.8515757422, 30275.848620756755, 30700.8464957676, 30789.0, 31292.0, 3514.420120680085, 3516.314318707853, 3551.5027896094307, 3578.1233597768455, 3583.050491619723, 248525.0, 249030.0, 249167.0, 249689.0, 249907.0, 52272.0, 52548.05889558298, 52726.47273527215, 52743.47256527462, 52849.471505284455, 55533.72233138808, 55597.722011389684, 55649.165262520284, 55676.0, 55772.58615259216, 13504.257265850472, 13934.651633709238, 13946.721065578631, 13957.511487097903, 13965.23191224472, 9632.9036709632, 10315.071643552117, 10462.26764126519, 10581.523831427605, 10612.57549698019, 15325.770113448307, 15549.844501555066, 15566.143862087467, 15581.220938953007, 15671.216439177995, 4875.966606775929, 5578.944210557924, 5702.201691763156, 5727.5990680652785, 5802.158686990447, 797.6011994002998, 872.9738107856774, 917.2845180759018, 921.953902304882, 982.7641366072091, 26779.598306025426, 27981.951641191317, 28157.71842281592, 28449.857750711115, 28622.427551448855, 888.8888888888889, 963.2149797914677, 973.3575839945602, 983.6065573770549, 1020.4489575629226, 14392.0, 14859.70280594382, 15025.323860426308, 15259.694806103817, 15297.388104475918, 366349.0, 368094.0, 370868.0, 371562.0, 371890.0, 48190.27714584284, 48333.5166648336, 48427.515724843004, 48466.27300590494, 48470.5152948466, 1061.6072053340313, 1120.8486854274568, 1123.342844436014, 1164.7321116143335, 1203.1096988228649, 26253.34366640849, 29176.562351565168, 29954.0, 29987.250318742204, 29997.0, 43353.13293734171, 43699.0, 44114.55885441104, 44175.77912110419, 44219.55780442283, 370450.0, 371599.0, 372945.0, 373859.0, 375559.0, 32891.8355408231, 37027.0, 38094.0, 38168.2366352677, 41068.383974241005, 42372.57627423686, 42821.78589107034, 43273.78363108164, 43400.56599433965, 43503.78248108866, 35946.0, 36769.0, 37269.6273037277, 37318.0, 37606.62393376031, 36614.26771464609, 36620.63379366279, 36887.63112368842, 37383.626163738016, 37776.0, 36076.0, 36249.0, 36552.0, 36601.45097823482, 37033.259334813694, 32344.0, 33188.33623327568, 33532.66467335393, 33786.83106584451, 33804.83097584496, 23273.185438509572, 23526.294211173692, 23543.0, 23764.64353034671, 23795.167169148997], "value": 18118.043584950272, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.326430577192, 367.2050011724616, 367.5148803579275, 370.3722190886448, 381.990450238744, 13102.082854200198, 14028.368723407446, 15467.458638947654, 17419.82580174198, 17449.73825392617, 16603.584910377216, 16736.079515626636, 16760.32958681651, 16785.91607041963, 16799.0760508172, 4047.433359329696, 4970.4284007339165, 6034.788782392618, 6038.939610603904, 6154.3537928517535, 6043.516518678495, 6101.115338275948, 6101.847453813646, 6107.603005804608, 6108.8472788180425, 6073.60521566099, 6080.635161890279, 6083.239595050619, 6083.48290395317, 6087.2999605045325, 5063.18988961768, 5322.281491998569, 6057.363976782441, 6057.787977420791, 6062.575619706622, 5220.556252718486, 5307.28351672527, 5310.468953104697, 5311.468853114697, 5313.442088580682, 11716.882831171664, 11751.7062073448, 11780.941095294555, 11954.462049207807, 12173.573924912675, 1769.186174359796, 1881.520212345843, 1892.9053547322578, 2067.886266255355, 2215.8892055397328, 8793.340499462565, 8811.0, 8811.867821982676, 9204.631814727403, 9408.905910940872, 1773.1488885334982, 1887.8206570375792, 1918.0505649703346, 1974.5853370792152, 1975.1111999600093, 64979.0, 67920.6603966977, 72476.0, 72865.90701139487, 72979.0, 9944.602215911427, 10067.597296108073, 10103.595856165817, 10336.328138670962, 10409.167266618653, 13813.0, 13866.237356945263, 13884.791728123884, 13889.166650001032, 13900.235487048107, 7100.644967751592, 7166.570005799668, 7232.240614735482, 7233.0, 7238.674259658328, 6711.161104861892, 6758.0, 6816.147981502312, 6835.487338449636, 6958.512904096766, 4305.547917468683, 4353.390525326457, 4361.760103194355, 4363.192809330284, 4431.667624928079, 1761.3571046568168, 1795.0, 1826.8173182681626, 1830.3410772122024, 1853.8609604279734, 846.1200351634354, 846.504794695098, 900.7207765592556, 904.1500989070253, 909.5452273863068, 16335.346586136659, 16852.325906963582, 17205.397811076553, 17445.21496532659, 17890.0, 840.5881118252013, 865.1262225152516, 880.9559522023873, 888.138505649519, 903.2683526343683, 8797.560121993874, 9927.80144397108, 9950.104490595737, 9970.102690757722, 10056.145227655585, 398671.0, 402716.0, 438683.0, 443590.0, 444473.0, 82739.5863020681, 89051.55474222587, 89086.55456722675, 90504.5474772622, 90826.54586727024, 842.0568962761746, 873.5588527793424, 874.2612492443875, 874.873143394217, 917.0645941140133, 16148.757768633715, 16520.75218871742, 16638.75041874397, 16773.91613041976, 16982.0, 38861.41707874441, 38937.63718269847, 39092.804535977135, 39460.0, 39902.80048599738, 56109.43890561042, 56763.0, 57547.0, 57868.421315786305, 58021.0, 7211.278872112747, 7432.851342973218, 7529.8117547061765, 7620.123685776207, 7647.082350117799, 11301.830472542753, 11910.464029118537, 12121.333326667118, 12181.756364872475, 12229.633111006684, 10520.105791007543, 10696.946515267375, 10762.515686793957, 10770.623028193975, 10996.28524145928, 10519.947400263256, 10548.525316360628, 10621.0, 10625.415602141647, 10746.0, 10623.36259824413, 10665.200109991936, 10819.0, 10847.728806779895, 10880.238383313092, 7426.257374262531, 7625.733099341496, 7627.656755446129, 7639.04511936008, 7738.303552680286, 9927.702168934944, 10056.69829905104, 10183.79632407333, 10240.846387304346, 10562.735931601772], "value": 8298.923474645326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1155.1451925575066, 1369.2263870912936, 1410.1468611490047, 1498.3557070459706, 1729.481155653303, 6756.797296081113, 7422.814429639262, 7692.4999875008225, 7697.5766332851745, 7878.172791856844, 7817.335526480256, 7940.086890007651, 7960.641771120299, 7964.123946365895, 7966.083900351461, 2227.543353612514, 2249.460129568908, 2256.0524579676576, 2256.717910261217, 2256.8645881247176, 2138.433315171481, 2144.828413726898, 2154.1060459909118, 2162.1675654872906, 2188.2341180586745, 2148.709924160242, 2165.8808765517892, 2175.2930297653324, 2180.8364372672036, 2210.502636906699, 2126.521532655148, 2131.190147743863, 2132.029926383492, 2132.6374516332185, 2132.8507004509693, 2083.270855200683, 2126.3939777163587, 2127.2022991378235, 2128.0849234829016, 2128.4572434029224, 7747.380209583276, 7906.130325664172, 7964.323032542241, 7972.760817175494, 7983.72056978003, 4462.062966776981, 4534.659900507475, 4547.226971414834, 4560.908781824378, 4563.064571762814, 2806.2843974786297, 2870.7846911481724, 2912.4757543642136, 2912.7961042727015, 2917.416516696669, 905.97282081537, 924.1820988425292, 925.2644147902433, 936.9953150234273, 946.2288235088381, 10669.413182274971, 10713.785724285548, 10729.356238625707, 10766.24636275461, 10772.08437282832, 3947.9605203948167, 4085.632293093576, 4167.333226683777, 4191.8532851350665, 4195.58044195578, 8511.74464766058, 8545.871811922827, 8563.657453701782, 8563.871541926876, 8568.742937711879, 4486.147631949919, 4487.573680500347, 4511.503734589192, 4522.954770452254, 4528.252838281646, 3588.8385022674042, 3879.8642047528765, 4044.393340998815, 4164.5210800757695, 4166.416701661769, 3469.913252168716, 3498.8950331490096, 3547.308274886424, 3587.874424395186, 3600.477930700034, 1051.6529545250048, 1075.9664234596619, 1080.5569716416232, 1082.2640604388935, 1087.4127970895786, 724.822418507469, 773.5745340062942, 774.82953750176, 777.4208214879951, 790.1348023913805, 5152.613553983466, 5238.319018527567, 5380.139177731544, 5512.090505066619, 5642.971785141048, 794.8171920458327, 806.2139414071233, 810.9675612975533, 815.6696537902159, 822.6832669422196, 3363.4954756786187, 3415.692587667122, 3456.412409890325, 3476.11359103427, 3501.6148223695373, 9671.613135474503, 9852.310338276395, 10015.69952901414, 10144.137748291478, 10173.389596624227, 9909.950450247703, 9934.205263578897, 9943.45311007887, 9950.552225149886, 9973.750656233507, 7162.964185179041, 7271.34557889803, 7289.2346303638415, 7290.307420795016, 7300.926990730131, 5085.262636917552, 5176.741162941913, 5189.948100519097, 5222.947770522246, 5272.209168624737, 8983.775405614912, 9200.861987070333, 9249.768755781159, 9315.208207302185, 9356.391834530734, 9242.537873106183, 9310.301727370339, 9530.809383812424, 9548.522573871418, 9549.713508594754, 5789.884202316014, 6145.170401995673, 6339.746410143543, 6503.154589903283, 6620.0, 7567.962160189164, 7632.847343052997, 7638.847223055619, 7668.731594394169, 7732.536047837148, 6792.117024786944, 6875.0, 6927.099477068151, 7013.123359580052, 7066.364027237573, 6787.389134977876, 6793.048973143665, 6802.897956530755, 6875.759348422781, 6918.584884906922, 6179.721912513858, 6440.2915679276175, 6543.803685889431, 6604.9009264862025, 6618.371254730793, 4572.4055872736335, 4615.515370886009, 4670.78981445829, 4691.765411729468, 4764.737939413366, 4462.419885414875, 4501.504834468271, 4516.661250406167, 4576.58810707038, 4585.633149348111], "value": 4102.559674458341, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.98981535646254, 291.6165242705842, 298.11905818306906, 302.9910398373416, 309.64081665268293, 4606.33208184813, 4761.666683332168, 4800.8319708810195, 4858.149823780837, 4859.295402166684, 4576.405067341241, 4738.123447162277, 4741.814546363409, 4758.52414758524, 4769.546893045163, 3772.7547709398937, 3782.7919464429447, 3793.298239825627, 3800.6579407853287, 3820.319059613768, 3581.459972211948, 3641.7268704847243, 3799.886003419902, 3804.695624350059, 3818.8663396781117, 3744.9438258426144, 3752.287065457568, 3753.7935413552245, 3755.887323380289, 3760.210355825266, 3717.34946384383, 3730.160713839378, 3737.364648009845, 3745.6628903398823, 3752.549694036733, 3300.092474569489, 3310.0400883743687, 3310.6825222344214, 3320.4853247746637, 3350.2294472271515, 4617.561331673519, 4668.346431499593, 4678.596421073698, 4696.812127514895, 4750.4299484061785, 4270.615644592001, 4302.333138363559, 4302.397664326997, 4305.203537345601, 4310.4611923509565, 4843.443004054544, 4949.604031677457, 4989.625778066623, 5061.670991385585, 5066.189409694432, 3535.681788639035, 3551.5205447264807, 3554.7689400188906, 3566.144125409909, 3566.4828599853136, 5230.750777165817, 5266.815661451869, 5275.155975044013, 5291.259223708646, 5306.6550674206055, 3644.7448678592245, 3646.3983442732183, 3653.12325041988, 3682.6869716073898, 3682.8710995115043, 3558.5907620623443, 3685.668289853926, 3687.709301744368, 3693.0, 3700.703943684499, 4185.330347144503, 4222.704410691284, 4235.9621892636505, 4237.512686041145, 4254.29804082323, 5032.496750324938, 5037.471065538139, 5046.520580544842, 5087.338645976073, 5103.489651034941, 1193.3376975778353, 1204.265398107154, 1274.0381012335627, 1284.7045179608742, 1296.3971753134838, 859.1837754133599, 877.5656050255164, 878.4597472554461, 879.7096958003843, 884.9955750221336, 4418.4918734345965, 4428.202923473741, 4434.84478043267, 4441.555844415532, 4445.555444455528, 5140.278006867667, 5156.432792392834, 5163.586913046947, 5165.380154381498, 5178.352705911761, 4309.224339618899, 4394.2749446340995, 4406.008648054162, 4424.646028317727, 4424.867253982386, 2438.5122975404634, 2444.6821913151534, 2449.8407603505716, 2457.140000999636, 2471.7033955925403, 4345.587169218919, 4368.628666563378, 4370.169667763115, 4374.884404476838, 4395.582419670191, 4359.17175736609, 4668.719876807402, 4682.297655351725, 4696.225122854691, 4732.787024583902, 4342.89369655723, 4357.0196705740955, 4377.496587892433, 4390.978045109818, 4396.4064851244675, 4526.8189272428735, 4533.939590776279, 4584.541545845389, 4602.30965355186, 4615.23848564983, 4214.262504061839, 4423.8276856633665, 4443.289073748185, 4459.777011149365, 4537.410136682211, 4393.494748103881, 4412.852658308927, 4423.668224883082, 4437.312216606431, 4438.35643831649, 3303.207230264671, 3317.3365326934227, 3320.369129865318, 3324.5870505035746, 3435.230856109056, 4980.576650984562, 5136.434992150786, 5143.974280128576, 5147.433782284021, 5162.9741851292, 5014.991005396732, 5020.42265139499, 5020.598352131894, 5023.949760502494, 5024.949750502595, 4826.203676393497, 4986.8753281168265, 4989.25161225819, 5014.247862820606, 5028.220625803006, 4892.315075889307, 4908.165611845923, 4911.386076740408, 4924.901501970012, 4935.876603084808, 5009.5491405773655, 5024.522670346311, 5024.824131155392, 5030.37120359955, 5038.244263360525, 4654.790534425892, 4888.315635810918, 4894.314795928502, 4898.853034408973, 4902.803887844589], "value": 3690.9183471416973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.4466667332691, 603.1676286724321, 633.8890694128529, 645.8320836582487, 697.2922483679064, 12206.450709718061, 12560.874391256084, 12584.748305033894, 12653.367331633415, 12971.610851674464, 15219.619509512268, 15282.159481228528, 15352.155631440295, 15359.385624575032, 15374.69250614987, 557.8884223155364, 617.4813156948163, 774.2335088262622, 790.5296348672531, 790.9169537198597, 764.4343186042345, 765.1010063175775, 765.4832987733286, 765.4947734495234, 776.9728059517918, 806.0166596751953, 810.096742132521, 810.6473683947472, 810.7446154461326, 810.8905297784783, 644.1497223664765, 788.2669117720518, 803.3974519110667, 806.379088102161, 807.6930766308824, 591.624318557719, 593.6022864680674, 594.8275000249922, 594.9583529152961, 595.1013968906939, 11974.34141122238, 11986.820197697041, 12046.15676902617, 12050.276983381025, 12051.698707532294, 12185.878141218564, 12737.490500379974, 12790.872091279061, 13057.020723445685, 13213.075084744072, 10510.527026283835, 10550.103241224506, 10589.36463812166, 10686.893131068668, 10995.0, 3261.445554255782, 3290.8190049547266, 3300.8679652813858, 3311.536384906115, 3405.7786243894316, 64625.3537464624, 65233.3476665232, 65853.3414665852, 66337.66831165813, 66355.00467492992, 9439.716808495756, 9511.619535218513, 9601.37591056579, 9919.40483570988, 10286.022827831344, 17459.738103928452, 18016.0, 18022.5494362642, 18686.626267474574, 18983.52541186454, 6312.084747711556, 6441.64570948593, 6485.935140648628, 6650.467962562983, 6797.864042719118, 3682.5212722345923, 3694.224212915264, 3785.8296376663116, 3803.31540322739, 3828.9617103828605, 2902.8403437810703, 2998.9550156747664, 3005.0383877159097, 3007.2331555453657, 3007.6390833100168, 526.7129414469124, 538.3351560822381, 547.9479449452296, 550.7686771555956, 551.2558046637008, 373.54987240375283, 493.22563575186615, 517.3765612437004, 585.265491807787, 591.9023361145449, 8460.407771456063, 8549.187827156535, 8637.136286371313, 8850.690225842065, 8903.0, 537.4517991648497, 580.587782674306, 582.5252419278274, 600.3456232706371, 608.7260732670228, 4095.5699651536756, 4230.661547076226, 4291.442112525414, 4360.934585981149, 4369.541198174146, 90381.64427533593, 91166.54416728007, 91419.5429022864, 92445.0, 92514.53742731379, 77308.0, 80761.59619201867, 80955.59522202352, 83810.0, 84362.15637843544, 44140.77929610331, 44937.55062449399, 46215.0, 58119.70940145357, 75178.73748837638, 7339.082614673166, 7405.518641288299, 7548.660310285941, 7585.393168546393, 7630.465867389229, 41348.0, 43551.744523988236, 43778.562214378726, 44948.0, 45833.77083114563, 54304.0, 62367.6881615589, 62593.68703156455, 62722.0, 63878.0, 9322.207612353026, 9604.231661467205, 9727.513624318897, 9962.50187490608, 9968.152707019985, 10811.945940270249, 11007.724806879893, 11231.989120979151, 11573.0, 12243.387830608612, 10395.84406233892, 10440.738981525219, 10885.23803333759, 10971.23201375896, 11152.163587731115, 10671.039606435148, 10740.409277489813, 10921.344719316867, 10946.124310055016, 11132.1650876183, 10469.214808889212, 10502.632407865687, 10608.098311643596, 10983.945080274867, 11331.376774277494, 9253.86119208199, 9276.768080798034, 9430.52847357643, 9447.763805904908, 9564.378315409476, 9163.175314221751, 9238.538073096453, 9398.436093834393, 9447.0, 9634.566444509874], "value": 6323.826324256896, "unit": "score"}], "name": "dromaeo_css", "value": 6390.796570186024, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 112.0, 113.0, 111.0, 113.0, 111.0, 113.0, 114.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 123.0, 173.0, 124.0, 126.0, 148.0, 123.0, 154.0, 122.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 161.0, 161.0, 160.0, 164.0, 162.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 114.0, 87.0, 77.0, 75.0, 75.0, 99.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 117.0, 87.0, 86.0, 86.0, 131.0, 85.0, 85.0, 118.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 96.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 81.0, 84.0, 78.0, 77.0, 84.0, 78.0, 78.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 126.0, 129.0, 127.0, 128.0, 127.0, 128.0, 202.0, 130.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 164.0, 168.0, 167.0, 164.0, 166.0, 164.0, 165.0, 166.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 66.0, 71.0, 67.0, 67.0, 68.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1527.0, "alertThreshold": 2.0}]} 22:22:57 INFO - Return code: 0 22:22:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:22:57 INFO - # TBPL SUCCESS # 22:22:57 INFO - Running post-action listener: _resource_record_post_action 22:22:57 INFO - ##### 22:22:57 INFO - ##### Finished run-tests step (success) 22:22:57 INFO - ##### 22:22:57 INFO - Running post-run listener: _resource_record_post_run 22:22:57 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 539447296; Read time: 0; Write time: 427440 22:22:57 INFO - TinderboxPrint: CPU usage
13.0% 22:22:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:22:57 INFO - TinderboxPrint: I/O write bytes / time
539,447,296 / 427,440 22:22:57 INFO - TinderboxPrint: CPU idle
8,324.4 (87.0%) 22:22:57 INFO - TinderboxPrint: CPU user
1,205.2 (12.6%) 22:22:57 INFO - TinderboxPrint: Swap in / out
0 / 0 22:22:57 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 249704448; Read time: 0; Write time: 231264 22:22:57 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 289447936; Read time: 0; Write time: 196148 22:22:57 INFO - Running post-run listener: _upload_blobber_files 22:22:57 INFO - Blob upload gear active. 22:22:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:22:57 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 22:22:57 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'] 22:22:57 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 22:22:58 INFO - (blobuploader) - INFO - Open directory for files ... 22:22:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:22:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:22:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:22:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:22:59 INFO - (blobuploader) - INFO - Done attempting. 22:22:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:22:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:22:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:23:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:23:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:23:00 INFO - (blobuploader) - INFO - Done attempting. 22:23:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:23:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:23:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:23:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:23:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:23:03 INFO - (blobuploader) - INFO - Done attempting. 22:23:03 INFO - (blobuploader) - INFO - Iteration through files over. 22:23:03 INFO - Return code: 0 22:23:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:23:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:23:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/842be8971a9d902bff3f6784fc6853a252763d36000406410003d6f41dc1f184020195eedc78dd9fe3cfb7a0f73eff0022b71c1563f80a4eaaf3a94a2a1d9457", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9385daf83b67f5f69c7857600efb41ace6c3a89b4da1653426401b69c1f1a8d385e3679242e58dab8321f4b350709d3dc5f78a1683d0e8032c9591c366e94c29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cbe6860c57be2089ae7e793c0b737f1a67284b29de09a67a0f71fdc8c6dd3d62eb29a91b735b1c7f57be5255faf3b570430114c35e535138de3a498d29c67e4"} 22:23:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:23:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:23:03 INFO - Contents: 22:23:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/842be8971a9d902bff3f6784fc6853a252763d36000406410003d6f41dc1f184020195eedc78dd9fe3cfb7a0f73eff0022b71c1563f80a4eaaf3a94a2a1d9457", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9385daf83b67f5f69c7857600efb41ace6c3a89b4da1653426401b69c1f1a8d385e3679242e58dab8321f4b350709d3dc5f78a1683d0e8032c9591c366e94c29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cbe6860c57be2089ae7e793c0b737f1a67284b29de09a67a0f71fdc8c6dd3d62eb29a91b735b1c7f57be5255faf3b570430114c35e535138de3a498d29c67e4"} 22:23:03 INFO - Running post-run listener: copy_logs_to_upload_dir 22:23:03 INFO - Copying logs to upload dir... 22:23:03 INFO - mkdir: /builds/slave/test/build/upload/logs 22:23:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.763538 ========= master_lag: 491.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 48 secs) (at 2016-07-06 22:31:14.518456) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-07-06 22:31:14.523394) ========= 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=0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030 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/842be8971a9d902bff3f6784fc6853a252763d36000406410003d6f41dc1f184020195eedc78dd9fe3cfb7a0f73eff0022b71c1563f80a4eaaf3a94a2a1d9457", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9385daf83b67f5f69c7857600efb41ace6c3a89b4da1653426401b69c1f1a8d385e3679242e58dab8321f4b350709d3dc5f78a1683d0e8032c9591c366e94c29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cbe6860c57be2089ae7e793c0b737f1a67284b29de09a67a0f71fdc8c6dd3d62eb29a91b735b1c7f57be5255faf3b570430114c35e535138de3a498d29c67e4"} build_url:https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/Vb5nUXjkTkeRog4ekCGcKg/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/842be8971a9d902bff3f6784fc6853a252763d36000406410003d6f41dc1f184020195eedc78dd9fe3cfb7a0f73eff0022b71c1563f80a4eaaf3a94a2a1d9457", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9385daf83b67f5f69c7857600efb41ace6c3a89b4da1653426401b69c1f1a8d385e3679242e58dab8321f4b350709d3dc5f78a1683d0e8032c9591c366e94c29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cbe6860c57be2089ae7e793c0b737f1a67284b29de09a67a0f71fdc8c6dd3d62eb29a91b735b1c7f57be5255faf3b570430114c35e535138de3a498d29c67e4"}' ========= master_lag: 2.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-07-06 22:31:16.633454) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 mins, 46 secs) (at 2016-07-06 22:31:16.633743) ========= 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=0333a256a5e4f052382dd180000001b1-1467867743.785987-714778030 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 286.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 mins, 46 secs) (at 2016-07-06 22:36:02.744935) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 22:36:02.745277) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 22:36:03.358817) ========= ========= Total master_lag: 779.33 =========