builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1468611842.03 results: success (0) buildid: 20160715083029 builduid: 19e194236067401a990142cf982e9592 revision: 2f9e69c982f1e67887a1834b36ff0af4ababb3af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:02.031558) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:02.032074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:02.032414) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:02.057357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:02.057701) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 12:44:02-- 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% 42.7M=0s 2016-07-15 12:44:02 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087037 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:02.161664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:02.162392) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015143 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:02.217846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:02.218654) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f9e69c982f1e67887a1834b36ff0af4ababb3af --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 2f9e69c982f1e67887a1834b36ff0af4ababb3af --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 12:44:02,479 truncating revision to first 12 chars 2016-07-15 12:44:02,479 Setting DEBUG logging. 2016-07-15 12:44:02,479 attempt 1/10 2016-07-15 12:44:02,479 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f9e69c982f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 12:44:02,895 unpacking tar archive at: fx-team-2f9e69c982f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.794799 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:03.032295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:03.032919) ========= script_repo_revision: 2f9e69c982f1e67887a1834b36ff0af4ababb3af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:03.033673) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:03.034305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 12:44:03.045808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-15 12:44:03.046161) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:44:03 INFO - MultiFileLogger online at 20160715 12:44:03 in /builds/slave/test 12:44:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:44:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:44:03 INFO - {'append_to_log': False, 12:44:03 INFO - 'base_work_dir': '/builds/slave/test', 12:44:03 INFO - 'blob_upload_branch': 'Fx-Team', 12:44:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:44:03 INFO - 'branch': 'Fx-Team', 12:44:03 INFO - 'buildbot_json_path': 'buildprops.json', 12:44:03 INFO - 'config_files': ('talos/linux_config.py',), 12:44:03 INFO - 'default_actions': ('clobber', 12:44:03 INFO - 'read-buildbot-config', 12:44:03 INFO - 'download-and-extract', 12:44:03 INFO - 'populate-webroot', 12:44:03 INFO - 'create-virtualenv', 12:44:03 INFO - 'install', 12:44:03 INFO - 'run-tests'), 12:44:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:44:03 INFO - 'download_minidump_stackwalk': True, 12:44:03 INFO - 'download_symbols': 'ondemand', 12:44:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:44:03 INFO - 'tooltool.py': '/tools/tooltool.py', 12:44:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:44:03 INFO - '/tools/misc-python/virtualenv.py')}, 12:44:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:44:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:44:03 INFO - 'installer_path': 'installer.exe', 12:44:03 INFO - 'log_level': 'info', 12:44:03 INFO - 'log_name': 'talos', 12:44:03 INFO - 'log_to_console': True, 12:44:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:44:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:44:03 INFO - 'opt_config_files': (), 12:44:03 INFO - 'pip_index': False, 12:44:03 INFO - 'sps_profile': False, 12:44:03 INFO - 'sps_profile_interval': 0, 12:44:03 INFO - 'suite': 'dromaeojs-e10s', 12:44:03 INFO - 'system_bits': '32', 12:44:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:44:03 INFO - 'title': 'talos-linux64-ix-022', 12:44:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:44:03 INFO - 'use_talos_json': True, 12:44:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:44:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:44:03 INFO - 'work_dir': 'build'} 12:44:03 INFO - ##### 12:44:03 INFO - ##### Running clobber step. 12:44:03 INFO - ##### 12:44:03 INFO - Running pre-action listener: _resource_record_pre_action 12:44:03 INFO - Running main action method: clobber 12:44:03 INFO - rmtree: /builds/slave/test/build 12:44:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:44:03 INFO - Running post-action listener: _resource_record_post_action 12:44:03 INFO - ##### 12:44:03 INFO - ##### Finished clobber step (success) 12:44:03 INFO - ##### 12:44:03 INFO - ##### 12:44:03 INFO - ##### Running read-buildbot-config step. 12:44:03 INFO - ##### 12:44:03 INFO - Running pre-action listener: _resource_record_pre_action 12:44:03 INFO - Running main action method: read_buildbot_config 12:44:03 INFO - Using buildbot properties: 12:44:03 INFO - { 12:44:03 INFO - "project": "", 12:44:03 INFO - "product": "firefox", 12:44:03 INFO - "script_repo_revision": "production", 12:44:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:44:03 INFO - "repository": "", 12:44:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:44:03 INFO - "buildid": "20160715083029", 12:44:03 INFO - "pgo_build": "True", 12:44:03 INFO - "basedir": "/builds/slave/test", 12:44:03 INFO - "buildnumber": 927, 12:44:03 INFO - "slavename": "talos-linux64-ix-022", 12:44:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:44:03 INFO - "platform": "ubuntu64_hw", 12:44:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:44:03 INFO - "branch": "fx-team", 12:44:03 INFO - "repo_path": "integration/fx-team", 12:44:03 INFO - "revision": "2f9e69c982f1e67887a1834b36ff0af4ababb3af", 12:44:03 INFO - "stage_platform": "linux64-pgo", 12:44:03 INFO - "builduid": "19e194236067401a990142cf982e9592", 12:44:03 INFO - "slavebuilddir": "test" 12:44:03 INFO - } 12:44:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:44:03 INFO - Running post-action listener: _resource_record_post_action 12:44:03 INFO - ##### 12:44:03 INFO - ##### Finished read-buildbot-config step (success) 12:44:03 INFO - ##### 12:44:03 INFO - ##### 12:44:03 INFO - ##### Running download-and-extract step. 12:44:03 INFO - ##### 12:44:03 INFO - Running pre-action listener: _resource_record_pre_action 12:44:03 INFO - Running main action method: download_and_extract 12:44:03 INFO - mkdir: /builds/slave/test/build/tests 12:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:03 INFO - https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/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 12:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/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 12:44:05 INFO - Downloaded 1361 bytes. 12:44:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:44:05 INFO - Using the following test package requirements: 12:44:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:44:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:44:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:44:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:05 INFO - u'jsshell-linux-x86_64.zip'], 12:44:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:44:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:44:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:44:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:44:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:44:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:44:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:44:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:05 INFO - https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:44:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:44:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:44:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/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 12:44:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/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 12:44:06 INFO - Downloaded 24325868 bytes. 12:44:06 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'] 12:44:06 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 12:44:07 INFO - Return code: 0 12:44:07 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 12:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:07 INFO - https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:44:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:44:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:44:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/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 12:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/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 12:44:08 INFO - Downloaded 24325868 bytes. 12:44:08 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'] 12:44:08 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 12:44:09 INFO - Return code: 0 12:44:09 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')]} 12:44:09 INFO - https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:44:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:44:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:44:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/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 12:44:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/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 12:44:10 INFO - Downloaded 14403317 bytes. 12:44:10 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'] 12:44:10 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 12:44:11 INFO - Return code: 0 12:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:11 INFO - https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:44:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:44:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:44:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/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 12:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0jm4NDASJ-u0Hcv6KASMg/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 12:44:12 INFO - Downloaded 60800128 bytes. 12:44:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:44:12 INFO - mkdir: /builds/slave/test/properties 12:44:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:44:12 INFO - Writing to file /builds/slave/test/properties/build_url 12:44:12 INFO - Contents: 12:44:12 INFO - build_url:https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:44:13 INFO - Running post-action listener: _resource_record_post_action 12:44:13 INFO - Running post-action listener: set_extra_try_arguments 12:44:13 INFO - ##### 12:44:13 INFO - ##### Finished download-and-extract step (success) 12:44:13 INFO - ##### 12:44:13 INFO - ##### 12:44:13 INFO - ##### Running populate-webroot step. 12:44:13 INFO - ##### 12:44:13 INFO - Running pre-action listener: _resource_record_pre_action 12:44:13 INFO - Running main action method: populate_webroot 12:44:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:44:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:44:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:44:13 INFO - '--tppagecycles', 12:44:13 INFO - '7'], 12:44:13 INFO - 'tests': ['tsvgm']}}, 12:44:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:44:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:44:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:44:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:44:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:13 INFO - 'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:44:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:44:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:13 INFO - 'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['damp', 'tps']}, 12:44:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:13 INFO - 'tests': ['damp', 'tps']}, 12:44:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['dromaeo_dom']}, 12:44:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:44:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['basic_compositor_video']}, 12:44:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:44:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['a11yr', 12:44:13 INFO - 'ts_paint', 12:44:13 INFO - 'tpaint', 12:44:13 INFO - 'sessionrestore', 12:44:13 INFO - 'sessionrestore_no_auto_restore', 12:44:13 INFO - 'tabpaint']}, 12:44:13 INFO - 'other-e10s': {'tests': ['a11yr', 12:44:13 INFO - 'ts_paint', 12:44:13 INFO - 'tpaint', 12:44:13 INFO - 'sessionrestore', 12:44:13 INFO - 'sessionrestore_no_auto_restore', 12:44:13 INFO - 'tabpaint']}, 12:44:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:44:13 INFO - 'ts_paint', 12:44:13 INFO - 'tpaint', 12:44:13 INFO - 'sessionrestore', 12:44:13 INFO - 'sessionrestore_no_auto_restore', 12:44:13 INFO - 'tabpaint']}, 12:44:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:44:13 INFO - 'ts_paint', 12:44:13 INFO - 'tpaint', 12:44:13 INFO - 'sessionrestore', 12:44:13 INFO - 'sessionrestore_no_auto_restore', 12:44:13 INFO - 'tabpaint']}, 12:44:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['a11yr', 12:44:13 INFO - 'ts_paint', 12:44:13 INFO - 'tpaint', 12:44:13 INFO - 'sessionrestore', 12:44:13 INFO - 'sessionrestore_no_auto_restore', 12:44:13 INFO - 'tabpaint']}, 12:44:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['a11yr', 12:44:13 INFO - 'ts_paint', 12:44:13 INFO - 'tpaint', 12:44:13 INFO - 'sessionrestore', 12:44:13 INFO - 'sessionrestore_no_auto_restore', 12:44:13 INFO - 'tabpaint']}, 12:44:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['tsvgx', 12:44:13 INFO - 'tsvgr_opacity', 12:44:13 INFO - 'tart', 12:44:13 INFO - 'tscrollx', 12:44:13 INFO - 'cart']}, 12:44:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:44:13 INFO - 'tsvgr_opacity', 12:44:13 INFO - 'tart', 12:44:13 INFO - 'tscrollx', 12:44:13 INFO - 'cart']}, 12:44:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:13 INFO - 'talos_options': ['--disable-e10s'], 12:44:13 INFO - 'tests': ['tp5o']}, 12:44:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:13 INFO - 'tests': ['tp5o']}, 12:44:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:13 INFO - 'talos_options': ['--disable-e10s', 12:44:13 INFO - '--xperf_path', 12:44:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:44:13 INFO - 'tests': ['tp5n']}, 12:44:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:13 INFO - 'talos_options': ['--xperf_path', 12:44:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:44:13 INFO - 'tests': ['tp5n']}}, 12:44:13 INFO - 'talos.zip': {'path': '', 12:44:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:44:13 INFO - Running post-action listener: _resource_record_post_action 12:44:13 INFO - ##### 12:44:13 INFO - ##### Finished populate-webroot step (success) 12:44:13 INFO - ##### 12:44:13 INFO - ##### 12:44:13 INFO - ##### Running create-virtualenv step. 12:44:13 INFO - ##### 12:44:13 INFO - Running pre-action listener: _resource_record_pre_action 12:44:13 INFO - Running main action method: create_virtualenv 12:44:13 INFO - Creating virtualenv /builds/slave/test/build/venv 12:44:13 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 12:44:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:44:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:44:13 INFO - Using real prefix '/usr' 12:44:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:44:14 INFO - Installing distribute.............................................................................................................................................................................................done. 12:44:16 INFO - Installing pip.................done. 12:44:16 INFO - Return code: 0 12:44:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:44:16 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')]} 12:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:16 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')]} 12:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:16 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 0x21d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f3b0>, '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 0x24902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', '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 12:44:16 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 12:44:16 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 12:44:16 INFO - Using env: {'DISPLAY': ':0', 12:44:16 INFO - 'HOME': '/home/cltbld', 12:44:16 INFO - 'LANG': 'en_US.UTF-8', 12:44:16 INFO - 'LANGUAGE': 'en_US:en', 12:44:16 INFO - 'LOGNAME': 'cltbld', 12:44:16 INFO - 'MAIL': '/var/mail/cltbld', 12:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:16 INFO - 'MOZ_NO_REMOTE': '1', 12:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:16 INFO - 'NO_EM_RESTART': '1', 12:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:16 INFO - 'PWD': '/builds/slave/test', 12:44:16 INFO - 'SHELL': '/bin/bash', 12:44:16 INFO - 'SHLVL': '1', 12:44:16 INFO - 'TERM': 'linux', 12:44:16 INFO - 'TMOUT': '86400', 12:44:16 INFO - 'USER': 'cltbld', 12:44:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', 12:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:16 INFO - '_': '/tools/buildbot/bin/python'} 12:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:16 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 12:44:16 INFO - Cleaning up... 12:44:16 INFO - Return code: 0 12:44:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:44:16 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')]} 12:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:16 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')]} 12:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:16 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 0x21d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f3b0>, '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 0x24902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', '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 12:44:16 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 12:44:16 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 12:44:16 INFO - Using env: {'DISPLAY': ':0', 12:44:16 INFO - 'HOME': '/home/cltbld', 12:44:16 INFO - 'LANG': 'en_US.UTF-8', 12:44:16 INFO - 'LANGUAGE': 'en_US:en', 12:44:16 INFO - 'LOGNAME': 'cltbld', 12:44:16 INFO - 'MAIL': '/var/mail/cltbld', 12:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:16 INFO - 'MOZ_NO_REMOTE': '1', 12:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:16 INFO - 'NO_EM_RESTART': '1', 12:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:16 INFO - 'PWD': '/builds/slave/test', 12:44:16 INFO - 'SHELL': '/bin/bash', 12:44:16 INFO - 'SHLVL': '1', 12:44:16 INFO - 'TERM': 'linux', 12:44:16 INFO - 'TMOUT': '86400', 12:44:16 INFO - 'USER': 'cltbld', 12:44:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', 12:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:16 INFO - '_': '/tools/buildbot/bin/python'} 12:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:16 INFO - Downloading/unpacking psutil>=3.1.1 12:44:16 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 12:44:16 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 12:44:16 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 12:44:16 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 12:44:16 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 12:44:16 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 12:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:44:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:44:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:44:18 INFO - Installing collected packages: psutil 12:44:18 INFO - Running setup.py install for psutil 12:44:18 INFO - building 'psutil._psutil_linux' extension 12:44:18 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 12:44:18 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 12:44:18 INFO - building 'psutil._psutil_posix' extension 12:44:18 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 12:44:18 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 12:44:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:44:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:44:18 INFO - Successfully installed psutil 12:44:18 INFO - Cleaning up... 12:44:19 INFO - Return code: 0 12:44:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:44:19 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')]} 12:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:19 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')]} 12:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:19 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 0x21d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f3b0>, '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 0x24902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', '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 12:44:19 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 12:44:19 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 12:44:19 INFO - Using env: {'DISPLAY': ':0', 12:44:19 INFO - 'HOME': '/home/cltbld', 12:44:19 INFO - 'LANG': 'en_US.UTF-8', 12:44:19 INFO - 'LANGUAGE': 'en_US:en', 12:44:19 INFO - 'LOGNAME': 'cltbld', 12:44:19 INFO - 'MAIL': '/var/mail/cltbld', 12:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:19 INFO - 'MOZ_NO_REMOTE': '1', 12:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:19 INFO - 'NO_EM_RESTART': '1', 12:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:19 INFO - 'PWD': '/builds/slave/test', 12:44:19 INFO - 'SHELL': '/bin/bash', 12:44:19 INFO - 'SHLVL': '1', 12:44:19 INFO - 'TERM': 'linux', 12:44:19 INFO - 'TMOUT': '86400', 12:44:19 INFO - 'USER': 'cltbld', 12:44:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', 12:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:19 INFO - '_': '/tools/buildbot/bin/python'} 12:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:44:19 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 12:44:19 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 12:44:19 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 12:44:19 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 12:44:19 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 12:44:19 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 12:44:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:44:21 INFO - Installing collected packages: mozsystemmonitor 12:44:21 INFO - Running setup.py install for mozsystemmonitor 12:44:21 INFO - Successfully installed mozsystemmonitor 12:44:21 INFO - Cleaning up... 12:44:21 INFO - Return code: 0 12:44:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f3b0>, '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 0x24902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', '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 12:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:44:21 INFO - Using env: {'DISPLAY': ':0', 12:44:21 INFO - 'HOME': '/home/cltbld', 12:44:21 INFO - 'LANG': 'en_US.UTF-8', 12:44:21 INFO - 'LANGUAGE': 'en_US:en', 12:44:21 INFO - 'LOGNAME': 'cltbld', 12:44:21 INFO - 'MAIL': '/var/mail/cltbld', 12:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:21 INFO - 'MOZ_NO_REMOTE': '1', 12:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:21 INFO - 'NO_EM_RESTART': '1', 12:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:21 INFO - 'PWD': '/builds/slave/test', 12:44:21 INFO - 'SHELL': '/bin/bash', 12:44:21 INFO - 'SHLVL': '1', 12:44:21 INFO - 'TERM': 'linux', 12:44:21 INFO - 'TMOUT': '86400', 12:44:21 INFO - 'USER': 'cltbld', 12:44:21 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', 12:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:21 INFO - '_': '/tools/buildbot/bin/python'} 12:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:21 INFO - Downloading/unpacking jsonschema==2.5.1 12:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:44:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:23 INFO - Downloading functools32-3.2.3-2.tar.gz 12:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:44:23 INFO - warning: no files found matching '*.txt' 12:44:23 INFO - no previously-included directories found matching 'build' 12:44:23 INFO - no previously-included directories found matching 'dist' 12:44:23 INFO - no previously-included directories found matching '.git*' 12:44:23 INFO - Installing collected packages: jsonschema, functools32 12:44:23 INFO - Running setup.py install for functools32 12:44:23 INFO - warning: no files found matching '*.txt' 12:44:23 INFO - no previously-included directories found matching 'build' 12:44:23 INFO - no previously-included directories found matching 'dist' 12:44:23 INFO - no previously-included directories found matching '.git*' 12:44:23 INFO - Successfully installed jsonschema functools32 12:44:23 INFO - Cleaning up... 12:44:23 INFO - Return code: 0 12:44:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f3b0>, '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 0x24902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', '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 12:44:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:44:23 INFO - Using env: {'DISPLAY': ':0', 12:44:23 INFO - 'HOME': '/home/cltbld', 12:44:23 INFO - 'LANG': 'en_US.UTF-8', 12:44:23 INFO - 'LANGUAGE': 'en_US:en', 12:44:23 INFO - 'LOGNAME': 'cltbld', 12:44:23 INFO - 'MAIL': '/var/mail/cltbld', 12:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:23 INFO - 'MOZ_NO_REMOTE': '1', 12:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:23 INFO - 'NO_EM_RESTART': '1', 12:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:23 INFO - 'PWD': '/builds/slave/test', 12:44:23 INFO - 'SHELL': '/bin/bash', 12:44:23 INFO - 'SHLVL': '1', 12:44:23 INFO - 'TERM': 'linux', 12:44:23 INFO - 'TMOUT': '86400', 12:44:23 INFO - 'USER': 'cltbld', 12:44:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', 12:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:23 INFO - '_': '/tools/buildbot/bin/python'} 12:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:24 INFO - Downloading/unpacking blobuploader==1.2.4 12:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:26 INFO - Downloading blobuploader-1.2.4.tar.gz 12:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:44:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:44:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:26 INFO - Downloading docopt-0.6.1.tar.gz 12:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:44:26 INFO - Installing collected packages: blobuploader, requests, docopt 12:44:26 INFO - Running setup.py install for blobuploader 12:44:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:44:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:44:26 INFO - Running setup.py install for requests 12:44:27 INFO - Running setup.py install for docopt 12:44:27 INFO - Successfully installed blobuploader requests docopt 12:44:27 INFO - Cleaning up... 12:44:27 INFO - Return code: 0 12:44:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:44: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')]} 12:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44: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')]} 12:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:27 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 0x21d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f3b0>, '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 0x24902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', '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 12:44:27 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 12:44:27 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 12:44:27 INFO - Using env: {'DISPLAY': ':0', 12:44:27 INFO - 'HOME': '/home/cltbld', 12:44:27 INFO - 'LANG': 'en_US.UTF-8', 12:44:27 INFO - 'LANGUAGE': 'en_US:en', 12:44:27 INFO - 'LOGNAME': 'cltbld', 12:44:27 INFO - 'MAIL': '/var/mail/cltbld', 12:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:27 INFO - 'MOZ_NO_REMOTE': '1', 12:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:27 INFO - 'NO_EM_RESTART': '1', 12:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:27 INFO - 'PWD': '/builds/slave/test', 12:44:27 INFO - 'SHELL': '/bin/bash', 12:44:27 INFO - 'SHLVL': '1', 12:44:27 INFO - 'TERM': 'linux', 12:44:27 INFO - 'TMOUT': '86400', 12:44:27 INFO - 'USER': 'cltbld', 12:44:27 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', 12:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:27 INFO - '_': '/tools/buildbot/bin/python'} 12:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:44:27 INFO - Running setup.py (path:/tmp/pip-tLZkp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:44:27 INFO - Running setup.py (path:/tmp/pip-pNzxLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:44:27 INFO - Running setup.py (path:/tmp/pip-4Q3p2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:44:27 INFO - Running setup.py (path:/tmp/pip-bDyvrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:44:27 INFO - Running setup.py (path:/tmp/pip-7nME0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:44:27 INFO - Running setup.py (path:/tmp/pip-emIJJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:44:28 INFO - Running setup.py (path:/tmp/pip-oVImeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:44:28 INFO - Running setup.py (path:/tmp/pip-_V2jK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:44:28 INFO - Running setup.py (path:/tmp/pip-pAbg1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:44:28 INFO - Running setup.py (path:/tmp/pip-UCTTMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:44:28 INFO - Running setup.py (path:/tmp/pip-xSp0Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:44:28 INFO - Running setup.py (path:/tmp/pip-_cqOje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:44:28 INFO - Running setup.py (path:/tmp/pip-x6aiHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:44:28 INFO - Running setup.py (path:/tmp/pip-qGy3L0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:28 INFO - Running setup.py (path:/tmp/pip-q6hULs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:44:28 INFO - Running setup.py (path:/tmp/pip-9w_XUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:44:28 INFO - Running setup.py (path:/tmp/pip-vAuPNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:44:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:44:28 INFO - Running setup.py install for manifestparser 12:44:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:44:28 INFO - Running setup.py install for mozcrash 12:44:29 INFO - Running setup.py install for mozdebug 12:44:29 INFO - Running setup.py install for mozdevice 12:44:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:44:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:44:29 INFO - Running setup.py install for mozfile 12:44:29 INFO - Running setup.py install for mozhttpd 12:44:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:44:29 INFO - Running setup.py install for mozinfo 12:44:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:44:29 INFO - Running setup.py install for mozInstall 12:44:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:44:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:44:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:44:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:44:29 INFO - Running setup.py install for mozleak 12:44:29 INFO - Running setup.py install for mozlog 12:44:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:44:29 INFO - Running setup.py install for moznetwork 12:44:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:44:29 INFO - Running setup.py install for mozprocess 12:44:30 INFO - Running setup.py install for mozprofile 12:44:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:44:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:44:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:44:30 INFO - Running setup.py install for mozrunner 12:44:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:44:30 INFO - Running setup.py install for mozscreenshot 12:44:30 INFO - Running setup.py install for moztest 12:44:30 INFO - Running setup.py install for mozversion 12:44:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:44:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:44:30 INFO - Cleaning up... 12:44:30 INFO - Return code: 0 12:44:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:44: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')]} 12:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44: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')]} 12:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:30 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 0x21d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f3b0>, '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 0x24902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', '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 12:44:30 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 12:44:30 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 12:44:30 INFO - Using env: {'DISPLAY': ':0', 12:44:30 INFO - 'HOME': '/home/cltbld', 12:44:30 INFO - 'LANG': 'en_US.UTF-8', 12:44:30 INFO - 'LANGUAGE': 'en_US:en', 12:44:30 INFO - 'LOGNAME': 'cltbld', 12:44:30 INFO - 'MAIL': '/var/mail/cltbld', 12:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:30 INFO - 'MOZ_NO_REMOTE': '1', 12:44:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:30 INFO - 'NO_EM_RESTART': '1', 12:44:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:30 INFO - 'PWD': '/builds/slave/test', 12:44:30 INFO - 'SHELL': '/bin/bash', 12:44:30 INFO - 'SHLVL': '1', 12:44:30 INFO - 'TERM': 'linux', 12:44:30 INFO - 'TMOUT': '86400', 12:44:30 INFO - 'USER': 'cltbld', 12:44:30 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', 12:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:30 INFO - '_': '/tools/buildbot/bin/python'} 12:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:44:30 INFO - Running setup.py (path:/tmp/pip-pV3YC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:44:30 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)) 12:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:44:30 INFO - Running setup.py (path:/tmp/pip-bbI4gM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:44:30 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)) 12:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:44:30 INFO - Running setup.py (path:/tmp/pip-TimXEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:44:31 INFO - Running setup.py (path:/tmp/pip-agNGLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:44:31 INFO - Running setup.py (path:/tmp/pip-x4Pmuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:44:31 INFO - Running setup.py (path:/tmp/pip-y4Item-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:44:31 INFO - Running setup.py (path:/tmp/pip-FA7_mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:44:31 INFO - Running setup.py (path:/tmp/pip-yN6Adx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:44:31 INFO - Running setup.py (path:/tmp/pip-8pDunR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:44:31 INFO - Running setup.py (path:/tmp/pip-URgp47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:44:31 INFO - Running setup.py (path:/tmp/pip-Sal9vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:44:31 INFO - Running setup.py (path:/tmp/pip-2EHw1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:44:31 INFO - Running setup.py (path:/tmp/pip-Qb_z72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:44:31 INFO - Running setup.py (path:/tmp/pip-Evl9gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:31 INFO - Running setup.py (path:/tmp/pip-LAQumC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:44:31 INFO - Running setup.py (path:/tmp/pip-zaiORY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:44:31 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)) 12:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:44:31 INFO - Running setup.py (path:/tmp/pip-qNY61y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:44:32 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)) 12:44:32 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)) 12:44:32 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)) 12:44:32 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)) 12:44:32 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)) 12:44:32 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)) 12:44:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:44:32 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 12:44:32 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 12:44:32 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 12:44:32 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 12:44:32 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 12:44:32 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 12:44:33 INFO - Downloading blessings-1.6.tar.gz 12:44:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:44:34 INFO - Installing collected packages: blessings 12:44:34 INFO - Running setup.py install for blessings 12:44:34 INFO - Successfully installed blessings 12:44:34 INFO - Cleaning up... 12:44:34 INFO - Return code: 0 12:44:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:44:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:44:34 INFO - Reading from file tmpfile_stdout 12:44:34 INFO - Current package versions: 12:44:34 INFO - argparse == 1.2.1 12:44:34 INFO - blessings == 1.6 12:44:34 INFO - blobuploader == 1.2.4 12:44:34 INFO - docopt == 0.6.1 12:44:34 INFO - functools32 == 3.2.3-2 12:44:34 INFO - jsonschema == 2.5.1 12:44:34 INFO - manifestparser == 1.1 12:44:34 INFO - mozInstall == 1.12 12:44:34 INFO - mozcrash == 0.17 12:44:34 INFO - mozdebug == 0.1 12:44:34 INFO - mozdevice == 0.48 12:44:34 INFO - mozfile == 1.2 12:44:34 INFO - mozhttpd == 0.7 12:44:34 INFO - mozinfo == 0.9 12:44:34 INFO - mozleak == 0.1 12:44:34 INFO - mozlog == 3.2 12:44:34 INFO - moznetwork == 0.27 12:44:34 INFO - mozprocess == 0.23 12:44:34 INFO - mozprofile == 0.28 12:44:34 INFO - mozrunner == 6.12 12:44:34 INFO - mozscreenshot == 0.1 12:44:34 INFO - mozsystemmonitor == 0.3 12:44:34 INFO - moztest == 0.7 12:44:34 INFO - mozversion == 1.4 12:44:34 INFO - psutil == 3.1.1 12:44:34 INFO - requests == 1.2.3 12:44:34 INFO - wsgiref == 0.1.2 12:44:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:44:34 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')]} 12:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:34 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')]} 12:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:34 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 0x21d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f3b0>, '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 0x24902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', '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 12:44:34 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 12:44:34 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 12:44:34 INFO - Using env: {'DISPLAY': ':0', 12:44:34 INFO - 'HOME': '/home/cltbld', 12:44:34 INFO - 'LANG': 'en_US.UTF-8', 12:44:34 INFO - 'LANGUAGE': 'en_US:en', 12:44:34 INFO - 'LOGNAME': 'cltbld', 12:44:34 INFO - 'MAIL': '/var/mail/cltbld', 12:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:34 INFO - 'MOZ_NO_REMOTE': '1', 12:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:34 INFO - 'NO_EM_RESTART': '1', 12:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:34 INFO - 'PWD': '/builds/slave/test', 12:44:34 INFO - 'SHELL': '/bin/bash', 12:44:34 INFO - 'SHLVL': '1', 12:44:34 INFO - 'TERM': 'linux', 12:44:34 INFO - 'TMOUT': '86400', 12:44:34 INFO - 'USER': 'cltbld', 12:44:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', 12:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:34 INFO - '_': '/tools/buildbot/bin/python'} 12:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:34 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)) 12:44:34 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)) 12:44:34 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)) 12:44:34 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)) 12:44:34 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)) 12:44:34 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)) 12:44:34 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)) 12:44:34 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)) 12:44:34 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)) 12:44:34 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)) 12:44:34 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)) 12:44:34 INFO - Cleaning up... 12:44:34 INFO - Return code: 0 12:44:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:44:34 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')]} 12:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:34 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')]} 12:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:34 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 0x21d0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2491180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248f3b0>, '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 0x24902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', '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 12:44:34 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 12:44:34 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 12:44:34 INFO - Using env: {'DISPLAY': ':0', 12:44:34 INFO - 'HOME': '/home/cltbld', 12:44:34 INFO - 'LANG': 'en_US.UTF-8', 12:44:34 INFO - 'LANGUAGE': 'en_US:en', 12:44:34 INFO - 'LOGNAME': 'cltbld', 12:44:34 INFO - 'MAIL': '/var/mail/cltbld', 12:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:34 INFO - 'MOZ_NO_REMOTE': '1', 12:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:34 INFO - 'NO_EM_RESTART': '1', 12:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:34 INFO - 'PWD': '/builds/slave/test', 12:44:34 INFO - 'SHELL': '/bin/bash', 12:44:34 INFO - 'SHLVL': '1', 12:44:34 INFO - 'TERM': 'linux', 12:44:34 INFO - 'TMOUT': '86400', 12:44:34 INFO - 'USER': 'cltbld', 12:44:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', 12:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:34 INFO - '_': '/tools/buildbot/bin/python'} 12:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:44:34 INFO - Cleaning up... 12:44:34 INFO - Return code: 0 12:44:34 INFO - Running post-action listener: _resource_record_post_action 12:44:34 INFO - Running post-action listener: _start_resource_monitoring 12:44:34 INFO - Starting resource monitoring. 12:44:34 INFO - ##### 12:44:34 INFO - ##### Finished create-virtualenv step (success) 12:44:34 INFO - ##### 12:44:34 INFO - ##### 12:44:34 INFO - ##### Running install step. 12:44:34 INFO - ##### 12:44:34 INFO - Running pre-action listener: _resource_record_pre_action 12:44:34 INFO - Running main action method: install 12:44:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:44:35 INFO - Reading from file tmpfile_stdout 12:44:35 INFO - Detecting whether we're running mozinstall >=1.0... 12:44:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:44:35 INFO - Reading from file tmpfile_stdout 12:44:35 INFO - Output received: 12:44:35 INFO - Usage: mozinstall [options] installer 12:44:35 INFO - Options: 12:44:35 INFO - -h, --help show this help message and exit 12:44:35 INFO - -d DEST, --destination=DEST 12:44:35 INFO - Directory to install application into. [default: 12:44:35 INFO - "/builds/slave/test"] 12:44:35 INFO - --app=APP Application being installed. [default: firefox] 12:44:35 INFO - mkdir: /builds/slave/test/build/application 12:44:35 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'] 12:44:35 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 12:44:52 INFO - Reading from file tmpfile_stdout 12:44:52 INFO - Output received: 12:44:52 INFO - /builds/slave/test/build/application/firefox/firefox 12:44:52 INFO - Running post-action listener: _resource_record_post_action 12:44:52 INFO - ##### 12:44:52 INFO - ##### Finished install step (success) 12:44:52 INFO - ##### 12:44:52 INFO - ##### 12:44:52 INFO - ##### Running run-tests step. 12:44:52 INFO - ##### 12:44:52 INFO - Running pre-action listener: _resource_record_pre_action 12:44:52 INFO - Running main action method: run_tests 12:44:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:44:52 INFO - Python 2.7.3 12:44:52 INFO - Return code: 0 12:44:52 INFO - grabbing minidump binary from tooltool 12:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:52 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 0x248f3b0>, '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 0x24902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2490740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:44:52 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 12:44:52 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 12:44:52 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 12:44:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:44:52 INFO - Return code: 0 12:44:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:44:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:44:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:44:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:44:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:44:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:44:52 INFO - Using env: {'DISPLAY': ':0', 12:44:52 INFO - 'HOME': '/home/cltbld', 12:44:52 INFO - 'LANG': 'en_US.UTF-8', 12:44:52 INFO - 'LANGUAGE': 'en_US:en', 12:44:52 INFO - 'LOGNAME': 'cltbld', 12:44:52 INFO - 'MAIL': '/var/mail/cltbld', 12:44:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:44:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:52 INFO - 'MOZ_NO_REMOTE': '1', 12:44:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:52 INFO - 'NO_EM_RESTART': '1', 12:44:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:52 INFO - 'PWD': '/builds/slave/test', 12:44:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:44:52 INFO - 'SHELL': '/bin/bash', 12:44:52 INFO - 'SHLVL': '1', 12:44:52 INFO - 'TERM': 'linux', 12:44:52 INFO - 'TMOUT': '86400', 12:44:52 INFO - 'USER': 'cltbld', 12:44:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999', 12:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:52 INFO - '_': '/tools/buildbot/bin/python'} 12:44:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:44:52 INFO - mozversion application_buildid: 20160715083029 12:44:52 INFO - mozversion application_changeset: 2f9e69c982f1e67887a1834b36ff0af4ababb3af 12:44:52 INFO - mozversion application_display_name: Nightly 12:44:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:44:52 INFO - mozversion application_name: Firefox 12:44:52 INFO - mozversion application_remotingname: firefox 12:44:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:44:52 INFO - mozversion application_vendor: Mozilla 12:44:52 INFO - mozversion application_version: 50.0a1 12:44:52 INFO - mozversion platform_buildid: 20160715083029 12:44:52 INFO - mozversion platform_changeset: 2f9e69c982f1e67887a1834b36ff0af4ababb3af 12:44:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:44:52 INFO - mozversion platform_version: 50.0a1 12:44:52 INFO - using testdate: 1468611892 12:44:52 INFO - actual date: 1468611892 12:44:52 INFO - starting webserver on 'localhost:52129' 12:44:52 INFO - SUITE-START | Running 2 tests 12:44:52 INFO - TEST-START | dromaeo_css 12:44:52 INFO - operating with platform_type : linux_ 12:44:52 INFO - Initialising browser for dromaeo_css test... 12:44:52 INFO - TEST-INFO | started process 13081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRPFfpN/profile http://localhost:52129/getInfo.html) 12:44:57 INFO - PROCESS | 13081 | __metrics Screen width/height:1600/1200 12:44:57 INFO - PROCESS | 13081 | colorDepth:24 12:44:57 INFO - PROCESS | 13081 | Browser inner width/height: 1024/697 12:44:57 INFO - PROCESS | 13081 | __metrics 12:44:58 ERROR - PROCESS | 13081 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 12:44:59 INFO - TEST-INFO | 13081: exit 0 12:44:59 INFO - Browser initialized. 12:44:59 INFO - Running cycle 1/1 for dromaeo_css test... 12:44:59 INFO - TEST-INFO | started process 13203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRPFfpN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:45:10 INFO - PROCESS | 13203 | RSS: Main: 167972864 12:45:10 INFO - PROCESS | 13203 | 12:46:00 INFO - PROCESS | 13203 | 1468611960435 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] 12:48:08 INFO - PROCESS | 13203 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52129/tests/dromaeo/cssquery-ext.html) 12:48:09 INFO - PROCESS | 13203 | RSS: Main: 171933696 12:48:09 INFO - PROCESS | 13203 | 12:51:11 INFO - PROCESS | 13203 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-ext.html (next: http://localhost:52129/tests/dromaeo/cssquery-jquery.html) 12:51:12 INFO - PROCESS | 13203 | RSS: Main: 168927232 12:51:12 INFO - PROCESS | 13203 | 12:54:14 INFO - PROCESS | 13203 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52129/tests/dromaeo/cssquery-mootools.html) 12:54:14 INFO - PROCESS | 13203 | RSS: Main: 172949504 12:54:14 INFO - PROCESS | 13203 | 12:57:16 INFO - PROCESS | 13203 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52129/tests/dromaeo/cssquery-prototype.html) 12:57:17 INFO - PROCESS | 13203 | RSS: Main: 166928384 12:57:17 INFO - PROCESS | 13203 | 13:00:19 INFO - PROCESS | 13203 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52129/tests/dromaeo/cssquery-yui.html) 13:00:20 INFO - PROCESS | 13203 | RSS: Main: 168988672 13:00:20 INFO - PROCESS | 13203 | 13:03:22 INFO - PROCESS | 13203 | Cycle 1(1): loaded http://localhost:52129/tests/dromaeo/cssquery-yui.html (next: http://localhost:52129/tests/dromaeo/cssquery-dojo.html) 13:03:22 INFO - PROCESS | 13203 | RSS: Main: 169943040 13:03:22 INFO - PROCESS | 13203 | 13:03:22 INFO - PROCESS | 13203 | __start_tp_report 13:03:22 INFO - PROCESS | 13203 | _x_x_mozilla_page_load 13:03:22 INFO - PROCESS | 13203 | _x_x_mozilla_page_load_details 13:03:22 INFO - PROCESS | 13203 | |i|pagename|runs| 13:03:22 INFO - PROCESS | 13203 | |0;dojo.html;3027.651820040695;3069.416810805948;3085.1515833145895;3087;3091.1344823449426;5439.755211015504;5452.291202143726;5484.7531861066245;5508.724563771815;5518.862028449291;5367.865803354918;5413.53984911283;5447.918281225785;5452.318460192476;5524.364698059724;4908.950910490894;4925.729084900329;5033.345665063536;5079.822206222783;5114.7698353574;707.5421243152866;4904.190808516591;4957.900841983158;5001.499850015006;5036.647434679556;5030.874228144289;5043.873903152414;5045.798168073273;5049.899002019957;5060.063888180698;5080.771365288534;5083.237514372837;5086.440491545927;5090.770915308783;5126.026055049529;4940.036692844897;4968.205087186033;4981.352424184833;5022.522860328263;5060.595152387837;5520.475554822286;5532.336119665626;5536.889262214773;5542.806001789918;5591.944080559183;5733.397993210695;5822.097574875901;5933.228680271537;5936.881262374728;5971.581989260753;5878.353381128072;5890.617109887844;5927.022041363213;5948.851278718023;5992.071228959475;5513.5037846594;5514.6691198528215;5527.889442211173;5543.861403464905;5545.0018996581;5839.357670656224;6057.969710151421;6060;6068.393160683896;6122.908156377658;5650.237217975603;5651.9152212716845;5701.771929122871;5730.455606717355;5745.88508229833;5825.242718446575;5830.912536311958;5839.562032847553;5842.912356314659;5854.736536855852;5716.142578613241;5756.510696590837;5773.076307790733;5785.392533783976;5807.245058142415;5771.378430121224;5824.737886795105;5827.213326200908;5828.5337173026055;5833.183354330397;4379.912401751947;4431.047324825114;4436.245838207513;4450.265706158512;4492.326151077365;3887.358585833306;3912.8043597819997;3952.545457272393;3967.543732470745;3973.205358928226;5532.2254884315425;5577.414371491016;5589.105743081088;5627.831165065055;5630;5793.8841223175305;5891.05743081105;5893.970530147408;5905.7932972346625;5918.378570250148;5514.972425137848;5541.224228607998;5546.833594992157;5555.361133469622;5561.637398837311;5000.474950130257;5053.444121146671;5054.2661794527185;5060.671056381323;5109.770060347293;5946.940530594638;6035.939640603626;6067.696615169224;6076.878462430726;6091.177691011657;5879.059350503813;5959.67221802805;5964.701764911651;5984.1921340618455;5998.210831963158;6072.30168530607;6079.088136779518;6092.725827337692;6125.9693701531205;6145.262568491809;5599.552035837205;5789.884202316014;5793.739281732416;5821.970890145522;5831.825045248649;5945.524358051259;5946.167536544801;5951.732172052181;5963.612365196248;6018.247719035121;5811.302643682785;5814.796482123105;5815.127730840408;5816.302043754777;5817.243758311392;5626.1842032905815;5695.829125126253;5729.512991395778;5756.366799651951;5790.710464476843;5655.802046928337;5696.572757043321;5697.23087383198;5710.800121995876;5712.228849105318;5752.395998420273;5766.135079738073;5771.480566749013;5812.564057695605;5837.562182836219;5462.590305727007;5670.773169073191;5684.403137670485;5737.971310143423;5770.394108618535 13:03:22 INFO - PROCESS | 13203 | |1;ext.html;550.5094882786142;587;594.3046635436539;616.6916541729134;632.8386261503316;40870.79564602177;42281;44561;44705.552944470546;44740.77629611856;45152.54847451524;45614.543854561445;45621.31568026482;45812.77093614527;45820.31269530951;8893.733188004355;8986.460812351248;9013.233875120623;9031.23234525066;9040.367174297802;8916.15296546827;8959.73120806377;8980.775480612972;9014.233790127848;9031.187193152615;8970.730878073668;9012.954935225314;9038.2317503012;9047.728568142966;9087.909120908806;8979.293934152523;8992.055834137453;9032.27741780656;9054.366194366365;9072.183503484684;8919.73240802777;8930.151635594608;8959.507227102507;8987.595558199831;9003.59483823223;33478.33043339144;37178;37309.06727331838;37368.06579835526;37406.625933740586;3421.127612458832;3432.70821980132;3440.673136052071;3478.9826050869838;3660.194757153422;31543.526847097313;31888.681113188803;32085.83957080223;32128.196795080075;32986.34027319464;3377.5946886373545;3414.487826825996;3442.1050526862946;3464.2898205867737;3511.052015955703;299839;300995;302162;303336;303732.4813375941;34139.31721365559;35060.12349691278;35073.82463087668;35157.29685406278;35351;36834.07914802151;36845;36902.8154859224;36903.81548092296;36995.63004369922;15492.14793186363;15496.30266638004;15502.689946201239;15536.223188840513;15587.06477611347;12801.679958001125;12832.935835320764;12860;12875.742485150244;12921.935390322988;8324.458910170819;8342.874856877152;8346.457480263764;8400.327973762085;8470.957645211858;3232.8221947792626;3234.2832021102386;3254.4792833146585;3263.7878537894962;3267.8856240031487;959.2374062620233;1017.2421545948316;1020.2501161646184;1053.8893416191343;1081.8079940231603;32693.346133077204;32898.83550582232;33054.5041824368;33182.336353272796;33463.3307333852;1083.869935607732;1128.9209755317213;1134.1267224237456;1192.3263356203718;1195.8385617941467;16927.746083808754;17120;17390.565235869206;17471.475855724348;17492.47522574325;567296;570230;570476;571440;571950;57816.71091644599;59147.40852591419;59221.70389148027;59300.11049834256;59350.70324648349;1324.5364122557028;1335.8998075144402;1349.6490912362856;1352.4387379237505;1362.2575696245767;30685.23286917845;32262.838685806422;32326.676733233307;32670.34659306848;33042.17394565155;50950;51390.48609513857;51623.741881290356;51946.22080668869;52095.73952130215;506712;507803;508351;508916;509791;25931.22206333813;26009.349766255997;26123.955041798115;26166.084187054123;27223.59164612493;49203.753981229864;49530.25704614362;49838.25242621436;50705;50960.23559646534;42976;44072.118557628026;44121.77939110412;44655.330170048124;45129.323060154784;41902.37146442745;43082.78458607687;43246.351304729826;43457.13085738331;44450.55549444464;43805.78097109622;45281;45389.54610453853;46065.76967115277;46364.30453543132;43465.78267108644;44806.55193448154;45564.772176138904;45875.08249834918;45903.54096458993;34148.31703365968;35180.472292916136;35207.82396088003;35306.11734706653;35503.82248088743 13:03:22 INFO - PROCESS | 13203 | |2;jquery.html;392.39962856829055;395.85749130313076;396.9662578680812;399.86004898285603;416.3983044500696;14286;18832.90583547082;19806.90096549515;20241.797582024174;20365.28721494748;19154.13806378713;19653.50866228345;19723.704144437845;19812.30656927008;19884.304049358274;5430.456954304567;5616.3260408751;5683.403242659502;5995.280566332046;6005.189299444584;5971;6041.637501749887;6044.123602077696;6058;6081.3006504252135;5988.730507127168;6049.243844519435;6083.452489275965;6116.81649550512;6118.877622447549;6097.817065488042;6299.33856945021;6677.732890684342;6680.265170831205;6812.386885180357;5961.701914904281;5992.9700351498395;6012.488938440238;6012.609180403259;6037.728302226366;14789;14802.703945921021;21635.026423810967;23211.3036608902;23703.288901332988;2482.32977096183;2537.0359263479945;2608.79129669626;2815.507286224923;3056;10457.58169673212;10574.577016919315;10868.61959831402;11137.05335046522;14638.926805365905;1928.363639998797;1947.7662680478293;1992.1732481020358;1996.8103030212108;2025.73665423494;85094.57452712758;87823;88054;89288.55355723244;91156.54421727848;10443.373397596017;10446.955304469493;10775.353478791141;11294.774104517863;11362.375069371265;15594.29825657848;15698.68602627941;15722.371105155895;15752.369905203663;15756.76364854528;8236.588170591447;8393.496390216607;8419.663213471515;8503.149685031447;8557.058723540405;8042.396820238506;8109.148539403395;8137.633806478722;8163.10205877353;8290.751277461564;4754.882602588389;4766.642501812378;4792.209285467929;4821.228603423436;4828.927566086511;1951.7853036166011;1967.960640787205;1983.9206431742568;1989.9801001990083;2024.5647185855112;907.6324088744069;952.173568770284;1001.4241810958728;1083.8211695070383;1102.32207192576;20411.36881033117;20671.483212919797;20684.689729654066;20813.271535496184;20845.374638760863;994.7015895231401;998.1266391907081;1005.8038682456997;1024.293237666008;1029.9330543514648;10781.784364312669;11461.885381146249;11463.942680286713;11523.423828808525;11532.135089868294;494631;500602;509353;509627;511377;58830.70584647135;84104.15895840964;84153.57923210345;96941.5152924231;98261;945.3666043750703;959.2421986630484;969.8011907558933;978.090375950373;992.846108853129;18676.906615466836;18733.939266680383;19277;19309;19400.611987760447;44862.102757944005;44999.32501012422;45097.32354014758;45297;46202.76898615486;63720.362796371446;63817.361826383;64480.67759661359;65012.34987650252;65102.674486629156;8595.18345757152;8625.784355391166;8639.222469977733;8656.91343086561;8687.956560217159;9793.853092203764;12798.68003299925;13008.414621341873;13037.543685970946;13089.934550327187;11182.440877955907;11194.328340299608;11270;11306.604268850551;11319.434028298387;10843.295185812896;11080.722981925517;11226.158038147008;11412.828807567726;11603.535858565563;10998.395088270221;11120.499577519193;11297;11513.481893314989;11733;8398.328133749408;8703.086175951434;8714.38999270045;8736.606852691772;8866.911330886609;8897.555122243992;11090.724566674935;11185.944070279596;11336.773264534828;11663.650090497298 13:03:22 INFO - PROCESS | 13203 | |3;mootools.html;1493.6564590144262;1517.1049081042186;1639.4016184092802;1788.4277031349966;1791.7133258678614;8013.11855695873;8618.181272779077;8664;9227.169554740072;9235.26117910568;8840.160184782435;8926.642934282621;8975.102489751021;8982.730518084452;9057.90942090579;2346.1671106757112;2371.4782747795457;2376.572217000939;2377.3699969508093;2380.583397905368;2354.9293521194304;2377.5126099149634;2382.3924899150693;2400.1239547565187;2401.5917294059964;2356.1988923765916;2383.4398916254668;2388.665586817847;2393.3418309964813;2395.4969456414174;2343.589871772433;2349.8472599281076;2361.2325994052003;2364.7517010713973;2365.5387199496104;2311.6879221305076;2320.756320586348;2341.789238968484;2342.26218741096;2348.7181538215523;9133.178013978708;9184.540772961325;9192.95403522978;9205.217556507638;9212.124848139416;5289.497497737709;5427.457254274541;5431.83704488866;5453.781848726086;5455.18172274158;3322.501624756306;3372.7470439717117;3400.0819778659625;3451.4132597458242;3454.516367708523;1080.3193987787643;1091.7543552700579;1092.0226397374306;1093.2074246171542;1112.2103306652286;12467.189632673937;12490.375481225994;12508.937455312756;12515.74968500634;12550.058745594026;4496.392986946786;4572.0627271409285;4714.151452738472;4719;4740.075685241345;10611.734706632396;10648;10664;10695.465226738788;10736.89263107359;5327.3074500314715;5327.600429967768;5334.946650533522;5358.8660283492445;5362.731863406814;4292.291771857671;4752.928706069411;4884.3161957326;4891.388576427947;4926.6551341406475;4010.3583426651594;4020.8190631421658;4077.4903137107863;4086.1214838809797;4086.693497987663;1295.57893684551;1296.3471573743552;1311.3312210772574;1326.9867301327056;1330.7737684593642;961.5048250151178;983.6785186958772;987.116530705015;989.4656885282011;1004.2217281606668;5877.765669209429;5921.763129474859;5986.850328741729;6040.067178502837;6113.969430152821;441.5672640812022;443.29737366274816;446.3862189489452;982.219135787051;1045.2160879340495;4003.1793482336634;4025.3156963316305;4033.838646454109;4038.959610403917;4157.584241575879;10884.292520986111;11220.214584978972;11232.943835280772;11249.83125253122;11299.548018079186;10766.676999690022;11099.167562432849;11147.665570032912;11167.553297868157;11206.719832004264;8148.755537333889;8292.051367928532;8325.375596830261;8342.62458189383;8362.790930226793;5673.205751194919;5748.367679555329;5780.508656764222;5786.161006653927;5883.999720047516;10540.420276884844;10598.629047983284;10617;10711;10711.732206694895;10239.846402303823;10324.48377581133;10715.410652414192;10742.409167495864;10807.135429165804;6218;7130.465215108784;7203.8559228816175;7317.780466586011;7326.560406375635;8876.334274929277;8933.28533717314;8933.731988040368;8935;8956.507392093237;7553.7356192533;7702.884456733042;7724.382049436144;7774.30031297186;7849.058113026245;7648.235176482307;7674.347680447001;7775.572343520935;7783.922160778547;7857.292843643871;7066.893996590158;7123.394511466583;7125.3230943060325;7164.355208031302;7178.8564228714085;4928.260760885896;5033.874153146201;5103.387593488805;5167.974160129175;5174.844754657366;5299.2316114164005;5360.65155764874;5386.218998245311;5413.052715774802;5468.972655136698 13:03:22 INFO - PROCESS | 13203 | |4;prototype.html;331.6683316683317;335.3477486289168;340.13435805874064;340.4773672412847;343.1849357775284;5569.777208911643;5599.236240584219;5618.471687740518;5625.40933202014;5673.290838645169;5465.398806131332;5476.17857321402;5498.80754173604;5531.502164805167;5533.257024037425;4077.7553346799214;4188.350805625133;4309.547497512763;4322.589354011379;4327.74033557986;4267.850625228118;4301.182775272689;4304.569543045686;4318.330658747884;4338.696291259597;4259.190753756792;4276.486821581399;4281.143771245747;4294.334378171388;4300.97849510752;4067.430559721656;4274.358846173099;4282.308488147196;4284.614384705392;4300.784960751966;3715.4055351143957;3723.9813800930824;3740.1023754299044;3751.118487155516;3751.74316603938;5392.622516423852;5401.405845357047;5466.8359949201185;5490.69801160936;5491.419033054458;4853.150698627726;4853.781579828917;4909.288153217799;4914.410270767495;4936.531029552187;5774.769009239625;5789.334226563957;5790.7973220937065;5814.592978491507;5818.941810581925;4092.5498195198506;4129.752214867118;4134.421181034658;4134.710570260083;4149.024979129902;5812.38969908162;5939.2575928009;6004.42957918997;6014.879702405928;6090.939090609126;4159.209750147523;4163.063310755117;4173.269677806433;4191.832326706897;4191.8532851350055;4226.767527786002;4228.154369126187;4249.150169966019;4259.787010649455;4265;4690.929636055462;4894.730789806595;4897.534734200245;4912.803487860517;4924.72913989734;5805.593608447368;5820.388859169726;5834.824955251349;5869.413058694096;5913.196475075058;1469.1478942213491;1497.7119677077706;1501.3394106593064;1502.9479364444933;1504.9247537623294;944.9196818270386;967.8596603492454;986.2208855004466;1014.7209517382779;1024.7386916336436;5446.754896029688;5559.833205003856;5616.550675945915;5617.971910140505;5649.406812284651;5896.882062358729;5922.496587790086;5932.49573786233;5976.372480889531;5992.15372697965;5395.460453954652;5596.888062238732;5750.108733146369;5772.249607550992;5779.624324418984;3212.855421506038;3222.3555288942307;3234.692704193098;3242.4649932761304;3264.237311851621;6102.511799056065;6226.688665566703;6243.470349764246;6251.999360204691;6282.748690052438;6152.077188421683;6161.568690191643;6164.506839452833;6201.193844800147;6237.812865614039;5993.3706960768495;6266.154069200691;6285.9057114143325;6301.464375528039;6309.526785491106;5988.041913293852;5991.244027747285;6006.699665016819;6025.78909738157;6025.939740602713;5893.499052580579;5959.851003724768;5973.790917317873;5994.250718660168;6019.103982245579;6019.789307374221;6146.723397447036;6155.384461553809;6195.380461953769;6217.533684973555;4133.400656904792;4162.791860407028;4183.121544475573;4195.223883581547;4197.286461301525;5737.397573254915;5812.593118481665;6016.699165041818;6022.879542409215;6103.389661033861;5848.473637372657;5856.677882716492;5861.160939584579;5870.589058765845;5898.882022359443;5802.535797136304;5855.795047173328;5875.063707316023;5882.411758824083;5904.261967254093;5591.6365436246515;5756.827295181151;5767.250257466502;5776.508996735157;5801.941980580309;5851.941480585139;5860.208871802252;5885.411458854081;5918.2898052234;5923.437273459014;5493.340799104133;5749.885002299847;5755.539556835527;5768.826935191951;5791.82624521265 13:03:22 INFO - PROCESS | 13203 | |5;yui.html;731.2723839779419;735.2685469006941;824.8020475085978;831.7587899509147;839.9412041157121;13208.801867971975;14567.271636418189;14772.556823295292;14807.851921480782;14836.629084272898;13346.532871349506;13451.730965380686;13468.66328341792;13501.2574308413;13534.052616316862;640.3468462168586;755.6939439526986;763.5914785589711;785.1206648553627;786.3709032773787;780.5550836023469;785.8074771680917;786.0763602766726;789.17925357628;790.1269097647104;832.9958350208241;836.1638361638362;838.4508147163588;840.6133178737788;841.5287439034161;829.2826704900248;835.2274146414603;837.0833936839151;837.9203975622337;839.4879123734516;605.8364241654773;607.271274470637;607.6991889014965;608.1698481572665;608.9177960975256;13619.387127579283;13620.387082581208;13650;13658.453661853513;13659.317034148253;14845.851541484662;14941.17823519706;15237.61905952349;15289;15503.147326897017;11920.701982450508;11982.460789264416;12026.398680065962;12179.086568507397;12194.366140866503;3912.256671232485;3952.3873799561115;3955.208958208341;3957.0503079261057;4069.165821006716;79289.60355198187;79874.20125798725;79907.20092799056;79919.60040199762;84394.57802711008;10963.451827408599;10971.725706857393;11106.44467776608;11223.270487418291;11268.042216411697;22351.994160262828;22538.887305563694;22618.547629047654;22660.660090098663;22708.205212817473;8568.657253709782;8726.127387261224;8731.083236260229;8798.560071996502;8838.248748856418;4834.395700537433;4957.161867832241;4996.850094497171;5022.799088036438;5186.974065129651;3423.4864770284657;3494.1963348430004;3504.0539054455153;3528.68241858234;3532.6114127445962;608.856918624123;624.1262232874012;632.0361448790632;635.7425242776683;643.2313385504277;653.0009086098278;728.5300980867311;743.4387037786545;752.3153929923852;761.2501685839444;8631.309495240366;8740.169683880022;8833.955830220808;9010.098990100938;9309.72070837876;594.4531031451075;594.6224147666263;688.6178171114979;735.7020406735281;744.144234130754;4409.9559004410185;4567.586596721556;4583.862484125481;4608.124456353349;4673.322368256584;110635;113728.43135784268;114939.42530287462;115972.42013789876;119101;100058.499707501;100805.49597251967;100872;101048;101864.49067754614;82681.99999999879;84481.15518844855;86326;86917;90694;8532.744017679479;8839.64093644411;8913.242374397989;8954.328425368254;8970.551472426483;36817.815910920275;42684.57315426806;47055.52944470648;48377;48388.758056209495;74570.50858982898;76009.61995189989;78591;80326.79509807241;80808.19191808006;13675;13730.794038089636;13803.654908627364;13879.514217002357;14168.929155354157;12397.44211510466;12403.25580465175;12878.742425151631;13220.669483262995;14922.925385373004;13076.476940922257;13251.801222981856;13335.599932002055;13396.330183490982;13955.720885582028;12589.307588082744;12848.164869283466;13067.803982940453;13431.597052088453;13566.660833479242;13213.537526186537;13219.603411897659;13295.20228786276;13439.395227214995;13659.317034148451;11543.711407214887;11556.653300401002;11946.701332466759;11970.162088653711;12017.218880772722;11295.943520282346;11386.772264554827;11616.128790340927;11689;11787.823182652095 13:03:22 INFO - PROCESS | 13203 | __end_tp_report 13:03:22 INFO - PROCESS | 13203 | __start_cc_report 13:03:22 INFO - PROCESS | 13203 | _x_x_mozilla_cycle_collect,362 13:03:22 INFO - PROCESS | 13203 | __end_cc_report 13:03:22 INFO - PROCESS | 13203 | __startTimestamp1468613002948__endTimestamp 13:03:22 INFO - PROCESS | 13203 | 13:03:22 INFO - PROCESS | 13203 | ------- Summary: start ------- 13:03:22 INFO - PROCESS | 13203 | Number of tests: 6 13:03:22 INFO - PROCESS | 13203 | 13:03:22 INFO - PROCESS | 13203 | [#0] dojo.html Cycles:165 Average:5432.10 Median:5695.83 stddev:736.77 (12.9%) stddev-sans-first:714.47 13:03:22 INFO - PROCESS | 13203 | Values: 3027.7 3069.4 3085.2 3087.0 3091.1 5439.8 5452.3 5484.8 5508.7 5518.9 5367.9 5413.5 5447.9 5452.3 5524.4 4909.0 4925.7 5033.3 5079.8 5114.8 707.5 4904.2 4957.9 5001.5 5036.6 5030.9 5043.9 5045.8 5049.9 5060.1 5080.8 5083.2 5086.4 5090.8 5126.0 4940.0 4968.2 4981.4 5022.5 5060.6 5520.5 5532.3 5536.9 5542.8 5591.9 5733.4 5822.1 5933.2 5936.9 5971.6 5878.4 5890.6 5927.0 5948.9 5992.1 5513.5 5514.7 5527.9 5543.9 5545.0 5839.4 6058.0 6060.0 6068.4 6122.9 5650.2 5651.9 5701.8 5730.5 5745.9 5825.2 5830.9 5839.6 5842.9 5854.7 5716.1 5756.5 5773.1 5785.4 5807.2 5771.4 5824.7 5827.2 5828.5 5833.2 4379.9 4431.0 4436.2 4450.3 4492.3 3887.4 3912.8 3952.5 3967.5 3973.2 5532.2 5577.4 5589.1 5627.8 5630.0 5793.9 5891.1 5894.0 5905.8 5918.4 5515.0 5541.2 5546.8 5555.4 5561.6 5000.5 5053.4 5054.3 5060.7 5109.8 5946.9 6035.9 6067.7 6076.9 6091.2 5879.1 5959.7 5964.7 5984.2 5998.2 6072.3 6079.1 6092.7 6126.0 6145.3 5599.6 5789.9 5793.7 5822.0 5831.8 5945.5 5946.2 5951.7 5963.6 6018.2 5811.3 5814.8 5815.1 5816.3 5817.2 5626.2 5695.8 5729.5 5756.4 5790.7 5655.8 5696.6 5697.2 5710.8 5712.2 5752.4 5766.1 5771.5 5812.6 5837.6 5462.6 5670.8 5684.4 5738.0 5770.4 13:03:22 INFO - PROCESS | 13203 | 13:03:22 INFO - PROCESS | 13203 | [#1] ext.html Cycles:180 Average:60795.79 Median:42091.69 stddev:126459.85 (300.4%) stddev-sans-first:126733.71 13:03:22 INFO - PROCESS | 13203 | Values: 550.5 587.0 594.3 616.7 632.8 40870.8 42281.0 44561.0 44705.6 44740.8 45152.5 45614.5 45621.3 45812.8 45820.3 8893.7 8986.5 9013.2 9031.2 9040.4 8916.2 8959.7 8980.8 9014.2 9031.2 8970.7 9013.0 9038.2 9047.7 9087.9 8979.3 8992.1 9032.3 9054.4 9072.2 8919.7 8930.2 8959.5 8987.6 9003.6 33478.3 37178.0 37309.1 37368.1 37406.6 3421.1 3432.7 3440.7 3479.0 3660.2 31543.5 31888.7 32085.8 32128.2 32986.3 3377.6 3414.5 3442.1 3464.3 3511.1 299839.0 300995.0 302162.0 303336.0 303732.5 34139.3 35060.1 35073.8 35157.3 35351.0 36834.1 36845.0 36902.8 36903.8 36995.6 15492.1 15496.3 15502.7 15536.2 15587.1 12801.7 12832.9 12860.0 12875.7 12921.9 8324.5 8342.9 8346.5 8400.3 8471.0 3232.8 3234.3 3254.5 3263.8 3267.9 959.2 1017.2 1020.3 1053.9 1081.8 32693.3 32898.8 33054.5 33182.3 33463.3 1083.9 1128.9 1134.1 1192.3 1195.8 16927.7 17120.0 17390.6 17471.5 17492.5 567296.0 570230.0 570476.0 571440.0 571950.0 57816.7 59147.4 59221.7 59300.1 59350.7 1324.5 1335.9 1349.6 1352.4 1362.3 30685.2 32262.8 32326.7 32670.3 33042.2 50950.0 51390.5 51623.7 51946.2 52095.7 506712.0 507803.0 508351.0 508916.0 509791.0 25931.2 26009.3 26124.0 26166.1 27223.6 49203.8 49530.3 49838.3 50705.0 50960.2 42976.0 44072.1 44121.8 44655.3 45129.3 41902.4 43082.8 43246.4 43457.1 44450.6 43805.8 45281.0 45389.5 46065.8 46364.3 43465.8 44806.6 45564.8 45875.1 45903.5 34148.3 35180.5 35207.8 35306.1 35503.8 13:03:22 INFO - PROCESS | 13203 | 13:03:22 INFO - PROCESS | 13203 | [#2] jquery.html Cycles:180 Average:29747.07 Median:396.41 stddev:83297.20 (21012.8%) stddev-sans-first:83501.71 13:03:22 INFO - PROCESS | 13203 | Values: 392.4 395.9 397.0 399.9 416.4 14286.0 18832.9 19806.9 20241.8 20365.3 19154.1 19653.5 19723.7 19812.3 19884.3 5430.5 5616.3 5683.4 5995.3 6005.2 5971.0 6041.6 6044.1 6058.0 6081.3 5988.7 6049.2 6083.5 6116.8 6118.9 6097.8 6299.3 6677.7 6680.3 6812.4 5961.7 5993.0 6012.5 6012.6 6037.7 14789.0 14802.7 21635.0 23211.3 23703.3 2482.3 2537.0 2608.8 2815.5 3056.0 10457.6 10574.6 10868.6 11137.1 14638.9 1928.4 1947.8 1992.2 1996.8 2025.7 85094.6 87823.0 88054.0 89288.6 91156.5 10443.4 10447.0 10775.4 11294.8 11362.4 15594.3 15698.7 15722.4 15752.4 15756.8 8236.6 8393.5 8419.7 8503.1 8557.1 8042.4 8109.1 8137.6 8163.1 8290.8 4754.9 4766.6 4792.2 4821.2 4828.9 1951.8 1968.0 1983.9 1990.0 2024.6 907.6 952.2 1001.4 1083.8 1102.3 20411.4 20671.5 20684.7 20813.3 20845.4 994.7 998.1 1005.8 1024.3 1029.9 10781.8 11461.9 11463.9 11523.4 11532.1 494631.0 500602.0 509353.0 509627.0 511377.0 58830.7 84104.2 84153.6 96941.5 98261.0 945.4 959.2 969.8 978.1 992.8 18676.9 18733.9 19277.0 19309.0 19400.6 44862.1 44999.3 45097.3 45297.0 46202.8 63720.4 63817.4 64480.7 65012.3 65102.7 8595.2 8625.8 8639.2 8656.9 8688.0 9793.9 12798.7 13008.4 13037.5 13089.9 11182.4 11194.3 11270.0 11306.6 11319.4 10843.3 11080.7 11226.2 11412.8 11603.5 10998.4 11120.5 11297.0 11513.5 11733.0 8398.3 8703.1 8714.4 8736.6 8866.9 8897.6 11090.7 11185.9 11336.8 11663.7 13:03:22 INFO - PROCESS | 13203 | 13:03:22 INFO - PROCESS | 13203 | [#3] mootools.html Cycles:180 Average:5883.75 Median:2471.39 stddev:3393.80 (137.3%) stddev-sans-first:3387.29 13:03:22 INFO - PROCESS | 13203 | Values: 1493.7 1517.1 1639.4 1788.4 1791.7 8013.1 8618.2 8664.0 9227.2 9235.3 8840.2 8926.6 8975.1 8982.7 9057.9 2346.2 2371.5 2376.6 2377.4 2380.6 2354.9 2377.5 2382.4 2400.1 2401.6 2356.2 2383.4 2388.7 2393.3 2395.5 2343.6 2349.8 2361.2 2364.8 2365.5 2311.7 2320.8 2341.8 2342.3 2348.7 9133.2 9184.5 9193.0 9205.2 9212.1 5289.5 5427.5 5431.8 5453.8 5455.2 3322.5 3372.7 3400.1 3451.4 3454.5 1080.3 1091.8 1092.0 1093.2 1112.2 12467.2 12490.4 12508.9 12515.7 12550.1 4496.4 4572.1 4714.2 4719.0 4740.1 10611.7 10648.0 10664.0 10695.5 10736.9 5327.3 5327.6 5334.9 5358.9 5362.7 4292.3 4752.9 4884.3 4891.4 4926.7 4010.4 4020.8 4077.5 4086.1 4086.7 1295.6 1296.3 1311.3 1327.0 1330.8 961.5 983.7 987.1 989.5 1004.2 5877.8 5921.8 5986.9 6040.1 6114.0 441.6 443.3 446.4 982.2 1045.2 4003.2 4025.3 4033.8 4039.0 4157.6 10884.3 11220.2 11232.9 11249.8 11299.5 10766.7 11099.2 11147.7 11167.6 11206.7 8148.8 8292.1 8325.4 8342.6 8362.8 5673.2 5748.4 5780.5 5786.2 5884.0 10540.4 10598.6 10617.0 10711.0 10711.7 10239.8 10324.5 10715.4 10742.4 10807.1 6218.0 7130.5 7203.9 7317.8 7326.6 8876.3 8933.3 8933.7 8935.0 8956.5 7553.7 7702.9 7724.4 7774.3 7849.1 7648.2 7674.3 7775.6 7783.9 7857.3 7066.9 7123.4 7125.3 7164.4 7178.9 4928.3 5033.9 5103.4 5168.0 5174.8 5299.2 5360.7 5386.2 5413.1 5469.0 13:03:22 INFO - PROCESS | 13203 | 13:03:22 INFO - PROCESS | 13203 | [#4] prototype.html Cycles:180 Average:4902.33 Median:5617.26 stddev:1458.67 (26.0%) stddev-sans-first:1421.85 13:03:22 INFO - PROCESS | 13203 | Values: 331.7 335.3 340.1 340.5 343.2 5569.8 5599.2 5618.5 5625.4 5673.3 5465.4 5476.2 5498.8 5531.5 5533.3 4077.8 4188.4 4309.5 4322.6 4327.7 4267.9 4301.2 4304.6 4318.3 4338.7 4259.2 4276.5 4281.1 4294.3 4301.0 4067.4 4274.4 4282.3 4284.6 4300.8 3715.4 3724.0 3740.1 3751.1 3751.7 5392.6 5401.4 5466.8 5490.7 5491.4 4853.2 4853.8 4909.3 4914.4 4936.5 5774.8 5789.3 5790.8 5814.6 5818.9 4092.5 4129.8 4134.4 4134.7 4149.0 5812.4 5939.3 6004.4 6014.9 6090.9 4159.2 4163.1 4173.3 4191.8 4191.9 4226.8 4228.2 4249.2 4259.8 4265.0 4690.9 4894.7 4897.5 4912.8 4924.7 5805.6 5820.4 5834.8 5869.4 5913.2 1469.1 1497.7 1501.3 1502.9 1504.9 944.9 967.9 986.2 1014.7 1024.7 5446.8 5559.8 5616.6 5618.0 5649.4 5896.9 5922.5 5932.5 5976.4 5992.2 5395.5 5596.9 5750.1 5772.2 5779.6 3212.9 3222.4 3234.7 3242.5 3264.2 6102.5 6226.7 6243.5 6252.0 6282.7 6152.1 6161.6 6164.5 6201.2 6237.8 5993.4 6266.2 6285.9 6301.5 6309.5 5988.0 5991.2 6006.7 6025.8 6025.9 5893.5 5959.9 5973.8 5994.3 6019.1 6019.8 6146.7 6155.4 6195.4 6217.5 4133.4 4162.8 4183.1 4195.2 4197.3 5737.4 5812.6 6016.7 6022.9 6103.4 5848.5 5856.7 5861.2 5870.6 5898.9 5802.5 5855.8 5875.1 5882.4 5904.3 5591.6 5756.8 5767.3 5776.5 5801.9 5851.9 5860.2 5885.4 5918.3 5923.4 5493.3 5749.9 5755.5 5768.8 5791.8 13:03:22 INFO - PROCESS | 13203 | 13:03:22 INFO - PROCESS | 13203 | [#5] yui.html Cycles:180 Average:20785.29 Median:23376.87 stddev:30348.16 (129.8%) stddev-sans-first:30395.94 13:03:22 INFO - PROCESS | 13203 | Values: 731.3 735.3 824.8 831.8 839.9 13208.8 14567.3 14772.6 14807.9 14836.6 13346.5 13451.7 13468.7 13501.3 13534.1 640.3 755.7 763.6 785.1 786.4 780.6 785.8 786.1 789.2 790.1 833.0 836.2 838.5 840.6 841.5 829.3 835.2 837.1 837.9 839.5 605.8 607.3 607.7 608.2 608.9 13619.4 13620.4 13650.0 13658.5 13659.3 14845.9 14941.2 15237.6 15289.0 15503.1 11920.7 11982.5 12026.4 12179.1 12194.4 3912.3 3952.4 3955.2 3957.1 4069.2 79289.6 79874.2 79907.2 79919.6 84394.6 10963.5 10971.7 11106.4 11223.3 11268.0 22352.0 22538.9 22618.5 22660.7 22708.2 8568.7 8726.1 8731.1 8798.6 8838.2 4834.4 4957.2 4996.9 5022.8 5187.0 3423.5 3494.2 3504.1 3528.7 3532.6 608.9 624.1 632.0 635.7 643.2 653.0 728.5 743.4 752.3 761.3 8631.3 8740.2 8834.0 9010.1 9309.7 594.5 594.6 688.6 735.7 744.1 4410.0 4567.6 4583.9 4608.1 4673.3 110635.0 113728.4 114939.4 115972.4 119101.0 100058.5 100805.5 100872.0 101048.0 101864.5 82682.0 84481.2 86326.0 86917.0 90694.0 8532.7 8839.6 8913.2 8954.3 8970.6 36817.8 42684.6 47055.5 48377.0 48388.8 74570.5 76009.6 78591.0 80326.8 80808.2 13675.0 13730.8 13803.7 13879.5 14168.9 12397.4 12403.3 12878.7 13220.7 14922.9 13076.5 13251.8 13335.6 13396.3 13955.7 12589.3 12848.2 13067.8 13431.6 13566.7 13213.5 13219.6 13295.2 13439.4 13659.3 11543.7 11556.7 11946.7 11970.2 12017.2 11295.9 11386.8 11616.1 11689.0 11787.8 13:03:22 INFO - PROCESS | 13203 | -------- Summary: end -------- 13:03:22 INFO - PROCESS | 13203 | 13:03:23 INFO - TEST-INFO | 13203: exit 0 13:03:23 INFO - TEST-OK | dromaeo_css | took 1111025ms 13:03:23 INFO - TEST-START | kraken 13:03:23 INFO - operating with platform_type : linux_ 13:03:23 INFO - Initialising browser for kraken test... 13:03:23 INFO - TEST-INFO | started process 13450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE16T_g/profile http://localhost:52129/getInfo.html) 13:03:28 INFO - PROCESS | 13450 | __metrics Screen width/height:1600/1200 13:03:28 INFO - PROCESS | 13450 | colorDepth:24 13:03:28 INFO - PROCESS | 13450 | Browser inner width/height: 1024/697 13:03:28 INFO - PROCESS | 13450 | __metrics 13:03:29 ERROR - PROCESS | 13450 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 13:03:29 INFO - TEST-INFO | 13450: exit 0 13:03:29 INFO - Browser initialized. 13:03:29 INFO - Running cycle 1/1 for kraken test... 13:03:29 INFO - TEST-INFO | started process 13570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE16T_g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:03:41 INFO - PROCESS | 13570 | RSS: Main: 167604224 13:03:41 INFO - PROCESS | 13570 | 13:03:44 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-beat-detection) 13:03:45 INFO - PROCESS | 13570 | RSS: Main: 172654592 13:03:45 INFO - PROCESS | 13570 | 13:03:47 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-dft) 13:03:48 INFO - PROCESS | 13570 | RSS: Main: 172429312 13:03:48 INFO - PROCESS | 13570 | 13:03:51 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-fft) 13:03:51 INFO - PROCESS | 13570 | RSS: Main: 166952960 13:03:51 INFO - PROCESS | 13570 | 13:03:53 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52129/tests/kraken/driver.html?testName=audio-oscillator) 13:03:54 INFO - PROCESS | 13570 | RSS: Main: 167845888 13:03:54 INFO - PROCESS | 13570 | 13:03:56 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52129/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:03:57 INFO - PROCESS | 13570 | RSS: Main: 168656896 13:03:57 INFO - PROCESS | 13570 | 13:04:00 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52129/tests/kraken/driver.html?testName=imaging-darkroom) 13:04:01 INFO - PROCESS | 13570 | RSS: Main: 168222720 13:04:01 INFO - PROCESS | 13570 | 13:04:04 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52129/tests/kraken/driver.html?testName=imaging-desaturate) 13:04:05 INFO - PROCESS | 13570 | RSS: Main: 166793216 13:04:05 INFO - PROCESS | 13570 | 13:04:08 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52129/tests/kraken/driver.html?testName=json-parse-financial) 13:04:08 INFO - PROCESS | 13570 | RSS: Main: 168259584 13:04:08 INFO - PROCESS | 13570 | 13:04:10 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52129/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:04:10 INFO - PROCESS | 13570 | RSS: Main: 168468480 13:04:10 INFO - PROCESS | 13570 | 13:04:12 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:04:13 INFO - PROCESS | 13570 | RSS: Main: 168574976 13:04:13 INFO - PROCESS | 13570 | 13:04:15 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:04:16 INFO - PROCESS | 13570 | RSS: Main: 168611840 13:04:16 INFO - PROCESS | 13570 | 13:04:18 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:04:19 INFO - PROCESS | 13570 | RSS: Main: 169123840 13:04:19 INFO - PROCESS | 13570 | 13:04:21 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:04:22 INFO - PROCESS | 13570 | RSS: Main: 169304064 13:04:22 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | Cycle 1(1): loaded http://localhost:52129/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52129/tests/kraken/driver.html?testName=ai-astar) 13:04:24 INFO - PROCESS | 13570 | RSS: Main: 169484288 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | __start_tp_report 13:04:24 INFO - PROCESS | 13570 | _x_x_mozilla_page_load 13:04:24 INFO - PROCESS | 13570 | _x_x_mozilla_page_load_details 13:04:24 INFO - PROCESS | 13570 | |i|pagename|runs| 13:04:24 INFO - PROCESS | 13570 | |0;ai-astar;101;111;105;113;113;112;114;113;111;110 13:04:24 INFO - PROCESS | 13570 | |1;audio-beat-detection;156;117;152;178;119;146;147;118;179;119 13:04:24 INFO - PROCESS | 13570 | |2;audio-dft;162;161;162;162;161;167;177;164;162;164 13:04:24 INFO - PROCESS | 13570 | |3;audio-fft;75;75;76;138;77;76;76;75;156;75 13:04:24 INFO - PROCESS | 13570 | |4;audio-oscillator;84;82;141;86;84;84;137;84;84;146 13:04:24 INFO - PROCESS | 13570 | |5;imaging-gaussian-blur;118;117;118;118;117;117;117;117;118;119 13:04:24 INFO - PROCESS | 13570 | |6;imaging-darkroom;147;147;148;149;147;147;148;147;147;146 13:04:24 INFO - PROCESS | 13570 | |7;imaging-desaturate;96;96;96;96;96;96;95;96;95;96 13:04:24 INFO - PROCESS | 13570 | |8;json-parse-financial;55;53;55;54;53;55;53;54;53;53 13:04:24 INFO - PROCESS | 13570 | |9;json-stringify-tinderbox;63;63;63;63;63;62;62;62;62;62 13:04:24 INFO - PROCESS | 13570 | |10;stanford-crypto-aes;75;76;76;79;85;76;81;76;80;83 13:04:24 INFO - PROCESS | 13570 | |11;stanford-crypto-ccm;130;121;119;120;135;123;123;132;162;124 13:04:24 INFO - PROCESS | 13570 | |12;stanford-crypto-pbkdf2;155;155;163;153;159;158;153;160;154;159 13:04:24 INFO - PROCESS | 13570 | |13;stanford-crypto-sha256-iterative;62;64;66;64;66;62;62;63;65;63 13:04:24 INFO - PROCESS | 13570 | __end_tp_report 13:04:24 INFO - PROCESS | 13570 | __start_cc_report 13:04:24 INFO - PROCESS | 13570 | _x_x_mozilla_cycle_collect,924 13:04:24 INFO - PROCESS | 13570 | __end_cc_report 13:04:24 INFO - PROCESS | 13570 | __startTimestamp1468613064493__endTimestamp 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | ------- Summary: start ------- 13:04:24 INFO - PROCESS | 13570 | Number of tests: 14 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.50 stddev:4.14 (3.7%) stddev-sans-first:2.69 13:04:24 INFO - PROCESS | 13570 | Values: 101.0 111.0 105.0 113.0 113.0 112.0 114.0 113.0 111.0 110.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:149.50 stddev:24.15 (16.2%) stddev-sans-first:25.16 13:04:24 INFO - PROCESS | 13570 | Values: 156.0 117.0 152.0 178.0 119.0 146.0 147.0 118.0 179.0 119.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.00 stddev:4.85 (3.0%) stddev-sans-first:5.08 13:04:24 INFO - PROCESS | 13570 | Values: 162.0 161.0 162.0 162.0 161.0 167.0 177.0 164.0 162.0 164.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#3] audio-fft Cycles:10 Average:89.90 Median:75.50 stddev:30.40 (40.3%) stddev-sans-first:31.76 13:04:24 INFO - PROCESS | 13570 | Values: 75.0 75.0 76.0 138.0 77.0 76.0 76.0 75.0 156.0 75.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:84.00 stddev:27.79 (33.1%) stddev-sans-first:28.77 13:04:24 INFO - PROCESS | 13570 | Values: 84.0 82.0 141.0 86.0 84.0 84.0 137.0 84.0 84.0 146.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 13:04:24 INFO - PROCESS | 13570 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 119.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 13:04:24 INFO - PROCESS | 13570 | Values: 147.0 147.0 148.0 149.0 147.0 147.0 148.0 147.0 147.0 146.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:04:24 INFO - PROCESS | 13570 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.87 13:04:24 INFO - PROCESS | 13570 | Values: 55.0 53.0 55.0 54.0 53.0 55.0 53.0 54.0 53.0 53.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 13:04:24 INFO - PROCESS | 13570 | Values: 63.0 63.0 63.0 63.0 63.0 62.0 62.0 62.0 62.0 62.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.50 stddev:3.47 (4.4%) stddev-sans-first:3.41 13:04:24 INFO - PROCESS | 13570 | Values: 75.0 76.0 76.0 79.0 85.0 76.0 81.0 76.0 80.0 83.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:127.00 stddev:12.81 (10.1%) stddev-sans-first:13.58 13:04:24 INFO - PROCESS | 13570 | Values: 130.0 121.0 119.0 120.0 135.0 123.0 123.0 132.0 162.0 124.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:158.50 stddev:3.38 (2.1%) stddev-sans-first:3.52 13:04:24 INFO - PROCESS | 13570 | Values: 155.0 155.0 163.0 153.0 159.0 158.0 153.0 160.0 154.0 159.0 13:04:24 INFO - PROCESS | 13570 | 13:04:24 INFO - PROCESS | 13570 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.57 (2.4%) stddev-sans-first:1.54 13:04:24 INFO - PROCESS | 13570 | Values: 62.0 64.0 66.0 64.0 66.0 62.0 62.0 63.0 65.0 63.0 13:04:24 INFO - PROCESS | 13570 | -------- Summary: end -------- 13:04:24 INFO - PROCESS | 13570 | 13:04:25 INFO - TEST-INFO | 13570: exit 0 13:04:25 INFO - TEST-OK | kraken | took 61782ms 13:04:25 INFO - SUITE-END | took 1172s 13:04:25 INFO - Completed test suite (00:19:32) 13:04:25 INFO - javascript benchmark 13:04:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7274.11665232745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3027.651820040695, 3069.416810805948, 3085.1515833145895, 3087.0, 3091.1344823449426, 5439.755211015504, 5452.291202143726, 5484.7531861066245, 5508.724563771815, 5518.862028449291, 5367.865803354918, 5413.53984911283, 5447.918281225785, 5452.318460192476, 5524.364698059724, 4908.950910490894, 4925.729084900329, 5033.345665063536, 5079.822206222783, 5114.7698353574, 707.5421243152866, 4904.190808516591, 4957.900841983158, 5001.499850015006, 5036.647434679556, 5030.874228144289, 5043.873903152414, 5045.798168073273, 5049.899002019957, 5060.063888180698, 5080.771365288534, 5083.237514372837, 5086.440491545927, 5090.770915308783, 5126.026055049529, 4940.036692844897, 4968.205087186033, 4981.352424184833, 5022.522860328263, 5060.595152387837, 5520.475554822286, 5532.336119665626, 5536.889262214773, 5542.806001789918, 5591.944080559183, 5733.397993210695, 5822.097574875901, 5933.228680271537, 5936.881262374728, 5971.581989260753, 5878.353381128072, 5890.617109887844, 5927.022041363213, 5948.851278718023, 5992.071228959475, 5513.5037846594, 5514.6691198528215, 5527.889442211173, 5543.861403464905, 5545.0018996581, 5839.357670656224, 6057.969710151421, 6060.0, 6068.393160683896, 6122.908156377658, 5650.237217975603, 5651.9152212716845, 5701.771929122871, 5730.455606717355, 5745.88508229833, 5825.242718446575, 5830.912536311958, 5839.562032847553, 5842.912356314659, 5854.736536855852, 5716.142578613241, 5756.510696590837, 5773.076307790733, 5785.392533783976, 5807.245058142415, 5771.378430121224, 5824.737886795105, 5827.213326200908, 5828.5337173026055, 5833.183354330397, 4379.912401751947, 4431.047324825114, 4436.245838207513, 4450.265706158512, 4492.326151077365, 3887.358585833306, 3912.8043597819997, 3952.545457272393, 3967.543732470745, 3973.205358928226, 5532.2254884315425, 5577.414371491016, 5589.105743081088, 5627.831165065055, 5630.0, 5793.8841223175305, 5891.05743081105, 5893.970530147408, 5905.7932972346625, 5918.378570250148, 5514.972425137848, 5541.224228607998, 5546.833594992157, 5555.361133469622, 5561.637398837311, 5000.474950130257, 5053.444121146671, 5054.2661794527185, 5060.671056381323, 5109.770060347293, 5946.940530594638, 6035.939640603626, 6067.696615169224, 6076.878462430726, 6091.177691011657, 5879.059350503813, 5959.67221802805, 5964.701764911651, 5984.1921340618455, 5998.210831963158, 6072.30168530607, 6079.088136779518, 6092.725827337692, 6125.9693701531205, 6145.262568491809, 5599.552035837205, 5789.884202316014, 5793.739281732416, 5821.970890145522, 5831.825045248649, 5945.524358051259, 5946.167536544801, 5951.732172052181, 5963.612365196248, 6018.247719035121, 5811.302643682785, 5814.796482123105, 5815.127730840408, 5816.302043754777, 5817.243758311392, 5626.1842032905815, 5695.829125126253, 5729.512991395778, 5756.366799651951, 5790.710464476843, 5655.802046928337, 5696.572757043321, 5697.23087383198, 5710.800121995876, 5712.228849105318, 5752.395998420273, 5766.135079738073, 5771.480566749013, 5812.564057695605, 5837.562182836219, 5462.590305727007, 5670.773169073191, 5684.403137670485, 5737.971310143423, 5770.394108618535], "value": 5381.910959958904, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.5094882786142, 587.0, 594.3046635436539, 616.6916541729134, 632.8386261503316, 40870.79564602177, 42281.0, 44561.0, 44705.552944470546, 44740.77629611856, 45152.54847451524, 45614.543854561445, 45621.31568026482, 45812.77093614527, 45820.31269530951, 8893.733188004355, 8986.460812351248, 9013.233875120623, 9031.23234525066, 9040.367174297802, 8916.15296546827, 8959.73120806377, 8980.775480612972, 9014.233790127848, 9031.187193152615, 8970.730878073668, 9012.954935225314, 9038.2317503012, 9047.728568142966, 9087.909120908806, 8979.293934152523, 8992.055834137453, 9032.27741780656, 9054.366194366365, 9072.183503484684, 8919.73240802777, 8930.151635594608, 8959.507227102507, 8987.595558199831, 9003.59483823223, 33478.33043339144, 37178.0, 37309.06727331838, 37368.06579835526, 37406.625933740586, 3421.127612458832, 3432.70821980132, 3440.673136052071, 3478.9826050869838, 3660.194757153422, 31543.526847097313, 31888.681113188803, 32085.83957080223, 32128.196795080075, 32986.34027319464, 3377.5946886373545, 3414.487826825996, 3442.1050526862946, 3464.2898205867737, 3511.052015955703, 299839.0, 300995.0, 302162.0, 303336.0, 303732.4813375941, 34139.31721365559, 35060.12349691278, 35073.82463087668, 35157.29685406278, 35351.0, 36834.07914802151, 36845.0, 36902.8154859224, 36903.81548092296, 36995.63004369922, 15492.14793186363, 15496.30266638004, 15502.689946201239, 15536.223188840513, 15587.06477611347, 12801.679958001125, 12832.935835320764, 12860.0, 12875.742485150244, 12921.935390322988, 8324.458910170819, 8342.874856877152, 8346.457480263764, 8400.327973762085, 8470.957645211858, 3232.8221947792626, 3234.2832021102386, 3254.4792833146585, 3263.7878537894962, 3267.8856240031487, 959.2374062620233, 1017.2421545948316, 1020.2501161646184, 1053.8893416191343, 1081.8079940231603, 32693.346133077204, 32898.83550582232, 33054.5041824368, 33182.336353272796, 33463.3307333852, 1083.869935607732, 1128.9209755317213, 1134.1267224237456, 1192.3263356203718, 1195.8385617941467, 16927.746083808754, 17120.0, 17390.565235869206, 17471.475855724348, 17492.47522574325, 567296.0, 570230.0, 570476.0, 571440.0, 571950.0, 57816.71091644599, 59147.40852591419, 59221.70389148027, 59300.11049834256, 59350.70324648349, 1324.5364122557028, 1335.8998075144402, 1349.6490912362856, 1352.4387379237505, 1362.2575696245767, 30685.23286917845, 32262.838685806422, 32326.676733233307, 32670.34659306848, 33042.17394565155, 50950.0, 51390.48609513857, 51623.741881290356, 51946.22080668869, 52095.73952130215, 506712.0, 507803.0, 508351.0, 508916.0, 509791.0, 25931.22206333813, 26009.349766255997, 26123.955041798115, 26166.084187054123, 27223.59164612493, 49203.753981229864, 49530.25704614362, 49838.25242621436, 50705.0, 50960.23559646534, 42976.0, 44072.118557628026, 44121.77939110412, 44655.330170048124, 45129.323060154784, 41902.37146442745, 43082.78458607687, 43246.351304729826, 43457.13085738331, 44450.55549444464, 43805.78097109622, 45281.0, 45389.54610453853, 46065.76967115277, 46364.30453543132, 43465.78267108644, 44806.55193448154, 45564.772176138904, 45875.08249834918, 45903.54096458993, 34148.31703365968, 35180.472292916136, 35207.82396088003, 35306.11734706653, 35503.82248088743], "value": 18940.3627181897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.39962856829055, 395.85749130313076, 396.9662578680812, 399.86004898285603, 416.3983044500696, 14286.0, 18832.90583547082, 19806.90096549515, 20241.797582024174, 20365.28721494748, 19154.13806378713, 19653.50866228345, 19723.704144437845, 19812.30656927008, 19884.304049358274, 5430.456954304567, 5616.3260408751, 5683.403242659502, 5995.280566332046, 6005.189299444584, 5971.0, 6041.637501749887, 6044.123602077696, 6058.0, 6081.3006504252135, 5988.730507127168, 6049.243844519435, 6083.452489275965, 6116.81649550512, 6118.877622447549, 6097.817065488042, 6299.33856945021, 6677.732890684342, 6680.265170831205, 6812.386885180357, 5961.701914904281, 5992.9700351498395, 6012.488938440238, 6012.609180403259, 6037.728302226366, 14789.0, 14802.703945921021, 21635.026423810967, 23211.3036608902, 23703.288901332988, 2482.32977096183, 2537.0359263479945, 2608.79129669626, 2815.507286224923, 3056.0, 10457.58169673212, 10574.577016919315, 10868.61959831402, 11137.05335046522, 14638.926805365905, 1928.363639998797, 1947.7662680478293, 1992.1732481020358, 1996.8103030212108, 2025.73665423494, 85094.57452712758, 87823.0, 88054.0, 89288.55355723244, 91156.54421727848, 10443.373397596017, 10446.955304469493, 10775.353478791141, 11294.774104517863, 11362.375069371265, 15594.29825657848, 15698.68602627941, 15722.371105155895, 15752.369905203663, 15756.76364854528, 8236.588170591447, 8393.496390216607, 8419.663213471515, 8503.149685031447, 8557.058723540405, 8042.396820238506, 8109.148539403395, 8137.633806478722, 8163.10205877353, 8290.751277461564, 4754.882602588389, 4766.642501812378, 4792.209285467929, 4821.228603423436, 4828.927566086511, 1951.7853036166011, 1967.960640787205, 1983.9206431742568, 1989.9801001990083, 2024.5647185855112, 907.6324088744069, 952.173568770284, 1001.4241810958728, 1083.8211695070383, 1102.32207192576, 20411.36881033117, 20671.483212919797, 20684.689729654066, 20813.271535496184, 20845.374638760863, 994.7015895231401, 998.1266391907081, 1005.8038682456997, 1024.293237666008, 1029.9330543514648, 10781.784364312669, 11461.885381146249, 11463.942680286713, 11523.423828808525, 11532.135089868294, 494631.0, 500602.0, 509353.0, 509627.0, 511377.0, 58830.70584647135, 84104.15895840964, 84153.57923210345, 96941.5152924231, 98261.0, 945.3666043750703, 959.2421986630484, 969.8011907558933, 978.090375950373, 992.846108853129, 18676.906615466836, 18733.939266680383, 19277.0, 19309.0, 19400.611987760447, 44862.102757944005, 44999.32501012422, 45097.32354014758, 45297.0, 46202.76898615486, 63720.362796371446, 63817.361826383, 64480.67759661359, 65012.34987650252, 65102.674486629156, 8595.18345757152, 8625.784355391166, 8639.222469977733, 8656.91343086561, 8687.956560217159, 9793.853092203764, 12798.68003299925, 13008.414621341873, 13037.543685970946, 13089.934550327187, 11182.440877955907, 11194.328340299608, 11270.0, 11306.604268850551, 11319.434028298387, 10843.295185812896, 11080.722981925517, 11226.158038147008, 11412.828807567726, 11603.535858565563, 10998.395088270221, 11120.499577519193, 11297.0, 11513.481893314989, 11733.0, 8398.328133749408, 8703.086175951434, 8714.38999270045, 8736.606852691772, 8866.911330886609, 8897.555122243992, 11090.724566674935, 11185.944070279596, 11336.773264534828, 11663.650090497298], "value": 9416.611964964843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.6564590144262, 1517.1049081042186, 1639.4016184092802, 1788.4277031349966, 1791.7133258678614, 8013.11855695873, 8618.181272779077, 8664.0, 9227.169554740072, 9235.26117910568, 8840.160184782435, 8926.642934282621, 8975.102489751021, 8982.730518084452, 9057.90942090579, 2346.1671106757112, 2371.4782747795457, 2376.572217000939, 2377.3699969508093, 2380.583397905368, 2354.9293521194304, 2377.5126099149634, 2382.3924899150693, 2400.1239547565187, 2401.5917294059964, 2356.1988923765916, 2383.4398916254668, 2388.665586817847, 2393.3418309964813, 2395.4969456414174, 2343.589871772433, 2349.8472599281076, 2361.2325994052003, 2364.7517010713973, 2365.5387199496104, 2311.6879221305076, 2320.756320586348, 2341.789238968484, 2342.26218741096, 2348.7181538215523, 9133.178013978708, 9184.540772961325, 9192.95403522978, 9205.217556507638, 9212.124848139416, 5289.497497737709, 5427.457254274541, 5431.83704488866, 5453.781848726086, 5455.18172274158, 3322.501624756306, 3372.7470439717117, 3400.0819778659625, 3451.4132597458242, 3454.516367708523, 1080.3193987787643, 1091.7543552700579, 1092.0226397374306, 1093.2074246171542, 1112.2103306652286, 12467.189632673937, 12490.375481225994, 12508.937455312756, 12515.74968500634, 12550.058745594026, 4496.392986946786, 4572.0627271409285, 4714.151452738472, 4719.0, 4740.075685241345, 10611.734706632396, 10648.0, 10664.0, 10695.465226738788, 10736.89263107359, 5327.3074500314715, 5327.600429967768, 5334.946650533522, 5358.8660283492445, 5362.731863406814, 4292.291771857671, 4752.928706069411, 4884.3161957326, 4891.388576427947, 4926.6551341406475, 4010.3583426651594, 4020.8190631421658, 4077.4903137107863, 4086.1214838809797, 4086.693497987663, 1295.57893684551, 1296.3471573743552, 1311.3312210772574, 1326.9867301327056, 1330.7737684593642, 961.5048250151178, 983.6785186958772, 987.116530705015, 989.4656885282011, 1004.2217281606668, 5877.765669209429, 5921.763129474859, 5986.850328741729, 6040.067178502837, 6113.969430152821, 441.5672640812022, 443.29737366274816, 446.3862189489452, 982.219135787051, 1045.2160879340495, 4003.1793482336634, 4025.3156963316305, 4033.838646454109, 4038.959610403917, 4157.584241575879, 10884.292520986111, 11220.214584978972, 11232.943835280772, 11249.83125253122, 11299.548018079186, 10766.676999690022, 11099.167562432849, 11147.665570032912, 11167.553297868157, 11206.719832004264, 8148.755537333889, 8292.051367928532, 8325.375596830261, 8342.62458189383, 8362.790930226793, 5673.205751194919, 5748.367679555329, 5780.508656764222, 5786.161006653927, 5883.999720047516, 10540.420276884844, 10598.629047983284, 10617.0, 10711.0, 10711.732206694895, 10239.846402303823, 10324.48377581133, 10715.410652414192, 10742.409167495864, 10807.135429165804, 6218.0, 7130.465215108784, 7203.8559228816175, 7317.780466586011, 7326.560406375635, 8876.334274929277, 8933.28533717314, 8933.731988040368, 8935.0, 8956.507392093237, 7553.7356192533, 7702.884456733042, 7724.382049436144, 7774.30031297186, 7849.058113026245, 7648.235176482307, 7674.347680447001, 7775.572343520935, 7783.922160778547, 7857.292843643871, 7066.893996590158, 7123.394511466583, 7125.3230943060325, 7164.355208031302, 7178.8564228714085, 4928.260760885896, 5033.874153146201, 5103.387593488805, 5167.974160129175, 5174.844754657366, 5299.2316114164005, 5360.65155764874, 5386.218998245311, 5413.052715774802, 5468.972655136698], "value": 4661.380127307044, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.6683316683317, 335.3477486289168, 340.13435805874064, 340.4773672412847, 343.1849357775284, 5569.777208911643, 5599.236240584219, 5618.471687740518, 5625.40933202014, 5673.290838645169, 5465.398806131332, 5476.17857321402, 5498.80754173604, 5531.502164805167, 5533.257024037425, 4077.7553346799214, 4188.350805625133, 4309.547497512763, 4322.589354011379, 4327.74033557986, 4267.850625228118, 4301.182775272689, 4304.569543045686, 4318.330658747884, 4338.696291259597, 4259.190753756792, 4276.486821581399, 4281.143771245747, 4294.334378171388, 4300.97849510752, 4067.430559721656, 4274.358846173099, 4282.308488147196, 4284.614384705392, 4300.784960751966, 3715.4055351143957, 3723.9813800930824, 3740.1023754299044, 3751.118487155516, 3751.74316603938, 5392.622516423852, 5401.405845357047, 5466.8359949201185, 5490.69801160936, 5491.419033054458, 4853.150698627726, 4853.781579828917, 4909.288153217799, 4914.410270767495, 4936.531029552187, 5774.769009239625, 5789.334226563957, 5790.7973220937065, 5814.592978491507, 5818.941810581925, 4092.5498195198506, 4129.752214867118, 4134.421181034658, 4134.710570260083, 4149.024979129902, 5812.38969908162, 5939.2575928009, 6004.42957918997, 6014.879702405928, 6090.939090609126, 4159.209750147523, 4163.063310755117, 4173.269677806433, 4191.832326706897, 4191.8532851350055, 4226.767527786002, 4228.154369126187, 4249.150169966019, 4259.787010649455, 4265.0, 4690.929636055462, 4894.730789806595, 4897.534734200245, 4912.803487860517, 4924.72913989734, 5805.593608447368, 5820.388859169726, 5834.824955251349, 5869.413058694096, 5913.196475075058, 1469.1478942213491, 1497.7119677077706, 1501.3394106593064, 1502.9479364444933, 1504.9247537623294, 944.9196818270386, 967.8596603492454, 986.2208855004466, 1014.7209517382779, 1024.7386916336436, 5446.754896029688, 5559.833205003856, 5616.550675945915, 5617.971910140505, 5649.406812284651, 5896.882062358729, 5922.496587790086, 5932.49573786233, 5976.372480889531, 5992.15372697965, 5395.460453954652, 5596.888062238732, 5750.108733146369, 5772.249607550992, 5779.624324418984, 3212.855421506038, 3222.3555288942307, 3234.692704193098, 3242.4649932761304, 3264.237311851621, 6102.511799056065, 6226.688665566703, 6243.470349764246, 6251.999360204691, 6282.748690052438, 6152.077188421683, 6161.568690191643, 6164.506839452833, 6201.193844800147, 6237.812865614039, 5993.3706960768495, 6266.154069200691, 6285.9057114143325, 6301.464375528039, 6309.526785491106, 5988.041913293852, 5991.244027747285, 6006.699665016819, 6025.78909738157, 6025.939740602713, 5893.499052580579, 5959.851003724768, 5973.790917317873, 5994.250718660168, 6019.103982245579, 6019.789307374221, 6146.723397447036, 6155.384461553809, 6195.380461953769, 6217.533684973555, 4133.400656904792, 4162.791860407028, 4183.121544475573, 4195.223883581547, 4197.286461301525, 5737.397573254915, 5812.593118481665, 6016.699165041818, 6022.879542409215, 6103.389661033861, 5848.473637372657, 5856.677882716492, 5861.160939584579, 5870.589058765845, 5898.882022359443, 5802.535797136304, 5855.795047173328, 5875.063707316023, 5882.411758824083, 5904.261967254093, 5591.6365436246515, 5756.827295181151, 5767.250257466502, 5776.508996735157, 5801.941980580309, 5851.941480585139, 5860.208871802252, 5885.411458854081, 5918.2898052234, 5923.437273459014, 5493.340799104133, 5749.885002299847, 5755.539556835527, 5768.826935191951, 5791.82624521265], "value": 4435.460712317407, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.2723839779419, 735.2685469006941, 824.8020475085978, 831.7587899509147, 839.9412041157121, 13208.801867971975, 14567.271636418189, 14772.556823295292, 14807.851921480782, 14836.629084272898, 13346.532871349506, 13451.730965380686, 13468.66328341792, 13501.2574308413, 13534.052616316862, 640.3468462168586, 755.6939439526986, 763.5914785589711, 785.1206648553627, 786.3709032773787, 780.5550836023469, 785.8074771680917, 786.0763602766726, 789.17925357628, 790.1269097647104, 832.9958350208241, 836.1638361638362, 838.4508147163588, 840.6133178737788, 841.5287439034161, 829.2826704900248, 835.2274146414603, 837.0833936839151, 837.9203975622337, 839.4879123734516, 605.8364241654773, 607.271274470637, 607.6991889014965, 608.1698481572665, 608.9177960975256, 13619.387127579283, 13620.387082581208, 13650.0, 13658.453661853513, 13659.317034148253, 14845.851541484662, 14941.17823519706, 15237.61905952349, 15289.0, 15503.147326897017, 11920.701982450508, 11982.460789264416, 12026.398680065962, 12179.086568507397, 12194.366140866503, 3912.256671232485, 3952.3873799561115, 3955.208958208341, 3957.0503079261057, 4069.165821006716, 79289.60355198187, 79874.20125798725, 79907.20092799056, 79919.60040199762, 84394.57802711008, 10963.451827408599, 10971.725706857393, 11106.44467776608, 11223.270487418291, 11268.042216411697, 22351.994160262828, 22538.887305563694, 22618.547629047654, 22660.660090098663, 22708.205212817473, 8568.657253709782, 8726.127387261224, 8731.083236260229, 8798.560071996502, 8838.248748856418, 4834.395700537433, 4957.161867832241, 4996.850094497171, 5022.799088036438, 5186.974065129651, 3423.4864770284657, 3494.1963348430004, 3504.0539054455153, 3528.68241858234, 3532.6114127445962, 608.856918624123, 624.1262232874012, 632.0361448790632, 635.7425242776683, 643.2313385504277, 653.0009086098278, 728.5300980867311, 743.4387037786545, 752.3153929923852, 761.2501685839444, 8631.309495240366, 8740.169683880022, 8833.955830220808, 9010.098990100938, 9309.72070837876, 594.4531031451075, 594.6224147666263, 688.6178171114979, 735.7020406735281, 744.144234130754, 4409.9559004410185, 4567.586596721556, 4583.862484125481, 4608.124456353349, 4673.322368256584, 110635.0, 113728.43135784268, 114939.42530287462, 115972.42013789876, 119101.0, 100058.499707501, 100805.49597251967, 100872.0, 101048.0, 101864.49067754614, 82681.99999999879, 84481.15518844855, 86326.0, 86917.0, 90694.0, 8532.744017679479, 8839.64093644411, 8913.242374397989, 8954.328425368254, 8970.551472426483, 36817.815910920275, 42684.57315426806, 47055.52944470648, 48377.0, 48388.758056209495, 74570.50858982898, 76009.61995189989, 78591.0, 80326.79509807241, 80808.19191808006, 13675.0, 13730.794038089636, 13803.654908627364, 13879.514217002357, 14168.929155354157, 12397.44211510466, 12403.25580465175, 12878.742425151631, 13220.669483262995, 14922.925385373004, 13076.476940922257, 13251.801222981856, 13335.599932002055, 13396.330183490982, 13955.720885582028, 12589.307588082744, 12848.164869283466, 13067.803982940453, 13431.597052088453, 13566.660833479242, 13213.537526186537, 13219.603411897659, 13295.20228786276, 13439.395227214995, 13659.317034148451, 11543.711407214887, 11556.653300401002, 11946.701332466759, 11970.162088653711, 12017.218880772722, 11295.943520282346, 11386.772264554827, 11616.128790340927, 11689.0, 11787.823182652095], "value": 7463.938607401816, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 113.0, 113.0, 112.0, 114.0, 113.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 117.0, 152.0, 178.0, 119.0, 146.0, 147.0, 118.0, 179.0, 119.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 161.0, 167.0, 177.0, 164.0, 162.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 138.0, 77.0, 76.0, 76.0, 75.0, 156.0, 75.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 141.0, 86.0, 84.0, 84.0, 137.0, 84.0, 84.0, 146.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 54.0, 53.0, 55.0, 53.0, 54.0, 53.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 79.0, 85.0, 76.0, 81.0, 76.0, 80.0, 83.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 121.0, 119.0, 120.0, 135.0, 123.0, 123.0, 132.0, 162.0, 124.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 163.0, 153.0, 159.0, 158.0, 153.0, 160.0, 154.0, 159.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 66.0, 64.0, 66.0, 62.0, 62.0, 63.0, 65.0, 63.0], "value": 63.7, "unit": "score"}]}]} 13:04:25 INFO - Return code: 0 13:04:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:04:25 ERROR - # TBPL SUCCESS # 13:04:25 INFO - Running post-action listener: _resource_record_post_action 13:04:25 INFO - ##### 13:04:25 INFO - ##### Finished run-tests step (success) 13:04:25 INFO - ##### 13:04:25 INFO - Running post-run listener: _resource_record_post_run 13:04:25 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 568979456; Read time: 16; Write time: 385844 13:04:25 INFO - TinderboxPrint: CPU usage
13.3% 13:04:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 13:04:25 INFO - TinderboxPrint: I/O write bytes / time
568,979,456 / 385,844 13:04:25 INFO - TinderboxPrint: CPU idle
8,232.1 (86.7%) 13:04:25 INFO - TinderboxPrint: CPU user
1,209.4 (12.7%) 13:04:25 INFO - TinderboxPrint: Swap in / out
0 / 0 13:04:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 257519616; Read time: 0; Write time: 203500 13:04:25 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 295694336; Read time: 0; Write time: 173136 13:04:26 INFO - Running post-run listener: _upload_blobber_files 13:04:26 INFO - Blob upload gear active. 13:04:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:04:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:04:26 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:04:26 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:04:26 INFO - (blobuploader) - INFO - Open directory for files ... 13:04:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:04:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:04:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:27 INFO - (blobuploader) - INFO - Done attempting. 13:04:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:04:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:04:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:32 INFO - (blobuploader) - INFO - Done attempting. 13:04:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:04:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:04:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:33 INFO - (blobuploader) - INFO - Done attempting. 13:04:33 INFO - (blobuploader) - INFO - Iteration through files over. 13:04:33 INFO - Return code: 0 13:04:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:04:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:04:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/314a4105efafa53ff0755b7e449bc26c4504b37ba9094e5dfa3008cd142a54f4d717988aeddfca39c6b62ab3cca65a0de7f661db391f4888205c09826ff9182b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdf7279b15ae2d1da23f236d9e7ae8a74ed491e1828eef08c357ebe8f55e7cfad5813a4d6536738294522ee5204a0a95376623eaa5a1384af436be361fe29b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/496d712869d40833f20cce799f4f80a50bd582a0822ddfd1576712a795375617edc940dcee9f93228ad71d34bd309eeb4366aef9bf67c5678b30b965ca4d6868"} 13:04:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:04:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:04:33 INFO - Contents: 13:04:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/314a4105efafa53ff0755b7e449bc26c4504b37ba9094e5dfa3008cd142a54f4d717988aeddfca39c6b62ab3cca65a0de7f661db391f4888205c09826ff9182b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdf7279b15ae2d1da23f236d9e7ae8a74ed491e1828eef08c357ebe8f55e7cfad5813a4d6536738294522ee5204a0a95376623eaa5a1384af436be361fe29b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/496d712869d40833f20cce799f4f80a50bd582a0822ddfd1576712a795375617edc940dcee9f93228ad71d34bd309eeb4366aef9bf67c5678b30b965ca4d6868"} 13:04:33 INFO - Running post-run listener: copy_logs_to_upload_dir 13:04:33 INFO - Copying logs to upload dir... 13:04:33 INFO - mkdir: /builds/slave/test/build/upload/logs 13:04:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.946880 ========= master_lag: 7.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-15 13:04:40.000563) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 13:04:40.001669) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/314a4105efafa53ff0755b7e449bc26c4504b37ba9094e5dfa3008cd142a54f4d717988aeddfca39c6b62ab3cca65a0de7f661db391f4888205c09826ff9182b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdf7279b15ae2d1da23f236d9e7ae8a74ed491e1828eef08c357ebe8f55e7cfad5813a4d6536738294522ee5204a0a95376623eaa5a1384af436be361fe29b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/496d712869d40833f20cce799f4f80a50bd582a0822ddfd1576712a795375617edc940dcee9f93228ad71d34bd309eeb4366aef9bf67c5678b30b965ca4d6868"} build_url:https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/A0jm4NDASJ-u0Hcv6KASMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/314a4105efafa53ff0755b7e449bc26c4504b37ba9094e5dfa3008cd142a54f4d717988aeddfca39c6b62ab3cca65a0de7f661db391f4888205c09826ff9182b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdf7279b15ae2d1da23f236d9e7ae8a74ed491e1828eef08c357ebe8f55e7cfad5813a4d6536738294522ee5204a0a95376623eaa5a1384af436be361fe29b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/496d712869d40833f20cce799f4f80a50bd582a0822ddfd1576712a795375617edc940dcee9f93228ad71d34bd309eeb4366aef9bf67c5678b30b965ca4d6868"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 13:04:40.126312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:04:40.129768) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1468611840.853487-1258043999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 13:04:40.418587) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 13:04:40.418962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 13:04:40.424670) ========= ========= Total master_lag: 7.48 =========