builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1471536509.87 results: success (0) buildid: 20160818053002 builduid: cbeedfa291004b609a65846e2785f8a5 revision: a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:29.865748) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:29.866224) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:29.866498) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:29.881353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:29.881725) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 09:08:30-- 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% 221M=0s 2016-08-18 09:08:30 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095800 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:29.991610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:29.991928) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016382 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:30.041473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:30.041829) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 --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 a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 --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=a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 09:08:30,274 truncating revision to first 12 chars 2016-08-18 09:08:30,274 Setting DEBUG logging. 2016-08-18 09:08:30,274 attempt 1/10 2016-08-18 09:08:30,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a6f67ab4a4ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 09:08:30,582 unpacking tar archive at: fx-team-a6f67ab4a4ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:30.720116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:30.720435) ========= script_repo_revision: a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:30.720839) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:30.721102) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 09:08:30.731038) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-18 09:08:30.731422) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:08:31 INFO - MultiFileLogger online at 20160818 09:08:31 in /builds/slave/test 09:08:31 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 09:08:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:08:31 INFO - {'append_to_log': False, 09:08:31 INFO - 'base_work_dir': '/builds/slave/test', 09:08:31 INFO - 'blob_upload_branch': 'Fx-Team', 09:08:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:08:31 INFO - 'branch': 'Fx-Team', 09:08:31 INFO - 'buildbot_json_path': 'buildprops.json', 09:08:31 INFO - 'config_files': ('talos/linux_config.py',), 09:08:31 INFO - 'default_actions': ('clobber', 09:08:31 INFO - 'read-buildbot-config', 09:08:31 INFO - 'download-and-extract', 09:08:31 INFO - 'populate-webroot', 09:08:31 INFO - 'create-virtualenv', 09:08:31 INFO - 'install', 09:08:31 INFO - 'run-tests'), 09:08:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:08:31 INFO - 'download_minidump_stackwalk': True, 09:08:31 INFO - 'download_symbols': 'ondemand', 09:08:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:08:31 INFO - 'tooltool.py': '/tools/tooltool.py', 09:08:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:08:31 INFO - '/tools/misc-python/virtualenv.py')}, 09:08:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:08:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:08:31 INFO - 'installer_path': 'installer.exe', 09:08:31 INFO - 'log_level': 'info', 09:08:31 INFO - 'log_name': 'talos', 09:08:31 INFO - 'log_to_console': True, 09:08:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:08:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:08:31 INFO - 'opt_config_files': (), 09:08:31 INFO - 'pip_index': False, 09:08:31 INFO - 'sps_profile': False, 09:08:31 INFO - 'sps_profile_interval': 0, 09:08:31 INFO - 'suite': 'dromaeojs-e10s', 09:08:31 INFO - 'system_bits': '32', 09:08:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:08:31 INFO - 'title': 'talos-linux64-ix-064', 09:08:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:08:31 INFO - 'use_talos_json': True, 09:08:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:08:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:08:31 INFO - 'work_dir': 'build'} 09:08:31 INFO - [mozharness: 2016-08-18 16:08:31.058341Z] Running clobber step. 09:08:31 INFO - Running pre-action listener: _resource_record_pre_action 09:08:31 INFO - Running main action method: clobber 09:08:31 INFO - rmtree: /builds/slave/test/build 09:08:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:08:31 INFO - Running post-action listener: _resource_record_post_action 09:08:31 INFO - [mozharness: 2016-08-18 16:08:31.528408Z] Finished clobber step (success) 09:08:31 INFO - [mozharness: 2016-08-18 16:08:31.528512Z] Running read-buildbot-config step. 09:08:31 INFO - Running pre-action listener: _resource_record_pre_action 09:08:31 INFO - Running main action method: read_buildbot_config 09:08:31 INFO - Using buildbot properties: 09:08:31 INFO - { 09:08:31 INFO - "project": "", 09:08:31 INFO - "product": "firefox", 09:08:31 INFO - "script_repo_revision": "production", 09:08:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:08:31 INFO - "repository": "", 09:08:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 09:08:31 INFO - "buildid": "20160818053002", 09:08:31 INFO - "pgo_build": "True", 09:08:31 INFO - "basedir": "/builds/slave/test", 09:08:31 INFO - "buildnumber": 1055, 09:08:31 INFO - "slavename": "talos-linux64-ix-064", 09:08:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:08:31 INFO - "platform": "ubuntu64_hw", 09:08:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:08:31 INFO - "branch": "fx-team", 09:08:31 INFO - "repo_path": "integration/fx-team", 09:08:31 INFO - "revision": "a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388", 09:08:31 INFO - "stage_platform": "linux64-pgo", 09:08:31 INFO - "builduid": "cbeedfa291004b609a65846e2785f8a5", 09:08:31 INFO - "slavebuilddir": "test" 09:08:31 INFO - } 09:08:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:08:31 INFO - Running post-action listener: _resource_record_post_action 09:08:31 INFO - [mozharness: 2016-08-18 16:08:31.530925Z] Finished read-buildbot-config step (success) 09:08:31 INFO - [mozharness: 2016-08-18 16:08:31.531014Z] Running download-and-extract step. 09:08:31 INFO - Running pre-action listener: _resource_record_pre_action 09:08:31 INFO - Running main action method: download_and_extract 09:08:31 INFO - mkdir: /builds/slave/test/build/tests 09:08: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:31 INFO - trying https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:08:31 INFO - Downloading https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:08:32 INFO - Downloaded 1361 bytes. 09:08:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:08:32 INFO - Using the following test package requirements: 09:08:32 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:08:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:08:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:08:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:32 INFO - u'jsshell-linux-x86_64.zip'], 09:08:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:08:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:08:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:08:32 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:08:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:08:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:08:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:08:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:32 INFO - trying https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:08:32 INFO - Downloading https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:08:33 INFO - Downloaded 21907088 bytes. 09:08:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 09:08:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:08:37 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:37 INFO - trying https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:08:37 INFO - Downloading https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:08:38 INFO - Downloaded 21907088 bytes. 09:08:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 09:08:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:43 INFO - trying https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:08:43 INFO - Downloading https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:08:43 INFO - Downloaded 14413981 bytes. 09:08:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 09:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:44 INFO - trying https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:08:44 INFO - Downloading https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:08:45 INFO - Downloaded 59604716 bytes. 09:08:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:08:45 INFO - mkdir: /builds/slave/test/properties 09:08:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:08:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:08:45 INFO - Contents: 09:08:45 INFO - build_url:https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:08:45 INFO - Running post-action listener: _resource_record_post_action 09:08:45 INFO - Running post-action listener: set_extra_try_arguments 09:08:45 INFO - [mozharness: 2016-08-18 16:08:45.870539Z] Finished download-and-extract step (success) 09:08:45 INFO - [mozharness: 2016-08-18 16:08:45.870762Z] Running populate-webroot step. 09:08:45 INFO - Running pre-action listener: _resource_record_pre_action 09:08:45 INFO - Running main action method: populate_webroot 09:08:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:08:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:08:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:08:45 INFO - '--tppagecycles', 09:08:45 INFO - '7'], 09:08:45 INFO - 'tests': ['tsvgm']}}, 09:08:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:08:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:08:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:08:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:08:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:45 INFO - 'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:08:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:08:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:45 INFO - 'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['damp', 'tps']}, 09:08:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:45 INFO - 'tests': ['damp', 'tps']}, 09:08:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['dromaeo_dom']}, 09:08:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:08:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['basic_compositor_video']}, 09:08:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:08:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['a11yr', 09:08:45 INFO - 'ts_paint', 09:08:45 INFO - 'tpaint', 09:08:45 INFO - 'sessionrestore', 09:08:45 INFO - 'sessionrestore_no_auto_restore', 09:08:45 INFO - 'tabpaint']}, 09:08:45 INFO - 'other-e10s': {'tests': ['a11yr', 09:08:45 INFO - 'ts_paint', 09:08:45 INFO - 'tpaint', 09:08:45 INFO - 'sessionrestore', 09:08:45 INFO - 'sessionrestore_no_auto_restore', 09:08:45 INFO - 'tabpaint']}, 09:08:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:08:45 INFO - 'ts_paint', 09:08:45 INFO - 'tpaint', 09:08:45 INFO - 'sessionrestore', 09:08:45 INFO - 'sessionrestore_no_auto_restore', 09:08:45 INFO - 'tabpaint']}, 09:08:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:08:45 INFO - 'ts_paint', 09:08:45 INFO - 'tpaint', 09:08:45 INFO - 'sessionrestore', 09:08:45 INFO - 'sessionrestore_no_auto_restore', 09:08:45 INFO - 'tabpaint']}, 09:08:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['a11yr', 09:08:45 INFO - 'ts_paint', 09:08:45 INFO - 'tpaint', 09:08:45 INFO - 'sessionrestore', 09:08:45 INFO - 'sessionrestore_no_auto_restore', 09:08:45 INFO - 'tabpaint']}, 09:08:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['a11yr', 09:08:45 INFO - 'ts_paint', 09:08:45 INFO - 'tpaint', 09:08:45 INFO - 'sessionrestore', 09:08:45 INFO - 'sessionrestore_no_auto_restore', 09:08:45 INFO - 'tabpaint']}, 09:08:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['tsvgx', 09:08:45 INFO - 'tsvgr_opacity', 09:08:45 INFO - 'tart', 09:08:45 INFO - 'tscrollx', 09:08:45 INFO - 'cart']}, 09:08:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:08:45 INFO - 'tsvgr_opacity', 09:08:45 INFO - 'tart', 09:08:45 INFO - 'tscrollx', 09:08:45 INFO - 'cart']}, 09:08:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:45 INFO - 'talos_options': ['--disable-e10s'], 09:08:45 INFO - 'tests': ['tp5o']}, 09:08:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:45 INFO - 'tests': ['tp5o']}, 09:08:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:45 INFO - 'talos_options': ['--disable-e10s', 09:08:45 INFO - '--xperf_path', 09:08:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:08:45 INFO - 'tests': ['tp5n']}, 09:08:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:08:45 INFO - 'talos_options': ['--xperf_path', 09:08:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:08:45 INFO - 'tests': ['tp5n']}}, 09:08:45 INFO - 'talos.zip': {'path': '', 09:08:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:08:45 INFO - Running post-action listener: _resource_record_post_action 09:08:45 INFO - [mozharness: 2016-08-18 16:08:45.888163Z] Finished populate-webroot step (success) 09:08:45 INFO - [mozharness: 2016-08-18 16:08:45.888252Z] Running create-virtualenv step. 09:08:45 INFO - Running pre-action listener: _resource_record_pre_action 09:08:45 INFO - Running main action method: create_virtualenv 09:08:45 INFO - Creating virtualenv /builds/slave/test/build/venv 09:08:45 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 09:08:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:08:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:08:45 INFO - Using real prefix '/usr' 09:08:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:08:46 INFO - Installing distribute.............................................................................................................................................................................................done. 09:08:48 INFO - Installing pip.................done. 09:08:48 INFO - Return code: 0 09:08:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:08:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:48 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 0x7fa75efcef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', '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 09:08:48 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 09:08:48 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 09:08:48 INFO - Using env: {'DISPLAY': ':0', 09:08:48 INFO - 'HOME': '/home/cltbld', 09:08:48 INFO - 'LANG': 'en_US.UTF-8', 09:08:48 INFO - 'LANGUAGE': 'en_US:en', 09:08:48 INFO - 'LOGNAME': 'cltbld', 09:08:48 INFO - 'MAIL': '/var/mail/cltbld', 09:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:48 INFO - 'MOZ_NO_REMOTE': '1', 09:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:48 INFO - 'NO_EM_RESTART': '1', 09:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:48 INFO - 'PWD': '/builds/slave/test', 09:08:48 INFO - 'SHELL': '/bin/bash', 09:08:48 INFO - 'SHLVL': '1', 09:08:48 INFO - 'TERM': 'linux', 09:08:48 INFO - 'TMOUT': '86400', 09:08:48 INFO - 'USER': 'cltbld', 09:08:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:48 INFO - '_': '/tools/buildbot/bin/python'} 09:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:48 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 09:08:48 INFO - Cleaning up... 09:08:48 INFO - Return code: 0 09:08:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:08:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:48 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 0x7fa75efcef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', '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 09:08:48 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 09:08:48 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 09:08:48 INFO - Using env: {'DISPLAY': ':0', 09:08:48 INFO - 'HOME': '/home/cltbld', 09:08:48 INFO - 'LANG': 'en_US.UTF-8', 09:08:48 INFO - 'LANGUAGE': 'en_US:en', 09:08:48 INFO - 'LOGNAME': 'cltbld', 09:08:48 INFO - 'MAIL': '/var/mail/cltbld', 09:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:48 INFO - 'MOZ_NO_REMOTE': '1', 09:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:48 INFO - 'NO_EM_RESTART': '1', 09:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:48 INFO - 'PWD': '/builds/slave/test', 09:08:48 INFO - 'SHELL': '/bin/bash', 09:08:48 INFO - 'SHLVL': '1', 09:08:48 INFO - 'TERM': 'linux', 09:08:48 INFO - 'TMOUT': '86400', 09:08:48 INFO - 'USER': 'cltbld', 09:08:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:48 INFO - '_': '/tools/buildbot/bin/python'} 09:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:48 INFO - Downloading/unpacking psutil>=3.1.1 09:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:08:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:50 INFO - Installing collected packages: psutil 09:08:50 INFO - Running setup.py install for psutil 09:08:50 INFO - building 'psutil._psutil_linux' extension 09:08:50 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 09:08:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:08:51 INFO - building 'psutil._psutil_posix' extension 09:08:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:08:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:08:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:08:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:51 INFO - Successfully installed psutil 09:08:51 INFO - Cleaning up... 09:08:51 INFO - Return code: 0 09:08:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:08:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:51 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 0x7fa75efcef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', '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 09:08:51 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 09:08:51 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 09:08:51 INFO - Using env: {'DISPLAY': ':0', 09:08:51 INFO - 'HOME': '/home/cltbld', 09:08:51 INFO - 'LANG': 'en_US.UTF-8', 09:08:51 INFO - 'LANGUAGE': 'en_US:en', 09:08:51 INFO - 'LOGNAME': 'cltbld', 09:08:51 INFO - 'MAIL': '/var/mail/cltbld', 09:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:51 INFO - 'MOZ_NO_REMOTE': '1', 09:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:51 INFO - 'NO_EM_RESTART': '1', 09:08:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:51 INFO - 'PWD': '/builds/slave/test', 09:08:51 INFO - 'SHELL': '/bin/bash', 09:08:51 INFO - 'SHLVL': '1', 09:08:51 INFO - 'TERM': 'linux', 09:08:51 INFO - 'TMOUT': '86400', 09:08:51 INFO - 'USER': 'cltbld', 09:08:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:51 INFO - '_': '/tools/buildbot/bin/python'} 09:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:08:51 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 09:08:51 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 09:08:51 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 09:08:51 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 09:08:51 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 09:08:51 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 09:08:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:08:53 INFO - Installing collected packages: mozsystemmonitor 09:08:53 INFO - Running setup.py install for mozsystemmonitor 09:08:53 INFO - Successfully installed mozsystemmonitor 09:08:53 INFO - Cleaning up... 09:08:53 INFO - Return code: 0 09:08:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:53 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 0x7fa75efcef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', '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 09:08:53 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 09:08:53 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 09:08:53 INFO - Using env: {'DISPLAY': ':0', 09:08:53 INFO - 'HOME': '/home/cltbld', 09:08:53 INFO - 'LANG': 'en_US.UTF-8', 09:08:53 INFO - 'LANGUAGE': 'en_US:en', 09:08:53 INFO - 'LOGNAME': 'cltbld', 09:08:53 INFO - 'MAIL': '/var/mail/cltbld', 09:08:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:53 INFO - 'MOZ_NO_REMOTE': '1', 09:08:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:53 INFO - 'NO_EM_RESTART': '1', 09:08:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:53 INFO - 'PWD': '/builds/slave/test', 09:08:53 INFO - 'SHELL': '/bin/bash', 09:08:53 INFO - 'SHLVL': '1', 09:08:53 INFO - 'TERM': 'linux', 09:08:53 INFO - 'TMOUT': '86400', 09:08:53 INFO - 'USER': 'cltbld', 09:08:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:08:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:53 INFO - '_': '/tools/buildbot/bin/python'} 09:08:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:53 INFO - Downloading/unpacking jsonschema==2.5.1 09:08:53 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 09:08:53 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 09:08:53 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 09:08:53 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 09:08:53 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 09:08:53 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 09:08:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:08:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:55 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 09:08:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:08:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:08:56 INFO - warning: no files found matching '*.txt' 09:08:56 INFO - no previously-included directories found matching 'build' 09:08:56 INFO - no previously-included directories found matching 'dist' 09:08:56 INFO - no previously-included directories found matching '.git*' 09:08:56 INFO - Installing collected packages: jsonschema, functools32 09:08:56 INFO - Running setup.py install for functools32 09:08:56 INFO - warning: no files found matching '*.txt' 09:08:56 INFO - no previously-included directories found matching 'build' 09:08:56 INFO - no previously-included directories found matching 'dist' 09:08:56 INFO - no previously-included directories found matching '.git*' 09:08:56 INFO - Successfully installed jsonschema functools32 09:08:56 INFO - Cleaning up... 09:08:56 INFO - Return code: 0 09:08:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:08:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:56 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75efcef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', '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 09:08:56 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:08:56 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 functools32==3.2.3-2 09:08:56 INFO - Using env: {'DISPLAY': ':0', 09:08:56 INFO - 'HOME': '/home/cltbld', 09:08:56 INFO - 'LANG': 'en_US.UTF-8', 09:08:56 INFO - 'LANGUAGE': 'en_US:en', 09:08:56 INFO - 'LOGNAME': 'cltbld', 09:08:56 INFO - 'MAIL': '/var/mail/cltbld', 09:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:56 INFO - 'MOZ_NO_REMOTE': '1', 09:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:56 INFO - 'NO_EM_RESTART': '1', 09:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:56 INFO - 'PWD': '/builds/slave/test', 09:08:56 INFO - 'SHELL': '/bin/bash', 09:08:56 INFO - 'SHLVL': '1', 09:08:56 INFO - 'TERM': 'linux', 09:08:56 INFO - 'TMOUT': '86400', 09:08:56 INFO - 'USER': 'cltbld', 09:08:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:56 INFO - '_': '/tools/buildbot/bin/python'} 09:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:08:56 INFO - Cleaning up... 09:08:56 INFO - Return code: 0 09:08:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:08:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:56 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 0x7fa75efcef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', '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 09:08:56 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 09:08:56 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 09:08:56 INFO - Using env: {'DISPLAY': ':0', 09:08:56 INFO - 'HOME': '/home/cltbld', 09:08:56 INFO - 'LANG': 'en_US.UTF-8', 09:08:56 INFO - 'LANGUAGE': 'en_US:en', 09:08:56 INFO - 'LOGNAME': 'cltbld', 09:08:56 INFO - 'MAIL': '/var/mail/cltbld', 09:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:56 INFO - 'MOZ_NO_REMOTE': '1', 09:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:56 INFO - 'NO_EM_RESTART': '1', 09:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:56 INFO - 'PWD': '/builds/slave/test', 09:08:56 INFO - 'SHELL': '/bin/bash', 09:08:56 INFO - 'SHLVL': '1', 09:08:56 INFO - 'TERM': 'linux', 09:08:56 INFO - 'TMOUT': '86400', 09:08:56 INFO - 'USER': 'cltbld', 09:08:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:56 INFO - '_': '/tools/buildbot/bin/python'} 09:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:58 INFO - Downloading blobuploader-1.2.4.tar.gz 09:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:08:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:08:58 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 09:08:58 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 09:08:58 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 09:08:58 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 09:08:58 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 09:08:58 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 09:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:08:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:59 INFO - Downloading docopt-0.6.1.tar.gz 09:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:08:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:08:59 INFO - Running setup.py install for blobuploader 09:08:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:08:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:08:59 INFO - Running setup.py install for requests 09:08:59 INFO - Running setup.py install for docopt 09:08:59 INFO - Successfully installed blobuploader requests docopt 09:08:59 INFO - Cleaning up... 09:09:00 INFO - Return code: 0 09:09:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75efcef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', '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 09:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:09:00 INFO - Using env: {'DISPLAY': ':0', 09:09:00 INFO - 'HOME': '/home/cltbld', 09:09:00 INFO - 'LANG': 'en_US.UTF-8', 09:09:00 INFO - 'LANGUAGE': 'en_US:en', 09:09:00 INFO - 'LOGNAME': 'cltbld', 09:09:00 INFO - 'MAIL': '/var/mail/cltbld', 09:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:00 INFO - 'MOZ_NO_REMOTE': '1', 09:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:00 INFO - 'NO_EM_RESTART': '1', 09:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:00 INFO - 'PWD': '/builds/slave/test', 09:09:00 INFO - 'SHELL': '/bin/bash', 09:09:00 INFO - 'SHLVL': '1', 09:09:00 INFO - 'TERM': 'linux', 09:09:00 INFO - 'TMOUT': '86400', 09:09:00 INFO - 'USER': 'cltbld', 09:09:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:00 INFO - '_': '/tools/buildbot/bin/python'} 09:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:00 INFO - Running setup.py (path:/tmp/pip-9dOp2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:00 INFO - Running setup.py (path:/tmp/pip-LOgkKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:00 INFO - Running setup.py (path:/tmp/pip-4u9WNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:00 INFO - Running setup.py (path:/tmp/pip-xDIuxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:00 INFO - Running setup.py (path:/tmp/pip-d1A802-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:00 INFO - Running setup.py (path:/tmp/pip-lNejEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:00 INFO - Running setup.py (path:/tmp/pip-WdCo4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:00 INFO - Running setup.py (path:/tmp/pip-nnROAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:00 INFO - Running setup.py (path:/tmp/pip-G14qor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:00 INFO - Running setup.py (path:/tmp/pip-zyf81K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:00 INFO - Running setup.py (path:/tmp/pip-nNjvX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:01 INFO - Running setup.py (path:/tmp/pip-V8_a5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:01 INFO - Running setup.py (path:/tmp/pip-oP7mFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:01 INFO - Running setup.py (path:/tmp/pip-LoKRbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:01 INFO - Running setup.py (path:/tmp/pip-ruTyvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:01 INFO - Running setup.py (path:/tmp/pip-_6ikB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:01 INFO - Running setup.py (path:/tmp/pip-dqMZmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:01 INFO - Running setup.py install for manifestparser 09:09:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:01 INFO - Running setup.py install for mozcrash 09:09:01 INFO - Running setup.py install for mozdebug 09:09:01 INFO - Running setup.py install for mozdevice 09:09:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:09:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:01 INFO - Running setup.py install for mozfile 09:09:01 INFO - Running setup.py install for mozhttpd 09:09:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Running setup.py install for mozinfo 09:09:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Running setup.py install for mozInstall 09:09:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Running setup.py install for mozleak 09:09:02 INFO - Running setup.py install for mozlog 09:09:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Running setup.py install for moznetwork 09:09:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Running setup.py install for mozprocess 09:09:02 INFO - Running setup.py install for mozprofile 09:09:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Running setup.py install for mozrunner 09:09:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:09:02 INFO - Running setup.py install for mozscreenshot 09:09:03 INFO - Running setup.py install for moztest 09:09:03 INFO - Running setup.py install for mozversion 09:09:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:09:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:09:03 INFO - Cleaning up... 09:09:03 INFO - Return code: 0 09:09:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75efcef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', '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 09:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:09:03 INFO - Using env: {'DISPLAY': ':0', 09:09:03 INFO - 'HOME': '/home/cltbld', 09:09:03 INFO - 'LANG': 'en_US.UTF-8', 09:09:03 INFO - 'LANGUAGE': 'en_US:en', 09:09:03 INFO - 'LOGNAME': 'cltbld', 09:09:03 INFO - 'MAIL': '/var/mail/cltbld', 09:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:03 INFO - 'MOZ_NO_REMOTE': '1', 09:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:03 INFO - 'NO_EM_RESTART': '1', 09:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:03 INFO - 'PWD': '/builds/slave/test', 09:09:03 INFO - 'SHELL': '/bin/bash', 09:09:03 INFO - 'SHLVL': '1', 09:09:03 INFO - 'TERM': 'linux', 09:09:03 INFO - 'TMOUT': '86400', 09:09:03 INFO - 'USER': 'cltbld', 09:09:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:03 INFO - '_': '/tools/buildbot/bin/python'} 09:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:03 INFO - Running setup.py (path:/tmp/pip-MRmbfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:03 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)) 09:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:03 INFO - Running setup.py (path:/tmp/pip-pX07_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:03 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)) 09:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:03 INFO - Running setup.py (path:/tmp/pip-0BQLIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:03 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)) 09:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:03 INFO - Running setup.py (path:/tmp/pip-IHIfhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:03 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)) 09:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:03 INFO - Running setup.py (path:/tmp/pip-gA_Dla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:03 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)) 09:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:03 INFO - Running setup.py (path:/tmp/pip-A6vLxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:03 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)) 09:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:03 INFO - Running setup.py (path:/tmp/pip-0vTUht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:03 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)) 09:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:03 INFO - Running setup.py (path:/tmp/pip-W513_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:04 INFO - Running setup.py (path:/tmp/pip-SOoeNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:04 INFO - Running setup.py (path:/tmp/pip-qNC1Rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:04 INFO - Running setup.py (path:/tmp/pip-_ISKol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:04 INFO - Running setup.py (path:/tmp/pip-4IAU6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:04 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)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:04 INFO - Running setup.py (path:/tmp/pip-OkG7ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:04 INFO - Running setup.py (path:/tmp/pip-d5Vn6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:04 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)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:04 INFO - Running setup.py (path:/tmp/pip-ItiOP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:04 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)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:04 INFO - Running setup.py (path:/tmp/pip-J6Glt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:04 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)) 09:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:04 INFO - Running setup.py (path:/tmp/pip-p_76_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:04 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)) 09:09:04 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)) 09:09:04 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)) 09:09:04 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)) 09:09:04 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)) 09:09:04 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)) 09:09:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:04 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 09:09:04 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 09:09:04 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 09:09:04 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 09:09:04 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 09:09:04 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 09:09:06 INFO - Downloading blessings-1.6.tar.gz 09:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:09:06 INFO - Installing collected packages: blessings 09:09:06 INFO - Running setup.py install for blessings 09:09:06 INFO - Successfully installed blessings 09:09:06 INFO - Cleaning up... 09:09:06 INFO - Return code: 0 09:09:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:09:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:07 INFO - Reading from file tmpfile_stdout 09:09:07 INFO - Current package versions: 09:09:07 INFO - argparse == 1.2.1 09:09:07 INFO - blessings == 1.6 09:09:07 INFO - blobuploader == 1.2.4 09:09:07 INFO - docopt == 0.6.1 09:09:07 INFO - functools32 == 3.2.3-2 09:09:07 INFO - jsonschema == 2.5.1 09:09:07 INFO - manifestparser == 1.1 09:09:07 INFO - mozInstall == 1.12 09:09:07 INFO - mozcrash == 0.17 09:09:07 INFO - mozdebug == 0.1 09:09:07 INFO - mozdevice == 0.48 09:09:07 INFO - mozfile == 1.2 09:09:07 INFO - mozhttpd == 0.7 09:09:07 INFO - mozinfo == 0.9 09:09:07 INFO - mozleak == 0.1 09:09:07 INFO - mozlog == 3.3 09:09:07 INFO - moznetwork == 0.27 09:09:07 INFO - mozprocess == 0.23 09:09:07 INFO - mozprofile == 0.28 09:09:07 INFO - mozrunner == 6.12 09:09:07 INFO - mozscreenshot == 0.1 09:09:07 INFO - mozsystemmonitor == 0.3 09:09:07 INFO - moztest == 0.7 09:09:07 INFO - mozversion == 1.4 09:09:07 INFO - psutil == 3.1.1 09:09:07 INFO - requests == 1.2.3 09:09:07 INFO - wsgiref == 0.1.2 09:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75efcef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', '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 09:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:09:07 INFO - Using env: {'DISPLAY': ':0', 09:09:07 INFO - 'HOME': '/home/cltbld', 09:09:07 INFO - 'LANG': 'en_US.UTF-8', 09:09:07 INFO - 'LANGUAGE': 'en_US:en', 09:09:07 INFO - 'LOGNAME': 'cltbld', 09:09:07 INFO - 'MAIL': '/var/mail/cltbld', 09:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:07 INFO - 'MOZ_NO_REMOTE': '1', 09:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:07 INFO - 'NO_EM_RESTART': '1', 09:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:07 INFO - 'PWD': '/builds/slave/test', 09:09:07 INFO - 'SHELL': '/bin/bash', 09:09:07 INFO - 'SHLVL': '1', 09:09:07 INFO - 'TERM': 'linux', 09:09:07 INFO - 'TMOUT': '86400', 09:09:07 INFO - 'USER': 'cltbld', 09:09:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:07 INFO - '_': '/tools/buildbot/bin/python'} 09:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:09:07 INFO - Cleaning up... 09:09:07 INFO - Return code: 0 09:09:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa75efcef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16568d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', '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 09:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:09:07 INFO - Using env: {'DISPLAY': ':0', 09:09:07 INFO - 'HOME': '/home/cltbld', 09:09:07 INFO - 'LANG': 'en_US.UTF-8', 09:09:07 INFO - 'LANGUAGE': 'en_US:en', 09:09:07 INFO - 'LOGNAME': 'cltbld', 09:09:07 INFO - 'MAIL': '/var/mail/cltbld', 09:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:07 INFO - 'MOZ_NO_REMOTE': '1', 09:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:07 INFO - 'NO_EM_RESTART': '1', 09:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:07 INFO - 'PWD': '/builds/slave/test', 09:09:07 INFO - 'SHELL': '/bin/bash', 09:09:07 INFO - 'SHLVL': '1', 09:09:07 INFO - 'TERM': 'linux', 09:09:07 INFO - 'TMOUT': '86400', 09:09:07 INFO - 'USER': 'cltbld', 09:09:07 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:07 INFO - '_': '/tools/buildbot/bin/python'} 09:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:09:07 INFO - Cleaning up... 09:09:07 INFO - Return code: 0 09:09:07 INFO - Running post-action listener: _resource_record_post_action 09:09:07 INFO - Running post-action listener: _start_resource_monitoring 09:09:07 INFO - Starting resource monitoring. 09:09:07 INFO - [mozharness: 2016-08-18 16:09:07.528029Z] Finished create-virtualenv step (success) 09:09:07 INFO - [mozharness: 2016-08-18 16:09:07.528492Z] Running install step. 09:09:07 INFO - Running pre-action listener: _resource_record_pre_action 09:09:07 INFO - Running main action method: install 09:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:07 INFO - Reading from file tmpfile_stdout 09:09:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:09:07 INFO - Reading from file tmpfile_stdout 09:09:07 INFO - Output received: 09:09:07 INFO - Usage: mozinstall [options] installer 09:09:07 INFO - Options: 09:09:07 INFO - -h, --help show this help message and exit 09:09:07 INFO - -d DEST, --destination=DEST 09:09:07 INFO - Directory to install application into. [default: 09:09:07 INFO - "/builds/slave/test"] 09:09:07 INFO - --app=APP Application being installed. [default: firefox] 09:09:07 INFO - mkdir: /builds/slave/test/build/application 09:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:09:24 INFO - Reading from file tmpfile_stdout 09:09:24 INFO - Output received: 09:09:24 INFO - /builds/slave/test/build/application/firefox/firefox 09:09:24 INFO - Running post-action listener: _resource_record_post_action 09:09:24 INFO - [mozharness: 2016-08-18 16:09:24.788773Z] Finished install step (success) 09:09:24 INFO - [mozharness: 2016-08-18 16:09:24.789018Z] Running run-tests step. 09:09:24 INFO - Running pre-action listener: _resource_record_pre_action 09:09:24 INFO - Running main action method: run_tests 09:09:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:09:24 INFO - Python 2.7.3 09:09:24 INFO - Return code: 0 09:09:24 INFO - grabbing minidump binary from tooltool 09:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e5760>, '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 0x16e6660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:09:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:09:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:09:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:09:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:09:24 INFO - Return code: 0 09:09:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:09:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:09:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:09:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:09:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:09:24 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/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 09:09:24 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/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 09:09:24 INFO - Using env: {'DISPLAY': ':0', 09:09:24 INFO - 'HOME': '/home/cltbld', 09:09:24 INFO - 'LANG': 'en_US.UTF-8', 09:09:24 INFO - 'LANGUAGE': 'en_US:en', 09:09:24 INFO - 'LOGNAME': 'cltbld', 09:09:24 INFO - 'MAIL': '/var/mail/cltbld', 09:09:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:09:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:24 INFO - 'MOZ_NO_REMOTE': '1', 09:09:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:24 INFO - 'NO_EM_RESTART': '1', 09:09:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:24 INFO - 'PWD': '/builds/slave/test', 09:09:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:09:24 INFO - 'SHELL': '/bin/bash', 09:09:24 INFO - 'SHLVL': '1', 09:09:24 INFO - 'TERM': 'linux', 09:09:24 INFO - 'TMOUT': '86400', 09:09:24 INFO - 'USER': 'cltbld', 09:09:24 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402', 09:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:24 INFO - '_': '/tools/buildbot/bin/python'} 09:09:24 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/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 09:09:25 INFO - mozversion application_buildid: 20160818053002 09:09:25 INFO - mozversion application_changeset: a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 09:09:25 INFO - mozversion application_display_name: Nightly 09:09:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:09:25 INFO - mozversion application_name: Firefox 09:09:25 INFO - mozversion application_remotingname: firefox 09:09:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:09:25 INFO - mozversion application_vendor: Mozilla 09:09:25 INFO - mozversion application_version: 51.0a1 09:09:25 INFO - mozversion platform_buildid: 20160818053002 09:09:25 INFO - mozversion platform_changeset: a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 09:09:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:09:25 INFO - mozversion platform_version: 51.0a1 09:09:25 INFO - using testdate: 1471536565 09:09:25 INFO - actual date: 1471536565 09:09:25 INFO - starting webserver on 'localhost:42536' 09:09:25 INFO - SUITE-START | Running 2 tests 09:09:25 INFO - TEST-START | dromaeo_css 09:09:25 INFO - operating with platform_type : linux_ 09:09:25 INFO - Initialising browser for dromaeo_css test... 09:09:25 INFO - TEST-INFO | started process 2166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_HIgd/profile http://localhost:42536/getInfo.html) 09:09:29 INFO - PROCESS | 2166 | __metrics Screen width/height:1600/1200 09:09:29 INFO - PROCESS | 2166 | colorDepth:24 09:09:29 INFO - PROCESS | 2166 | Browser inner width/height: 1024/697 09:09:29 INFO - PROCESS | 2166 | __metrics 09:09:30 ERROR - PROCESS | 2166 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 09:09:31 INFO - TEST-INFO | 2166: exit 0 09:09:31 INFO - Browser initialized. 09:09:31 INFO - Running cycle 1/1 for dromaeo_css test... 09:09:31 INFO - TEST-INFO | started process 2288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW_HIgd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:42 INFO - PROCESS | 2288 | RSS: Main: 163528704 09:09:42 INFO - PROCESS | 2288 | 09:10:32 INFO - PROCESS | 2288 | 1471536632432 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] 09:12:41 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42536/tests/dromaeo/cssquery-ext.html) 09:12:42 INFO - PROCESS | 2288 | RSS: Main: 167247872 09:12:42 INFO - PROCESS | 2288 | 09:15:44 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-ext.html (next: http://localhost:42536/tests/dromaeo/cssquery-jquery.html) 09:15:45 INFO - PROCESS | 2288 | RSS: Main: 165654528 09:15:45 INFO - PROCESS | 2288 | 09:18:47 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42536/tests/dromaeo/cssquery-mootools.html) 09:18:48 INFO - PROCESS | 2288 | RSS: Main: 166924288 09:18:48 INFO - PROCESS | 2288 | 09:21:49 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42536/tests/dromaeo/cssquery-prototype.html) 09:21:50 INFO - PROCESS | 2288 | RSS: Main: 164401152 09:21:50 INFO - PROCESS | 2288 | 09:24:53 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42536/tests/dromaeo/cssquery-yui.html) 09:24:53 INFO - PROCESS | 2288 | RSS: Main: 166744064 09:24:53 INFO - PROCESS | 2288 | 09:27:56 INFO - PROCESS | 2288 | Cycle 1(1): loaded http://localhost:42536/tests/dromaeo/cssquery-yui.html (next: http://localhost:42536/tests/dromaeo/cssquery-dojo.html) 09:27:57 INFO - PROCESS | 2288 | RSS: Main: 167030784 09:27:57 INFO - PROCESS | 2288 | 09:27:57 INFO - PROCESS | 2288 | __start_tp_report 09:27:57 INFO - PROCESS | 2288 | _x_x_mozilla_page_load 09:27:57 INFO - PROCESS | 2288 | _x_x_mozilla_page_load_details 09:27:57 INFO - PROCESS | 2288 | |i|pagename|runs| 09:27:57 INFO - PROCESS | 2288 | |0;dojo.html;3078.199668086297;3099.3801239752056;3112.4553203189434;3117.672644372341;3121;5371.892562148755;5425.810096646618;5508.338999320083;5522.447755224481;5526.226328314029;5456.263404440409;5495.093309603911;5562.276904002474;5566.025945459549;5570.526505247059;4935.457099719028;4967.751612419383;4967.826126085579;4988.426330971948;5025.949740502603;5014.874628134289;5047.116754567955;5077.263796749469;5114.386273647167;5120.334356533645;244.48656821954236;4921.704697718148;5077.873053173664;5121.359830021247;5148.922766158511;5055.191169412877;5064.139096353629;5068.797248110071;5096.872578185538;5117.6161787865685;5016.172331565287;5018.473060328686;5020.824271150529;5026.371703537058;5074.238864170367;5356.732163391854;5393.352797664305;5454.372747134091;5459.153831156137;5511.724413779335;5774.855628609276;5859.472647461706;5879;5906.350301466835;5910.438508341701;5874.97062514689;5907.822765317047;5920.851978700523;5923.911141332884;5926.2295901532525;5283.260343551868;5419.756110975016;5458.808941687022;5461.9453805461835;5468;5988.311344195473;6065.54508411862;6068.848278793065;6108.725107370179;6120.051392034242;5786.450287222707;5793.768249270066;5803.767849286066;5804.622699524602;5809.24479817621;5644.85887852807;5746.224259724883;5850.151727999416;5867.6772777497645;5870;5717.542596592262;5831.562632802556;5834.766609335579;5859.033259512218;5880.470757631833;5767.711614419262;5841.7371218295275;5846.29844418664;5864.06175011996;5875.324337701134;4285.292926667127;4419.425474688334;4467.486239082482;4474.194644963938;4515.096980603892;3958.366661334173;3987.80060996949;3991.8203680833853;4022.577629348935;4030.3954406839207;5626.156076588544;5667.093265077568;5672.602917795797;5672.943270567324;5678.0915053591225;5718.399568045378;5808.041673123887;5843.152742852262;5933.673647949404;5933.851653708692;5611.2144299798065;5617.550595952314;5618.550515958714;5651.095824668033;5672.688002159838;5075.593952483792;5081.517255860687;5081.568066714297;5099.107656160231;5124.718140502234;5976.820695379146;6016.969915150396;6077.483413909778;6109.450149486479;6116.327204007555;5899.115132730125;5912.231409916683;5926.703664816656;5954.493868021266;5960.642361458326;6125.326214116532;6133.601315914451;6137.140800287874;6140.5701600887505;6146.692665366624;5610.747516361692;5741.483266506035;5790.7973220937065;5801.738921748447;5848.181254624441;5914.201582786441;5924.140999554954;5935.495482883831;5988.161657368059;5993.520518358608;5777.39337369587;5809.593328466966;5819;5826.126081087871;5837.299524056971;5525.4474552544425;5655.547556195576;5734.942650573441;5798.76804927815;5805.94194058054;5703.372629010889;5704.458076482728;5708.200851880657;5727.31272247333;5743.3395159557185;5725.2843394575675;5742.08126699726;5784.623999440023;5802.82591522255;5806.65160090396;5453.182022696627;5559.63862348946;5613.129964855454;5621.5221706155435;5673 09:27:57 INFO - PROCESS | 2288 | |1;ext.html;544.8267650910823;591.5474661883659;601.6540489218697;603.2037710222506;625.5308518611042;39284.60715392845;44306;44313.33529997049;44351.33472997908;44369;43626.78186609071;43854;43867.56132438675;44006.77996610021;44393.11213775723;8832.470051796881;8965.417247878899;8996.370254082216;9009.459432434041;9023.954880225623;8885.333599980027;8948.552572371387;8962.955185224066;8978;8989.640414383417;8990.775230619221;9053;9078.137576930181;9083.500407477586;9095.863562046574;8920.241779448756;8929.642814287421;8990;9007.369484136114;9009.819803603892;8841.425307355;8871.822563548758;8919.509426981513;8935.106489351077;8936.151065648754;42485;42557.78721106405;42736.57263427357;42863.78568107139;42966.57033429657;3475.2528206435736;3482.703970162514;3626.582942961567;3629.3104310181243;4078.9796051019853;33109.6689033109;33125;33454.498182527284;35035.64964350349;35064;4292.871213863589;4406.22890994078;4445.462193658884;4609.562091601292;4642.094791515656;391301;392444;392979.0351048255;393165.5125865543;393910;60959.6952015246;61407.38592614017;61611.6919415409;61630;61716.382836171964;64184.35815641877;64244.357556423834;64291.67854160793;64459.35540644627;64529;17155.142242887807;17648.823511764716;17651.73522397165;18493.352732654563;18554.165062572218;12435.37823108859;12458.81311780324;12470.501179952882;12476.875231247754;12577.434015469325;19334.733754780897;19376.806231937782;19405;19409.320673776634;19447.932850527035;7200.927990720026;7377.668004939791;7443.776686699408;7490.475666703387;7525.6989720410575;956.4978386347224;1034.9689509314733;1049.7165765243494;1061.5223149582719;1167.8131498960126;33867.66132338694;34005.659943400744;34342.31315373679;34344;34457.31085378279;1108.539955918301;1138.8804175561613;1225.4546726706708;1247.7442124364484;1293.3080801771007;16359.427420040241;17903.46289611314;18392.448226553224;18597.16312765929;19527.804721952598;536105;538729;540907;541335;542642;61523.769524609255;61652;61767;61877;61965.380346196864;1367.2890097149427;1393.811835402228;1407.4933024111313;1417.3267697843442;1425.465450456079;32277;33834.323313534085;34576.48135277923;34618.48072278968;34707.917524948585;51948.480515194366;52315.73842130765;52727.73636131795;52842.47157528376;52878.73560632172;475114;475619.30378006975;475950;476332;476784;28635.99322071236;29098.418031638827;29133.271668208465;29138.483535052103;29141.85429072841;47044.52955470538;47448.2882756752;47543.524564755295;48251.517484824704;48501.5149848497;41021.58978410178;41743;42150.578494214664;42406.78796605997;43807.78096109499;39617;40935.38596920989;41956.58043419527;42084.36873446839;42560.36159457549;35636.64363356437;39133.21733565256;40687;40847.1830563393;42743.786281068395;33350;37122.8143859279;37717.62282377141;37822.243555128196;38036.619633803304;28423;28638;28681.36129089994;28689.426211475235;28719.71280287254 09:27:57 INFO - PROCESS | 2288 | |2;jquery.html;375.86468871206375;385.64327996603134;400.2934820042625;400.7475290566943;418.6362576696246;18779.154938027787;19958.50103747407;20305.898470507644;20367.18531258748;20813;19421.834689918578;19505.90504940448;19528.31650892219;19711.211551537956;19763.505912352164;5669.8582535436635;5672.68800215988;5817.243758311413;5830.650160990333;5894.322152952401;5774;5801.709914504279;5839.065749480084;5845.0647896336595;5851.356350801409;5628.0713682242385;5810.389909059551;5838.883222335551;5864.237649105632;5874.206982057411;5734.767025089611;5788.218590490272;5808.941910580882;5854.18041474194;5854.238948936632;5137.948620513785;5181.35233095863;5186.974065129651;5200.895982080375;5206.323177986876;24171.274861754177;24301.756982430124;24401;24430.26709198727;24633.261002169962;2466.8889899954365;2522.369407648088;2780.7219278072234;3126.04655580048;3229.9677003230136;14710.63223419423;14812.851871481364;15166.31751571182;15407.460738874086;15961.12213828239;1910.3791267838008;1977.149825575002;1996.2414282572674;2027.2803154879953;2051.21028404064;83203.7519437209;83578;84672;85652;87417.68873466966;9719.65981190655;9856.359336643096;10030.799384012278;10049.698509044594;10220.795584088277;13426.530071447452;13451.798223026663;13452.5291614793;13477.865221347856;13528.053036287365;7799.45403821727;8112.959435202904;8176.405600907885;8180.719070836905;8312.792180195544;8101.878471822927;8210.58947052657;8341.290990265774;8396.328293736486;8432.789180270542;6212.9068063979075;6305.653189074553;6312.212672396618;6394.680265986682;6454.48275172683;1827.8446332061924;1845.603195313014;1855.2282570145478;1872.9719054214197;1876.1463534091956;977.2475194100645;1017.9898201018043;1036.409246729357;1070.8982646648556;1078.962236321725;20211.191552337743;20898.37304880856;21137.471563210736;21162.97742840446;21176.364709058755;1009.9545520451597;1058.82529382651;1059.279689810936;1082.3235477826358;1109.5118148014847;11105.167112466597;11815.113866459878;11816.113791465674;11860.94069529664;11950.103742219368;426853;435809;450457;456124;481661;85249.57375213085;89499.55250223707;99128;101950.49024754977;102401.48799255956;1010.8786945566579;1016.7305663998899;1037.911777498921;1061.4268295120703;1062.4740753327153;18442.354517592357;18773;19188.712169317194;19374.321898733477;19443.4166974991;44340.778296108314;44940.325895112255;45195.774021129684;45806;45919.31121033254;59059.40940590539;61302.693486532284;62169.689151553954;62421.37578624337;64008.3599164021;8601;8702.695405661025;8716.302695784449;8789.780255493408;9174.587143578421;11356.886431135583;12945.158564693265;13228.206307621573;13229.933850330686;13238.933805331297;10701.250912436055;11238.494267758135;11608.767824643628;11810.527578896748;12210.87789122133;7433.516821406592;7743.264389882952;11515.19393642437;11705;12174.147809653594;11954.103442241692;12166.513339466323;12279.69300767488;12310.569130080405;12343.13598048128;8825.867611985954;8994.59524321394;9078;9143.542822858963;9278.304127190622;11692.94153529227;11868.940655296668;12102.697432564257;12137.514499419924;12481.193236062725 09:27:57 INFO - PROCESS | 2288 | |3;mootools.html;1472.8379878213395;1519.6884638649074;1646.8847180697348;1744.5028166972415;1756.9560760980974;8093.109757926638;8695.56522173891;9023.428322927966;9566.712998610035;9585.089416505438;9007.864882026759;9349.345545811795;9409.153176214139;9448.66929657462;9476.857847132282;2358.882055897207;2388.534235824015;2392;2393.126508824284;2396.089485995319;2306.1121468234683;2381.5117900830373;2413.3845869303304;2423.018677435641;2424.987875060622;2391.1272385579314;2407.939801504968;2424.7575242475787;2435.8294919355562;2450.424150324672;2379.845310054841;2381.630847218675;2387.248016874679;2401.327628264089;2407;2319.257837492003;2362.8109751219863;2363.988180059089;2372.6559648850994;2377.8335516513853;9308.394954328014;9408.43549387039;9445.574949127305;9452.19656329213;9484.90515094847;5413;5502.669839809624;5567.359753628303;5572.024895643287;5612.326520817487;3563.1804684922354;3599.2441587266703;3603.94594081089;3630.1287690954246;3655.9086022849374;1106.397013627575;1120.467777805544;1171.7187874910046;1172.6657902497748;2200.1859312054644;12608.873911260862;13204.075714699975;13321.467141314335;13402.329883505883;13415.329233538381;4652.767361631905;4670.579647831643;4715.717056976524;4798.376211092605;4809.206480930678;10190.898091019144;10243.94878025605;10254.58981640726;10293.691189264335;10297.9485102574;5493.093639549509;5534.225208470817;5537.473939975695;5546.639468434539;5567.66594004361;4374.693771435969;5004.9499505005215;5072.163093089599;5085.084684756779;5183.896322073538;3849.615038496128;3980.124372638015;3997.320455522568;4004.9199016019516;4071.959280407217;1204.7289359893953;1221.5785553983862;1227.5458080510268;1240.8076748104058;1244.6452760963082;985.2364417576292;1001.1290177545582;1021.1779517488493;1022.7903279827617;1034.1261633919326;6253.249610046823;6313.589616674902;6343.492520598341;6343.714532846033;6560.639164845979;429.43100391980124;434.8564973558718;445.2253079641401;450.5764581293574;453.2770231480783;4456.554344565582;4467.888302792391;4469.240229161051;4481.596656300949;4561.566651168134;11017;11391.601293954673;11665.59170429031;11772.88227117735;11859.34773587461;11229;11718.70703232409;11739.765204696028;11765.176437649454;11766.117541184445;8098.838023239502;8219.424640275123;8235.341172706168;8276.627551760184;8319.126491718403;6125.816225513242;6425.261094973951;6478.060681201294;6479.676016199265;6609.636469994197;10410.843837342294;10936.453177340942;10987.450627468435;11038.724031898946;11061.336319820837;11102.056325212447;11125.109991200523;11198.496067676811;11229;11237.494312755782;7414.258574142543;8009.839803203787;8172.632231549714;8179.386546009192;8408.83182336362;9234.399764015317;9268.58291376903;9283.210927071004;9343.392679475812;9371.062893710574;7953.13810874523;8087.3125784308995;8180.509169449852;8209.835803283782;8274.13121622221;8021.197880212166;8137.877931831145;8197.959010204911;8198.262156405952;8365.498070115813;7207.5675459472595;7364.852702946018;7471.40228781707;7481.588512631857;7487.588182650006;5640.210370548045;5644.153376993319;5656.830295091154;5797.565182611237;5822.796202132905;5490.478404551562;5532.751026203911;5579.944200557942;5603.691796951207;5618.915716264341 09:27:57 INFO - PROCESS | 2288 | |4;prototype.html;338.1411215512598;342.8268724294231;344.3612099555325;348.8848679935621;350.3605919197465;5542.695151766657;5626.268585083933;5633.718314084294;5635.633683810554;5690.4025077366905;5489.58828087894;5525.336959564847;5534.363548191959;5570.721463926798;5579.218909352694;4126.2160189563965;4180.456540649711;4250.744955302676;4285.635720963722;4285.764282964436;4242.830286788525;4304;4310.267254566716;4317.301686445971;4376.737395756249;4331.805068771912;4335;4356.803943822536;4357.324614684729;4362.847300344489;4074.2055299216663;4252.298370768819;4261.722988005769;4290.871273861789;4368.279233926414;3759.172981943968;3764.6235376462137;3772.3401703250483;3780.319542482352;3784.243151369737;5364.22218778275;5395.352557693062;5434.212039254326;5466.961277357329;5481.232627432163;4792.9281060784115;4840.0053888719685;4849.903001939977;4875.196177414344;4950.405951285833;5691.658500489983;5694.658320500783;5705.1727499512335;5718.285214348207;5726.656400615935;4079.714419990602;4089.26393249215;4098;4108.26051310764;4120.237756015147;5929.733162007677;5939.940600594025;5952.523798096142;5957.880842383128;5996.740684456269;4189.2668782962855;4218.303979843353;4224.936625950613;4227.598378154071;4239.618434340924;4256.659467242675;4260.25445547028;4277;4281.272183728774;4291.334843099325;4683.578477937002;4869.318295438641;4898.436679781799;4911.16510193268;4931.50684931504;5779.3642699303045;5789.102689083199;5790.88418231633;5792.466595376817;5803.303603567599;1445.1401416157369;1449.8332691740584;1466.8093147890706;1467.3763650448516;1481.8369979302267;894.1238415148372;937.5359197197295;951.9480973524295;952.8380175370204;994.6469003503797;5540.891821635689;5551.2228288039705;5572.108462645957;5628.127640215773;5645.576581756302;5900.079460666997;5980.671063091485;5981.491573216325;5987;6015.699215039231;5402.837914862561;5507.449255074461;5554.91667624986;5563.221149039137;5679.119736440858;3061.479548476764;3123.3440977395003;3143.402753476832;3148.544135574256;3163.604549431321;5974.641521508724;6105.236845394325;6113.724882380304;6122.234720659918;6130.908036379368;5952.970235148797;5960.821175364746;5964;6001.969990150022;6009.819705408845;6062.151298818169;6065.484433823086;6073.815605956796;6075.878482430238;6083.726232319645;5663.2071509989455;5881.206037184926;5885.470307672159;5892.852678682896;5914.526837852875;5812.948202193882;5833.833233353431;5835.708214589169;5835.824925252249;5872.003518803627;5886.764529418775;5969.492593129459;6095.603785753912;6125.264968203844;6146.723397447215;4200.873973780792;4206.705530612828;4229.809658565434;4246.723962942398;4248.893777655583;5897.970510147422;5913.58604897653;5918.496927761188;5956.404359564009;6000.849978750566;5465.966388654335;5687.630304030225;5714.485696287354;5729.455701708331;5790.768369265351;5737.168110624019;5755.194272801895;5758.539316854725;5766.462756387176;5767.826965191051;5474.616776825744;5528.502434780889;5646.745896434588;5680.017990554992;5681.602287839812;5734.3978882218435;5813.970930145322;5822.534197264124;5837.474627283565;5859.2382990211;5674.092145256905;5695.629784064023;5696.120280307571;5701.201831743642;5715.428457154418 09:27:57 INFO - PROCESS | 2288 | |5;yui.html;763.496092578898;797.8843067755175;819.6680344460495;849.5200211880291;877.254333816256;15260.847391526082;16522;16576.58558536037;16577.75133372999;16621.168941552904;15754.369825206977;15920.283587238573;15941.043537387764;15947.601309967256;15951.202439877989;655.311922481395;785.4541093939714;794.8370584030274;805.267206841774;811.7077851973285;804.6781287484994;809.0776514773163;809.3889113719164;809.5142914251431;809.6518497046268;862.6851199312268;865.2558799432514;866.6836604639325;869.6738722978882;870.6734974384606;861.9008813986378;862.0431321233426;864.5115509736978;868.1492137705021;868.448535180162;635.3265538529174;635.4249404289126;635.4693830651412;635.6789821140295;635.7838334966087;15427.30577124032;15509.146996915166;15531.223438828014;15532.145731984736;15533.068015919082;14900.329485173193;15039.097654140787;15972.361105555763;16272.75590866138;16287;12547.058970577244;12621.873781262253;12660.746785064339;12719.809202861965;12924.741505169937;3755.9248815023548;3784.072902138966;3839.731218814684;3989.7207195496326;3993.4209539616595;76002.23997760007;79630;81062.59468702618;81705;82006;10706.571737130584;11207.327560346404;11225.326480411202;11482.540698372139;11488.655340339803;20266.189352426034;21259.574808503745;21531.138754449647;21676;21680.457988550097;8772.692955746517;8875.435718168274;8947.776305592412;9068.501232432147;9187.310951678652;5110.259012443249;5170.40540337866;5203.973980130151;5228.686278823283;5230.3985041719925;3504.842282097312;3688.741788074809;3691.3724666806706;3694.519712437366;3699.648533389324;598.0968737206762;606.9423404776539;614.9046897730859;623.3236937922405;632.5698525003043;689.7758228575733;696.3976160621128;722.6964674836581;755.8563872864248;775.5230533222028;10353.534090965924;10455.947720261502;10461.9476902615;10575.735606609896;10842.783144337069;583.6760597868139;654.5254690349459;673.0409166937095;737.985240295191;754.3429236983642;4917.729524876167;5071.644984851025;5126.179811230185;5185.559227465632;5200.271961925334;65404.67297663577;65670.67164664241;95231;99303;99752;97935;98372.50813746029;98986;101106.4944675272;102414.48792755988;84199;84408;86289.56855215684;87833;88568.5571572138;10384.636537721144;10427.582896684047;10513.632022879163;10673.252872298865;10720.73198170052;52311.47688523066;52353.47646523486;52809.735951321534;53059.73470132625;53570.73214633902;68624;77778.2222177771;77961;80462.19537804546;81424;13265.867341326462;13300.46798128064;13326.666833329244;13794.65513362174;13901;14925.402983880524;15307.311170997555;15696.92151539235;15766.527004189893;15918.9204053979;14170.291485425894;14458.710825783215;14545.418183272974;14653.413863445343;14758.650784992293;14154.363053662404;14287;14618.80015132521;14777.261136943325;15234.542963711106;13712;14323.856761432253;14354.49759258421;14710.55868323952;14906.627334316729;11484.483198255932;12147.817782733442;12217.877821221675;12238.694032649255;12624.87375126237;10636.946815265874;10911.290766100496;11068.833967490655;11946.226096625962;12295.262284262973 09:27:57 INFO - PROCESS | 2288 | __end_tp_report 09:27:57 INFO - PROCESS | 2288 | __start_cc_report 09:27:57 INFO - PROCESS | 2288 | _x_x_mozilla_cycle_collect,331 09:27:57 INFO - PROCESS | 2288 | __end_cc_report 09:27:57 INFO - PROCESS | 2288 | __startTimestamp1471537677083__endTimestamp 09:27:57 INFO - PROCESS | 2288 | 09:27:57 INFO - PROCESS | 2288 | ------- Summary: start ------- 09:27:57 INFO - PROCESS | 2288 | Number of tests: 6 09:27:57 INFO - PROCESS | 2288 | 09:27:57 INFO - PROCESS | 2288 | [#0] dojo.html Cycles:165 Average:5437.24 Median:5673.00 stddev:749.38 (13.2%) stddev-sans-first:728.46 09:27:57 INFO - PROCESS | 2288 | Values: 3078.2 3099.4 3112.5 3117.7 3121.0 5371.9 5425.8 5508.3 5522.4 5526.2 5456.3 5495.1 5562.3 5566.0 5570.5 4935.5 4967.8 4967.8 4988.4 5025.9 5014.9 5047.1 5077.3 5114.4 5120.3 244.5 4921.7 5077.9 5121.4 5148.9 5055.2 5064.1 5068.8 5096.9 5117.6 5016.2 5018.5 5020.8 5026.4 5074.2 5356.7 5393.4 5454.4 5459.2 5511.7 5774.9 5859.5 5879.0 5906.4 5910.4 5875.0 5907.8 5920.9 5923.9 5926.2 5283.3 5419.8 5458.8 5461.9 5468.0 5988.3 6065.5 6068.8 6108.7 6120.1 5786.5 5793.8 5803.8 5804.6 5809.2 5644.9 5746.2 5850.2 5867.7 5870.0 5717.5 5831.6 5834.8 5859.0 5880.5 5767.7 5841.7 5846.3 5864.1 5875.3 4285.3 4419.4 4467.5 4474.2 4515.1 3958.4 3987.8 3991.8 4022.6 4030.4 5626.2 5667.1 5672.6 5672.9 5678.1 5718.4 5808.0 5843.2 5933.7 5933.9 5611.2 5617.6 5618.6 5651.1 5672.7 5075.6 5081.5 5081.6 5099.1 5124.7 5976.8 6017.0 6077.5 6109.5 6116.3 5899.1 5912.2 5926.7 5954.5 5960.6 6125.3 6133.6 6137.1 6140.6 6146.7 5610.7 5741.5 5790.8 5801.7 5848.2 5914.2 5924.1 5935.5 5988.2 5993.5 5777.4 5809.6 5819.0 5826.1 5837.3 5525.4 5655.5 5734.9 5798.8 5805.9 5703.4 5704.5 5708.2 5727.3 5743.3 5725.3 5742.1 5784.6 5802.8 5806.7 5453.2 5559.6 5613.1 5621.5 5673.0 09:27:57 INFO - PROCESS | 2288 | 09:27:57 INFO - PROCESS | 2288 | [#1] ext.html Cycles:180 Average:63311.34 Median:42740.18 stddev:125485.43 (293.6%) stddev-sans-first:125748.96 09:27:57 INFO - PROCESS | 2288 | Values: 544.8 591.5 601.7 603.2 625.5 39284.6 44306.0 44313.3 44351.3 44369.0 43626.8 43854.0 43867.6 44006.8 44393.1 8832.5 8965.4 8996.4 9009.5 9024.0 8885.3 8948.6 8963.0 8978.0 8989.6 8990.8 9053.0 9078.1 9083.5 9095.9 8920.2 8929.6 8990.0 9007.4 9009.8 8841.4 8871.8 8919.5 8935.1 8936.2 42485.0 42557.8 42736.6 42863.8 42966.6 3475.3 3482.7 3626.6 3629.3 4079.0 33109.7 33125.0 33454.5 35035.6 35064.0 4292.9 4406.2 4445.5 4609.6 4642.1 391301.0 392444.0 392979.0 393165.5 393910.0 60959.7 61407.4 61611.7 61630.0 61716.4 64184.4 64244.4 64291.7 64459.4 64529.0 17155.1 17648.8 17651.7 18493.4 18554.2 12435.4 12458.8 12470.5 12476.9 12577.4 19334.7 19376.8 19405.0 19409.3 19447.9 7200.9 7377.7 7443.8 7490.5 7525.7 956.5 1035.0 1049.7 1061.5 1167.8 33867.7 34005.7 34342.3 34344.0 34457.3 1108.5 1138.9 1225.5 1247.7 1293.3 16359.4 17903.5 18392.4 18597.2 19527.8 536105.0 538729.0 540907.0 541335.0 542642.0 61523.8 61652.0 61767.0 61877.0 61965.4 1367.3 1393.8 1407.5 1417.3 1425.5 32277.0 33834.3 34576.5 34618.5 34707.9 51948.5 52315.7 52727.7 52842.5 52878.7 475114.0 475619.3 475950.0 476332.0 476784.0 28636.0 29098.4 29133.3 29138.5 29141.9 47044.5 47448.3 47543.5 48251.5 48501.5 41021.6 41743.0 42150.6 42406.8 43807.8 39617.0 40935.4 41956.6 42084.4 42560.4 35636.6 39133.2 40687.0 40847.2 42743.8 33350.0 37122.8 37717.6 37822.2 38036.6 28423.0 28638.0 28681.4 28689.4 28719.7 09:27:57 INFO - PROCESS | 2288 | 09:27:57 INFO - PROCESS | 2288 | [#2] jquery.html Cycles:180 Average:28611.51 Median:24531.76 stddev:74718.85 (304.6%) stddev-sans-first:74898.38 09:27:57 INFO - PROCESS | 2288 | Values: 375.9 385.6 400.3 400.7 418.6 18779.2 19958.5 20305.9 20367.2 20813.0 19421.8 19505.9 19528.3 19711.2 19763.5 5669.9 5672.7 5817.2 5830.7 5894.3 5774.0 5801.7 5839.1 5845.1 5851.4 5628.1 5810.4 5838.9 5864.2 5874.2 5734.8 5788.2 5808.9 5854.2 5854.2 5137.9 5181.4 5187.0 5200.9 5206.3 24171.3 24301.8 24401.0 24430.3 24633.3 2466.9 2522.4 2780.7 3126.0 3230.0 14710.6 14812.9 15166.3 15407.5 15961.1 1910.4 1977.1 1996.2 2027.3 2051.2 83203.8 83578.0 84672.0 85652.0 87417.7 9719.7 9856.4 10030.8 10049.7 10220.8 13426.5 13451.8 13452.5 13477.9 13528.1 7799.5 8113.0 8176.4 8180.7 8312.8 8101.9 8210.6 8341.3 8396.3 8432.8 6212.9 6305.7 6312.2 6394.7 6454.5 1827.8 1845.6 1855.2 1873.0 1876.1 977.2 1018.0 1036.4 1070.9 1079.0 20211.2 20898.4 21137.5 21163.0 21176.4 1010.0 1058.8 1059.3 1082.3 1109.5 11105.2 11815.1 11816.1 11860.9 11950.1 426853.0 435809.0 450457.0 456124.0 481661.0 85249.6 89499.6 99128.0 101950.5 102401.5 1010.9 1016.7 1037.9 1061.4 1062.5 18442.4 18773.0 19188.7 19374.3 19443.4 44340.8 44940.3 45195.8 45806.0 45919.3 59059.4 61302.7 62169.7 62421.4 64008.4 8601.0 8702.7 8716.3 8789.8 9174.6 11356.9 12945.2 13228.2 13229.9 13238.9 10701.3 11238.5 11608.8 11810.5 12210.9 7433.5 7743.3 11515.2 11705.0 12174.1 11954.1 12166.5 12279.7 12310.6 12343.1 8825.9 8994.6 9078.0 9143.5 9278.3 11692.9 11868.9 12102.7 12137.5 12481.2 09:27:57 INFO - PROCESS | 2288 | 09:27:57 INFO - PROCESS | 2288 | [#3] mootools.html Cycles:180 Average:6117.85 Median:4475.42 stddev:3533.81 (79.0%) stddev-sans-first:3526.49 09:27:57 INFO - PROCESS | 2288 | Values: 1472.8 1519.7 1646.9 1744.5 1757.0 8093.1 8695.6 9023.4 9566.7 9585.1 9007.9 9349.3 9409.2 9448.7 9476.9 2358.9 2388.5 2392.0 2393.1 2396.1 2306.1 2381.5 2413.4 2423.0 2425.0 2391.1 2407.9 2424.8 2435.8 2450.4 2379.8 2381.6 2387.2 2401.3 2407.0 2319.3 2362.8 2364.0 2372.7 2377.8 9308.4 9408.4 9445.6 9452.2 9484.9 5413.0 5502.7 5567.4 5572.0 5612.3 3563.2 3599.2 3603.9 3630.1 3655.9 1106.4 1120.5 1171.7 1172.7 2200.2 12608.9 13204.1 13321.5 13402.3 13415.3 4652.8 4670.6 4715.7 4798.4 4809.2 10190.9 10243.9 10254.6 10293.7 10297.9 5493.1 5534.2 5537.5 5546.6 5567.7 4374.7 5004.9 5072.2 5085.1 5183.9 3849.6 3980.1 3997.3 4004.9 4072.0 1204.7 1221.6 1227.5 1240.8 1244.6 985.2 1001.1 1021.2 1022.8 1034.1 6253.2 6313.6 6343.5 6343.7 6560.6 429.4 434.9 445.2 450.6 453.3 4456.6 4467.9 4469.2 4481.6 4561.6 11017.0 11391.6 11665.6 11772.9 11859.3 11229.0 11718.7 11739.8 11765.2 11766.1 8098.8 8219.4 8235.3 8276.6 8319.1 6125.8 6425.3 6478.1 6479.7 6609.6 10410.8 10936.5 10987.5 11038.7 11061.3 11102.1 11125.1 11198.5 11229.0 11237.5 7414.3 8009.8 8172.6 8179.4 8408.8 9234.4 9268.6 9283.2 9343.4 9371.1 7953.1 8087.3 8180.5 8209.8 8274.1 8021.2 8137.9 8198.0 8198.3 8365.5 7207.6 7364.9 7471.4 7481.6 7487.6 5640.2 5644.2 5656.8 5797.6 5822.8 5490.5 5532.8 5579.9 5603.7 5618.9 09:27:57 INFO - PROCESS | 2288 | 09:27:57 INFO - PROCESS | 2288 | [#4] prototype.html Cycles:180 Average:4856.42 Median:5602.74 stddev:1431.35 (25.5%) stddev-sans-first:1394.61 09:27:57 INFO - PROCESS | 2288 | Values: 338.1 342.8 344.4 348.9 350.4 5542.7 5626.3 5633.7 5635.6 5690.4 5489.6 5525.3 5534.4 5570.7 5579.2 4126.2 4180.5 4250.7 4285.6 4285.8 4242.8 4304.0 4310.3 4317.3 4376.7 4331.8 4335.0 4356.8 4357.3 4362.8 4074.2 4252.3 4261.7 4290.9 4368.3 3759.2 3764.6 3772.3 3780.3 3784.2 5364.2 5395.4 5434.2 5467.0 5481.2 4792.9 4840.0 4849.9 4875.2 4950.4 5691.7 5694.7 5705.2 5718.3 5726.7 4079.7 4089.3 4098.0 4108.3 4120.2 5929.7 5939.9 5952.5 5957.9 5996.7 4189.3 4218.3 4224.9 4227.6 4239.6 4256.7 4260.3 4277.0 4281.3 4291.3 4683.6 4869.3 4898.4 4911.2 4931.5 5779.4 5789.1 5790.9 5792.5 5803.3 1445.1 1449.8 1466.8 1467.4 1481.8 894.1 937.5 951.9 952.8 994.6 5540.9 5551.2 5572.1 5628.1 5645.6 5900.1 5980.7 5981.5 5987.0 6015.7 5402.8 5507.4 5554.9 5563.2 5679.1 3061.5 3123.3 3143.4 3148.5 3163.6 5974.6 6105.2 6113.7 6122.2 6130.9 5953.0 5960.8 5964.0 6002.0 6009.8 6062.2 6065.5 6073.8 6075.9 6083.7 5663.2 5881.2 5885.5 5892.9 5914.5 5812.9 5833.8 5835.7 5835.8 5872.0 5886.8 5969.5 6095.6 6125.3 6146.7 4200.9 4206.7 4229.8 4246.7 4248.9 5898.0 5913.6 5918.5 5956.4 6000.8 5466.0 5687.6 5714.5 5729.5 5790.8 5737.2 5755.2 5758.5 5766.5 5767.8 5474.6 5528.5 5646.7 5680.0 5681.6 5734.4 5814.0 5822.5 5837.5 5859.2 5674.1 5695.6 5696.1 5701.2 5715.4 09:27:57 INFO - PROCESS | 2288 | 09:27:57 INFO - PROCESS | 2288 | [#5] yui.html Cycles:180 Average:20572.56 Median:3991.57 stddev:28127.27 (704.7%) stddev-sans-first:28166.84 09:27:57 INFO - PROCESS | 2288 | Values: 763.5 797.9 819.7 849.5 877.3 15260.8 16522.0 16576.6 16577.8 16621.2 15754.4 15920.3 15941.0 15947.6 15951.2 655.3 785.5 794.8 805.3 811.7 804.7 809.1 809.4 809.5 809.7 862.7 865.3 866.7 869.7 870.7 861.9 862.0 864.5 868.1 868.4 635.3 635.4 635.5 635.7 635.8 15427.3 15509.1 15531.2 15532.1 15533.1 14900.3 15039.1 15972.4 16272.8 16287.0 12547.1 12621.9 12660.7 12719.8 12924.7 3755.9 3784.1 3839.7 3989.7 3993.4 76002.2 79630.0 81062.6 81705.0 82006.0 10706.6 11207.3 11225.3 11482.5 11488.7 20266.2 21259.6 21531.1 21676.0 21680.5 8772.7 8875.4 8947.8 9068.5 9187.3 5110.3 5170.4 5204.0 5228.7 5230.4 3504.8 3688.7 3691.4 3694.5 3699.6 598.1 606.9 614.9 623.3 632.6 689.8 696.4 722.7 755.9 775.5 10353.5 10455.9 10461.9 10575.7 10842.8 583.7 654.5 673.0 738.0 754.3 4917.7 5071.6 5126.2 5185.6 5200.3 65404.7 65670.7 95231.0 99303.0 99752.0 97935.0 98372.5 98986.0 101106.5 102414.5 84199.0 84408.0 86289.6 87833.0 88568.6 10384.6 10427.6 10513.6 10673.3 10720.7 52311.5 52353.5 52809.7 53059.7 53570.7 68624.0 77778.2 77961.0 80462.2 81424.0 13265.9 13300.5 13326.7 13794.7 13901.0 14925.4 15307.3 15696.9 15766.5 15918.9 14170.3 14458.7 14545.4 14653.4 14758.7 14154.4 14287.0 14618.8 14777.3 15234.5 13712.0 14323.9 14354.5 14710.6 14906.6 11484.5 12147.8 12217.9 12238.7 12624.9 10636.9 10911.3 11068.8 11946.2 12295.3 09:27:57 INFO - PROCESS | 2288 | -------- Summary: end -------- 09:27:57 INFO - PROCESS | 2288 | 09:27:57 INFO - TEST-INFO | 2288: exit 0 09:27:57 INFO - TEST-OK | dromaeo_css | took 1112837ms 09:27:57 INFO - TEST-START | kraken 09:27:57 INFO - operating with platform_type : linux_ 09:27:57 INFO - Initialising browser for kraken test... 09:27:57 INFO - TEST-INFO | started process 2812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyMkYT7/profile http://localhost:42536/getInfo.html) 09:28:02 INFO - PROCESS | 2812 | __metrics Screen width/height:1600/1200 09:28:02 INFO - PROCESS | 2812 | colorDepth:24 09:28:02 INFO - PROCESS | 2812 | Browser inner width/height: 1024/697 09:28:02 INFO - PROCESS | 2812 | __metrics 09:28:03 ERROR - PROCESS | 2812 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 09:28:03 INFO - TEST-INFO | 2812: exit 0 09:28:03 INFO - Browser initialized. 09:28:03 INFO - Running cycle 1/1 for kraken test... 09:28:03 INFO - TEST-INFO | started process 2962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyMkYT7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:15 INFO - PROCESS | 2962 | RSS: Main: 162906112 09:28:15 INFO - PROCESS | 2962 | 09:28:18 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42536/tests/kraken/driver.html?testName=audio-beat-detection) 09:28:19 INFO - PROCESS | 2962 | RSS: Main: 168620032 09:28:19 INFO - PROCESS | 2962 | 09:28:21 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42536/tests/kraken/driver.html?testName=audio-dft) 09:28:22 INFO - PROCESS | 2962 | RSS: Main: 167669760 09:28:22 INFO - PROCESS | 2962 | 09:28:25 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42536/tests/kraken/driver.html?testName=audio-fft) 09:28:26 INFO - PROCESS | 2962 | RSS: Main: 163553280 09:28:26 INFO - PROCESS | 2962 | 09:28:28 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42536/tests/kraken/driver.html?testName=audio-oscillator) 09:28:28 INFO - PROCESS | 2962 | RSS: Main: 164454400 09:28:28 INFO - PROCESS | 2962 | 09:28:30 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42536/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:28:31 INFO - PROCESS | 2962 | RSS: Main: 164102144 09:28:31 INFO - PROCESS | 2962 | 09:28:34 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42536/tests/kraken/driver.html?testName=imaging-darkroom) 09:28:35 INFO - PROCESS | 2962 | RSS: Main: 164696064 09:28:35 INFO - PROCESS | 2962 | 09:28:38 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42536/tests/kraken/driver.html?testName=imaging-desaturate) 09:28:39 INFO - PROCESS | 2962 | RSS: Main: 164741120 09:28:39 INFO - PROCESS | 2962 | 09:28:42 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42536/tests/kraken/driver.html?testName=json-parse-financial) 09:28:42 INFO - PROCESS | 2962 | RSS: Main: 164605952 09:28:42 INFO - PROCESS | 2962 | 09:28:44 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42536/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:28:45 INFO - PROCESS | 2962 | RSS: Main: 164642816 09:28:45 INFO - PROCESS | 2962 | 09:28:46 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:28:47 INFO - PROCESS | 2962 | RSS: Main: 164970496 09:28:47 INFO - PROCESS | 2962 | 09:28:49 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:28:50 INFO - PROCESS | 2962 | RSS: Main: 165253120 09:28:50 INFO - PROCESS | 2962 | 09:28:52 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:28:53 INFO - PROCESS | 2962 | RSS: Main: 165351424 09:28:53 INFO - PROCESS | 2962 | 09:28:56 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:28:56 INFO - PROCESS | 2962 | RSS: Main: 166117376 09:28:56 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | Cycle 1(1): loaded http://localhost:42536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42536/tests/kraken/driver.html?testName=ai-astar) 09:28:58 INFO - PROCESS | 2962 | RSS: Main: 166285312 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | __start_tp_report 09:28:58 INFO - PROCESS | 2962 | _x_x_mozilla_page_load 09:28:58 INFO - PROCESS | 2962 | _x_x_mozilla_page_load_details 09:28:58 INFO - PROCESS | 2962 | |i|pagename|runs| 09:28:58 INFO - PROCESS | 2962 | |0;ai-astar;103;112;110;112;112;112;117;110;111;111 09:28:58 INFO - PROCESS | 2962 | |1;audio-beat-detection;156;119;153;186;124;143;144;120;186;118 09:28:58 INFO - PROCESS | 2962 | |2;audio-dft;162;164;163;162;164;174;162;162;162;163 09:28:58 INFO - PROCESS | 2962 | |3;audio-fft;75;76;77;176;76;76;76;75;164;77 09:28:58 INFO - PROCESS | 2962 | |4;audio-oscillator;85;85;159;86;85;89;137;86;85;146 09:28:58 INFO - PROCESS | 2962 | |5;imaging-gaussian-blur;118;118;117;118;118;118;117;117;117;117 09:28:58 INFO - PROCESS | 2962 | |6;imaging-darkroom;146;147;148;147;149;148;148;147;147;147 09:28:58 INFO - PROCESS | 2962 | |7;imaging-desaturate;96;98;96;96;96;96;97;96;96;96 09:28:58 INFO - PROCESS | 2962 | |8;json-parse-financial;50;49;55;56;51;59;51;52;52;59 09:28:58 INFO - PROCESS | 2962 | |9;json-stringify-tinderbox;62;62;62;62;62;63;62;63;62;63 09:28:58 INFO - PROCESS | 2962 | |10;stanford-crypto-aes;95;84;81;80;80;84;84;81;90;79 09:28:58 INFO - PROCESS | 2962 | |11;stanford-crypto-ccm;128;137;134;124;125;131;133;126;145;127 09:28:58 INFO - PROCESS | 2962 | |12;stanford-crypto-pbkdf2;171;167;161;162;163;166;167;171;172;171 09:28:58 INFO - PROCESS | 2962 | |13;stanford-crypto-sha256-iterative;67;66;67;67;66;66;68;65;65;65 09:28:58 INFO - PROCESS | 2962 | __end_tp_report 09:28:58 INFO - PROCESS | 2962 | __start_cc_report 09:28:58 INFO - PROCESS | 2962 | _x_x_mozilla_cycle_collect,852 09:28:58 INFO - PROCESS | 2962 | __end_cc_report 09:28:58 INFO - PROCESS | 2962 | __startTimestamp1471537738951__endTimestamp 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | ------- Summary: start ------- 09:28:58 INFO - PROCESS | 2962 | Number of tests: 14 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:3.43 (3.1%) stddev-sans-first:2.09 09:28:58 INFO - PROCESS | 2962 | Values: 103.0 112.0 110.0 112.0 112.0 112.0 117.0 110.0 111.0 111.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:148.50 stddev:25.87 (17.4%) stddev-sans-first:27.12 09:28:58 INFO - PROCESS | 2962 | Values: 156.0 119.0 153.0 186.0 124.0 143.0 144.0 120.0 186.0 118.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:3.68 (2.3%) stddev-sans-first:3.84 09:28:58 INFO - PROCESS | 2962 | Values: 162.0 164.0 163.0 162.0 164.0 174.0 162.0 162.0 162.0 163.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:39.74 (52.3%) stddev-sans-first:41.50 09:28:58 INFO - PROCESS | 2962 | Values: 75.0 76.0 77.0 176.0 76.0 76.0 76.0 75.0 164.0 77.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:85.00 stddev:30.17 (35.5%) stddev-sans-first:31.19 09:28:58 INFO - PROCESS | 2962 | Values: 85.0 85.0 159.0 86.0 85.0 89.0 137.0 86.0 85.0 146.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:28:58 INFO - PROCESS | 2962 | Values: 118.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 09:28:58 INFO - PROCESS | 2962 | Values: 146.0 147.0 148.0 147.0 149.0 148.0 148.0 147.0 147.0 147.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:28:58 INFO - PROCESS | 2962 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:3.63 (6.8%) stddev-sans-first:3.63 09:28:58 INFO - PROCESS | 2962 | Values: 50.0 49.0 55.0 56.0 51.0 59.0 51.0 52.0 52.0 59.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 09:28:58 INFO - PROCESS | 2962 | Values: 62.0 62.0 62.0 62.0 62.0 63.0 62.0 63.0 62.0 63.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:5.07 (6.0%) stddev-sans-first:3.40 09:28:58 INFO - PROCESS | 2962 | Values: 95.0 84.0 81.0 80.0 80.0 84.0 84.0 81.0 90.0 79.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:132.00 stddev:6.50 (4.9%) stddev-sans-first:6.80 09:28:58 INFO - PROCESS | 2962 | Values: 128.0 137.0 134.0 124.0 125.0 131.0 133.0 126.0 145.0 127.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:169.00 stddev:4.09 (2.4%) stddev-sans-first:4.09 09:28:58 INFO - PROCESS | 2962 | Values: 171.0 167.0 161.0 162.0 163.0 166.0 167.0 171.0 172.0 171.0 09:28:58 INFO - PROCESS | 2962 | 09:28:58 INFO - PROCESS | 2962 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.03 (1.6%) stddev-sans-first:1.05 09:28:58 INFO - PROCESS | 2962 | Values: 67.0 66.0 67.0 67.0 66.0 66.0 68.0 65.0 65.0 65.0 09:28:58 INFO - PROCESS | 2962 | -------- Summary: end -------- 09:28:58 INFO - PROCESS | 2962 | 09:28:59 INFO - TEST-INFO | 2962: exit 0 09:28:59 INFO - TEST-OK | kraken | took 62095ms 09:28:59 INFO - SUITE-END | took 1174s 09:29:00 INFO - Completed test suite (00:19:35) 09:29:00 INFO - javascript benchmark 09:29:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7475.586334013076, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.199668086297, 3099.3801239752056, 3112.4553203189434, 3117.672644372341, 3121.0, 5371.892562148755, 5425.810096646618, 5508.338999320083, 5522.447755224481, 5526.226328314029, 5456.263404440409, 5495.093309603911, 5562.276904002474, 5566.025945459549, 5570.526505247059, 4935.457099719028, 4967.751612419383, 4967.826126085579, 4988.426330971948, 5025.949740502603, 5014.874628134289, 5047.116754567955, 5077.263796749469, 5114.386273647167, 5120.334356533645, 244.48656821954236, 4921.704697718148, 5077.873053173664, 5121.359830021247, 5148.922766158511, 5055.191169412877, 5064.139096353629, 5068.797248110071, 5096.872578185538, 5117.6161787865685, 5016.172331565287, 5018.473060328686, 5020.824271150529, 5026.371703537058, 5074.238864170367, 5356.732163391854, 5393.352797664305, 5454.372747134091, 5459.153831156137, 5511.724413779335, 5774.855628609276, 5859.472647461706, 5879.0, 5906.350301466835, 5910.438508341701, 5874.97062514689, 5907.822765317047, 5920.851978700523, 5923.911141332884, 5926.2295901532525, 5283.260343551868, 5419.756110975016, 5458.808941687022, 5461.9453805461835, 5468.0, 5988.311344195473, 6065.54508411862, 6068.848278793065, 6108.725107370179, 6120.051392034242, 5786.450287222707, 5793.768249270066, 5803.767849286066, 5804.622699524602, 5809.24479817621, 5644.85887852807, 5746.224259724883, 5850.151727999416, 5867.6772777497645, 5870.0, 5717.542596592262, 5831.562632802556, 5834.766609335579, 5859.033259512218, 5880.470757631833, 5767.711614419262, 5841.7371218295275, 5846.29844418664, 5864.06175011996, 5875.324337701134, 4285.292926667127, 4419.425474688334, 4467.486239082482, 4474.194644963938, 4515.096980603892, 3958.366661334173, 3987.80060996949, 3991.8203680833853, 4022.577629348935, 4030.3954406839207, 5626.156076588544, 5667.093265077568, 5672.602917795797, 5672.943270567324, 5678.0915053591225, 5718.399568045378, 5808.041673123887, 5843.152742852262, 5933.673647949404, 5933.851653708692, 5611.2144299798065, 5617.550595952314, 5618.550515958714, 5651.095824668033, 5672.688002159838, 5075.593952483792, 5081.517255860687, 5081.568066714297, 5099.107656160231, 5124.718140502234, 5976.820695379146, 6016.969915150396, 6077.483413909778, 6109.450149486479, 6116.327204007555, 5899.115132730125, 5912.231409916683, 5926.703664816656, 5954.493868021266, 5960.642361458326, 6125.326214116532, 6133.601315914451, 6137.140800287874, 6140.5701600887505, 6146.692665366624, 5610.747516361692, 5741.483266506035, 5790.7973220937065, 5801.738921748447, 5848.181254624441, 5914.201582786441, 5924.140999554954, 5935.495482883831, 5988.161657368059, 5993.520518358608, 5777.39337369587, 5809.593328466966, 5819.0, 5826.126081087871, 5837.299524056971, 5525.4474552544425, 5655.547556195576, 5734.942650573441, 5798.76804927815, 5805.94194058054, 5703.372629010889, 5704.458076482728, 5708.200851880657, 5727.31272247333, 5743.3395159557185, 5725.2843394575675, 5742.08126699726, 5784.623999440023, 5802.82591522255, 5806.65160090396, 5453.182022696627, 5559.63862348946, 5613.129964855454, 5621.5221706155435, 5673.0], "value": 5388.0575270990075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.8267650910823, 591.5474661883659, 601.6540489218697, 603.2037710222506, 625.5308518611042, 39284.60715392845, 44306.0, 44313.33529997049, 44351.33472997908, 44369.0, 43626.78186609071, 43854.0, 43867.56132438675, 44006.77996610021, 44393.11213775723, 8832.470051796881, 8965.417247878899, 8996.370254082216, 9009.459432434041, 9023.954880225623, 8885.333599980027, 8948.552572371387, 8962.955185224066, 8978.0, 8989.640414383417, 8990.775230619221, 9053.0, 9078.137576930181, 9083.500407477586, 9095.863562046574, 8920.241779448756, 8929.642814287421, 8990.0, 9007.369484136114, 9009.819803603892, 8841.425307355, 8871.822563548758, 8919.509426981513, 8935.106489351077, 8936.151065648754, 42485.0, 42557.78721106405, 42736.57263427357, 42863.78568107139, 42966.57033429657, 3475.2528206435736, 3482.703970162514, 3626.582942961567, 3629.3104310181243, 4078.9796051019853, 33109.6689033109, 33125.0, 33454.498182527284, 35035.64964350349, 35064.0, 4292.871213863589, 4406.22890994078, 4445.462193658884, 4609.562091601292, 4642.094791515656, 391301.0, 392444.0, 392979.0351048255, 393165.5125865543, 393910.0, 60959.6952015246, 61407.38592614017, 61611.6919415409, 61630.0, 61716.382836171964, 64184.35815641877, 64244.357556423834, 64291.67854160793, 64459.35540644627, 64529.0, 17155.142242887807, 17648.823511764716, 17651.73522397165, 18493.352732654563, 18554.165062572218, 12435.37823108859, 12458.81311780324, 12470.501179952882, 12476.875231247754, 12577.434015469325, 19334.733754780897, 19376.806231937782, 19405.0, 19409.320673776634, 19447.932850527035, 7200.927990720026, 7377.668004939791, 7443.776686699408, 7490.475666703387, 7525.6989720410575, 956.4978386347224, 1034.9689509314733, 1049.7165765243494, 1061.5223149582719, 1167.8131498960126, 33867.66132338694, 34005.659943400744, 34342.31315373679, 34344.0, 34457.31085378279, 1108.539955918301, 1138.8804175561613, 1225.4546726706708, 1247.7442124364484, 1293.3080801771007, 16359.427420040241, 17903.46289611314, 18392.448226553224, 18597.16312765929, 19527.804721952598, 536105.0, 538729.0, 540907.0, 541335.0, 542642.0, 61523.769524609255, 61652.0, 61767.0, 61877.0, 61965.380346196864, 1367.2890097149427, 1393.811835402228, 1407.4933024111313, 1417.3267697843442, 1425.465450456079, 32277.0, 33834.323313534085, 34576.48135277923, 34618.48072278968, 34707.917524948585, 51948.480515194366, 52315.73842130765, 52727.73636131795, 52842.47157528376, 52878.73560632172, 475114.0, 475619.30378006975, 475950.0, 476332.0, 476784.0, 28635.99322071236, 29098.418031638827, 29133.271668208465, 29138.483535052103, 29141.85429072841, 47044.52955470538, 47448.2882756752, 47543.524564755295, 48251.517484824704, 48501.5149848497, 41021.58978410178, 41743.0, 42150.578494214664, 42406.78796605997, 43807.78096109499, 39617.0, 40935.38596920989, 41956.58043419527, 42084.36873446839, 42560.36159457549, 35636.64363356437, 39133.21733565256, 40687.0, 40847.1830563393, 42743.786281068395, 33350.0, 37122.8143859279, 37717.62282377141, 37822.243555128196, 38036.619633803304, 28423.0, 28638.0, 28681.36129089994, 28689.426211475235, 28719.71280287254], "value": 20727.873971237168, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.86468871206375, 385.64327996603134, 400.2934820042625, 400.7475290566943, 418.6362576696246, 18779.154938027787, 19958.50103747407, 20305.898470507644, 20367.18531258748, 20813.0, 19421.834689918578, 19505.90504940448, 19528.31650892219, 19711.211551537956, 19763.505912352164, 5669.8582535436635, 5672.68800215988, 5817.243758311413, 5830.650160990333, 5894.322152952401, 5774.0, 5801.709914504279, 5839.065749480084, 5845.0647896336595, 5851.356350801409, 5628.0713682242385, 5810.389909059551, 5838.883222335551, 5864.237649105632, 5874.206982057411, 5734.767025089611, 5788.218590490272, 5808.941910580882, 5854.18041474194, 5854.238948936632, 5137.948620513785, 5181.35233095863, 5186.974065129651, 5200.895982080375, 5206.323177986876, 24171.274861754177, 24301.756982430124, 24401.0, 24430.26709198727, 24633.261002169962, 2466.8889899954365, 2522.369407648088, 2780.7219278072234, 3126.04655580048, 3229.9677003230136, 14710.63223419423, 14812.851871481364, 15166.31751571182, 15407.460738874086, 15961.12213828239, 1910.3791267838008, 1977.149825575002, 1996.2414282572674, 2027.2803154879953, 2051.21028404064, 83203.7519437209, 83578.0, 84672.0, 85652.0, 87417.68873466966, 9719.65981190655, 9856.359336643096, 10030.799384012278, 10049.698509044594, 10220.795584088277, 13426.530071447452, 13451.798223026663, 13452.5291614793, 13477.865221347856, 13528.053036287365, 7799.45403821727, 8112.959435202904, 8176.405600907885, 8180.719070836905, 8312.792180195544, 8101.878471822927, 8210.58947052657, 8341.290990265774, 8396.328293736486, 8432.789180270542, 6212.9068063979075, 6305.653189074553, 6312.212672396618, 6394.680265986682, 6454.48275172683, 1827.8446332061924, 1845.603195313014, 1855.2282570145478, 1872.9719054214197, 1876.1463534091956, 977.2475194100645, 1017.9898201018043, 1036.409246729357, 1070.8982646648556, 1078.962236321725, 20211.191552337743, 20898.37304880856, 21137.471563210736, 21162.97742840446, 21176.364709058755, 1009.9545520451597, 1058.82529382651, 1059.279689810936, 1082.3235477826358, 1109.5118148014847, 11105.167112466597, 11815.113866459878, 11816.113791465674, 11860.94069529664, 11950.103742219368, 426853.0, 435809.0, 450457.0, 456124.0, 481661.0, 85249.57375213085, 89499.55250223707, 99128.0, 101950.49024754977, 102401.48799255956, 1010.8786945566579, 1016.7305663998899, 1037.911777498921, 1061.4268295120703, 1062.4740753327153, 18442.354517592357, 18773.0, 19188.712169317194, 19374.321898733477, 19443.4166974991, 44340.778296108314, 44940.325895112255, 45195.774021129684, 45806.0, 45919.31121033254, 59059.40940590539, 61302.693486532284, 62169.689151553954, 62421.37578624337, 64008.3599164021, 8601.0, 8702.695405661025, 8716.302695784449, 8789.780255493408, 9174.587143578421, 11356.886431135583, 12945.158564693265, 13228.206307621573, 13229.933850330686, 13238.933805331297, 10701.250912436055, 11238.494267758135, 11608.767824643628, 11810.527578896748, 12210.87789122133, 7433.516821406592, 7743.264389882952, 11515.19393642437, 11705.0, 12174.147809653594, 11954.103442241692, 12166.513339466323, 12279.69300767488, 12310.569130080405, 12343.13598048128, 8825.867611985954, 8994.59524321394, 9078.0, 9143.542822858963, 9278.304127190622, 11692.94153529227, 11868.940655296668, 12102.697432564257, 12137.514499419924, 12481.193236062725], "value": 9555.870808396281, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.8379878213395, 1519.6884638649074, 1646.8847180697348, 1744.5028166972415, 1756.9560760980974, 8093.109757926638, 8695.56522173891, 9023.428322927966, 9566.712998610035, 9585.089416505438, 9007.864882026759, 9349.345545811795, 9409.153176214139, 9448.66929657462, 9476.857847132282, 2358.882055897207, 2388.534235824015, 2392.0, 2393.126508824284, 2396.089485995319, 2306.1121468234683, 2381.5117900830373, 2413.3845869303304, 2423.018677435641, 2424.987875060622, 2391.1272385579314, 2407.939801504968, 2424.7575242475787, 2435.8294919355562, 2450.424150324672, 2379.845310054841, 2381.630847218675, 2387.248016874679, 2401.327628264089, 2407.0, 2319.257837492003, 2362.8109751219863, 2363.988180059089, 2372.6559648850994, 2377.8335516513853, 9308.394954328014, 9408.43549387039, 9445.574949127305, 9452.19656329213, 9484.90515094847, 5413.0, 5502.669839809624, 5567.359753628303, 5572.024895643287, 5612.326520817487, 3563.1804684922354, 3599.2441587266703, 3603.94594081089, 3630.1287690954246, 3655.9086022849374, 1106.397013627575, 1120.467777805544, 1171.7187874910046, 1172.6657902497748, 2200.1859312054644, 12608.873911260862, 13204.075714699975, 13321.467141314335, 13402.329883505883, 13415.329233538381, 4652.767361631905, 4670.579647831643, 4715.717056976524, 4798.376211092605, 4809.206480930678, 10190.898091019144, 10243.94878025605, 10254.58981640726, 10293.691189264335, 10297.9485102574, 5493.093639549509, 5534.225208470817, 5537.473939975695, 5546.639468434539, 5567.66594004361, 4374.693771435969, 5004.9499505005215, 5072.163093089599, 5085.084684756779, 5183.896322073538, 3849.615038496128, 3980.124372638015, 3997.320455522568, 4004.9199016019516, 4071.959280407217, 1204.7289359893953, 1221.5785553983862, 1227.5458080510268, 1240.8076748104058, 1244.6452760963082, 985.2364417576292, 1001.1290177545582, 1021.1779517488493, 1022.7903279827617, 1034.1261633919326, 6253.249610046823, 6313.589616674902, 6343.492520598341, 6343.714532846033, 6560.639164845979, 429.43100391980124, 434.8564973558718, 445.2253079641401, 450.5764581293574, 453.2770231480783, 4456.554344565582, 4467.888302792391, 4469.240229161051, 4481.596656300949, 4561.566651168134, 11017.0, 11391.601293954673, 11665.59170429031, 11772.88227117735, 11859.34773587461, 11229.0, 11718.70703232409, 11739.765204696028, 11765.176437649454, 11766.117541184445, 8098.838023239502, 8219.424640275123, 8235.341172706168, 8276.627551760184, 8319.126491718403, 6125.816225513242, 6425.261094973951, 6478.060681201294, 6479.676016199265, 6609.636469994197, 10410.843837342294, 10936.453177340942, 10987.450627468435, 11038.724031898946, 11061.336319820837, 11102.056325212447, 11125.109991200523, 11198.496067676811, 11229.0, 11237.494312755782, 7414.258574142543, 8009.839803203787, 8172.632231549714, 8179.386546009192, 8408.83182336362, 9234.399764015317, 9268.58291376903, 9283.210927071004, 9343.392679475812, 9371.062893710574, 7953.13810874523, 8087.3125784308995, 8180.509169449852, 8209.835803283782, 8274.13121622221, 8021.197880212166, 8137.877931831145, 8197.959010204911, 8198.262156405952, 8365.498070115813, 7207.5675459472595, 7364.852702946018, 7471.40228781707, 7481.588512631857, 7487.588182650006, 5640.210370548045, 5644.153376993319, 5656.830295091154, 5797.565182611237, 5822.796202132905, 5490.478404551562, 5532.751026203911, 5579.944200557942, 5603.691796951207, 5618.915716264341], "value": 4786.567559396283, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.1411215512598, 342.8268724294231, 344.3612099555325, 348.8848679935621, 350.3605919197465, 5542.695151766657, 5626.268585083933, 5633.718314084294, 5635.633683810554, 5690.4025077366905, 5489.58828087894, 5525.336959564847, 5534.363548191959, 5570.721463926798, 5579.218909352694, 4126.2160189563965, 4180.456540649711, 4250.744955302676, 4285.635720963722, 4285.764282964436, 4242.830286788525, 4304.0, 4310.267254566716, 4317.301686445971, 4376.737395756249, 4331.805068771912, 4335.0, 4356.803943822536, 4357.324614684729, 4362.847300344489, 4074.2055299216663, 4252.298370768819, 4261.722988005769, 4290.871273861789, 4368.279233926414, 3759.172981943968, 3764.6235376462137, 3772.3401703250483, 3780.319542482352, 3784.243151369737, 5364.22218778275, 5395.352557693062, 5434.212039254326, 5466.961277357329, 5481.232627432163, 4792.9281060784115, 4840.0053888719685, 4849.903001939977, 4875.196177414344, 4950.405951285833, 5691.658500489983, 5694.658320500783, 5705.1727499512335, 5718.285214348207, 5726.656400615935, 4079.714419990602, 4089.26393249215, 4098.0, 4108.26051310764, 4120.237756015147, 5929.733162007677, 5939.940600594025, 5952.523798096142, 5957.880842383128, 5996.740684456269, 4189.2668782962855, 4218.303979843353, 4224.936625950613, 4227.598378154071, 4239.618434340924, 4256.659467242675, 4260.25445547028, 4277.0, 4281.272183728774, 4291.334843099325, 4683.578477937002, 4869.318295438641, 4898.436679781799, 4911.16510193268, 4931.50684931504, 5779.3642699303045, 5789.102689083199, 5790.88418231633, 5792.466595376817, 5803.303603567599, 1445.1401416157369, 1449.8332691740584, 1466.8093147890706, 1467.3763650448516, 1481.8369979302267, 894.1238415148372, 937.5359197197295, 951.9480973524295, 952.8380175370204, 994.6469003503797, 5540.891821635689, 5551.2228288039705, 5572.108462645957, 5628.127640215773, 5645.576581756302, 5900.079460666997, 5980.671063091485, 5981.491573216325, 5987.0, 6015.699215039231, 5402.837914862561, 5507.449255074461, 5554.91667624986, 5563.221149039137, 5679.119736440858, 3061.479548476764, 3123.3440977395003, 3143.402753476832, 3148.544135574256, 3163.604549431321, 5974.641521508724, 6105.236845394325, 6113.724882380304, 6122.234720659918, 6130.908036379368, 5952.970235148797, 5960.821175364746, 5964.0, 6001.969990150022, 6009.819705408845, 6062.151298818169, 6065.484433823086, 6073.815605956796, 6075.878482430238, 6083.726232319645, 5663.2071509989455, 5881.206037184926, 5885.470307672159, 5892.852678682896, 5914.526837852875, 5812.948202193882, 5833.833233353431, 5835.708214589169, 5835.824925252249, 5872.003518803627, 5886.764529418775, 5969.492593129459, 6095.603785753912, 6125.264968203844, 6146.723397447215, 4200.873973780792, 4206.705530612828, 4229.809658565434, 4246.723962942398, 4248.893777655583, 5897.970510147422, 5913.58604897653, 5918.496927761188, 5956.404359564009, 6000.849978750566, 5465.966388654335, 5687.630304030225, 5714.485696287354, 5729.455701708331, 5790.768369265351, 5737.168110624019, 5755.194272801895, 5758.539316854725, 5766.462756387176, 5767.826965191051, 5474.616776825744, 5528.502434780889, 5646.745896434588, 5680.017990554992, 5681.602287839812, 5734.3978882218435, 5813.970930145322, 5822.534197264124, 5837.474627283565, 5859.2382990211, 5674.092145256905, 5695.629784064023, 5696.120280307571, 5701.201831743642, 5715.428457154418], "value": 4396.536642884869, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.496092578898, 797.8843067755175, 819.6680344460495, 849.5200211880291, 877.254333816256, 15260.847391526082, 16522.0, 16576.58558536037, 16577.75133372999, 16621.168941552904, 15754.369825206977, 15920.283587238573, 15941.043537387764, 15947.601309967256, 15951.202439877989, 655.311922481395, 785.4541093939714, 794.8370584030274, 805.267206841774, 811.7077851973285, 804.6781287484994, 809.0776514773163, 809.3889113719164, 809.5142914251431, 809.6518497046268, 862.6851199312268, 865.2558799432514, 866.6836604639325, 869.6738722978882, 870.6734974384606, 861.9008813986378, 862.0431321233426, 864.5115509736978, 868.1492137705021, 868.448535180162, 635.3265538529174, 635.4249404289126, 635.4693830651412, 635.6789821140295, 635.7838334966087, 15427.30577124032, 15509.146996915166, 15531.223438828014, 15532.145731984736, 15533.068015919082, 14900.329485173193, 15039.097654140787, 15972.361105555763, 16272.75590866138, 16287.0, 12547.058970577244, 12621.873781262253, 12660.746785064339, 12719.809202861965, 12924.741505169937, 3755.9248815023548, 3784.072902138966, 3839.731218814684, 3989.7207195496326, 3993.4209539616595, 76002.23997760007, 79630.0, 81062.59468702618, 81705.0, 82006.0, 10706.571737130584, 11207.327560346404, 11225.326480411202, 11482.540698372139, 11488.655340339803, 20266.189352426034, 21259.574808503745, 21531.138754449647, 21676.0, 21680.457988550097, 8772.692955746517, 8875.435718168274, 8947.776305592412, 9068.501232432147, 9187.310951678652, 5110.259012443249, 5170.40540337866, 5203.973980130151, 5228.686278823283, 5230.3985041719925, 3504.842282097312, 3688.741788074809, 3691.3724666806706, 3694.519712437366, 3699.648533389324, 598.0968737206762, 606.9423404776539, 614.9046897730859, 623.3236937922405, 632.5698525003043, 689.7758228575733, 696.3976160621128, 722.6964674836581, 755.8563872864248, 775.5230533222028, 10353.534090965924, 10455.947720261502, 10461.9476902615, 10575.735606609896, 10842.783144337069, 583.6760597868139, 654.5254690349459, 673.0409166937095, 737.985240295191, 754.3429236983642, 4917.729524876167, 5071.644984851025, 5126.179811230185, 5185.559227465632, 5200.271961925334, 65404.67297663577, 65670.67164664241, 95231.0, 99303.0, 99752.0, 97935.0, 98372.50813746029, 98986.0, 101106.4944675272, 102414.48792755988, 84199.0, 84408.0, 86289.56855215684, 87833.0, 88568.5571572138, 10384.636537721144, 10427.582896684047, 10513.632022879163, 10673.252872298865, 10720.73198170052, 52311.47688523066, 52353.47646523486, 52809.735951321534, 53059.73470132625, 53570.73214633902, 68624.0, 77778.2222177771, 77961.0, 80462.19537804546, 81424.0, 13265.867341326462, 13300.46798128064, 13326.666833329244, 13794.65513362174, 13901.0, 14925.402983880524, 15307.311170997555, 15696.92151539235, 15766.527004189893, 15918.9204053979, 14170.291485425894, 14458.710825783215, 14545.418183272974, 14653.413863445343, 14758.650784992293, 14154.363053662404, 14287.0, 14618.80015132521, 14777.261136943325, 15234.542963711106, 13712.0, 14323.856761432253, 14354.49759258421, 14710.55868323952, 14906.627334316729, 11484.483198255932, 12147.817782733442, 12217.877821221675, 12238.694032649255, 12624.87375126237, 10636.946815265874, 10911.290766100496, 11068.833967490655, 11946.226096625962, 12295.262284262973], "value": 7770.260857230017, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 110.0, 112.0, 112.0, 112.0, 117.0, 110.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 119.0, 153.0, 186.0, 124.0, 143.0, 144.0, 120.0, 186.0, 118.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 162.0, 164.0, 174.0, 162.0, 162.0, 162.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 176.0, 76.0, 76.0, 76.0, 75.0, 164.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 159.0, 86.0, 85.0, 89.0, 137.0, 86.0, 85.0, 146.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 149.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 55.0, 56.0, 51.0, 59.0, 51.0, 52.0, 52.0, 59.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 84.0, 81.0, 80.0, 80.0, 84.0, 84.0, 81.0, 90.0, 79.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 137.0, 134.0, 124.0, 125.0, 131.0, 133.0, 126.0, 145.0, 127.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 161.0, 162.0, 163.0, 166.0, 167.0, 171.0, 172.0, 171.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 68.0, 65.0, 65.0, 65.0], "value": 66.2, "unit": "score"}]}]} 09:29:00 INFO - Return code: 0 09:29:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:29:00 ERROR - # TBPL SUCCESS # 09:29:00 INFO - Running post-action listener: _resource_record_post_action 09:29:00 INFO - [mozharness: 2016-08-18 16:29:00.285373Z] Finished run-tests step (success) 09:29:00 INFO - Running post-run listener: _resource_record_post_run 09:29:00 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 411164672; Read time: 8; Write time: 323672 09:29:00 INFO - TinderboxPrint: CPU usage
13.4% 09:29:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:29:00 INFO - TinderboxPrint: I/O write bytes / time
411,164,672 / 323,672 09:29:00 INFO - TinderboxPrint: CPU idle
8,235.8 (86.6%) 09:29:00 INFO - TinderboxPrint: CPU user
1,214.6 (12.8%) 09:29:00 INFO - TinderboxPrint: Swap in / out
0 / 0 09:29:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 121069568; Read time: 0; Write time: 133676 09:29:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 289128448; Read time: 0; Write time: 189992 09:29:00 INFO - Running post-run listener: _upload_blobber_files 09:29:00 INFO - Blob upload gear active. 09:29:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:29:00 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 09:29:00 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'] 09:29:00 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 09:29:01 INFO - (blobuploader) - INFO - Open directory for files ... 09:29:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:29:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:29:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:02 INFO - (blobuploader) - INFO - Done attempting. 09:29:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:29:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:07 INFO - (blobuploader) - INFO - Done attempting. 09:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:08 INFO - (blobuploader) - INFO - Done attempting. 09:29:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:29:08 INFO - Return code: 0 09:29:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:29:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:29:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24c55a9abc2b5e9fd4bb6fa05653cc31fea7cbd1fc937256a28b98100cf274a212660e38ecec5211c959eae765608de8c622d75cc5ff57ac03a08cb9b60f3b8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70a28ed67b02b349d440635b86bb94f0d5db7fbb63c48b58655fedbcff3d598f94fbd533593b8a958feb28a140b51ca57b3205d5c526db6a35f85868b6ad1aed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ec5999acb4b2d3a96a0b47d6a0afa7944b3a0f55c7650303f81a1bab8a2521575273323fef70ddcfcc05de376205e13d287dfd9806c5f5b529dedbe2cc0a181"} 09:29:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:29:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:29:08 INFO - Contents: 09:29:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24c55a9abc2b5e9fd4bb6fa05653cc31fea7cbd1fc937256a28b98100cf274a212660e38ecec5211c959eae765608de8c622d75cc5ff57ac03a08cb9b60f3b8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70a28ed67b02b349d440635b86bb94f0d5db7fbb63c48b58655fedbcff3d598f94fbd533593b8a958feb28a140b51ca57b3205d5c526db6a35f85868b6ad1aed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ec5999acb4b2d3a96a0b47d6a0afa7944b3a0f55c7650303f81a1bab8a2521575273323fef70ddcfcc05de376205e13d287dfd9806c5f5b529dedbe2cc0a181"} 09:29:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:29:08 INFO - Copying logs to upload dir... 09:29:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:29:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.708007 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-18 09:29:08.430434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 09:29:08.434074) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402 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/24c55a9abc2b5e9fd4bb6fa05653cc31fea7cbd1fc937256a28b98100cf274a212660e38ecec5211c959eae765608de8c622d75cc5ff57ac03a08cb9b60f3b8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70a28ed67b02b349d440635b86bb94f0d5db7fbb63c48b58655fedbcff3d598f94fbd533593b8a958feb28a140b51ca57b3205d5c526db6a35f85868b6ad1aed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ec5999acb4b2d3a96a0b47d6a0afa7944b3a0f55c7650303f81a1bab8a2521575273323fef70ddcfcc05de376205e13d287dfd9806c5f5b529dedbe2cc0a181"} build_url:https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011505 build_url: 'https://queue.taskcluster.net/v1/task/VN0EGphUQeO1b11I9V2auA/artifacts/public/build/firefox-51.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/24c55a9abc2b5e9fd4bb6fa05653cc31fea7cbd1fc937256a28b98100cf274a212660e38ecec5211c959eae765608de8c622d75cc5ff57ac03a08cb9b60f3b8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70a28ed67b02b349d440635b86bb94f0d5db7fbb63c48b58655fedbcff3d598f94fbd533593b8a958feb28a140b51ca57b3205d5c526db6a35f85868b6ad1aed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ec5999acb4b2d3a96a0b47d6a0afa7944b3a0f55c7650303f81a1bab8a2521575273323fef70ddcfcc05de376205e13d287dfd9806c5f5b529dedbe2cc0a181"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 09:29:08.459692) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:29:08.460012) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1471536509.206686-248059402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 09:29:08.543458) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 09:29:08.543780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 09:29:08.544067) ========= ========= Total master_lag: 0.15 =========