builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1468325471.5 results: success (0) buildid: 20160712023026 builduid: d91119467f71410c8c4a14d7add2fa89 revision: efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:11.500202) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:11.500684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:11.500972) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:11.516031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:11.516427) ========= 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=d2a8c569965ab8367867b893000001a1-1468325471.178437-787624523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 05:11:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.1M=0s 2016-07-12 05:11:12 (96.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076055 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:11.606450) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:11.606806) ========= 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=d2a8c569965ab8367867b893000001a1-1468325471.178437-787624523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015565 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:11.656677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:11.657090) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 --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 efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 --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=d2a8c569965ab8367867b893000001a1-1468325471.178437-787624523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 05:11:12,178 truncating revision to first 12 chars 2016-07-12 05:11:12,178 Setting DEBUG logging. 2016-07-12 05:11:12,178 attempt 1/10 2016-07-12 05:11:12,178 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/efc08ad3e8af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 05:11:12,482 unpacking tar archive at: fx-team-efc08ad3e8af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:12.294695) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:12.295118) ========= script_repo_revision: efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:12.295544) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:12.295874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:12.307669) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-12 05:11:12.308142) ========= /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=d2a8c569965ab8367867b893000001a1-1468325471.178437-787624523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:11:12 INFO - MultiFileLogger online at 20160712 05:11:12 in /builds/slave/test 05:11:12 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 05:11:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:11:12 INFO - {'append_to_log': False, 05:11:12 INFO - 'base_work_dir': '/builds/slave/test', 05:11:12 INFO - 'blob_upload_branch': 'Fx-Team', 05:11:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:11:12 INFO - 'branch': 'Fx-Team', 05:11:12 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:12 INFO - 'config_files': ('talos/linux_config.py',), 05:11:12 INFO - 'default_actions': ('clobber', 05:11:12 INFO - 'read-buildbot-config', 05:11:12 INFO - 'download-and-extract', 05:11:12 INFO - 'populate-webroot', 05:11:12 INFO - 'create-virtualenv', 05:11:12 INFO - 'install', 05:11:12 INFO - 'run-tests'), 05:11:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:12 INFO - 'download_minidump_stackwalk': True, 05:11:12 INFO - 'download_symbols': 'ondemand', 05:11:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:12 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:12 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:12 INFO - 'installer_path': 'installer.exe', 05:11:12 INFO - 'log_level': 'info', 05:11:12 INFO - 'log_name': 'talos', 05:11:12 INFO - 'log_to_console': True, 05:11:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:11:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:11:12 INFO - 'opt_config_files': (), 05:11:12 INFO - 'pip_index': False, 05:11:12 INFO - 'sps_profile': False, 05:11:12 INFO - 'sps_profile_interval': 0, 05:11:12 INFO - 'suite': 'dromaeojs-e10s', 05:11:12 INFO - 'system_bits': '32', 05:11:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:12 INFO - 'title': 'talos-linux64-ix-043', 05:11:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:12 INFO - 'use_talos_json': True, 05:11:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:11:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:12 INFO - 'work_dir': 'build'} 05:11:12 INFO - ##### 05:11:12 INFO - ##### Running clobber step. 05:11:12 INFO - ##### 05:11:12 INFO - Running pre-action listener: _resource_record_pre_action 05:11:12 INFO - Running main action method: clobber 05:11:12 INFO - rmtree: /builds/slave/test/build 05:11:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:11:13 INFO - Running post-action listener: _resource_record_post_action 05:11:13 INFO - ##### 05:11:13 INFO - ##### Finished clobber step (success) 05:11:13 INFO - ##### 05:11:13 INFO - ##### 05:11:13 INFO - ##### Running read-buildbot-config step. 05:11:13 INFO - ##### 05:11:13 INFO - Running pre-action listener: _resource_record_pre_action 05:11:13 INFO - Running main action method: read_buildbot_config 05:11:13 INFO - Using buildbot properties: 05:11:13 INFO - { 05:11:13 INFO - "project": "", 05:11:13 INFO - "product": "firefox", 05:11:13 INFO - "script_repo_revision": "production", 05:11:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:11:13 INFO - "repository": "", 05:11:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:11:13 INFO - "buildid": "20160712023026", 05:11:13 INFO - "pgo_build": "True", 05:11:13 INFO - "basedir": "/builds/slave/test", 05:11:13 INFO - "buildnumber": 571, 05:11:13 INFO - "slavename": "talos-linux64-ix-043", 05:11:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:11:13 INFO - "platform": "ubuntu64_hw", 05:11:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:11:13 INFO - "branch": "fx-team", 05:11:13 INFO - "repo_path": "integration/fx-team", 05:11:13 INFO - "revision": "efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8", 05:11:13 INFO - "stage_platform": "linux64-pgo", 05:11:13 INFO - "builduid": "d91119467f71410c8c4a14d7add2fa89", 05:11:13 INFO - "slavebuilddir": "test" 05:11:13 INFO - } 05:11:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:11:13 INFO - Running post-action listener: _resource_record_post_action 05:11:13 INFO - ##### 05:11:13 INFO - ##### Finished read-buildbot-config step (success) 05:11:13 INFO - ##### 05:11:13 INFO - ##### 05:11:13 INFO - ##### Running download-and-extract step. 05:11:13 INFO - ##### 05:11:13 INFO - Running pre-action listener: _resource_record_pre_action 05:11:13 INFO - Running main action method: download_and_extract 05:11:13 INFO - mkdir: /builds/slave/test/build/tests 05:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:13 INFO - https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:11:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:11:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:11:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:11:14 INFO - Downloaded 1361 bytes. 05:11:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:11:14 INFO - Using the following test package requirements: 05:11:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:11:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:14 INFO - u'jsshell-linux-x86_64.zip'], 05:11:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:11:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:11:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:14 INFO - https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:11:15 INFO - Downloaded 24271052 bytes. 05:11:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:11:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:11:16 INFO - Return code: 0 05:11:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:11: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')]} 05:11:16 INFO - https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:11:17 INFO - Downloaded 24271052 bytes. 05:11:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:11:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:11:19 INFO - Return code: 0 05:11: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')]} 05:11:19 INFO - https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:11:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:11:20 INFO - Downloaded 14403317 bytes. 05:11:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:11:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:11:20 INFO - Return code: 0 05:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:20 INFO - https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:11:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:11:22 INFO - Downloaded 60512571 bytes. 05:11:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:22 INFO - mkdir: /builds/slave/test/properties 05:11:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:22 INFO - Contents: 05:11:22 INFO - build_url:https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:24 INFO - Running post-action listener: _resource_record_post_action 05:11:24 INFO - Running post-action listener: set_extra_try_arguments 05:11:24 INFO - ##### 05:11:24 INFO - ##### Finished download-and-extract step (success) 05:11:24 INFO - ##### 05:11:24 INFO - ##### 05:11:24 INFO - ##### Running populate-webroot step. 05:11:24 INFO - ##### 05:11:24 INFO - Running pre-action listener: _resource_record_pre_action 05:11:24 INFO - Running main action method: populate_webroot 05:11:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:24 INFO - '--tppagecycles', 05:11:24 INFO - '7'], 05:11:24 INFO - 'tests': ['tsvgm']}}, 05:11:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:24 INFO - 'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:24 INFO - 'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['damp', 'tps']}, 05:11:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:24 INFO - 'tests': ['damp', 'tps']}, 05:11:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['dromaeo_dom']}, 05:11:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['basic_compositor_video']}, 05:11:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:11:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['a11yr', 05:11:24 INFO - 'ts_paint', 05:11:24 INFO - 'tpaint', 05:11:24 INFO - 'sessionrestore', 05:11:24 INFO - 'sessionrestore_no_auto_restore', 05:11:24 INFO - 'tabpaint']}, 05:11:24 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:24 INFO - 'ts_paint', 05:11:24 INFO - 'tpaint', 05:11:24 INFO - 'sessionrestore', 05:11:24 INFO - 'sessionrestore_no_auto_restore', 05:11:24 INFO - 'tabpaint']}, 05:11:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:24 INFO - 'ts_paint', 05:11:24 INFO - 'tpaint', 05:11:24 INFO - 'sessionrestore', 05:11:24 INFO - 'sessionrestore_no_auto_restore', 05:11:24 INFO - 'tabpaint']}, 05:11:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:24 INFO - 'ts_paint', 05:11:24 INFO - 'tpaint', 05:11:24 INFO - 'sessionrestore', 05:11:24 INFO - 'sessionrestore_no_auto_restore', 05:11:24 INFO - 'tabpaint']}, 05:11:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['a11yr', 05:11:24 INFO - 'ts_paint', 05:11:24 INFO - 'tpaint', 05:11:24 INFO - 'sessionrestore', 05:11:24 INFO - 'sessionrestore_no_auto_restore', 05:11:24 INFO - 'tabpaint']}, 05:11:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['a11yr', 05:11:24 INFO - 'ts_paint', 05:11:24 INFO - 'tpaint', 05:11:24 INFO - 'sessionrestore', 05:11:24 INFO - 'sessionrestore_no_auto_restore', 05:11:24 INFO - 'tabpaint']}, 05:11:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['tsvgx', 05:11:24 INFO - 'tsvgr_opacity', 05:11:24 INFO - 'tart', 05:11:24 INFO - 'tscrollx', 05:11:24 INFO - 'cart']}, 05:11:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:24 INFO - 'tsvgr_opacity', 05:11:24 INFO - 'tart', 05:11:24 INFO - 'tscrollx', 05:11:24 INFO - 'cart']}, 05:11:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:24 INFO - 'talos_options': ['--disable-e10s'], 05:11:24 INFO - 'tests': ['tp5o']}, 05:11:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:24 INFO - 'tests': ['tp5o']}, 05:11:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:24 INFO - 'talos_options': ['--disable-e10s', 05:11:24 INFO - '--xperf_path', 05:11:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:24 INFO - 'tests': ['tp5n']}, 05:11:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:24 INFO - 'talos_options': ['--xperf_path', 05:11:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:24 INFO - 'tests': ['tp5n']}}, 05:11:24 INFO - 'talos.zip': {'path': '', 05:11:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:24 INFO - Running post-action listener: _resource_record_post_action 05:11:24 INFO - ##### 05:11:24 INFO - ##### Finished populate-webroot step (success) 05:11:24 INFO - ##### 05:11:24 INFO - ##### 05:11:24 INFO - ##### Running create-virtualenv step. 05:11:24 INFO - ##### 05:11:24 INFO - Running pre-action listener: _resource_record_pre_action 05:11:24 INFO - Running main action method: create_virtualenv 05:11:24 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:11:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:24 INFO - Using real prefix '/usr' 05:11:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:24 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:26 INFO - Installing pip.................done. 05:11:26 INFO - Return code: 0 05:11:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3b0>, '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 0x100b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b740>, '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': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:11:26 INFO - Using env: {'DISPLAY': ':0', 05:11:26 INFO - 'HOME': '/home/cltbld', 05:11:26 INFO - 'LANG': 'en_US.UTF-8', 05:11:26 INFO - 'LANGUAGE': 'en_US:en', 05:11:26 INFO - 'LOGNAME': 'cltbld', 05:11:26 INFO - 'MAIL': '/var/mail/cltbld', 05:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:26 INFO - 'MOZ_NO_REMOTE': '1', 05:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:26 INFO - 'NO_EM_RESTART': '1', 05:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:26 INFO - 'PWD': '/builds/slave/test', 05:11:26 INFO - 'SHELL': '/bin/bash', 05:11:26 INFO - 'SHLVL': '1', 05:11:26 INFO - 'TERM': 'linux', 05:11:26 INFO - 'TMOUT': '86400', 05:11:26 INFO - 'USER': 'cltbld', 05:11:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 05:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:26 INFO - '_': '/tools/buildbot/bin/python'} 05:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:11:26 INFO - Cleaning up... 05:11:26 INFO - Return code: 0 05:11:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3b0>, '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 0x100b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b740>, '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': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:11:26 INFO - Using env: {'DISPLAY': ':0', 05:11:26 INFO - 'HOME': '/home/cltbld', 05:11:26 INFO - 'LANG': 'en_US.UTF-8', 05:11:26 INFO - 'LANGUAGE': 'en_US:en', 05:11:26 INFO - 'LOGNAME': 'cltbld', 05:11:26 INFO - 'MAIL': '/var/mail/cltbld', 05:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:26 INFO - 'MOZ_NO_REMOTE': '1', 05:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:26 INFO - 'NO_EM_RESTART': '1', 05:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:26 INFO - 'PWD': '/builds/slave/test', 05:11:26 INFO - 'SHELL': '/bin/bash', 05:11:26 INFO - 'SHLVL': '1', 05:11:26 INFO - 'TERM': 'linux', 05:11:26 INFO - 'TMOUT': '86400', 05:11:26 INFO - 'USER': 'cltbld', 05:11:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 05:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:26 INFO - '_': '/tools/buildbot/bin/python'} 05:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:27 INFO - Downloading/unpacking psutil>=3.1.1 05:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:29 INFO - Installing collected packages: psutil 05:11:29 INFO - Running setup.py install for psutil 05:11:29 INFO - building 'psutil._psutil_linux' extension 05:11:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:11:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:11:29 INFO - building 'psutil._psutil_posix' extension 05:11:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:11:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:11:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:29 INFO - Successfully installed psutil 05:11:29 INFO - Cleaning up... 05:11:29 INFO - Return code: 0 05:11:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:29 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 0xd4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3b0>, '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 0x100b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b740>, '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': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:11:29 INFO - Using env: {'DISPLAY': ':0', 05:11:29 INFO - 'HOME': '/home/cltbld', 05:11:29 INFO - 'LANG': 'en_US.UTF-8', 05:11:29 INFO - 'LANGUAGE': 'en_US:en', 05:11:29 INFO - 'LOGNAME': 'cltbld', 05:11:29 INFO - 'MAIL': '/var/mail/cltbld', 05:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:29 INFO - 'MOZ_NO_REMOTE': '1', 05:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:29 INFO - 'NO_EM_RESTART': '1', 05:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:29 INFO - 'PWD': '/builds/slave/test', 05:11:29 INFO - 'SHELL': '/bin/bash', 05:11:29 INFO - 'SHLVL': '1', 05:11:29 INFO - 'TERM': 'linux', 05:11:29 INFO - 'TMOUT': '86400', 05:11:29 INFO - 'USER': 'cltbld', 05:11:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 05:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:29 INFO - '_': '/tools/buildbot/bin/python'} 05:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:11:31 INFO - Installing collected packages: mozsystemmonitor 05:11:31 INFO - Running setup.py install for mozsystemmonitor 05:11:31 INFO - Successfully installed mozsystemmonitor 05:11:31 INFO - Cleaning up... 05:11:31 INFO - Return code: 0 05:11:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:31 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 0xd4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3b0>, '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 0x100b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b740>, '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': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:11:31 INFO - Using env: {'DISPLAY': ':0', 05:11:31 INFO - 'HOME': '/home/cltbld', 05:11:31 INFO - 'LANG': 'en_US.UTF-8', 05:11:31 INFO - 'LANGUAGE': 'en_US:en', 05:11:31 INFO - 'LOGNAME': 'cltbld', 05:11:31 INFO - 'MAIL': '/var/mail/cltbld', 05:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:31 INFO - 'MOZ_NO_REMOTE': '1', 05:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:31 INFO - 'NO_EM_RESTART': '1', 05:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:31 INFO - 'PWD': '/builds/slave/test', 05:11:31 INFO - 'SHELL': '/bin/bash', 05:11:31 INFO - 'SHLVL': '1', 05:11:31 INFO - 'TERM': 'linux', 05:11:31 INFO - 'TMOUT': '86400', 05:11:31 INFO - 'USER': 'cltbld', 05:11:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 05:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:31 INFO - '_': '/tools/buildbot/bin/python'} 05:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:32 INFO - Downloading/unpacking jsonschema==2.5.1 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:34 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:34 INFO - warning: no files found matching '*.txt' 05:11:34 INFO - no previously-included directories found matching 'build' 05:11:34 INFO - no previously-included directories found matching 'dist' 05:11:34 INFO - no previously-included directories found matching '.git*' 05:11:34 INFO - Installing collected packages: jsonschema, functools32 05:11:34 INFO - Running setup.py install for functools32 05:11:34 INFO - warning: no files found matching '*.txt' 05:11:34 INFO - no previously-included directories found matching 'build' 05:11:34 INFO - no previously-included directories found matching 'dist' 05:11:34 INFO - no previously-included directories found matching '.git*' 05:11:34 INFO - Successfully installed jsonschema functools32 05:11:34 INFO - Cleaning up... 05:11:34 INFO - Return code: 0 05:11:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', '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 0xd4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3b0>, '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 0x100b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b740>, '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': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11: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 blobuploader==1.2.4 05:11:34 INFO - Using env: {'DISPLAY': ':0', 05:11:34 INFO - 'HOME': '/home/cltbld', 05:11:34 INFO - 'LANG': 'en_US.UTF-8', 05:11:34 INFO - 'LANGUAGE': 'en_US:en', 05:11:34 INFO - 'LOGNAME': 'cltbld', 05:11:34 INFO - 'MAIL': '/var/mail/cltbld', 05:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:34 INFO - 'MOZ_NO_REMOTE': '1', 05:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:34 INFO - 'NO_EM_RESTART': '1', 05:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:34 INFO - 'PWD': '/builds/slave/test', 05:11:34 INFO - 'SHELL': '/bin/bash', 05:11:34 INFO - 'SHLVL': '1', 05:11:34 INFO - 'TERM': 'linux', 05:11:34 INFO - 'TMOUT': '86400', 05:11:34 INFO - 'USER': 'cltbld', 05:11:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 05:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:34 INFO - '_': '/tools/buildbot/bin/python'} 05:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:34 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:37 INFO - Downloading docopt-0.6.1.tar.gz 05:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:37 INFO - Running setup.py install for blobuploader 05:11:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:37 INFO - Running setup.py install for requests 05:11:37 INFO - Running setup.py install for docopt 05:11:38 INFO - Successfully installed blobuploader requests docopt 05:11:38 INFO - Cleaning up... 05:11:38 INFO - Return code: 0 05:11:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:38 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 0xd4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3b0>, '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 0x100b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b740>, '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': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:38 INFO - Using env: {'DISPLAY': ':0', 05:11:38 INFO - 'HOME': '/home/cltbld', 05:11:38 INFO - 'LANG': 'en_US.UTF-8', 05:11:38 INFO - 'LANGUAGE': 'en_US:en', 05:11:38 INFO - 'LOGNAME': 'cltbld', 05:11:38 INFO - 'MAIL': '/var/mail/cltbld', 05:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:38 INFO - 'MOZ_NO_REMOTE': '1', 05:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:38 INFO - 'NO_EM_RESTART': '1', 05:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:38 INFO - 'PWD': '/builds/slave/test', 05:11:38 INFO - 'SHELL': '/bin/bash', 05:11:38 INFO - 'SHLVL': '1', 05:11:38 INFO - 'TERM': 'linux', 05:11:38 INFO - 'TMOUT': '86400', 05:11:38 INFO - 'USER': 'cltbld', 05:11:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 05:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:38 INFO - '_': '/tools/buildbot/bin/python'} 05:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:38 INFO - Running setup.py (path:/tmp/pip-SJCFvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:38 INFO - Running setup.py (path:/tmp/pip-KnwOQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:38 INFO - Running setup.py (path:/tmp/pip-ZyOYdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:38 INFO - Running setup.py (path:/tmp/pip-X9CSrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:38 INFO - Running setup.py (path:/tmp/pip-buUneC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:38 INFO - Running setup.py (path:/tmp/pip-oWw23r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:38 INFO - Running setup.py (path:/tmp/pip-2uH4Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:38 INFO - Running setup.py (path:/tmp/pip-quZHLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:38 INFO - Running setup.py (path:/tmp/pip-48B6Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:39 INFO - Running setup.py (path:/tmp/pip-E03iyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:39 INFO - Running setup.py (path:/tmp/pip-R6lTIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:39 INFO - Running setup.py (path:/tmp/pip-xz8_yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:39 INFO - Running setup.py (path:/tmp/pip-qqk1po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:39 INFO - Running setup.py (path:/tmp/pip-yOAkHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:39 INFO - Running setup.py (path:/tmp/pip-qsSKzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:39 INFO - Running setup.py (path:/tmp/pip-ywtymT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:39 INFO - Running setup.py (path:/tmp/pip-5ia_kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:39 INFO - Running setup.py install for manifestparser 05:11:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:39 INFO - Running setup.py install for mozcrash 05:11:39 INFO - Running setup.py install for mozdebug 05:11:39 INFO - Running setup.py install for mozdevice 05:11:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Running setup.py install for mozfile 05:11:40 INFO - Running setup.py install for mozhttpd 05:11:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Running setup.py install for mozinfo 05:11:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Running setup.py install for mozInstall 05:11:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Running setup.py install for mozleak 05:11:40 INFO - Running setup.py install for mozlog 05:11:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Running setup.py install for moznetwork 05:11:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Running setup.py install for mozprocess 05:11:40 INFO - Running setup.py install for mozprofile 05:11:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:40 INFO - Running setup.py install for mozrunner 05:11:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:41 INFO - Running setup.py install for mozscreenshot 05:11:41 INFO - Running setup.py install for moztest 05:11:41 INFO - Running setup.py install for mozversion 05:11:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:41 INFO - Cleaning up... 05:11:41 INFO - Return code: 0 05:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:41 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 0xd4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3b0>, '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 0x100b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b740>, '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': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:41 INFO - Using env: {'DISPLAY': ':0', 05:11:41 INFO - 'HOME': '/home/cltbld', 05:11:41 INFO - 'LANG': 'en_US.UTF-8', 05:11:41 INFO - 'LANGUAGE': 'en_US:en', 05:11:41 INFO - 'LOGNAME': 'cltbld', 05:11:41 INFO - 'MAIL': '/var/mail/cltbld', 05:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:41 INFO - 'MOZ_NO_REMOTE': '1', 05:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:41 INFO - 'NO_EM_RESTART': '1', 05:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:41 INFO - 'PWD': '/builds/slave/test', 05:11:41 INFO - 'SHELL': '/bin/bash', 05:11:41 INFO - 'SHLVL': '1', 05:11:41 INFO - 'TERM': 'linux', 05:11:41 INFO - 'TMOUT': '86400', 05:11:41 INFO - 'USER': 'cltbld', 05:11:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 05:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:41 INFO - '_': '/tools/buildbot/bin/python'} 05:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:41 INFO - Running setup.py (path:/tmp/pip-UMSxLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:41 INFO - Running setup.py (path:/tmp/pip-KW7Yzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:41 INFO - Running setup.py (path:/tmp/pip-i8plVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:41 INFO - Running setup.py (path:/tmp/pip-Xkp4zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:41 INFO - Running setup.py (path:/tmp/pip-PYnJ0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:41 INFO - Running setup.py (path:/tmp/pip-LxnwRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:42 INFO - Running setup.py (path:/tmp/pip-5ZYHlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:42 INFO - Running setup.py (path:/tmp/pip-VD2WGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:42 INFO - Running setup.py (path:/tmp/pip-8i3yEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:42 INFO - Running setup.py (path:/tmp/pip-fgy7JJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:42 INFO - Running setup.py (path:/tmp/pip-g8Qy37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:42 INFO - Running setup.py (path:/tmp/pip-DgCSzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:42 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)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:42 INFO - Running setup.py (path:/tmp/pip-XWpkek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:42 INFO - Running setup.py (path:/tmp/pip-8xmgT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:42 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)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:42 INFO - Running setup.py (path:/tmp/pip-_CiySa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:42 INFO - Running setup.py (path:/tmp/pip-xSJqDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:42 INFO - Running setup.py (path:/tmp/pip-Q9R1ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:11:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:45 INFO - Downloading blessings-1.6.tar.gz 05:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:45 INFO - Installing collected packages: blessings 05:11:45 INFO - Running setup.py install for blessings 05:11:45 INFO - Successfully installed blessings 05:11:45 INFO - Cleaning up... 05:11:45 INFO - Return code: 0 05:11:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:45 INFO - Reading from file tmpfile_stdout 05:11:45 INFO - Current package versions: 05:11:45 INFO - argparse == 1.2.1 05:11:45 INFO - blessings == 1.6 05:11:45 INFO - blobuploader == 1.2.4 05:11:45 INFO - docopt == 0.6.1 05:11:45 INFO - functools32 == 3.2.3-2 05:11:45 INFO - jsonschema == 2.5.1 05:11:45 INFO - manifestparser == 1.1 05:11:45 INFO - mozInstall == 1.12 05:11:45 INFO - mozcrash == 0.17 05:11:45 INFO - mozdebug == 0.1 05:11:45 INFO - mozdevice == 0.48 05:11:45 INFO - mozfile == 1.2 05:11:45 INFO - mozhttpd == 0.7 05:11:45 INFO - mozinfo == 0.9 05:11:45 INFO - mozleak == 0.1 05:11:45 INFO - mozlog == 3.2 05:11:45 INFO - moznetwork == 0.27 05:11:45 INFO - mozprocess == 0.23 05:11:45 INFO - mozprofile == 0.28 05:11:45 INFO - mozrunner == 6.12 05:11:45 INFO - mozscreenshot == 0.1 05:11:45 INFO - mozsystemmonitor == 0.3 05:11:45 INFO - moztest == 0.7 05:11:45 INFO - mozversion == 1.4 05:11:45 INFO - psutil == 3.1.1 05:11:45 INFO - requests == 1.2.3 05:11:45 INFO - wsgiref == 0.1.2 05:11:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:45 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 0xd4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3b0>, '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 0x100b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b740>, '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': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:11:45 INFO - Using env: {'DISPLAY': ':0', 05:11:45 INFO - 'HOME': '/home/cltbld', 05:11:45 INFO - 'LANG': 'en_US.UTF-8', 05:11:45 INFO - 'LANGUAGE': 'en_US:en', 05:11:45 INFO - 'LOGNAME': 'cltbld', 05:11:45 INFO - 'MAIL': '/var/mail/cltbld', 05:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:45 INFO - 'MOZ_NO_REMOTE': '1', 05:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:45 INFO - 'NO_EM_RESTART': '1', 05:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:45 INFO - 'PWD': '/builds/slave/test', 05:11:45 INFO - 'SHELL': '/bin/bash', 05:11:45 INFO - 'SHLVL': '1', 05:11:45 INFO - 'TERM': 'linux', 05:11:45 INFO - 'TMOUT': '86400', 05:11:45 INFO - 'USER': 'cltbld', 05:11:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 05:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:45 INFO - '_': '/tools/buildbot/bin/python'} 05:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:11:45 INFO - Cleaning up... 05:11:45 INFO - Return code: 0 05:11:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:45 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 0xd4b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a3b0>, '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 0x100b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b740>, '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': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:11:45 INFO - Using env: {'DISPLAY': ':0', 05:11:45 INFO - 'HOME': '/home/cltbld', 05:11:45 INFO - 'LANG': 'en_US.UTF-8', 05:11:45 INFO - 'LANGUAGE': 'en_US:en', 05:11:45 INFO - 'LOGNAME': 'cltbld', 05:11:45 INFO - 'MAIL': '/var/mail/cltbld', 05:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:45 INFO - 'MOZ_NO_REMOTE': '1', 05:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:45 INFO - 'NO_EM_RESTART': '1', 05:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:45 INFO - 'PWD': '/builds/slave/test', 05:11:45 INFO - 'SHELL': '/bin/bash', 05:11:45 INFO - 'SHLVL': '1', 05:11:45 INFO - 'TERM': 'linux', 05:11:45 INFO - 'TMOUT': '86400', 05:11:45 INFO - 'USER': 'cltbld', 05:11:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 05:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:45 INFO - '_': '/tools/buildbot/bin/python'} 05:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:11:45 INFO - Cleaning up... 05:11:45 INFO - Return code: 0 05:11:45 INFO - Running post-action listener: _resource_record_post_action 05:11:45 INFO - Running post-action listener: _start_resource_monitoring 05:11:45 INFO - Starting resource monitoring. 05:11:45 INFO - ##### 05:11:45 INFO - ##### Finished create-virtualenv step (success) 05:11:45 INFO - ##### 05:11:45 INFO - ##### 05:11:45 INFO - ##### Running install step. 05:11:45 INFO - ##### 05:11:45 INFO - Running pre-action listener: _resource_record_pre_action 05:11:45 INFO - Running main action method: install 05:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:46 INFO - Reading from file tmpfile_stdout 05:11:46 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:46 INFO - Reading from file tmpfile_stdout 05:11:46 INFO - Output received: 05:11:46 INFO - Usage: mozinstall [options] installer 05:11:46 INFO - Options: 05:11:46 INFO - -h, --help show this help message and exit 05:11:46 INFO - -d DEST, --destination=DEST 05:11:46 INFO - Directory to install application into. [default: 05:11:46 INFO - "/builds/slave/test"] 05:11:46 INFO - --app=APP Application being installed. [default: firefox] 05:11:46 INFO - mkdir: /builds/slave/test/build/application 05:11:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:12:03 INFO - Reading from file tmpfile_stdout 05:12:03 INFO - Output received: 05:12:03 INFO - /builds/slave/test/build/application/firefox/firefox 05:12:03 INFO - Running post-action listener: _resource_record_post_action 05:12:03 INFO - ##### 05:12:03 INFO - ##### Finished install step (success) 05:12:03 INFO - ##### 05:12:03 INFO - ##### 05:12:03 INFO - ##### Running run-tests step. 05:12:03 INFO - ##### 05:12:03 INFO - Running pre-action listener: _resource_record_pre_action 05:12:03 INFO - Running main action method: run_tests 05:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:03 INFO - Python 2.7.3 05:12:03 INFO - Return code: 0 05:12:03 INFO - grabbing minidump binary from tooltool 05:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:03 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 0x100a3b0>, '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 0x100b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:12:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:12:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:12:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:03 INFO - Return code: 0 05:12:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:12:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:12:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:03 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/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 05:12:03 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/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 05:12:03 INFO - Using env: {'DISPLAY': ':0', 05:12:03 INFO - 'HOME': '/home/cltbld', 05:12:03 INFO - 'LANG': 'en_US.UTF-8', 05:12:03 INFO - 'LANGUAGE': 'en_US:en', 05:12:03 INFO - 'LOGNAME': 'cltbld', 05:12:03 INFO - 'MAIL': '/var/mail/cltbld', 05:12:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:03 INFO - 'MOZ_NO_REMOTE': '1', 05:12:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:03 INFO - 'NO_EM_RESTART': '1', 05:12:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:03 INFO - 'PWD': '/builds/slave/test', 05:12:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:03 INFO - 'SHELL': '/bin/bash', 05:12:03 INFO - 'SHLVL': '1', 05:12:03 INFO - 'TERM': 'linux', 05:12:03 INFO - 'TMOUT': '86400', 05:12:03 INFO - 'USER': 'cltbld', 05:12:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468325471.178437-787624523', 05:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:03 INFO - '_': '/tools/buildbot/bin/python'} 05:12:03 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/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 05:12:03 INFO - mozversion application_buildid: 20160712023026 05:12:03 INFO - mozversion application_changeset: efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 05:12:03 INFO - mozversion application_display_name: Nightly 05:12:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:03 INFO - mozversion application_name: Firefox 05:12:03 INFO - mozversion application_remotingname: firefox 05:12:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:12:03 INFO - mozversion application_vendor: Mozilla 05:12:03 INFO - mozversion application_version: 50.0a1 05:12:03 INFO - mozversion platform_buildid: 20160712023026 05:12:03 INFO - mozversion platform_changeset: efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 05:12:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:12:03 INFO - mozversion platform_version: 50.0a1 05:12:03 INFO - using testdate: 1468325523 05:12:03 INFO - actual date: 1468325523 05:12:03 INFO - starting webserver on 'localhost:44700' 05:12:03 INFO - SUITE-START | Running 2 tests 05:12:03 INFO - TEST-START | dromaeo_css 05:12:03 INFO - operating with platform_type : linux_ 05:12:03 INFO - Initialising browser for dromaeo_css test... 05:12:03 INFO - TEST-INFO | started process 25935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9_YKPZ/profile http://localhost:44700/getInfo.html) 05:12:08 INFO - PROCESS | 25935 | __metrics Screen width/height:1600/1200 05:12:08 INFO - PROCESS | 25935 | colorDepth:24 05:12:08 INFO - PROCESS | 25935 | Browser inner width/height: 1024/697 05:12:08 INFO - PROCESS | 25935 | __metrics 05:12:09 ERROR - PROCESS | 25935 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 05:12:10 INFO - TEST-INFO | 25935: exit 0 05:12:10 INFO - Browser initialized. 05:12:10 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:10 INFO - TEST-INFO | started process 26058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9_YKPZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:21 INFO - PROCESS | 26058 | RSS: Main: 167522304 05:12:21 INFO - PROCESS | 26058 | 05:13:11 INFO - PROCESS | 26058 | 1468325591501 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:15:19 INFO - PROCESS | 26058 | Cycle 1(1): loaded http://localhost:44700/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44700/tests/dromaeo/cssquery-ext.html) 05:15:20 INFO - PROCESS | 26058 | RSS: Main: 171114496 05:15:20 INFO - PROCESS | 26058 | 05:18:22 INFO - PROCESS | 26058 | Cycle 1(1): loaded http://localhost:44700/tests/dromaeo/cssquery-ext.html (next: http://localhost:44700/tests/dromaeo/cssquery-jquery.html) 05:18:23 INFO - PROCESS | 26058 | RSS: Main: 168476672 05:18:23 INFO - PROCESS | 26058 | 05:21:25 INFO - PROCESS | 26058 | Cycle 1(1): loaded http://localhost:44700/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44700/tests/dromaeo/cssquery-mootools.html) 05:21:25 INFO - PROCESS | 26058 | RSS: Main: 170364928 05:21:25 INFO - PROCESS | 26058 | 05:24:27 INFO - PROCESS | 26058 | Cycle 1(1): loaded http://localhost:44700/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44700/tests/dromaeo/cssquery-prototype.html) 05:24:28 INFO - PROCESS | 26058 | RSS: Main: 166494208 05:24:28 INFO - PROCESS | 26058 | 05:27:30 INFO - PROCESS | 26058 | Cycle 1(1): loaded http://localhost:44700/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44700/tests/dromaeo/cssquery-yui.html) 05:27:31 INFO - PROCESS | 26058 | RSS: Main: 168960000 05:27:31 INFO - PROCESS | 26058 | 05:30:34 INFO - PROCESS | 26058 | Cycle 1(1): loaded http://localhost:44700/tests/dromaeo/cssquery-yui.html (next: http://localhost:44700/tests/dromaeo/cssquery-dojo.html) 05:30:34 INFO - PROCESS | 26058 | RSS: Main: 169582592 05:30:34 INFO - PROCESS | 26058 | 05:30:34 INFO - PROCESS | 26058 | __start_tp_report 05:30:34 INFO - PROCESS | 26058 | _x_x_mozilla_page_load 05:30:34 INFO - PROCESS | 26058 | _x_x_mozilla_page_load_details 05:30:34 INFO - PROCESS | 26058 | |i|pagename|runs| 05:30:34 INFO - PROCESS | 26058 | |0;dojo.html;3069.447499450099;3128.249220187154;3134.185111870913;3161.8577164027615;3163.161762133034;5555.388907220203;5566.693831839248;5595.692236926972;5630.831075067755;5655.519280861132;5500.312460942382;5571.192177134313;5647.181158731982;5655.179998900157;5669.574781891364;5068.518490743373;5106.208537676647;5136.743162841862;5223.895522089575;5240.580753539708;594.9468891174595;4966.801327946878;5027.597792176617;5095.3885533736;5172.6637768545115;5018.971110922289;5071.670341427814;5079.23811428285;5080.618953578496;5089.541941225308;5088.821891233789;5116.181410974264;5127.871803204913;5131.897362052775;5152.9742351288005;4989;5037.823676171353;5059.1905295152965;5065.569426598743;5079.822206222764;5508.063629183049;5586.16207568868;5587.1339942309005;5614.129809879475;5615.073512870372;5721.370649228582;5867.559933005042;5917.763289468416;5955;5969.373215812364;5884.70576471179;5922.052471604523;5928.614640048426;5942.5840191186635;5968.074948383008;5532.2531458253425;5565.693886836222;5579.330480342344;5580.944190558083;5581.079121944874;5940;6097.054956481752;6107.572469927062;6114.7840275394365;6126.172966649446;5901.291844978544;5906.645601263938;5918.704064796743;5919.082542205965;5969.104634304802;5967.612105213234;5969.850753731192;5978.521718262528;5987.371326010706;5988.580799344004;5825.504832089235;5927.614705044159;5987.251593550806;5989.221401217814;6015.849603759853;5986.07215881539;6022.638641681513;6026.457618814327;6034.818955431344;6053.092036194606;4519.05099929012;4538.841140560065;4539.387182730356;4540.137373898949;4571.588557029883;3924.156306394082;3990.541087774885;3992.7205095643026;4000;4046.9392959105635;5658.377578466366;5697.886042279214;5719.828405147769;5723.799667011718;5770.855728606818;6046.939530604637;6089.147519347295;6093.4515893568905;6111.54163437744;6113.541484388688;5541.0580201365865;5558.416366281563;5580.86047848807;5597.6641401516035;5713.971430142906;5079.796808127708;5106.7191304477865;5124.5131712487255;5140.845774626767;5151.9484805152215;5935.050391937356;6097.420745029215;6108.009672508053;6108.584917381041;6119.318238417353;5945.881082378415;5985.25184351956;5993.940060599512;6012.368701286302;6055.878882422415;6045.818625441244;6113.358097399709;6148.415900489446;6160.907586386118;6178.165947597017;5787.160861675117;5883.441073098049;5914.852128696817;5920;5921.437463440966;6027.60820546663;6062.696865156813;6070.453659170696;6070.848228794315;6129.877402451837;5865.120231965239;5868.67722275279;5895.587308888508;5921.230240068936;5925.881482370242;5683.9715801420725;5754.136879468113;5819.359870414336;5862.736176872137;5870.589058765845;5764.42355764437;5775.393583673822;5787.305523337226;5800.651960882361;5810.186573879745;5810.186573879745;5825.359210486928;5852.707364631837;5873.089671100986;5877.059670452707;5614.129809879475;5705.486506214461;5708.086706127;5777.988851950976;5861.794837180678 05:30:34 INFO - PROCESS | 26058 | |1;ext.html;546.0135951869912;573.1689050876229;580.399286738226;602;611.5321778839192;38115;42215.577844221545;42220.78889605555;42239.78880105603;42253.78873105634;42071.36892946608;42686.35970460445;42761.35857962133;42813.357799632955;42831.78584107083;8762.605682744275;8968.551572421386;9004.279657627407;9013.819723605524;9021;8868.290536757077;8938.597763100644;8982.730518084469;8984.955075224614;9003.95498022509;8970.955145224265;9020.594073266719;9040.502772347518;9064.728058158265;9098.226650734696;8960.148785865333;8982.37123401362;8983.595738191798;8987.595558199897;9001;8814.338924580683;8832.779180520474;8874.778130546723;8878.644854205824;8951.68669096585;39618;39635;39742.60257397418;40179;40246.79876600627;3419.262709039239;3601.531800865897;3604.1710406606626;3665.138692407282;3733.4026555750947;32248.838755806304;32470.025899223063;32686.6731332686;32841;34135.65864341374;3788.488554045196;3836.3286424875537;3856.749311294757;3998.7800670963084;4071.7353372030725;232050;233035;233105;233519.8324008386;234443;34721.30557388838;35568.466473002925;35581;37230.627693723254;57740.42259577435;36976;36984.07539811526;37047.81476092602;37087.62912370896;37088.07279818026;15492.5352239433;15530.689386212212;15537.22313884324;15606.765898511532;15649.765253521206;13028;13136.080474366703;13155.802662960063;13161.27612981276;13217.074804763573;8352.955880514935;8417.106151116071;8429.409941304173;8466.957665211634;8492.278156356655;3201.7598680099086;3240.8379581021327;3257.8533965971587;3265.118418027167;3288.3094550144738;984.1634610581092;1068.9572417103384;1073.3398959639765;1102.6306187427142;1209.238179946628;31763.84118079441;32863.342733145684;33123.50314745281;33186.5198198245;33566.83216583901;1067.2849191042021;1147.4951021550492;1172.94135293235;1195.2051885496048;1201.303244118409;16999.23503442348;17217.56956076108;17420.47738567845;17433.21550530229;17438.47684569465;630870;636145;637195;638081;653659;56766.71616641973;57841.710791445774;58043.4195658038;58123;58318;1356.4438580182275;1360.4286199796109;1362.2371471975725;1372.5058978767836;1381.544090450149;30597.694023059485;32623.510647340783;32879.83560082184;32979;33172.50241246335;51878.22182667338;52060.73969630127;52509;52567;52775.47224527859;458189;460446;461591;462535;464354;28175.859120704266;28248;28488.145355638535;28588.714112858604;28636.42727145404;47453.28820067771;48908.75545622249;49378.259326109415;49909.25136122888;50284.49715502944;41206.587934120274;41818.37272440977;41958.370624440046;42187.15625687531;42906.494818043655;41832.58167418287;41844.58155418407;42121.578784211764;42715.57284427116;42785.57214427816;36238.818805906856;39523.2095358097;40366.39450408187;41292.38061429021;41412;35147.29705405929;37249.81375093107;37638.43542346812;37647.623523765506;37959.24081518299;28228.85885570559;28607;28610.85694571514;28724;28817.42365152727 05:30:34 INFO - PROCESS | 26058 | |2;jquery.html;380.3154322220005;383.86756568983697;384.55199692358406;386.6462187098805;411.72825934882985;18793.154308056135;19990.70013949792;20033.499162520944;20356.287529936457;20485.283015094476;18773.342932997348;18952.24191032357;19218.90390548049;20173.798262017375;20252.088656010477;5319.973400132994;5692.6299790513485;5734.942650573483;5889.8822023559715;5932.139839723238;5580.776768929238;5638.238837756912;5662;5663.4336566343445;5672.17753425753;5572.944270557283;5685.971570142144;5707.828765137032;5710.486056254937;5829.067349224125;5255;5786.826395208151;5795.536357091422;5804.535637149018;5819.825405237829;5313.840584782462;5370.624056316059;5388.892222155535;5399.082156033483;5426.321709786277;12755.362231888368;18447.89312641246;22081.227157049427;23495.177668781682;23534.29397118089;2115.8201552868027;2208.5251670890675;2216.312942987679;2427.599446091393;2464.6672699185738;9245.352825302232;9390.436573805593;9455.43267403951;9534.28492863038;9551.188149007343;1789.1948623119517;1801.8288262615163;1834.2296235581089;1867.3557622620174;1909.9522511937173;82353.58823205906;82425.58787206086;83781.58109209476;84844.57577712134;86096.56951715265;10644.361338319726;10739.83890241647;10766.78466430667;10880.510377033053;11118.277311974696;14728;14909.70180596382;14973.401063957537;14991.775123373158;15017.24913754308;8025.31784798287;8213.507189568645;8275.213854683796;8327.791805204919;8568.10034946334;8145.3483721302155;8204.630791614392;8246.793830154294;8345.4158208926;8359.247667709935;4221.261279276115;4393.209222339946;4578.587927086578;4605.286180642006;4609.285560738091;1793.8654600904983;1831.752713383676;1858.9349372772158;1869.12151288894;1869.5793446474706;409.41658137154434;411.8723195809309;445.359355515529;450.0548847420391;1026.5329275179924;11029.889701103048;11437.542498299976;11631.360275184777;11678.474468648932;11778.293302401884;441.8188542697479;449.2609657114029;449.8290649553214;459.0177021174689;465.9464161621457;5799.507041901401;6063.696815159225;6117.021276595723;6292.119103325446;10833.806577597203;486144;493700;494521;495407;510366;63434;67687.66156169187;93122;93682;93977.530112349;1018.5518371916334;1026.2251999740297;1030.685640879539;1036.2797855490362;1069.4438891776233;18466.169022393755;18699.532511687317;18928.33750818715;19117.13972871196;19158;41848.790756047245;42123;43821.78089109661;44741.328880066176;46874.296885546064;62476;63276.68361658162;63348.68325658342;64063.35936640574;64079.67960160356;7659.731909383145;8635.654573816977;8643.092475290256;8648.264897483785;8842.95578522129;11184.273022253528;13912;14034.2982850855;14541.345639446461;14801.851981480047;12439.689007774878;12653.430595623404;12772.297523636289;12820.61538153857;12914.966802655577;12495.312757798045;12580.112983052615;12672.366381681064;12736.235825850108;12981.740365192454;12728.936355318165;12900.8064879025;12909.806352904901;13070;13235.816090344984;8459.06950235486;8512.319014478951;8662.913370866463;8789.428687135316;8934.106589341274;12339.50641974311;12392.690182745142;12969.351532423152;13023.674408139872;13069.869301306866 05:30:34 INFO - PROCESS | 26058 | |3;mootools.html;1462.2469428244456;1483.4362942082007;1569.8587127158553;1703;1732.2551302939746;7516.060492438445;8236.299914507259;8278.586070696463;8786.6924657637;8796.956015219916;8345.874811877828;8526.74419767408;8541.65833366666;8613;8657.307415406769;2250.7411647660524;2297.1500544798446;2302.079168332672;2303.9193628222934;2306.250468597704;2204;2220.4781876259067;2275.6814046033487;2278.293728944024;2283.1894677389537;2189.0915270162864;2250.8987095580737;2251.5834570604407;2272.545490901818;2283.4405570635136;2184.1809321504434;2200.3069033254474;2221.9666704999436;2225.354647152332;2225.9220927267547;2165.8304515561736;2185.573813106445;2186.3987403464016;2194.868307901531;2207.5915955548276;8571.10003449635;8708.085651006617;8783.604737786814;8787.121287871161;8794.824103517958;4953.950460495421;5059.696418214882;5076.670016448919;5080.491950804927;5087.084324821531;3035.089473158044;3135.404273188087;3185.3151572412044;3190.122716253026;3211.1169428407143;1059.057438879398;1082.2856914436434;1083.5990683447096;1087.4943151434543;1095.6767753512654;11905.464254108585;11962.82055769164;11977.101717371232;11977.22148060382;11996.100292478099;4228.767417792051;4274.893127671833;4394.077243778842;4430.158269928703;4430.9587246996925;10059.144972677404;10115.898841011644;10122.746931326628;10142.087212150942;10171.135453486388;5072.898542029138;5081.74591270435;5115.590752739847;5124.743762811844;5126.410462796752;4158.604932531404;4554.0891821635805;4734.526547345306;4754.690945088558;4758.666893317434;3802.258559580855;3855.383138697795;3921.490206273223;3956.802159891994;4006.959930400717;1228.2998690746367;1262.61490245476;1274.0890263461483;1288.177229220661;1290.5031562848371;905.6649039855296;1011.4032720694826;1015.4465816130227;1022.9897701023043;1038.2680210451613;6137.508999280047;6181.96909015452;6211.751529938842;6300.684965751694;6345;398.2771270144678;404.4681244163915;406.63199804177265;406.7478163538625;407.8654044165418;4358.76026818528;4397.73613583186;4399.846005389796;4416.359627854007;4418.403515525363;9807.558659860324;10639.361638301727;10823.025927666547;10865.945670271756;10918;10657;10658.573657053787;10695.251332406657;10697.572097116028;10733.785324293627;7524.05949256343;7745.728899488491;7813.921860781319;7837.255460731221;7839.451238413257;6111.205543279523;6379.202599675041;6434.710438030394;6456.580322279036;6478.060681201294;9348.53257337144;9796.9020309796;10123.544440500047;10155.796884062425;10210.948945255226;9989.500524973577;10020.498975051072;10045.748856278651;10123.595056197964;10146.695599132037;6857.828554286183;7225.169105552929;7437.107547094383;7545.849083018199;7640.159582445815;8633.007204171601;8644.308455323684;8663.6101375437;8696.695615653422;8741.475511469333;7506.13679426851;7608.125065617525;7734.458587898793;7755.961220193863;7831.686732530635;7481.326680598555;7495.812604684927;7519.1728909818785;7656.157822639394;7767.067951845815;6816.113905192294;6856.9314306856295;6857.588544687334;6876.553024053421;6913.896291555731;5277.868053298698;5389.434109418611;5460.208269800777;5499.725013749377;5540.667559946416;5310.389305229948;5459.754311056092;5461.644993075437;5489.451054894478;5573.832785016456 05:30:34 INFO - PROCESS | 26058 | |4;prototype.html;309.36888746956225;320.4456290617232;320.8812739286464;323.1936318884384;325.3184578308443;5481.917771233435;5574.136008918614;5674.049494262986;5713.371529131798;5736.254286942697;5602.271704678396;5610.821727437243;5639.68981706006;5644.294463192101;5663.292088488939;4393.604575588196;4394.274944634148;4394.3188805735;4406.801693923781;4411.713238639494;4087.591240875918;4335.6965012449145;4340.699429302459;4399.054203346296;4399.38408622793;4218.409422680827;4253.766042867656;4273.8076786544525;4281.785910704468;4283.37891005804;4298.419713338691;4304.5480224576595;4308.870733877973;4326.09152078064;4344.956550434486;3572.321009125707;3770.5286839145106;3779.5637657690177;3782.546094468654;3789.3558095123894;5466.9179962300595;5494.148406996922;5496.7526461309335;5512.641678290898;5529.668219906778;4909.2881532177635;4909.803607855682;4939.728314942677;4945.159322915113;4952.232403977389;5540.2243685884005;5804.59367844251;5812.476877081083;5830.32951210612;5842.444967728059;4044.959550404488;4058.5535591085254;4075.89810254746;4077.9796101019306;4081.8571350002903;6083.391660833925;6107.72515236811;6116.174316467264;6119.806637705649;6121.479674227696;4036.374361973899;4154.210699966997;4160;4192.903548225887;4213.2837417639075;4217.8523751668545;4224.471941007374;4232.534421213664;4235.120118319511;4238.1099969006855;4901.362822833009;4901.387326584177;4906.975465122723;4922.90154196914;4926.261060840831;5584.5811564132855;5854.79976604795;5921.779332750219;5933.071751680721;5958.85102872423;1466.2375564706292;1483.9167407792372;1489.0916540910036;1495.9700805983819;1505.33012809301;948.323655568844;948.3788118782209;955.991429042367;963.6097380560744;967.5065716484644;4966.776495057731;4975.975120124376;4994.975025124923;5010.69935803853;5061.240813877874;5242.9290430279825;5332.3867755207875;5336.67979921206;5370.502716236969;5394.676319420847;5045.571126454292;5059;5068.541757247732;5339.599530035263;5749.396313387034;3231.4506533889294;3233.833331667788;3238.1904523869034;3242.383947050053;3258.1040213940882;6063.969680151659;6125.938740612626;6138.600990935575;6146.231721034871;6158.199434073631;6175.147455763253;6192.102145188923;6199.256089269226;6229.283632382334;6261.745771522248;6188.452886778306;6199.969000155061;6214.720337584729;6220.284667263232;6235.781747638811;5895.469407753323;6080;6081.452669259788;6081.543884208791;6090.512758979359;5892.435076778659;5942.405759424023;6013.849653758691;6015.759369625166;6035.69821508914;5922.763089476372;6145.692715364304;6147.754089836357;6162.969185154046;6185.628862268279;4031.596840315945;4040.393940908887;4061.3298805696727;4063.268611649813;4071.633552980246;6008.279006519246;6015.969920150371;6027.457528822427;6029.276486821609;6072.483838873745;5600.299962504687;5846.590738648424;5921.63802325459;5953.732082056231;5954.166416701579;5915.438033386821;5921.8748437796685;5923.970380148072;5964.465102331578;5967.6419414835245;5623.128415095667;5828.417158284137;5850.970745146247;5867;5870.530357571299;5930.258717660293;5930.347661757117;5930.733117009659;5950.880982380415;5954.523638108854;5796.710164491843;5850.473457388855;5856.238688970407;5858.853528661817;5866.970665146818 05:30:34 INFO - PROCESS | 26058 | |5;yui.html;747.1855677311729;768.6156921539231;793.8253584211475;810.9725685785533;813.8250276190618;14969.47606833761;15899.28453219605;16007.519774406757;16019.439319623787;16050.357985680588;14834.777478337834;14906.776398354006;14914.477993270239;14915.105093694387;14924.925375373108;665.0456594786473;783.1854870934221;785.4815821557773;801.7153910361825;802.7350974178536;759.6581538307784;765.705203496655;770.2490072179636;770.3721467004374;770.8342706318141;823.7117009046816;824.7072289337289;825.3438516379463;826.9586520673972;831.3266254334009;815.9347252219837;815.9388045896582;818.5988865455913;822.457178262344;822.7367242482408;597.8146774499919;599.5353600959248;601.5007543738686;602.135934933372;606.6754286456725;14616.342264598012;14786.704265914728;14825.851741482555;14854.628634284121;14895.553133406016;15226.46707365248;15280.31238594266;15505.147216903066;15513.612159695986;15583.766243506356;12295.877041229563;12332.81500777489;12437.689057773538;12472.126951113425;12889.419976101099;3904.3557812960826;3916.5887581804072;3936.311145549546;3937.4093885917055;3957.7625342479255;74965;75471.24528754698;75484.62257688676;75556.24443755602;75788.62105689436;11843.763124737457;11898.76202475963;11977;12110.57612983559;12300.876991230152;22795.772042279365;22873.656895146585;22892.084316627148;22920.312390628307;22934.19730309431;8588.484690918565;8598.5700714964;8731.869021964676;8768.693095741619;8941.150590693873;4779.115863565252;4867.513248675175;4961.479044700254;5086.313347698014;5173.948260517422;3360.0759791057653;3446.052335607728;3453.4819777033144;3456.740744444177;3463.030351501533;607.8996965500731;612.6324205476767;613.2977740487117;616.2235583165244;627.4635186915214;606.9089636554464;612.8590424202458;684.9280825513349;773.3426587400664;776.1152286393516;9899.356541824758;10135.49322533885;10381.480925953672;10480.63317783874;10558.155347572176;725.6045455226914;741.3772431157853;742.4209116888835;760.0803028335665;764.9923500765033;4981.576565991932;5082.872928176826;5144.356955380577;5167.9224811627855;5204.34945631796;68219;69635.73278404967;70458.64770676216;70900;70921.2907870925;82838;98010.50994744981;98144.50927745315;99095.50452247837;99101.50449247852;86186.56906715427;87799;91367;91401;91701.5414922921;9511.143997040299;9518.904810952079;9604.423734575948;9653.420794752337;9799.853002205115;39660.2067958645;47756.52243477521;50938.745306274715;51322.486775133264;52386;78808;80240.59879700564;81058.18941810506;81846;83014;12107.455164517442;12142.696432589257;12156.270623762603;12217.877821221675;12620.684482887635;13288;13302.93348533251;13314.8817761114;13711.931440342734;14198.503052393116;12327.383630818244;12366.381680915738;12513.874861251272;12715.87284127184;12775.61673149807;12613.49546018149;12905.741885162432;12972.286524241257;13081.149725267827;13567.52513662017;13032;14103.647408814863;14604.634884127981;14938.402463901322;15723.606909826889;11311.434428278717;11492.82760758606;11537.538498460304;11599.188056836278;11860.58487952952;11777.52889884395;12069.336186509827;12192.329421881881;12287.385630718607;12466.563670271496 05:30:34 INFO - PROCESS | 26058 | __end_tp_report 05:30:34 INFO - PROCESS | 26058 | __start_cc_report 05:30:34 INFO - PROCESS | 26058 | _x_x_mozilla_cycle_collect,371 05:30:34 INFO - PROCESS | 26058 | __end_cc_report 05:30:34 INFO - PROCESS | 26058 | __startTimestamp1468326634517__endTimestamp 05:30:34 INFO - PROCESS | 26058 | 05:30:34 INFO - PROCESS | 26058 | ------- Summary: start ------- 05:30:34 INFO - PROCESS | 26058 | Number of tests: 6 05:30:34 INFO - PROCESS | 26058 | 05:30:34 INFO - PROCESS | 26058 | [#0] dojo.html Cycles:165 Average:5518.23 Median:5777.99 stddev:752.43 (13.0%) stddev-sans-first:729.80 05:30:34 INFO - PROCESS | 26058 | Values: 3069.4 3128.2 3134.2 3161.9 3163.2 5555.4 5566.7 5595.7 5630.8 5655.5 5500.3 5571.2 5647.2 5655.2 5669.6 5068.5 5106.2 5136.7 5223.9 5240.6 594.9 4966.8 5027.6 5095.4 5172.7 5019.0 5071.7 5079.2 5080.6 5089.5 5088.8 5116.2 5127.9 5131.9 5153.0 4989.0 5037.8 5059.2 5065.6 5079.8 5508.1 5586.2 5587.1 5614.1 5615.1 5721.4 5867.6 5917.8 5955.0 5969.4 5884.7 5922.1 5928.6 5942.6 5968.1 5532.3 5565.7 5579.3 5580.9 5581.1 5940.0 6097.1 6107.6 6114.8 6126.2 5901.3 5906.6 5918.7 5919.1 5969.1 5967.6 5969.9 5978.5 5987.4 5988.6 5825.5 5927.6 5987.3 5989.2 6015.8 5986.1 6022.6 6026.5 6034.8 6053.1 4519.1 4538.8 4539.4 4540.1 4571.6 3924.2 3990.5 3992.7 4000.0 4046.9 5658.4 5697.9 5719.8 5723.8 5770.9 6046.9 6089.1 6093.5 6111.5 6113.5 5541.1 5558.4 5580.9 5597.7 5714.0 5079.8 5106.7 5124.5 5140.8 5151.9 5935.1 6097.4 6108.0 6108.6 6119.3 5945.9 5985.3 5993.9 6012.4 6055.9 6045.8 6113.4 6148.4 6160.9 6178.2 5787.2 5883.4 5914.9 5920.0 5921.4 6027.6 6062.7 6070.5 6070.8 6129.9 5865.1 5868.7 5895.6 5921.2 5925.9 5684.0 5754.1 5819.4 5862.7 5870.6 5764.4 5775.4 5787.3 5800.7 5810.2 5810.2 5825.4 5852.7 5873.1 5877.1 5614.1 5705.5 5708.1 5778.0 5861.8 05:30:34 INFO - PROCESS | 26058 | 05:30:34 INFO - PROCESS | 26058 | [#1] ext.html Cycles:180 Average:59026.66 Median:39688.80 stddev:127260.62 (320.6%) stddev-sans-first:127541.87 05:30:34 INFO - PROCESS | 26058 | Values: 546.0 573.2 580.4 602.0 611.5 38115.0 42215.6 42220.8 42239.8 42253.8 42071.4 42686.4 42761.4 42813.4 42831.8 8762.6 8968.6 9004.3 9013.8 9021.0 8868.3 8938.6 8982.7 8985.0 9004.0 8971.0 9020.6 9040.5 9064.7 9098.2 8960.1 8982.4 8983.6 8987.6 9001.0 8814.3 8832.8 8874.8 8878.6 8951.7 39618.0 39635.0 39742.6 40179.0 40246.8 3419.3 3601.5 3604.2 3665.1 3733.4 32248.8 32470.0 32686.7 32841.0 34135.7 3788.5 3836.3 3856.7 3998.8 4071.7 232050.0 233035.0 233105.0 233519.8 234443.0 34721.3 35568.5 35581.0 37230.6 57740.4 36976.0 36984.1 37047.8 37087.6 37088.1 15492.5 15530.7 15537.2 15606.8 15649.8 13028.0 13136.1 13155.8 13161.3 13217.1 8353.0 8417.1 8429.4 8467.0 8492.3 3201.8 3240.8 3257.9 3265.1 3288.3 984.2 1069.0 1073.3 1102.6 1209.2 31763.8 32863.3 33123.5 33186.5 33566.8 1067.3 1147.5 1172.9 1195.2 1201.3 16999.2 17217.6 17420.5 17433.2 17438.5 630870.0 636145.0 637195.0 638081.0 653659.0 56766.7 57841.7 58043.4 58123.0 58318.0 1356.4 1360.4 1362.2 1372.5 1381.5 30597.7 32623.5 32879.8 32979.0 33172.5 51878.2 52060.7 52509.0 52567.0 52775.5 458189.0 460446.0 461591.0 462535.0 464354.0 28175.9 28248.0 28488.1 28588.7 28636.4 47453.3 48908.8 49378.3 49909.3 50284.5 41206.6 41818.4 41958.4 42187.2 42906.5 41832.6 41844.6 42121.6 42715.6 42785.6 36238.8 39523.2 40366.4 41292.4 41412.0 35147.3 37249.8 37638.4 37647.6 37959.2 28228.9 28607.0 28610.9 28724.0 28817.4 05:30:34 INFO - PROCESS | 26058 | 05:30:34 INFO - PROCESS | 26058 | [#2] jquery.html Cycles:180 Average:28923.63 Median:23172.13 stddev:81783.52 (352.9%) stddev-sans-first:81984.86 05:30:34 INFO - PROCESS | 26058 | Values: 380.3 383.9 384.6 386.6 411.7 18793.2 19990.7 20033.5 20356.3 20485.3 18773.3 18952.2 19218.9 20173.8 20252.1 5320.0 5692.6 5734.9 5889.9 5932.1 5580.8 5638.2 5662.0 5663.4 5672.2 5572.9 5686.0 5707.8 5710.5 5829.1 5255.0 5786.8 5795.5 5804.5 5819.8 5313.8 5370.6 5388.9 5399.1 5426.3 12755.4 18447.9 22081.2 23495.2 23534.3 2115.8 2208.5 2216.3 2427.6 2464.7 9245.4 9390.4 9455.4 9534.3 9551.2 1789.2 1801.8 1834.2 1867.4 1910.0 82353.6 82425.6 83781.6 84844.6 86096.6 10644.4 10739.8 10766.8 10880.5 11118.3 14728.0 14909.7 14973.4 14991.8 15017.2 8025.3 8213.5 8275.2 8327.8 8568.1 8145.3 8204.6 8246.8 8345.4 8359.2 4221.3 4393.2 4578.6 4605.3 4609.3 1793.9 1831.8 1858.9 1869.1 1869.6 409.4 411.9 445.4 450.1 1026.5 11029.9 11437.5 11631.4 11678.5 11778.3 441.8 449.3 449.8 459.0 465.9 5799.5 6063.7 6117.0 6292.1 10833.8 486144.0 493700.0 494521.0 495407.0 510366.0 63434.0 67687.7 93122.0 93682.0 93977.5 1018.6 1026.2 1030.7 1036.3 1069.4 18466.2 18699.5 18928.3 19117.1 19158.0 41848.8 42123.0 43821.8 44741.3 46874.3 62476.0 63276.7 63348.7 64063.4 64079.7 7659.7 8635.7 8643.1 8648.3 8843.0 11184.3 13912.0 14034.3 14541.3 14801.9 12439.7 12653.4 12772.3 12820.6 12915.0 12495.3 12580.1 12672.4 12736.2 12981.7 12728.9 12900.8 12909.8 13070.0 13235.8 8459.1 8512.3 8662.9 8789.4 8934.1 12339.5 12392.7 12969.4 13023.7 13069.9 05:30:34 INFO - PROCESS | 26058 | 05:30:34 INFO - PROCESS | 26058 | [#3] mootools.html Cycles:180 Average:5707.40 Median:4398.79 stddev:3250.24 (73.9%) stddev-sans-first:3243.70 05:30:34 INFO - PROCESS | 26058 | Values: 1462.2 1483.4 1569.9 1703.0 1732.3 7516.1 8236.3 8278.6 8786.7 8797.0 8345.9 8526.7 8541.7 8613.0 8657.3 2250.7 2297.2 2302.1 2303.9 2306.3 2204.0 2220.5 2275.7 2278.3 2283.2 2189.1 2250.9 2251.6 2272.5 2283.4 2184.2 2200.3 2222.0 2225.4 2225.9 2165.8 2185.6 2186.4 2194.9 2207.6 8571.1 8708.1 8783.6 8787.1 8794.8 4954.0 5059.7 5076.7 5080.5 5087.1 3035.1 3135.4 3185.3 3190.1 3211.1 1059.1 1082.3 1083.6 1087.5 1095.7 11905.5 11962.8 11977.1 11977.2 11996.1 4228.8 4274.9 4394.1 4430.2 4431.0 10059.1 10115.9 10122.7 10142.1 10171.1 5072.9 5081.7 5115.6 5124.7 5126.4 4158.6 4554.1 4734.5 4754.7 4758.7 3802.3 3855.4 3921.5 3956.8 4007.0 1228.3 1262.6 1274.1 1288.2 1290.5 905.7 1011.4 1015.4 1023.0 1038.3 6137.5 6182.0 6211.8 6300.7 6345.0 398.3 404.5 406.6 406.7 407.9 4358.8 4397.7 4399.8 4416.4 4418.4 9807.6 10639.4 10823.0 10865.9 10918.0 10657.0 10658.6 10695.3 10697.6 10733.8 7524.1 7745.7 7813.9 7837.3 7839.5 6111.2 6379.2 6434.7 6456.6 6478.1 9348.5 9796.9 10123.5 10155.8 10210.9 9989.5 10020.5 10045.7 10123.6 10146.7 6857.8 7225.2 7437.1 7545.8 7640.2 8633.0 8644.3 8663.6 8696.7 8741.5 7506.1 7608.1 7734.5 7756.0 7831.7 7481.3 7495.8 7519.2 7656.2 7767.1 6816.1 6856.9 6857.6 6876.6 6913.9 5277.9 5389.4 5460.2 5499.7 5540.7 5310.4 5459.8 5461.6 5489.5 5573.8 05:30:34 INFO - PROCESS | 26058 | 05:30:34 INFO - PROCESS | 26058 | [#4] prototype.html Cycles:180 Average:4877.00 Median:5557.18 stddev:1457.50 (26.2%) stddev-sans-first:1420.70 05:30:34 INFO - PROCESS | 26058 | Values: 309.4 320.4 320.9 323.2 325.3 5481.9 5574.1 5674.0 5713.4 5736.3 5602.3 5610.8 5639.7 5644.3 5663.3 4393.6 4394.3 4394.3 4406.8 4411.7 4087.6 4335.7 4340.7 4399.1 4399.4 4218.4 4253.8 4273.8 4281.8 4283.4 4298.4 4304.5 4308.9 4326.1 4345.0 3572.3 3770.5 3779.6 3782.5 3789.4 5466.9 5494.1 5496.8 5512.6 5529.7 4909.3 4909.8 4939.7 4945.2 4952.2 5540.2 5804.6 5812.5 5830.3 5842.4 4045.0 4058.6 4075.9 4078.0 4081.9 6083.4 6107.7 6116.2 6119.8 6121.5 4036.4 4154.2 4160.0 4192.9 4213.3 4217.9 4224.5 4232.5 4235.1 4238.1 4901.4 4901.4 4907.0 4922.9 4926.3 5584.6 5854.8 5921.8 5933.1 5958.9 1466.2 1483.9 1489.1 1496.0 1505.3 948.3 948.4 956.0 963.6 967.5 4966.8 4976.0 4995.0 5010.7 5061.2 5242.9 5332.4 5336.7 5370.5 5394.7 5045.6 5059.0 5068.5 5339.6 5749.4 3231.5 3233.8 3238.2 3242.4 3258.1 6064.0 6125.9 6138.6 6146.2 6158.2 6175.1 6192.1 6199.3 6229.3 6261.7 6188.5 6200.0 6214.7 6220.3 6235.8 5895.5 6080.0 6081.5 6081.5 6090.5 5892.4 5942.4 6013.8 6015.8 6035.7 5922.8 6145.7 6147.8 6163.0 6185.6 4031.6 4040.4 4061.3 4063.3 4071.6 6008.3 6016.0 6027.5 6029.3 6072.5 5600.3 5846.6 5921.6 5953.7 5954.2 5915.4 5921.9 5924.0 5964.5 5967.6 5623.1 5828.4 5851.0 5867.0 5870.5 5930.3 5930.3 5930.7 5950.9 5954.5 5796.7 5850.5 5856.2 5858.9 5867.0 05:30:34 INFO - PROCESS | 26058 | 05:30:34 INFO - PROCESS | 26058 | [#5] yui.html Cycles:180 Average:19739.13 Median:5084.59 stddev:26928.42 (529.6%) stddev-sans-first:26966.20 05:30:34 INFO - PROCESS | 26058 | Values: 747.2 768.6 793.8 811.0 813.8 14969.5 15899.3 16007.5 16019.4 16050.4 14834.8 14906.8 14914.5 14915.1 14924.9 665.0 783.2 785.5 801.7 802.7 759.7 765.7 770.2 770.4 770.8 823.7 824.7 825.3 827.0 831.3 815.9 815.9 818.6 822.5 822.7 597.8 599.5 601.5 602.1 606.7 14616.3 14786.7 14825.9 14854.6 14895.6 15226.5 15280.3 15505.1 15513.6 15583.8 12295.9 12332.8 12437.7 12472.1 12889.4 3904.4 3916.6 3936.3 3937.4 3957.8 74965.0 75471.2 75484.6 75556.2 75788.6 11843.8 11898.8 11977.0 12110.6 12300.9 22795.8 22873.7 22892.1 22920.3 22934.2 8588.5 8598.6 8731.9 8768.7 8941.2 4779.1 4867.5 4961.5 5086.3 5173.9 3360.1 3446.1 3453.5 3456.7 3463.0 607.9 612.6 613.3 616.2 627.5 606.9 612.9 684.9 773.3 776.1 9899.4 10135.5 10381.5 10480.6 10558.2 725.6 741.4 742.4 760.1 765.0 4981.6 5082.9 5144.4 5167.9 5204.3 68219.0 69635.7 70458.6 70900.0 70921.3 82838.0 98010.5 98144.5 99095.5 99101.5 86186.6 87799.0 91367.0 91401.0 91701.5 9511.1 9518.9 9604.4 9653.4 9799.9 39660.2 47756.5 50938.7 51322.5 52386.0 78808.0 80240.6 81058.2 81846.0 83014.0 12107.5 12142.7 12156.3 12217.9 12620.7 13288.0 13302.9 13314.9 13711.9 14198.5 12327.4 12366.4 12513.9 12715.9 12775.6 12613.5 12905.7 12972.3 13081.1 13567.5 13032.0 14103.6 14604.6 14938.4 15723.6 11311.4 11492.8 11537.5 11599.2 11860.6 11777.5 12069.3 12192.3 12287.4 12466.6 05:30:34 INFO - PROCESS | 26058 | -------- Summary: end -------- 05:30:34 INFO - PROCESS | 26058 | 05:30:35 INFO - TEST-INFO | 26058: exit 0 05:30:35 INFO - TEST-OK | dromaeo_css | took 1111551ms 05:30:35 INFO - TEST-START | kraken 05:30:35 INFO - operating with platform_type : linux_ 05:30:35 INFO - Initialising browser for kraken test... 05:30:35 INFO - TEST-INFO | started process 26307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHRCPG/profile http://localhost:44700/getInfo.html) 05:30:40 INFO - PROCESS | 26307 | __metrics Screen width/height:1600/1200 05:30:40 INFO - PROCESS | 26307 | colorDepth:24 05:30:40 INFO - PROCESS | 26307 | Browser inner width/height: 1024/697 05:30:40 INFO - PROCESS | 26307 | __metrics 05:30:40 ERROR - PROCESS | 26307 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 05:30:41 INFO - TEST-INFO | 26307: exit 0 05:30:41 INFO - Browser initialized. 05:30:41 INFO - Running cycle 1/1 for kraken test... 05:30:41 INFO - TEST-INFO | started process 26429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHRCPG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:53 INFO - PROCESS | 26429 | RSS: Main: 167792640 05:30:53 INFO - PROCESS | 26429 | 05:30:55 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44700/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:56 INFO - PROCESS | 26429 | RSS: Main: 172896256 05:30:56 INFO - PROCESS | 26429 | 05:30:59 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44700/tests/kraken/driver.html?testName=audio-dft) 05:31:00 INFO - PROCESS | 26429 | RSS: Main: 172544000 05:31:00 INFO - PROCESS | 26429 | 05:31:02 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44700/tests/kraken/driver.html?testName=audio-fft) 05:31:03 INFO - PROCESS | 26429 | RSS: Main: 167055360 05:31:03 INFO - PROCESS | 26429 | 05:31:05 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44700/tests/kraken/driver.html?testName=audio-oscillator) 05:31:06 INFO - PROCESS | 26429 | RSS: Main: 167616512 05:31:06 INFO - PROCESS | 26429 | 05:31:08 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44700/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:09 INFO - PROCESS | 26429 | RSS: Main: 168480768 05:31:09 INFO - PROCESS | 26429 | 05:31:12 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44700/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:12 INFO - PROCESS | 26429 | RSS: Main: 167956480 05:31:12 INFO - PROCESS | 26429 | 05:31:16 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44700/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:16 INFO - PROCESS | 26429 | RSS: Main: 166039552 05:31:16 INFO - PROCESS | 26429 | 05:31:19 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44700/tests/kraken/driver.html?testName=json-parse-financial) 05:31:20 INFO - PROCESS | 26429 | RSS: Main: 167641088 05:31:20 INFO - PROCESS | 26429 | 05:31:21 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44700/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:22 INFO - PROCESS | 26429 | RSS: Main: 167772160 05:31:22 INFO - PROCESS | 26429 | 05:31:24 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44700/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:24 INFO - PROCESS | 26429 | RSS: Main: 168284160 05:31:24 INFO - PROCESS | 26429 | 05:31:26 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44700/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:27 INFO - PROCESS | 26429 | RSS: Main: 168693760 05:31:27 INFO - PROCESS | 26429 | 05:31:30 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:30 INFO - PROCESS | 26429 | RSS: Main: 169181184 05:31:30 INFO - PROCESS | 26429 | 05:31:33 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:34 INFO - PROCESS | 26429 | RSS: Main: 169041920 05:31:34 INFO - PROCESS | 26429 | 05:31:35 INFO - PROCESS | 26429 | Cycle 1(1): loaded http://localhost:44700/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44700/tests/kraken/driver.html?testName=ai-astar) 05:31:36 INFO - PROCESS | 26429 | RSS: Main: 169566208 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | __start_tp_report 05:31:36 INFO - PROCESS | 26429 | _x_x_mozilla_page_load 05:31:36 INFO - PROCESS | 26429 | _x_x_mozilla_page_load_details 05:31:36 INFO - PROCESS | 26429 | |i|pagename|runs| 05:31:36 INFO - PROCESS | 26429 | |0;ai-astar;104;112;106;111;111;113;114;111;111;112 05:31:36 INFO - PROCESS | 26429 | |1;audio-beat-detection;155;123;142;175;121;146;145;120;177;125 05:31:36 INFO - PROCESS | 26429 | |2;audio-dft;161;163;161;163;163;165;176;163;162;163 05:31:36 INFO - PROCESS | 26429 | |3;audio-fft;76;85;75;142;76;77;79;76;178;77 05:31:36 INFO - PROCESS | 26429 | |4;audio-oscillator;84;85;166;84;83;84;133;84;83;139 05:31:36 INFO - PROCESS | 26429 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;118;117;119 05:31:36 INFO - PROCESS | 26429 | |6;imaging-darkroom;147;148;147;148;148;146;147;146;148;147 05:31:36 INFO - PROCESS | 26429 | |7;imaging-desaturate;95;96;96;96;96;95;96;96;95;95 05:31:36 INFO - PROCESS | 26429 | |8;json-parse-financial;52;58;54;54;55;55;53;56;54;57 05:31:36 INFO - PROCESS | 26429 | |9;json-stringify-tinderbox;62;62;63;62;63;63;62;63;63;63 05:31:36 INFO - PROCESS | 26429 | |10;stanford-crypto-aes;77;77;78;77;77;84;76;76;76;81 05:31:36 INFO - PROCESS | 26429 | |11;stanford-crypto-ccm;130;132;131;138;125;125;136;121;172;134 05:31:36 INFO - PROCESS | 26429 | |12;stanford-crypto-pbkdf2;162;166;162;168;161;160;164;168;163;174 05:31:36 INFO - PROCESS | 26429 | |13;stanford-crypto-sha256-iterative;63;64;66;74;64;69;64;63;62;66 05:31:36 INFO - PROCESS | 26429 | __end_tp_report 05:31:36 INFO - PROCESS | 26429 | __start_cc_report 05:31:36 INFO - PROCESS | 26429 | _x_x_mozilla_cycle_collect,896 05:31:36 INFO - PROCESS | 26429 | __end_cc_report 05:31:36 INFO - PROCESS | 26429 | __startTimestamp1468326696227__endTimestamp 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | ------- Summary: start ------- 05:31:36 INFO - PROCESS | 26429 | Number of tests: 14 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:3.10 (2.8%) stddev-sans-first:2.22 05:31:36 INFO - PROCESS | 26429 | Values: 104.0 112.0 106.0 111.0 111.0 113.0 114.0 111.0 111.0 112.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:145.50 stddev:21.28 (14.6%) stddev-sans-first:22.11 05:31:36 INFO - PROCESS | 26429 | Values: 155.0 123.0 142.0 175.0 121.0 146.0 145.0 120.0 177.0 125.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.37 (2.7%) stddev-sans-first:4.50 05:31:36 INFO - PROCESS | 26429 | Values: 161.0 163.0 161.0 163.0 163.0 165.0 176.0 163.0 162.0 163.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.50 stddev:35.87 (46.9%) stddev-sans-first:37.44 05:31:36 INFO - PROCESS | 26429 | Values: 76.0 85.0 75.0 142.0 76.0 77.0 79.0 76.0 178.0 77.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.00 stddev:31.15 (37.1%) stddev-sans-first:32.31 05:31:36 INFO - PROCESS | 26429 | Values: 84.0 85.0 166.0 84.0 83.0 84.0 133.0 84.0 83.0 139.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:31:36 INFO - PROCESS | 26429 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 119.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 05:31:36 INFO - PROCESS | 26429 | Values: 147.0 148.0 147.0 148.0 148.0 146.0 147.0 146.0 148.0 147.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:31:36 INFO - PROCESS | 26429 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.81 (3.3%) stddev-sans-first:1.62 05:31:36 INFO - PROCESS | 26429 | Values: 52.0 58.0 54.0 54.0 55.0 55.0 53.0 56.0 54.0 57.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:31:36 INFO - PROCESS | 26429 | Values: 62.0 62.0 63.0 62.0 63.0 63.0 62.0 63.0 63.0 63.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:77.00 stddev:2.60 (3.4%) stddev-sans-first:2.74 05:31:36 INFO - PROCESS | 26429 | Values: 77.0 77.0 78.0 77.0 77.0 84.0 76.0 76.0 76.0 81.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:133.00 stddev:14.23 (10.7%) stddev-sans-first:15.00 05:31:36 INFO - PROCESS | 26429 | Values: 130.0 132.0 131.0 138.0 125.0 125.0 136.0 121.0 172.0 134.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.00 stddev:4.26 (2.6%) stddev-sans-first:4.40 05:31:36 INFO - PROCESS | 26429 | Values: 162.0 166.0 162.0 168.0 161.0 160.0 164.0 168.0 163.0 174.0 05:31:36 INFO - PROCESS | 26429 | 05:31:36 INFO - PROCESS | 26429 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:3.60 (5.5%) stddev-sans-first:3.70 05:31:36 INFO - PROCESS | 26429 | Values: 63.0 64.0 66.0 74.0 64.0 69.0 64.0 63.0 62.0 66.0 05:31:36 INFO - PROCESS | 26429 | -------- Summary: end -------- 05:31:36 INFO - PROCESS | 26429 | 05:31:37 INFO - TEST-INFO | 26429: exit 0 05:31:37 INFO - TEST-OK | kraken | took 61928ms 05:31:37 INFO - SUITE-END | took 1173s 05:31:37 INFO - Completed test suite (00:19:33) 05:31:37 INFO - javascript benchmark 05:31:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7132.185546908864, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3069.447499450099, 3128.249220187154, 3134.185111870913, 3161.8577164027615, 3163.161762133034, 5555.388907220203, 5566.693831839248, 5595.692236926972, 5630.831075067755, 5655.519280861132, 5500.312460942382, 5571.192177134313, 5647.181158731982, 5655.179998900157, 5669.574781891364, 5068.518490743373, 5106.208537676647, 5136.743162841862, 5223.895522089575, 5240.580753539708, 594.9468891174595, 4966.801327946878, 5027.597792176617, 5095.3885533736, 5172.6637768545115, 5018.971110922289, 5071.670341427814, 5079.23811428285, 5080.618953578496, 5089.541941225308, 5088.821891233789, 5116.181410974264, 5127.871803204913, 5131.897362052775, 5152.9742351288005, 4989.0, 5037.823676171353, 5059.1905295152965, 5065.569426598743, 5079.822206222764, 5508.063629183049, 5586.16207568868, 5587.1339942309005, 5614.129809879475, 5615.073512870372, 5721.370649228582, 5867.559933005042, 5917.763289468416, 5955.0, 5969.373215812364, 5884.70576471179, 5922.052471604523, 5928.614640048426, 5942.5840191186635, 5968.074948383008, 5532.2531458253425, 5565.693886836222, 5579.330480342344, 5580.944190558083, 5581.079121944874, 5940.0, 6097.054956481752, 6107.572469927062, 6114.7840275394365, 6126.172966649446, 5901.291844978544, 5906.645601263938, 5918.704064796743, 5919.082542205965, 5969.104634304802, 5967.612105213234, 5969.850753731192, 5978.521718262528, 5987.371326010706, 5988.580799344004, 5825.504832089235, 5927.614705044159, 5987.251593550806, 5989.221401217814, 6015.849603759853, 5986.07215881539, 6022.638641681513, 6026.457618814327, 6034.818955431344, 6053.092036194606, 4519.05099929012, 4538.841140560065, 4539.387182730356, 4540.137373898949, 4571.588557029883, 3924.156306394082, 3990.541087774885, 3992.7205095643026, 4000.0, 4046.9392959105635, 5658.377578466366, 5697.886042279214, 5719.828405147769, 5723.799667011718, 5770.855728606818, 6046.939530604637, 6089.147519347295, 6093.4515893568905, 6111.54163437744, 6113.541484388688, 5541.0580201365865, 5558.416366281563, 5580.86047848807, 5597.6641401516035, 5713.971430142906, 5079.796808127708, 5106.7191304477865, 5124.5131712487255, 5140.845774626767, 5151.9484805152215, 5935.050391937356, 6097.420745029215, 6108.009672508053, 6108.584917381041, 6119.318238417353, 5945.881082378415, 5985.25184351956, 5993.940060599512, 6012.368701286302, 6055.878882422415, 6045.818625441244, 6113.358097399709, 6148.415900489446, 6160.907586386118, 6178.165947597017, 5787.160861675117, 5883.441073098049, 5914.852128696817, 5920.0, 5921.437463440966, 6027.60820546663, 6062.696865156813, 6070.453659170696, 6070.848228794315, 6129.877402451837, 5865.120231965239, 5868.67722275279, 5895.587308888508, 5921.230240068936, 5925.881482370242, 5683.9715801420725, 5754.136879468113, 5819.359870414336, 5862.736176872137, 5870.589058765845, 5764.42355764437, 5775.393583673822, 5787.305523337226, 5800.651960882361, 5810.186573879745, 5810.186573879745, 5825.359210486928, 5852.707364631837, 5873.089671100986, 5877.059670452707, 5614.129809879475, 5705.486506214461, 5708.086706127, 5777.988851950976, 5861.794837180678], "value": 5467.254611953803, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.0135951869912, 573.1689050876229, 580.399286738226, 602.0, 611.5321778839192, 38115.0, 42215.577844221545, 42220.78889605555, 42239.78880105603, 42253.78873105634, 42071.36892946608, 42686.35970460445, 42761.35857962133, 42813.357799632955, 42831.78584107083, 8762.605682744275, 8968.551572421386, 9004.279657627407, 9013.819723605524, 9021.0, 8868.290536757077, 8938.597763100644, 8982.730518084469, 8984.955075224614, 9003.95498022509, 8970.955145224265, 9020.594073266719, 9040.502772347518, 9064.728058158265, 9098.226650734696, 8960.148785865333, 8982.37123401362, 8983.595738191798, 8987.595558199897, 9001.0, 8814.338924580683, 8832.779180520474, 8874.778130546723, 8878.644854205824, 8951.68669096585, 39618.0, 39635.0, 39742.60257397418, 40179.0, 40246.79876600627, 3419.262709039239, 3601.531800865897, 3604.1710406606626, 3665.138692407282, 3733.4026555750947, 32248.838755806304, 32470.025899223063, 32686.6731332686, 32841.0, 34135.65864341374, 3788.488554045196, 3836.3286424875537, 3856.749311294757, 3998.7800670963084, 4071.7353372030725, 232050.0, 233035.0, 233105.0, 233519.8324008386, 234443.0, 34721.30557388838, 35568.466473002925, 35581.0, 37230.627693723254, 57740.42259577435, 36976.0, 36984.07539811526, 37047.81476092602, 37087.62912370896, 37088.07279818026, 15492.5352239433, 15530.689386212212, 15537.22313884324, 15606.765898511532, 15649.765253521206, 13028.0, 13136.080474366703, 13155.802662960063, 13161.27612981276, 13217.074804763573, 8352.955880514935, 8417.106151116071, 8429.409941304173, 8466.957665211634, 8492.278156356655, 3201.7598680099086, 3240.8379581021327, 3257.8533965971587, 3265.118418027167, 3288.3094550144738, 984.1634610581092, 1068.9572417103384, 1073.3398959639765, 1102.6306187427142, 1209.238179946628, 31763.84118079441, 32863.342733145684, 33123.50314745281, 33186.5198198245, 33566.83216583901, 1067.2849191042021, 1147.4951021550492, 1172.94135293235, 1195.2051885496048, 1201.303244118409, 16999.23503442348, 17217.56956076108, 17420.47738567845, 17433.21550530229, 17438.47684569465, 630870.0, 636145.0, 637195.0, 638081.0, 653659.0, 56766.71616641973, 57841.710791445774, 58043.4195658038, 58123.0, 58318.0, 1356.4438580182275, 1360.4286199796109, 1362.2371471975725, 1372.5058978767836, 1381.544090450149, 30597.694023059485, 32623.510647340783, 32879.83560082184, 32979.0, 33172.50241246335, 51878.22182667338, 52060.73969630127, 52509.0, 52567.0, 52775.47224527859, 458189.0, 460446.0, 461591.0, 462535.0, 464354.0, 28175.859120704266, 28248.0, 28488.145355638535, 28588.714112858604, 28636.42727145404, 47453.28820067771, 48908.75545622249, 49378.259326109415, 49909.25136122888, 50284.49715502944, 41206.587934120274, 41818.37272440977, 41958.370624440046, 42187.15625687531, 42906.494818043655, 41832.58167418287, 41844.58155418407, 42121.578784211764, 42715.57284427116, 42785.57214427816, 36238.818805906856, 39523.2095358097, 40366.39450408187, 41292.38061429021, 41412.0, 35147.29705405929, 37249.81375093107, 37638.43542346812, 37647.623523765506, 37959.24081518299, 28228.85885570559, 28607.0, 28610.85694571514, 28724.0, 28817.42365152727], "value": 18721.960148992177, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.3154322220005, 383.86756568983697, 384.55199692358406, 386.6462187098805, 411.72825934882985, 18793.154308056135, 19990.70013949792, 20033.499162520944, 20356.287529936457, 20485.283015094476, 18773.342932997348, 18952.24191032357, 19218.90390548049, 20173.798262017375, 20252.088656010477, 5319.973400132994, 5692.6299790513485, 5734.942650573483, 5889.8822023559715, 5932.139839723238, 5580.776768929238, 5638.238837756912, 5662.0, 5663.4336566343445, 5672.17753425753, 5572.944270557283, 5685.971570142144, 5707.828765137032, 5710.486056254937, 5829.067349224125, 5255.0, 5786.826395208151, 5795.536357091422, 5804.535637149018, 5819.825405237829, 5313.840584782462, 5370.624056316059, 5388.892222155535, 5399.082156033483, 5426.321709786277, 12755.362231888368, 18447.89312641246, 22081.227157049427, 23495.177668781682, 23534.29397118089, 2115.8201552868027, 2208.5251670890675, 2216.312942987679, 2427.599446091393, 2464.6672699185738, 9245.352825302232, 9390.436573805593, 9455.43267403951, 9534.28492863038, 9551.188149007343, 1789.1948623119517, 1801.8288262615163, 1834.2296235581089, 1867.3557622620174, 1909.9522511937173, 82353.58823205906, 82425.58787206086, 83781.58109209476, 84844.57577712134, 86096.56951715265, 10644.361338319726, 10739.83890241647, 10766.78466430667, 10880.510377033053, 11118.277311974696, 14728.0, 14909.70180596382, 14973.401063957537, 14991.775123373158, 15017.24913754308, 8025.31784798287, 8213.507189568645, 8275.213854683796, 8327.791805204919, 8568.10034946334, 8145.3483721302155, 8204.630791614392, 8246.793830154294, 8345.4158208926, 8359.247667709935, 4221.261279276115, 4393.209222339946, 4578.587927086578, 4605.286180642006, 4609.285560738091, 1793.8654600904983, 1831.752713383676, 1858.9349372772158, 1869.12151288894, 1869.5793446474706, 409.41658137154434, 411.8723195809309, 445.359355515529, 450.0548847420391, 1026.5329275179924, 11029.889701103048, 11437.542498299976, 11631.360275184777, 11678.474468648932, 11778.293302401884, 441.8188542697479, 449.2609657114029, 449.8290649553214, 459.0177021174689, 465.9464161621457, 5799.507041901401, 6063.696815159225, 6117.021276595723, 6292.119103325446, 10833.806577597203, 486144.0, 493700.0, 494521.0, 495407.0, 510366.0, 63434.0, 67687.66156169187, 93122.0, 93682.0, 93977.530112349, 1018.5518371916334, 1026.2251999740297, 1030.685640879539, 1036.2797855490362, 1069.4438891776233, 18466.169022393755, 18699.532511687317, 18928.33750818715, 19117.13972871196, 19158.0, 41848.790756047245, 42123.0, 43821.78089109661, 44741.328880066176, 46874.296885546064, 62476.0, 63276.68361658162, 63348.68325658342, 64063.35936640574, 64079.67960160356, 7659.731909383145, 8635.654573816977, 8643.092475290256, 8648.264897483785, 8842.95578522129, 11184.273022253528, 13912.0, 14034.2982850855, 14541.345639446461, 14801.851981480047, 12439.689007774878, 12653.430595623404, 12772.297523636289, 12820.61538153857, 12914.966802655577, 12495.312757798045, 12580.112983052615, 12672.366381681064, 12736.235825850108, 12981.740365192454, 12728.936355318165, 12900.8064879025, 12909.806352904901, 13070.0, 13235.816090344984, 8459.06950235486, 8512.319014478951, 8662.913370866463, 8789.428687135316, 8934.106589341274, 12339.50641974311, 12392.690182745142, 12969.351532423152, 13023.674408139872, 13069.869301306866], "value": 8687.302715146097, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.2469428244456, 1483.4362942082007, 1569.8587127158553, 1703.0, 1732.2551302939746, 7516.060492438445, 8236.299914507259, 8278.586070696463, 8786.6924657637, 8796.956015219916, 8345.874811877828, 8526.74419767408, 8541.65833366666, 8613.0, 8657.307415406769, 2250.7411647660524, 2297.1500544798446, 2302.079168332672, 2303.9193628222934, 2306.250468597704, 2204.0, 2220.4781876259067, 2275.6814046033487, 2278.293728944024, 2283.1894677389537, 2189.0915270162864, 2250.8987095580737, 2251.5834570604407, 2272.545490901818, 2283.4405570635136, 2184.1809321504434, 2200.3069033254474, 2221.9666704999436, 2225.354647152332, 2225.9220927267547, 2165.8304515561736, 2185.573813106445, 2186.3987403464016, 2194.868307901531, 2207.5915955548276, 8571.10003449635, 8708.085651006617, 8783.604737786814, 8787.121287871161, 8794.824103517958, 4953.950460495421, 5059.696418214882, 5076.670016448919, 5080.491950804927, 5087.084324821531, 3035.089473158044, 3135.404273188087, 3185.3151572412044, 3190.122716253026, 3211.1169428407143, 1059.057438879398, 1082.2856914436434, 1083.5990683447096, 1087.4943151434543, 1095.6767753512654, 11905.464254108585, 11962.82055769164, 11977.101717371232, 11977.22148060382, 11996.100292478099, 4228.767417792051, 4274.893127671833, 4394.077243778842, 4430.158269928703, 4430.9587246996925, 10059.144972677404, 10115.898841011644, 10122.746931326628, 10142.087212150942, 10171.135453486388, 5072.898542029138, 5081.74591270435, 5115.590752739847, 5124.743762811844, 5126.410462796752, 4158.604932531404, 4554.0891821635805, 4734.526547345306, 4754.690945088558, 4758.666893317434, 3802.258559580855, 3855.383138697795, 3921.490206273223, 3956.802159891994, 4006.959930400717, 1228.2998690746367, 1262.61490245476, 1274.0890263461483, 1288.177229220661, 1290.5031562848371, 905.6649039855296, 1011.4032720694826, 1015.4465816130227, 1022.9897701023043, 1038.2680210451613, 6137.508999280047, 6181.96909015452, 6211.751529938842, 6300.684965751694, 6345.0, 398.2771270144678, 404.4681244163915, 406.63199804177265, 406.7478163538625, 407.8654044165418, 4358.76026818528, 4397.73613583186, 4399.846005389796, 4416.359627854007, 4418.403515525363, 9807.558659860324, 10639.361638301727, 10823.025927666547, 10865.945670271756, 10918.0, 10657.0, 10658.573657053787, 10695.251332406657, 10697.572097116028, 10733.785324293627, 7524.05949256343, 7745.728899488491, 7813.921860781319, 7837.255460731221, 7839.451238413257, 6111.205543279523, 6379.202599675041, 6434.710438030394, 6456.580322279036, 6478.060681201294, 9348.53257337144, 9796.9020309796, 10123.544440500047, 10155.796884062425, 10210.948945255226, 9989.500524973577, 10020.498975051072, 10045.748856278651, 10123.595056197964, 10146.695599132037, 6857.828554286183, 7225.169105552929, 7437.107547094383, 7545.849083018199, 7640.159582445815, 8633.007204171601, 8644.308455323684, 8663.6101375437, 8696.695615653422, 8741.475511469333, 7506.13679426851, 7608.125065617525, 7734.458587898793, 7755.961220193863, 7831.686732530635, 7481.326680598555, 7495.812604684927, 7519.1728909818785, 7656.157822639394, 7767.067951845815, 6816.113905192294, 6856.9314306856295, 6857.588544687334, 6876.553024053421, 6913.896291555731, 5277.868053298698, 5389.434109418611, 5460.208269800777, 5499.725013749377, 5540.667559946416, 5310.389305229948, 5459.754311056092, 5461.644993075437, 5489.451054894478, 5573.832785016456], "value": 4478.265379132694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.36888746956225, 320.4456290617232, 320.8812739286464, 323.1936318884384, 325.3184578308443, 5481.917771233435, 5574.136008918614, 5674.049494262986, 5713.371529131798, 5736.254286942697, 5602.271704678396, 5610.821727437243, 5639.68981706006, 5644.294463192101, 5663.292088488939, 4393.604575588196, 4394.274944634148, 4394.3188805735, 4406.801693923781, 4411.713238639494, 4087.591240875918, 4335.6965012449145, 4340.699429302459, 4399.054203346296, 4399.38408622793, 4218.409422680827, 4253.766042867656, 4273.8076786544525, 4281.785910704468, 4283.37891005804, 4298.419713338691, 4304.5480224576595, 4308.870733877973, 4326.09152078064, 4344.956550434486, 3572.321009125707, 3770.5286839145106, 3779.5637657690177, 3782.546094468654, 3789.3558095123894, 5466.9179962300595, 5494.148406996922, 5496.7526461309335, 5512.641678290898, 5529.668219906778, 4909.2881532177635, 4909.803607855682, 4939.728314942677, 4945.159322915113, 4952.232403977389, 5540.2243685884005, 5804.59367844251, 5812.476877081083, 5830.32951210612, 5842.444967728059, 4044.959550404488, 4058.5535591085254, 4075.89810254746, 4077.9796101019306, 4081.8571350002903, 6083.391660833925, 6107.72515236811, 6116.174316467264, 6119.806637705649, 6121.479674227696, 4036.374361973899, 4154.210699966997, 4160.0, 4192.903548225887, 4213.2837417639075, 4217.8523751668545, 4224.471941007374, 4232.534421213664, 4235.120118319511, 4238.1099969006855, 4901.362822833009, 4901.387326584177, 4906.975465122723, 4922.90154196914, 4926.261060840831, 5584.5811564132855, 5854.79976604795, 5921.779332750219, 5933.071751680721, 5958.85102872423, 1466.2375564706292, 1483.9167407792372, 1489.0916540910036, 1495.9700805983819, 1505.33012809301, 948.323655568844, 948.3788118782209, 955.991429042367, 963.6097380560744, 967.5065716484644, 4966.776495057731, 4975.975120124376, 4994.975025124923, 5010.69935803853, 5061.240813877874, 5242.9290430279825, 5332.3867755207875, 5336.67979921206, 5370.502716236969, 5394.676319420847, 5045.571126454292, 5059.0, 5068.541757247732, 5339.599530035263, 5749.396313387034, 3231.4506533889294, 3233.833331667788, 3238.1904523869034, 3242.383947050053, 3258.1040213940882, 6063.969680151659, 6125.938740612626, 6138.600990935575, 6146.231721034871, 6158.199434073631, 6175.147455763253, 6192.102145188923, 6199.256089269226, 6229.283632382334, 6261.745771522248, 6188.452886778306, 6199.969000155061, 6214.720337584729, 6220.284667263232, 6235.781747638811, 5895.469407753323, 6080.0, 6081.452669259788, 6081.543884208791, 6090.512758979359, 5892.435076778659, 5942.405759424023, 6013.849653758691, 6015.759369625166, 6035.69821508914, 5922.763089476372, 6145.692715364304, 6147.754089836357, 6162.969185154046, 6185.628862268279, 4031.596840315945, 4040.393940908887, 4061.3298805696727, 4063.268611649813, 4071.633552980246, 6008.279006519246, 6015.969920150371, 6027.457528822427, 6029.276486821609, 6072.483838873745, 5600.299962504687, 5846.590738648424, 5921.63802325459, 5953.732082056231, 5954.166416701579, 5915.438033386821, 5921.8748437796685, 5923.970380148072, 5964.465102331578, 5967.6419414835245, 5623.128415095667, 5828.417158284137, 5850.970745146247, 5867.0, 5870.530357571299, 5930.258717660293, 5930.347661757117, 5930.733117009659, 5950.880982380415, 5954.523638108854, 5796.710164491843, 5850.473457388855, 5856.238688970407, 5858.853528661817, 5866.970665146818], "value": 4404.1495436484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.1855677311729, 768.6156921539231, 793.8253584211475, 810.9725685785533, 813.8250276190618, 14969.47606833761, 15899.28453219605, 16007.519774406757, 16019.439319623787, 16050.357985680588, 14834.777478337834, 14906.776398354006, 14914.477993270239, 14915.105093694387, 14924.925375373108, 665.0456594786473, 783.1854870934221, 785.4815821557773, 801.7153910361825, 802.7350974178536, 759.6581538307784, 765.705203496655, 770.2490072179636, 770.3721467004374, 770.8342706318141, 823.7117009046816, 824.7072289337289, 825.3438516379463, 826.9586520673972, 831.3266254334009, 815.9347252219837, 815.9388045896582, 818.5988865455913, 822.457178262344, 822.7367242482408, 597.8146774499919, 599.5353600959248, 601.5007543738686, 602.135934933372, 606.6754286456725, 14616.342264598012, 14786.704265914728, 14825.851741482555, 14854.628634284121, 14895.553133406016, 15226.46707365248, 15280.31238594266, 15505.147216903066, 15513.612159695986, 15583.766243506356, 12295.877041229563, 12332.81500777489, 12437.689057773538, 12472.126951113425, 12889.419976101099, 3904.3557812960826, 3916.5887581804072, 3936.311145549546, 3937.4093885917055, 3957.7625342479255, 74965.0, 75471.24528754698, 75484.62257688676, 75556.24443755602, 75788.62105689436, 11843.763124737457, 11898.76202475963, 11977.0, 12110.57612983559, 12300.876991230152, 22795.772042279365, 22873.656895146585, 22892.084316627148, 22920.312390628307, 22934.19730309431, 8588.484690918565, 8598.5700714964, 8731.869021964676, 8768.693095741619, 8941.150590693873, 4779.115863565252, 4867.513248675175, 4961.479044700254, 5086.313347698014, 5173.948260517422, 3360.0759791057653, 3446.052335607728, 3453.4819777033144, 3456.740744444177, 3463.030351501533, 607.8996965500731, 612.6324205476767, 613.2977740487117, 616.2235583165244, 627.4635186915214, 606.9089636554464, 612.8590424202458, 684.9280825513349, 773.3426587400664, 776.1152286393516, 9899.356541824758, 10135.49322533885, 10381.480925953672, 10480.63317783874, 10558.155347572176, 725.6045455226914, 741.3772431157853, 742.4209116888835, 760.0803028335665, 764.9923500765033, 4981.576565991932, 5082.872928176826, 5144.356955380577, 5167.9224811627855, 5204.34945631796, 68219.0, 69635.73278404967, 70458.64770676216, 70900.0, 70921.2907870925, 82838.0, 98010.50994744981, 98144.50927745315, 99095.50452247837, 99101.50449247852, 86186.56906715427, 87799.0, 91367.0, 91401.0, 91701.5414922921, 9511.143997040299, 9518.904810952079, 9604.423734575948, 9653.420794752337, 9799.853002205115, 39660.2067958645, 47756.52243477521, 50938.745306274715, 51322.486775133264, 52386.0, 78808.0, 80240.59879700564, 81058.18941810506, 81846.0, 83014.0, 12107.455164517442, 12142.696432589257, 12156.270623762603, 12217.877821221675, 12620.684482887635, 13288.0, 13302.93348533251, 13314.8817761114, 13711.931440342734, 14198.503052393116, 12327.383630818244, 12366.381680915738, 12513.874861251272, 12715.87284127184, 12775.61673149807, 12613.49546018149, 12905.741885162432, 12972.286524241257, 13081.149725267827, 13567.52513662017, 13032.0, 14103.647408814863, 14604.634884127981, 14938.402463901322, 15723.606909826889, 11311.434428278717, 11492.82760758606, 11537.538498460304, 11599.188056836278, 11860.58487952952, 11777.52889884395, 12069.336186509827, 12192.329421881881, 12287.385630718607, 12466.563670271496], "value": 7504.42848378334, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 106.0, 111.0, 111.0, 113.0, 114.0, 111.0, 111.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 142.0, 175.0, 121.0, 146.0, 145.0, 120.0, 177.0, 125.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 163.0, 163.0, 165.0, 176.0, 163.0, 162.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 85.0, 75.0, 142.0, 76.0, 77.0, 79.0, 76.0, 178.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 166.0, 84.0, 83.0, 84.0, 133.0, 84.0, 83.0, 139.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 148.0, 146.0, 147.0, 146.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 58.0, 54.0, 54.0, 55.0, 55.0, 53.0, 56.0, 54.0, 57.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 77.0, 77.0, 84.0, 76.0, 76.0, 76.0, 81.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 131.0, 138.0, 125.0, 125.0, 136.0, 121.0, 172.0, 134.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 162.0, 168.0, 161.0, 160.0, 164.0, 168.0, 163.0, 174.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 74.0, 64.0, 69.0, 64.0, 63.0, 62.0, 66.0], "value": 65.5, "unit": "score"}]}]} 05:31:37 INFO - Return code: 0 05:31:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:37 ERROR - # TBPL SUCCESS # 05:31:37 INFO - Running post-action listener: _resource_record_post_action 05:31:37 INFO - ##### 05:31:37 INFO - ##### Finished run-tests step (success) 05:31:37 INFO - ##### 05:31:37 INFO - Running post-run listener: _resource_record_post_run 05:31:37 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557871104; Read time: 8; Write time: 508888 05:31:37 INFO - TinderboxPrint: CPU usage
13.3% 05:31:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:31:37 INFO - TinderboxPrint: I/O write bytes / time
557,871,104 / 508,888 05:31:37 INFO - TinderboxPrint: CPU idle
8,234.1 (86.6%) 05:31:37 INFO - TinderboxPrint: CPU user
1,213.5 (12.8%) 05:31:37 INFO - TinderboxPrint: Swap in / out
0 / 0 05:31:37 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 264544256; Read time: 0; Write time: 320560 05:31:37 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 292536320; Read time: 0; Write time: 188300 05:31:38 INFO - Running post-run listener: _upload_blobber_files 05:31:38 INFO - Blob upload gear active. 05:31:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:31:38 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'] 05:31:38 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 05:31:38 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:31:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:31:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:39 INFO - (blobuploader) - INFO - Done attempting. 05:31:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:42 INFO - (blobuploader) - INFO - Done attempting. 05:31:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:43 INFO - (blobuploader) - INFO - Done attempting. 05:31:43 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:43 INFO - Return code: 0 05:31:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6eb8e3852f41ff0732c4bad7111eba69561a0623e577315e2ec35f89b08a51974d302ed1e7f2da258436deb938063357f64bde82adfd44bbced13cf36783e91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20ff4edeb6d073ce3a3afa3b28658a116ee5ff392c7ae7fd9c2451a2f92a36b6c18bd7b7542f20d0a71f35e240a33341216931080e777c89efc23f01f915569e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/673841cf3933645985d8edff3b156b94044b0583617e9f08e54d9b3e3a6567b82e16b24fe9069bbaf08cc42fd91cbb4019f8797d173f364d32e7b75825ffdb6b"} 05:31:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:43 INFO - Contents: 05:31:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6eb8e3852f41ff0732c4bad7111eba69561a0623e577315e2ec35f89b08a51974d302ed1e7f2da258436deb938063357f64bde82adfd44bbced13cf36783e91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20ff4edeb6d073ce3a3afa3b28658a116ee5ff392c7ae7fd9c2451a2f92a36b6c18bd7b7542f20d0a71f35e240a33341216931080e777c89efc23f01f915569e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/673841cf3933645985d8edff3b156b94044b0583617e9f08e54d9b3e3a6567b82e16b24fe9069bbaf08cc42fd91cbb4019f8797d173f364d32e7b75825ffdb6b"} 05:31:43 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:43 INFO - Copying logs to upload dir... 05:31:43 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.790669 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-12 05:31:43.331400) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 05:31:43.335036) ========= 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=d2a8c569965ab8367867b893000001a1-1468325471.178437-787624523 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/a6eb8e3852f41ff0732c4bad7111eba69561a0623e577315e2ec35f89b08a51974d302ed1e7f2da258436deb938063357f64bde82adfd44bbced13cf36783e91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20ff4edeb6d073ce3a3afa3b28658a116ee5ff392c7ae7fd9c2451a2f92a36b6c18bd7b7542f20d0a71f35e240a33341216931080e777c89efc23f01f915569e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/673841cf3933645985d8edff3b156b94044b0583617e9f08e54d9b3e3a6567b82e16b24fe9069bbaf08cc42fd91cbb4019f8797d173f364d32e7b75825ffdb6b"} build_url:https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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/a6eb8e3852f41ff0732c4bad7111eba69561a0623e577315e2ec35f89b08a51974d302ed1e7f2da258436deb938063357f64bde82adfd44bbced13cf36783e91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/20ff4edeb6d073ce3a3afa3b28658a116ee5ff392c7ae7fd9c2451a2f92a36b6c18bd7b7542f20d0a71f35e240a33341216931080e777c89efc23f01f915569e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/673841cf3933645985d8edff3b156b94044b0583617e9f08e54d9b3e3a6567b82e16b24fe9069bbaf08cc42fd91cbb4019f8797d173f364d32e7b75825ffdb6b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 05:31:43.360528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:31:43.360889) ========= 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=d2a8c569965ab8367867b893000001a1-1468325471.178437-787624523 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:31:43.493768) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 05:31:43.494113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 05:31:43.494439) ========= ========= Total master_lag: 0.44 =========