builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1477770555.69 results: success (0) buildid: 20161029093005 builduid: 7f169e42477040a28eb6e4ba70777630 revision: 969c3295d3aa77931cca26eddb047d9d74bd9858 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:15.686519) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:15.687522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:15.688305) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:15.700920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:15.701261) ========= 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=af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-29 12:49:16-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.1M=0s 2016-10-29 12:49:16 (24.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:15.826629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:15.826960) ========= 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=af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015751 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:15.877603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 12:49:15.878363) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 969c3295d3aa77931cca26eddb047d9d74bd9858 --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 969c3295d3aa77931cca26eddb047d9d74bd9858 --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=af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-29 12:49:16,314 truncating revision to first 12 chars 2016-10-29 12:49:16,314 Setting DEBUG logging. 2016-10-29 12:49:16,314 attempt 1/10 2016-10-29 12:49:16,314 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/969c3295d3aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 12:49:17,616 unpacking tar archive at: fx-team-969c3295d3aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.666681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 12:49:17.559877) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:17.560217) ========= script_repo_revision: 969c3295d3aa77931cca26eddb047d9d74bd9858 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:17.560690) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:17.560964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 12:49:17.571003) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-29 12:49:17.571337) ========= /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=af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:49:18 INFO - MultiFileLogger online at 20161029 12:49:18 in /builds/slave/test 12:49:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:49:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:49:18 INFO - {'append_to_log': False, 12:49:18 INFO - 'base_work_dir': '/builds/slave/test', 12:49:18 INFO - 'blob_upload_branch': 'Fx-Team', 12:49:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:49:18 INFO - 'branch': 'Fx-Team', 12:49:18 INFO - 'buildbot_json_path': 'buildprops.json', 12:49:18 INFO - 'config_files': ('talos/linux_config.py',), 12:49:18 INFO - 'default_actions': ('clobber', 12:49:18 INFO - 'read-buildbot-config', 12:49:18 INFO - 'download-and-extract', 12:49:18 INFO - 'populate-webroot', 12:49:18 INFO - 'create-virtualenv', 12:49:18 INFO - 'install', 12:49:18 INFO - 'run-tests'), 12:49:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:49:18 INFO - 'download_minidump_stackwalk': True, 12:49:18 INFO - 'download_symbols': 'ondemand', 12:49:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:49:18 INFO - 'tooltool.py': '/tools/tooltool.py', 12:49:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:49:18 INFO - '/tools/misc-python/virtualenv.py')}, 12:49:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:49:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:49:18 INFO - 'installer_path': 'installer.exe', 12:49:18 INFO - 'log_level': 'info', 12:49:18 INFO - 'log_name': 'talos', 12:49:18 INFO - 'log_to_console': True, 12:49:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:49:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:49:18 INFO - 'opt_config_files': (), 12:49:18 INFO - 'pip_index': False, 12:49:18 INFO - 'sps_profile': False, 12:49:18 INFO - 'sps_profile_interval': 0, 12:49:18 INFO - 'suite': 'dromaeojs-e10s', 12:49:18 INFO - 'system_bits': '32', 12:49:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:49:18 INFO - 'title': 'talos-linux64-ix-020', 12:49:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:49:18 INFO - 'use_talos_json': True, 12:49:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:49:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:49:18 INFO - 'work_dir': 'build'} 12:49:18 INFO - [mozharness: 2016-10-29 19:49:18.110015Z] Running clobber step. 12:49:18 INFO - Running pre-action listener: _resource_record_pre_action 12:49:18 INFO - Running main action method: clobber 12:49:18 INFO - rmtree: /builds/slave/test/build 12:49:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:49:18 INFO - Running post-action listener: _resource_record_post_action 12:49:18 INFO - [mozharness: 2016-10-29 19:49:18.568237Z] Finished clobber step (success) 12:49:18 INFO - [mozharness: 2016-10-29 19:49:18.568336Z] Running read-buildbot-config step. 12:49:18 INFO - Running pre-action listener: _resource_record_pre_action 12:49:18 INFO - Running main action method: read_buildbot_config 12:49:18 INFO - Using buildbot properties: 12:49:18 INFO - { 12:49:18 INFO - "project": "", 12:49:18 INFO - "product": "firefox", 12:49:18 INFO - "script_repo_revision": "production", 12:49:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:49:18 INFO - "repository": "", 12:49:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:49:18 INFO - "buildid": "20161029093005", 12:49:18 INFO - "pgo_build": "True", 12:49:18 INFO - "basedir": "/builds/slave/test", 12:49:18 INFO - "buildnumber": 857, 12:49:18 INFO - "slavename": "talos-linux64-ix-020", 12:49:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:49:18 INFO - "platform": "ubuntu64_hw", 12:49:18 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:49:18 INFO - "branch": "fx-team", 12:49:18 INFO - "repo_path": "integration/fx-team", 12:49:18 INFO - "revision": "969c3295d3aa77931cca26eddb047d9d74bd9858", 12:49:18 INFO - "stage_platform": "linux64-pgo", 12:49:18 INFO - "builduid": "7f169e42477040a28eb6e4ba70777630", 12:49:18 INFO - "slavebuilddir": "test" 12:49:18 INFO - } 12:49:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:49:18 INFO - Running post-action listener: _resource_record_post_action 12:49:18 INFO - [mozharness: 2016-10-29 19:49:18.570744Z] Finished read-buildbot-config step (success) 12:49:18 INFO - [mozharness: 2016-10-29 19:49:18.570832Z] Running download-and-extract step. 12:49:18 INFO - Running pre-action listener: _resource_record_pre_action 12:49:18 INFO - Running main action method: download_and_extract 12:49:18 INFO - mkdir: /builds/slave/test/build/tests 12:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:18 INFO - trying https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:49:18 INFO - Downloading https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:49:19 INFO - Downloaded 1361 bytes. 12:49:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:49:19 INFO - Using the following test package requirements: 12:49:19 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:49:19 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:49:19 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:49:19 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:19 INFO - u'jsshell-linux-x86_64.zip'], 12:49:19 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:49:19 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:49:19 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:49:19 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:49:19 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:49:19 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:49:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:49:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:49:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:49:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:49:19 INFO - Fetch https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:49:19 INFO - Http code: 200 12:49:19 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 12:49:19 INFO - x-amz-cf-id: Tcm8L3iP_uTCdBPrRCE7prgit-_qTxiyTcZo-HkqEP7xEoFQ9M1fwA== 12:49:19 INFO - x-amz-version-id: fr.OkWUvzY3AeIwS1A1VTlnzpuK1_eez 12:49:20 INFO - Expected file size: 22006276 12:49:20 INFO - Obtained file size: 22006276 12:49:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:49:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:49:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:49:24 INFO - Fetch https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:49:24 INFO - Http code: 200 12:49:24 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 12:49:24 INFO - x-amz-cf-id: yyD7TCVZhQZ4nw14oNb5eKNxlwx4uV4o-6-lxB0YoURtwOOP6itDww== 12:49:24 INFO - x-amz-version-id: fr.OkWUvzY3AeIwS1A1VTlnzpuK1_eez 12:49:24 INFO - Expected file size: 22006276 12:49:24 INFO - Obtained file size: 22006276 12:49:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:49:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:49:29 INFO - Fetch https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:49:29 INFO - Http code: 200 12:49:29 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 12:49:29 INFO - x-amz-cf-id: BvyBGEh5D4DkUQCxFmvBNzZUA1lFKifmlntvnHVfMxfElpd19xq5eA== 12:49:29 INFO - x-amz-version-id: t8Y44O9JvMnHnPNV2AehNV6ccbZKZETv 12:49:30 INFO - Expected file size: 14409038 12:49:30 INFO - Obtained file size: 14409038 12:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:30 INFO - trying https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:49:30 INFO - Downloading https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:49:31 INFO - Downloaded 59633840 bytes. 12:49:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:49:31 INFO - mkdir: /builds/slave/test/properties 12:49:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:49:31 INFO - Writing to file /builds/slave/test/properties/build_url 12:49:31 INFO - Contents: 12:49:31 INFO - build_url:https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:49:32 INFO - Running post-action listener: _resource_record_post_action 12:49:32 INFO - Running post-action listener: set_extra_try_arguments 12:49:32 INFO - [mozharness: 2016-10-29 19:49:32.376377Z] Finished download-and-extract step (success) 12:49:32 INFO - [mozharness: 2016-10-29 19:49:32.376602Z] Running populate-webroot step. 12:49:32 INFO - Running pre-action listener: _resource_record_pre_action 12:49:32 INFO - Running main action method: populate_webroot 12:49:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:49:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:49:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:49:32 INFO - '--tppagecycles', 12:49:32 INFO - '7'], 12:49:32 INFO - 'tests': ['tsvgm']}}, 12:49:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:49:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:49:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:49:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:49:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:32 INFO - 'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:49:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:49:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:32 INFO - 'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['damp', 'tps']}, 12:49:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:32 INFO - 'tests': ['damp', 'tps']}, 12:49:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['dromaeo_dom']}, 12:49:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:49:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['basic_compositor_video']}, 12:49:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:49:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['a11yr', 12:49:32 INFO - 'ts_paint', 12:49:32 INFO - 'tpaint', 12:49:32 INFO - 'sessionrestore', 12:49:32 INFO - 'sessionrestore_no_auto_restore', 12:49:32 INFO - 'tabpaint']}, 12:49:32 INFO - 'other-e10s': {'tests': ['a11yr', 12:49:32 INFO - 'ts_paint', 12:49:32 INFO - 'tpaint', 12:49:32 INFO - 'sessionrestore', 12:49:32 INFO - 'sessionrestore_no_auto_restore', 12:49:32 INFO - 'tabpaint']}, 12:49:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:49:32 INFO - 'ts_paint', 12:49:32 INFO - 'tpaint', 12:49:32 INFO - 'sessionrestore', 12:49:32 INFO - 'sessionrestore_no_auto_restore', 12:49:32 INFO - 'tabpaint']}, 12:49:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:49:32 INFO - 'ts_paint', 12:49:32 INFO - 'tpaint', 12:49:32 INFO - 'sessionrestore', 12:49:32 INFO - 'sessionrestore_no_auto_restore', 12:49:32 INFO - 'tabpaint']}, 12:49:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['a11yr', 12:49:32 INFO - 'ts_paint', 12:49:32 INFO - 'tpaint', 12:49:32 INFO - 'sessionrestore', 12:49:32 INFO - 'sessionrestore_no_auto_restore', 12:49:32 INFO - 'tabpaint']}, 12:49:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['a11yr', 12:49:32 INFO - 'ts_paint', 12:49:32 INFO - 'tpaint', 12:49:32 INFO - 'sessionrestore', 12:49:32 INFO - 'sessionrestore_no_auto_restore', 12:49:32 INFO - 'tabpaint']}, 12:49:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['tsvgx', 12:49:32 INFO - 'tsvgr_opacity', 12:49:32 INFO - 'tart', 12:49:32 INFO - 'tscrollx', 12:49:32 INFO - 'cart']}, 12:49:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:49:32 INFO - 'tsvgr_opacity', 12:49:32 INFO - 'tart', 12:49:32 INFO - 'tscrollx', 12:49:32 INFO - 'cart']}, 12:49:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:32 INFO - 'talos_options': ['--disable-e10s'], 12:49:32 INFO - 'tests': ['tp5o']}, 12:49:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:32 INFO - 'tests': ['tp5o']}, 12:49:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:32 INFO - 'talos_options': ['--disable-e10s', 12:49:32 INFO - '--xperf_path', 12:49:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:49:32 INFO - 'tests': ['tp5n']}, 12:49:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:49:32 INFO - 'talos_options': ['--xperf_path', 12:49:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:49:32 INFO - 'tests': ['tp5n']}}, 12:49:32 INFO - 'talos.zip': {'path': '', 12:49:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:49:32 INFO - Running post-action listener: _resource_record_post_action 12:49:32 INFO - [mozharness: 2016-10-29 19:49:32.396599Z] Finished populate-webroot step (success) 12:49:32 INFO - [mozharness: 2016-10-29 19:49:32.396687Z] Running create-virtualenv step. 12:49:32 INFO - Running pre-action listener: _resource_record_pre_action 12:49:32 INFO - Running main action method: create_virtualenv 12:49:32 INFO - Creating virtualenv /builds/slave/test/build/venv 12:49:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:49:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:49:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:49:32 INFO - Using real prefix '/usr' 12:49:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:49:33 INFO - Installing distribute.............................................................................................................................................................................................done. 12:49:34 INFO - Installing pip.................done. 12:49:34 INFO - Return code: 0 12:49:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:49:35 INFO - Reading from file tmpfile_stdout 12:49:35 INFO - Output received: 12:49:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:49:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:49:35 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')]} 12:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:35 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')]} 12:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:35 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 0x7f4daf4b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:49:35 INFO - Using env: {'DISPLAY': ':0', 12:49:35 INFO - 'HOME': '/home/cltbld', 12:49:35 INFO - 'LANG': 'en_US.UTF-8', 12:49:35 INFO - 'LANGUAGE': 'en_US:en', 12:49:35 INFO - 'LOGNAME': 'cltbld', 12:49:35 INFO - 'MAIL': '/var/mail/cltbld', 12:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:35 INFO - 'MOZ_NO_REMOTE': '1', 12:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:35 INFO - 'NO_EM_RESTART': '1', 12:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:35 INFO - 'PWD': '/builds/slave/test', 12:49:35 INFO - 'SHELL': '/bin/bash', 12:49:35 INFO - 'SHLVL': '1', 12:49:35 INFO - 'TERM': 'linux', 12:49:35 INFO - 'TMOUT': '86400', 12:49:35 INFO - 'USER': 'cltbld', 12:49:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:35 INFO - '_': '/tools/buildbot/bin/python'} 12:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:49:35 INFO - Cleaning up... 12:49:35 INFO - Return code: 0 12:49:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:49:35 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')]} 12:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:35 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')]} 12:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:35 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 0x7f4daf4b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:49:35 INFO - Using env: {'DISPLAY': ':0', 12:49:35 INFO - 'HOME': '/home/cltbld', 12:49:35 INFO - 'LANG': 'en_US.UTF-8', 12:49:35 INFO - 'LANGUAGE': 'en_US:en', 12:49:35 INFO - 'LOGNAME': 'cltbld', 12:49:35 INFO - 'MAIL': '/var/mail/cltbld', 12:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:35 INFO - 'MOZ_NO_REMOTE': '1', 12:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:35 INFO - 'NO_EM_RESTART': '1', 12:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:35 INFO - 'PWD': '/builds/slave/test', 12:49:35 INFO - 'SHELL': '/bin/bash', 12:49:35 INFO - 'SHLVL': '1', 12:49:35 INFO - 'TERM': 'linux', 12:49:35 INFO - 'TMOUT': '86400', 12:49:35 INFO - 'USER': 'cltbld', 12:49:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:35 INFO - '_': '/tools/buildbot/bin/python'} 12:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:35 INFO - Downloading/unpacking psutil>=3.1.1 12:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:49:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:49:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:49:37 INFO - Installing collected packages: psutil 12:49:37 INFO - Running setup.py install for psutil 12:49:37 INFO - building 'psutil._psutil_linux' extension 12:49:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:49:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:49:38 INFO - building 'psutil._psutil_posix' extension 12:49:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:49:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:49:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:49:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:49:38 INFO - Successfully installed psutil 12:49:38 INFO - Cleaning up... 12:49:38 INFO - Return code: 0 12:49:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4daf4b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:49:38 INFO - Using env: {'DISPLAY': ':0', 12:49:38 INFO - 'HOME': '/home/cltbld', 12:49:38 INFO - 'LANG': 'en_US.UTF-8', 12:49:38 INFO - 'LANGUAGE': 'en_US:en', 12:49:38 INFO - 'LOGNAME': 'cltbld', 12:49:38 INFO - 'MAIL': '/var/mail/cltbld', 12:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:38 INFO - 'MOZ_NO_REMOTE': '1', 12:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:38 INFO - 'NO_EM_RESTART': '1', 12:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:38 INFO - 'PWD': '/builds/slave/test', 12:49:38 INFO - 'SHELL': '/bin/bash', 12:49:38 INFO - 'SHLVL': '1', 12:49:38 INFO - 'TERM': 'linux', 12:49:38 INFO - 'TMOUT': '86400', 12:49:38 INFO - 'USER': 'cltbld', 12:49:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:38 INFO - '_': '/tools/buildbot/bin/python'} 12:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:49:40 INFO - Installing collected packages: mozsystemmonitor 12:49:40 INFO - Running setup.py install for mozsystemmonitor 12:49:40 INFO - Successfully installed mozsystemmonitor 12:49:40 INFO - Cleaning up... 12:49:40 INFO - Return code: 0 12:49:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:49:40 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')]} 12:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:40 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')]} 12:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:40 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 0x7f4daf4b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:49:40 INFO - Using env: {'DISPLAY': ':0', 12:49:40 INFO - 'HOME': '/home/cltbld', 12:49:40 INFO - 'LANG': 'en_US.UTF-8', 12:49:40 INFO - 'LANGUAGE': 'en_US:en', 12:49:40 INFO - 'LOGNAME': 'cltbld', 12:49:40 INFO - 'MAIL': '/var/mail/cltbld', 12:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:40 INFO - 'MOZ_NO_REMOTE': '1', 12:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:40 INFO - 'NO_EM_RESTART': '1', 12:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:40 INFO - 'PWD': '/builds/slave/test', 12:49:40 INFO - 'SHELL': '/bin/bash', 12:49:40 INFO - 'SHLVL': '1', 12:49:40 INFO - 'TERM': 'linux', 12:49:40 INFO - 'TMOUT': '86400', 12:49:40 INFO - 'USER': 'cltbld', 12:49:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:40 INFO - '_': '/tools/buildbot/bin/python'} 12:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:40 INFO - Downloading/unpacking jsonschema==2.5.1 12:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:49:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:43 INFO - Downloading functools32-3.2.3-2.tar.gz 12:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:49:43 INFO - warning: no files found matching '*.txt' 12:49:43 INFO - no previously-included directories found matching 'build' 12:49:43 INFO - no previously-included directories found matching 'dist' 12:49:43 INFO - no previously-included directories found matching '.git*' 12:49:43 INFO - Installing collected packages: jsonschema, functools32 12:49:43 INFO - Running setup.py install for functools32 12:49:43 INFO - warning: no files found matching '*.txt' 12:49:43 INFO - no previously-included directories found matching 'build' 12:49:43 INFO - no previously-included directories found matching 'dist' 12:49:43 INFO - no previously-included directories found matching '.git*' 12:49:43 INFO - Successfully installed jsonschema functools32 12:49:43 INFO - Cleaning up... 12:49:43 INFO - Return code: 0 12:49:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:49: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')]} 12:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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')]} 12:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:43 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 0x7f4daf4b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:49:43 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 12:49:43 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 12:49:43 INFO - Using env: {'DISPLAY': ':0', 12:49:43 INFO - 'HOME': '/home/cltbld', 12:49:43 INFO - 'LANG': 'en_US.UTF-8', 12:49:43 INFO - 'LANGUAGE': 'en_US:en', 12:49:43 INFO - 'LOGNAME': 'cltbld', 12:49:43 INFO - 'MAIL': '/var/mail/cltbld', 12:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:43 INFO - 'MOZ_NO_REMOTE': '1', 12:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:43 INFO - 'NO_EM_RESTART': '1', 12:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:43 INFO - 'PWD': '/builds/slave/test', 12:49:43 INFO - 'SHELL': '/bin/bash', 12:49:43 INFO - 'SHLVL': '1', 12:49:43 INFO - 'TERM': 'linux', 12:49:43 INFO - 'TMOUT': '86400', 12:49:43 INFO - 'USER': 'cltbld', 12:49:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:43 INFO - '_': '/tools/buildbot/bin/python'} 12:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:49:43 INFO - Cleaning up... 12:49:43 INFO - Return code: 0 12:49:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:49: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')]} 12:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49: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')]} 12:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:43 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 0x7f4daf4b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:49:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:49:43 INFO - Using env: {'DISPLAY': ':0', 12:49:43 INFO - 'HOME': '/home/cltbld', 12:49:43 INFO - 'LANG': 'en_US.UTF-8', 12:49:43 INFO - 'LANGUAGE': 'en_US:en', 12:49:43 INFO - 'LOGNAME': 'cltbld', 12:49:43 INFO - 'MAIL': '/var/mail/cltbld', 12:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:43 INFO - 'MOZ_NO_REMOTE': '1', 12:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:43 INFO - 'NO_EM_RESTART': '1', 12:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:43 INFO - 'PWD': '/builds/slave/test', 12:49:43 INFO - 'SHELL': '/bin/bash', 12:49:43 INFO - 'SHLVL': '1', 12:49:43 INFO - 'TERM': 'linux', 12:49:43 INFO - 'TMOUT': '86400', 12:49:43 INFO - 'USER': 'cltbld', 12:49:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:43 INFO - '_': '/tools/buildbot/bin/python'} 12:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:43 INFO - Downloading/unpacking blobuploader==1.2.4 12:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:45 INFO - Downloading blobuploader-1.2.4.tar.gz 12:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:49:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:49:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:49:46 INFO - Downloading docopt-0.6.1.tar.gz 12:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:49:46 INFO - Installing collected packages: blobuploader, requests, docopt 12:49:46 INFO - Running setup.py install for blobuploader 12:49:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:49:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:49:46 INFO - Running setup.py install for requests 12:49:47 INFO - Running setup.py install for docopt 12:49:47 INFO - Successfully installed blobuploader requests docopt 12:49:47 INFO - Cleaning up... 12:49:47 INFO - Return code: 0 12:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:49:47 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')]} 12:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:47 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')]} 12:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:47 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 0x7f4daf4b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:49:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:49:47 INFO - Using env: {'DISPLAY': ':0', 12:49:47 INFO - 'HOME': '/home/cltbld', 12:49:47 INFO - 'LANG': 'en_US.UTF-8', 12:49:47 INFO - 'LANGUAGE': 'en_US:en', 12:49:47 INFO - 'LOGNAME': 'cltbld', 12:49:47 INFO - 'MAIL': '/var/mail/cltbld', 12:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:47 INFO - 'MOZ_NO_REMOTE': '1', 12:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:47 INFO - 'NO_EM_RESTART': '1', 12:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:47 INFO - 'PWD': '/builds/slave/test', 12:49:47 INFO - 'SHELL': '/bin/bash', 12:49:47 INFO - 'SHLVL': '1', 12:49:47 INFO - 'TERM': 'linux', 12:49:47 INFO - 'TMOUT': '86400', 12:49:47 INFO - 'USER': 'cltbld', 12:49:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:47 INFO - '_': '/tools/buildbot/bin/python'} 12:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:49:47 INFO - Running setup.py (path:/tmp/pip-gHWNDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:49:47 INFO - Running setup.py (path:/tmp/pip-VgIg6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:49:47 INFO - Running setup.py (path:/tmp/pip-mQyXfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:49:47 INFO - Running setup.py (path:/tmp/pip-61pVip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:49:47 INFO - Running setup.py (path:/tmp/pip-IL18kK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:49:47 INFO - Running setup.py (path:/tmp/pip-nsqWpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:49:47 INFO - Running setup.py (path:/tmp/pip-dswI2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:49:47 INFO - Running setup.py (path:/tmp/pip-H5JYD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:49:47 INFO - Running setup.py (path:/tmp/pip-wuGk2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:49:48 INFO - Running setup.py (path:/tmp/pip-EoNg1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:49:48 INFO - Running setup.py (path:/tmp/pip-lvhBf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:49:48 INFO - Running setup.py (path:/tmp/pip-YwdbJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:49:48 INFO - Running setup.py (path:/tmp/pip-yjsWKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:49:48 INFO - Running setup.py (path:/tmp/pip-qJkL9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:49:48 INFO - Running setup.py (path:/tmp/pip-fob2j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:49:48 INFO - Running setup.py (path:/tmp/pip-SYyQRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:49:48 INFO - Running setup.py (path:/tmp/pip-ELrrn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:49:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:49:48 INFO - Running setup.py install for manifestparser 12:49:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:49:48 INFO - Running setup.py install for mozcrash 12:49:48 INFO - Running setup.py install for mozdebug 12:49:48 INFO - Running setup.py install for mozdevice 12:49:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Running setup.py install for mozfile 12:49:49 INFO - Running setup.py install for mozhttpd 12:49:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Running setup.py install for mozinfo 12:49:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Running setup.py install for mozInstall 12:49:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Running setup.py install for mozleak 12:49:49 INFO - Running setup.py install for mozlog 12:49:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Running setup.py install for moznetwork 12:49:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Running setup.py install for mozprocess 12:49:49 INFO - Running setup.py install for mozprofile 12:49:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:49:49 INFO - Running setup.py install for mozrunner 12:49:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:49:50 INFO - Running setup.py install for mozscreenshot 12:49:50 INFO - Running setup.py install for moztest 12:49:50 INFO - Running setup.py install for mozversion 12:49:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:49:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:49:50 INFO - Cleaning up... 12:49:50 INFO - Return code: 0 12:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:50 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 0x7f4daf4b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:49:50 INFO - Using env: {'DISPLAY': ':0', 12:49:50 INFO - 'HOME': '/home/cltbld', 12:49:50 INFO - 'LANG': 'en_US.UTF-8', 12:49:50 INFO - 'LANGUAGE': 'en_US:en', 12:49:50 INFO - 'LOGNAME': 'cltbld', 12:49:50 INFO - 'MAIL': '/var/mail/cltbld', 12:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:50 INFO - 'MOZ_NO_REMOTE': '1', 12:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:50 INFO - 'NO_EM_RESTART': '1', 12:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:50 INFO - 'PWD': '/builds/slave/test', 12:49:50 INFO - 'SHELL': '/bin/bash', 12:49:50 INFO - 'SHLVL': '1', 12:49:50 INFO - 'TERM': 'linux', 12:49:50 INFO - 'TMOUT': '86400', 12:49:50 INFO - 'USER': 'cltbld', 12:49:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:50 INFO - '_': '/tools/buildbot/bin/python'} 12:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:49:50 INFO - Running setup.py (path:/tmp/pip-XygmL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:49:50 INFO - Running setup.py (path:/tmp/pip-BrvXqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:49:50 INFO - Running setup.py (path:/tmp/pip-swrn4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:49:50 INFO - Running setup.py (path:/tmp/pip-XoG2PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:49:50 INFO - Running setup.py (path:/tmp/pip-Yvil92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:49:51 INFO - Running setup.py (path:/tmp/pip-qcv1YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:49:51 INFO - Running setup.py (path:/tmp/pip-hGlChM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:49:51 INFO - Running setup.py (path:/tmp/pip-W9W7FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:49:51 INFO - Running setup.py (path:/tmp/pip-UAmwQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:49:51 INFO - Running setup.py (path:/tmp/pip-iByXsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:49:51 INFO - Running setup.py (path:/tmp/pip-ePFNFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:49:51 INFO - Running setup.py (path:/tmp/pip-iq8OHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:49:51 INFO - Running setup.py (path:/tmp/pip-iKDYRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:49:51 INFO - Running setup.py (path:/tmp/pip-K6ZHPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:49:51 INFO - Running setup.py (path:/tmp/pip-bdSmgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:49:51 INFO - Running setup.py (path:/tmp/pip-JLd4ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:49:51 INFO - Running setup.py (path:/tmp/pip-k6mMWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:49:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49: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 12:49:53 INFO - Downloading blessings-1.6.tar.gz 12:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:49:54 INFO - Installing collected packages: blessings 12:49:54 INFO - Running setup.py install for blessings 12:49:54 INFO - Successfully installed blessings 12:49:54 INFO - Cleaning up... 12:49:54 INFO - Return code: 0 12:49:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:49:54 INFO - Reading from file tmpfile_stdout 12:49:54 INFO - Current package versions: 12:49:54 INFO - argparse == 1.2.1 12:49:54 INFO - blessings == 1.6 12:49:54 INFO - blobuploader == 1.2.4 12:49:54 INFO - docopt == 0.6.1 12:49:54 INFO - functools32 == 3.2.3-2 12:49:54 INFO - jsonschema == 2.5.1 12:49:54 INFO - manifestparser == 1.1 12:49:54 INFO - mozInstall == 1.12 12:49:54 INFO - mozcrash == 0.17 12:49:54 INFO - mozdebug == 0.1 12:49:54 INFO - mozdevice == 0.48 12:49:54 INFO - mozfile == 1.2 12:49:54 INFO - mozhttpd == 0.7 12:49:54 INFO - mozinfo == 0.9 12:49:54 INFO - mozleak == 0.1 12:49:54 INFO - mozlog == 3.4 12:49:54 INFO - moznetwork == 0.27 12:49:54 INFO - mozprocess == 0.23 12:49:54 INFO - mozprofile == 0.28 12:49:54 INFO - mozrunner == 6.12 12:49:54 INFO - mozscreenshot == 0.1 12:49:54 INFO - mozsystemmonitor == 0.3 12:49:54 INFO - moztest == 0.7 12:49:54 INFO - mozversion == 1.4 12:49:54 INFO - psutil == 3.1.1 12:49:54 INFO - requests == 1.2.3 12:49:54 INFO - wsgiref == 0.1.2 12:49:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:49:54 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')]} 12:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:54 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')]} 12:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:54 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 0x7f4daf4b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:49:54 INFO - Using env: {'DISPLAY': ':0', 12:49:54 INFO - 'HOME': '/home/cltbld', 12:49:54 INFO - 'LANG': 'en_US.UTF-8', 12:49:54 INFO - 'LANGUAGE': 'en_US:en', 12:49:54 INFO - 'LOGNAME': 'cltbld', 12:49:54 INFO - 'MAIL': '/var/mail/cltbld', 12:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:54 INFO - 'MOZ_NO_REMOTE': '1', 12:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:54 INFO - 'NO_EM_RESTART': '1', 12:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:54 INFO - 'PWD': '/builds/slave/test', 12:49:54 INFO - 'SHELL': '/bin/bash', 12:49:54 INFO - 'SHLVL': '1', 12:49:54 INFO - 'TERM': 'linux', 12:49:54 INFO - 'TMOUT': '86400', 12:49:54 INFO - 'USER': 'cltbld', 12:49:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:54 INFO - '_': '/tools/buildbot/bin/python'} 12:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:49:54 INFO - Cleaning up... 12:49:54 INFO - Return code: 0 12:49:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:49:54 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')]} 12:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:54 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')]} 12:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:49:54 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 0x7f4daf4b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c5790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, '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': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:49:54 INFO - Using env: {'DISPLAY': ':0', 12:49:54 INFO - 'HOME': '/home/cltbld', 12:49:54 INFO - 'LANG': 'en_US.UTF-8', 12:49:54 INFO - 'LANGUAGE': 'en_US:en', 12:49:54 INFO - 'LOGNAME': 'cltbld', 12:49:54 INFO - 'MAIL': '/var/mail/cltbld', 12:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:54 INFO - 'MOZ_NO_REMOTE': '1', 12:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:54 INFO - 'NO_EM_RESTART': '1', 12:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:54 INFO - 'PWD': '/builds/slave/test', 12:49:54 INFO - 'SHELL': '/bin/bash', 12:49:54 INFO - 'SHLVL': '1', 12:49:54 INFO - 'TERM': 'linux', 12:49:54 INFO - 'TMOUT': '86400', 12:49:54 INFO - 'USER': 'cltbld', 12:49:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:54 INFO - '_': '/tools/buildbot/bin/python'} 12:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:49:54 INFO - Cleaning up... 12:49:54 INFO - Return code: 0 12:49:54 INFO - Running post-action listener: _resource_record_post_action 12:49:54 INFO - Running post-action listener: _start_resource_monitoring 12:49:54 INFO - Starting resource monitoring. 12:49:54 INFO - [mozharness: 2016-10-29 19:49:54.975529Z] Finished create-virtualenv step (success) 12:49:54 INFO - [mozharness: 2016-10-29 19:49:54.976032Z] Running install step. 12:49:54 INFO - Running pre-action listener: _resource_record_pre_action 12:49:54 INFO - Running main action method: install 12:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:49:55 INFO - Reading from file tmpfile_stdout 12:49:55 INFO - Detecting whether we're running mozinstall >=1.0... 12:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:49:55 INFO - Reading from file tmpfile_stdout 12:49:55 INFO - Output received: 12:49:55 INFO - Usage: mozinstall [options] installer 12:49:55 INFO - Options: 12:49:55 INFO - -h, --help show this help message and exit 12:49:55 INFO - -d DEST, --destination=DEST 12:49:55 INFO - Directory to install application into. [default: 12:49:55 INFO - "/builds/slave/test"] 12:49:55 INFO - --app=APP Application being installed. [default: firefox] 12:49:55 INFO - mkdir: /builds/slave/test/build/application 12:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:50:12 INFO - Reading from file tmpfile_stdout 12:50:12 INFO - Output received: 12:50:12 INFO - /builds/slave/test/build/application/firefox/firefox 12:50:12 INFO - Running post-action listener: _resource_record_post_action 12:50:12 INFO - [mozharness: 2016-10-29 19:50:12.230284Z] Finished install step (success) 12:50:12 INFO - [mozharness: 2016-10-29 19:50:12.230526Z] Running run-tests step. 12:50:12 INFO - Running pre-action listener: _resource_record_pre_action 12:50:12 INFO - Running main action method: run_tests 12:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:50:12 INFO - Python 2.7.3 12:50:12 INFO - Return code: 0 12:50:12 INFO - grabbing minidump binary from tooltool 12:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:12 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 0x10c2930>, '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 0x10c3830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:50:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:50:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:50:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:50:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:50:12 INFO - Return code: 0 12:50:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:50:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:50:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:50:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:50:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:50:12 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/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:50:12 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/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:50:12 INFO - Using env: {'DISPLAY': ':0', 12:50:12 INFO - 'HOME': '/home/cltbld', 12:50:12 INFO - 'LANG': 'en_US.UTF-8', 12:50:12 INFO - 'LANGUAGE': 'en_US:en', 12:50:12 INFO - 'LOGNAME': 'cltbld', 12:50:12 INFO - 'MAIL': '/var/mail/cltbld', 12:50:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:50:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:50:12 INFO - 'MOZ_NO_REMOTE': '1', 12:50:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:50:12 INFO - 'NO_EM_RESTART': '1', 12:50:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:50:12 INFO - 'PWD': '/builds/slave/test', 12:50:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:50:12 INFO - 'SHELL': '/bin/bash', 12:50:12 INFO - 'SHLVL': '1', 12:50:12 INFO - 'TERM': 'linux', 12:50:12 INFO - 'TMOUT': '86400', 12:50:12 INFO - 'USER': 'cltbld', 12:50:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982', 12:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:50:12 INFO - '_': '/tools/buildbot/bin/python'} 12:50:12 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/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:50:12 INFO - mozversion application_buildid: 20161029093005 12:50:12 INFO - mozversion application_changeset: 969c3295d3aa77931cca26eddb047d9d74bd9858 12:50:12 INFO - mozversion application_display_name: Nightly 12:50:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:50:12 INFO - mozversion application_name: Firefox 12:50:12 INFO - mozversion application_remotingname: firefox 12:50:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:50:12 INFO - mozversion application_vendor: Mozilla 12:50:12 INFO - mozversion application_version: 52.0a1 12:50:12 INFO - mozversion platform_buildid: 20161029093005 12:50:12 INFO - mozversion platform_changeset: 969c3295d3aa77931cca26eddb047d9d74bd9858 12:50:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:50:12 INFO - mozversion platform_version: 52.0a1 12:50:12 INFO - using testdate: 1477770612 12:50:12 INFO - actual date: 1477770612 12:50:12 INFO - starting webserver on 'localhost:34841' 12:50:12 INFO - SUITE-START | Running 2 tests 12:50:12 INFO - TEST-START | dromaeo_css 12:50:12 INFO - operating with platform_type : linux_ 12:50:12 INFO - Initialising browser for dromaeo_css test... 12:50:12 INFO - TEST-INFO | started process 14161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpilAeyd/profile http://localhost:34841/getInfo.html) 12:50:17 INFO - PROCESS | 14161 | __metrics Screen width/height:1600/1200 12:50:17 INFO - PROCESS | 14161 | colorDepth:24 12:50:17 INFO - PROCESS | 14161 | Browser inner width/height: 1024/697 12:50:17 INFO - PROCESS | 14161 | __metrics 12:50:17 ERROR - PROCESS | 14161 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 12:50:18 INFO - TEST-INFO | 14161: exit 0 12:50:18 INFO - Browser initialized. 12:50:18 INFO - Running cycle 1/1 for dromaeo_css test... 12:50:18 INFO - TEST-INFO | started process 14285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpilAeyd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:50:31 INFO - PROCESS | 14285 | RSS: Main: 185868288 12:50:31 INFO - PROCESS | 14285 | 12:51:20 INFO - PROCESS | 14285 | 1477770680734 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:53:31 INFO - PROCESS | 14285 | Cycle 1(1): loaded http://localhost:34841/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34841/tests/dromaeo/cssquery-ext.html) 12:53:33 INFO - PROCESS | 14285 | RSS: Main: 198938624 12:53:33 INFO - PROCESS | 14285 | 12:56:35 INFO - PROCESS | 14285 | Cycle 1(1): loaded http://localhost:34841/tests/dromaeo/cssquery-ext.html (next: http://localhost:34841/tests/dromaeo/cssquery-jquery.html) 12:56:36 INFO - PROCESS | 14285 | RSS: Main: 197627904 12:56:36 INFO - PROCESS | 14285 | 12:59:38 INFO - PROCESS | 14285 | Cycle 1(1): loaded http://localhost:34841/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34841/tests/dromaeo/cssquery-mootools.html) 12:59:38 INFO - PROCESS | 14285 | RSS: Main: 199462912 12:59:38 INFO - PROCESS | 14285 | 13:02:40 INFO - PROCESS | 14285 | Cycle 1(1): loaded http://localhost:34841/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34841/tests/dromaeo/cssquery-prototype.html) 13:02:41 INFO - PROCESS | 14285 | RSS: Main: 195588096 13:02:41 INFO - PROCESS | 14285 | 13:05:43 INFO - PROCESS | 14285 | Cycle 1(1): loaded http://localhost:34841/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34841/tests/dromaeo/cssquery-yui.html) 13:05:44 INFO - PROCESS | 14285 | RSS: Main: 199217152 13:05:44 INFO - PROCESS | 14285 | 13:08:46 INFO - PROCESS | 14285 | Cycle 1(1): loaded http://localhost:34841/tests/dromaeo/cssquery-yui.html (next: http://localhost:34841/tests/dromaeo/cssquery-dojo.html) 13:08:47 INFO - PROCESS | 14285 | RSS: Main: 198311936 13:08:47 INFO - PROCESS | 14285 | 13:08:47 INFO - PROCESS | 14285 | __start_tp_report 13:08:47 INFO - PROCESS | 14285 | _x_x_mozilla_page_load 13:08:47 INFO - PROCESS | 14285 | _x_x_mozilla_page_load_details 13:08:47 INFO - PROCESS | 14285 | |i|pagename|runs| 13:08:47 INFO - PROCESS | 14285 | |0;dojo.html;3000.654924683662;3002.864871080801;3005.053408176426;3006.8797248110072;3021.2295864554535;5102.081625307453;5153.716545589996;5175.560077393421;5247.921281180776;5280.392754833195;5092.974535127329;5103.106956282654;5145.022445735308;5162.070827251093;5189.558887494568;4698.953010469902;4720.33915251865;4801.73590452525;4814.1575224335775;4905.583025442842;4644.883877903046;4673.953260467403;4820.542048505386;4833.202521583935;4836.274558816171;4527.796249168795;4786.904261914742;4792.688475249132;4806.231003039515;4900.558949694527;4558.635309175258;4666.32338310943;4669.439667239919;4742.1227072991605;4814.181589129821;4697.600703940169;4708.552687494683;4724.078804633098;4732.100900828831;4773.665843390964;5143.871403214912;5156.767945442464;5174.301469301634;5204.719634993678;5246;5331.067063263952;5387.9461205388225;5430.239766432703;5481.643693159972;5516.089845175541;5604.467575580314;5607.355154157283;5609.467100625475;5609.663420194802;5628.240187574707;5187.766550505236;5216.3218781558535;5243.213517972296;5246.658967167122;5296.179092240709;5331.813386531453;5400.594955378362;5603.075492543685;5615.466530679579;5637.548996080303;5406.972965135149;5410.296661433988;5425.593080518976;5434.809781657623;5484.369297530755;5491.478309560585;5506.03644362243;5529.060059789765;5541.6120871539415;5543.279373681396;5184.429712731597;5247.1866860636665;5261.76322065508;5315.973420132875;5321.707306098125;5454.727263636882;5549.417311182348;5572.916406253909;5596.524295434933;5655.886882262332;4307.160103779733;4309.267424537836;4312.116016216668;4323.567643235651;4361.6510679145595;3727.161388687578;3844.750091244116;3863.864764733221;3873.477080594084;3907.0427745202605;5054.09026375256;5084.847454576368;5100.209467532539;5133.409657889316;5142.6914385137015;5360.544353729899;5394.244805727201;5396.865078372994;5405.324334458192;5409.215663728737;5109.795608175706;5128.307678463434;5133.332666753298;5136.845894623092;5137.33214682089;4701.153792317347;4722.881927951828;4725.243960966229;4728;4730.361401210861;5512.91730624041;5519.806806761744;5531.308586426697;5539.362973258047;5554.166874968787;5394.676319420847;5398.757055932414;5443.8094666686475;5549.0289199389135;5589.888202236014;5740.196372507936;5740.741666624928;5745.994450971147;5746.396628353963;5798.188253644577;5512.5314348280845;5518.255035570147;5519.806806761744;5525.171224316385;5525.530329922001;5319.707416092152;5378.112611419072;5462.126059830408;5493.066178749702;5500.669959802424;5417.891642167214;5422.566194704335;5432.972835135799;5453.809116680897;5479.890402192013;5387.380451248;5389.083855744454;5417.539509141609;5428.402875683592;5465.644733092496;5185.637005409585;5286.048511268009;5360.544353729977;5386.649867758583;5402.216678581663;5400.1089820180805;5498.257735205696;5502.339719233718;5550.084236100998;5552.194931734956;5292.285541452009;5382.273393091882;5386.434424385383;5399.2980912481125;5399.973000134974 13:08:47 INFO - PROCESS | 14285 | |1;ext.html;580.1587697838136;581.2995340614558;589.4694774702768;596.9164316995618;631.8609905820723;37996.430053549186;41800.790996045056;41853;41884.79057604712;42063.57936420635;41522.169556608926;42133.78933105338;42144.36783448251;42173.78913105438;42270;8694.478331300143;8890.155435233675;8911.331650126234;8912.509811960339;8915.153060459246;8678.566071696421;8688.174623410765;8717.694880679177;8751.518666473341;8767.649294028231;8751.956240218822;8759.824803503958;8786.16531429513;8807.911920880773;8831.16103970125;8720.29954158936;8726.738197854074;8770.079141690127;8770.473771573726;8810.427322224035;8624.439411438236;8658.610362533702;8697.304215662733;8702.390832641717;8711.651533938699;39715.40426893599;40041.79979100115;40076.398854017214;40178;40278.59721402778;3524.9823750881337;3527.982360088183;3614.0784100054316;3676.5955744868043;3700.50043244164;31108.688913111033;31270.905518306976;31457.8427107863;31522.36955260905;33105.66894331074;4311.137772445523;4384.101259241847;4505.166544189336;4586.472555656109;4642.117997580449;323649;328983;329668;331382;332117;55405.44594554003;55647.44352556504;55984.72007639936;56140.157897631565;56368.718156408955;58420;58539;58621.413785861594;59188.704056479444;59368;16648.16759162061;16831.57921051959;16850.494485165465;16888.40890568824;16964.066976316175;12508;12585.685357866127;12624.368781560885;12629.115961882764;12706.428210730539;16016.519504414886;16098;16123.53344031039;16291.266892989845;16440.75338869918;6031.849203769941;6053.00125479291;6144.262688477412;6321.367863213642;6341.682915854189;967.9274054445804;1049.8950104989592;1073.544789125137;1084.8752393474851;1171.6426489920486;31855.482788914847;31999.840000799846;32182.35635287328;32496.675033249365;32653;1116.916231282657;1122.7193201699574;1130.1862658885589;1145.7765735681628;1217.9208351457128;16385.180740963144;16895.91552042232;16904;16908;17048.403305884483;250174;252698;253424;253653;254093;56547.303580892636;56803.71598142065;57263;57399.713001435564;57435;1267.4866678995022;1337.3513845784787;1347.1311004402105;1364.5769811358512;1365.1263191557412;29983.250418739706;30811.383772324876;31745.523817143225;31782.523262150622;31833.62391033624;50694.23958640697;50991.74504127455;51369.7431512855;51462;51567.74216128895;451734;456195;456606;457281;458946;27427.725722743315;27578;27697.58453623157;27789.58315625227;27914.16257512278;45845.77077114593;46942.53057469382;47400.52599473961;48403.27395089147;48461.27308090452;39127.60872391354;41688.70183295996;41706.58293417027;41946.58053419427;42368.457892526545;39025.6097439022;39918.80040599895;39998.400103993146;40332.1933561333;40679.59320406758;39964;40141.59858401495;40237.59762402456;40291.39562906617;40331.395029075175;34180.658193417745;36231.456528151575;36420.635793641726;37016.81491592525;37056.25887482181;27898.16305510838;28061;28328.291792705346;28502.714972850004;28735 13:08:47 INFO - PROCESS | 14285 | |2;jquery.html;373.2926105030966;388.45034276498757;395.90498280412703;401.7167896632874;414.72835292883155;17874.195661195245;19050.33323833666;19383.612327753435;19439.805601943994;20044.1982320707;17809.287628494843;17833.554161145978;18290.085495725227;19238.615227695438;19536.31622893199;5528.75120619572;5608;5701.543876489871;5760.251167348239;5833.941660583382;5602.4957753802355;5642.999999999979;5657.632253903504;5710.428957104298;5710.514606258473;5619.550435965113;5645.830625081254;5672.06410942194;5898.085796701518;5930.258717660293;5944.048952167675;5948;5960.910586341209;5966.642001479925;5985.401459854002;5639.295088113986;5782.681952492611;5806.912896306559;5812.767489300423;5825.825225243207;13630.863691363058;13879.861201387957;17607.647847042987;22728.54542909149;23082.65376019361;2257.5710614983263;2268.5689718953345;2340.2394221877958;2422.4200383061957;2505.1983365323103;10156;10273.845892311621;10638.840417393745;12081.697957551043;14910.776338354934;1916.57835276239;2004.2984955265686;2140.4327853118934;2253.864768113902;2307.8153747700144;90012.54993725054;94559;97091;98623.50688246512;99645;16554.751678724828;17180.742288865677;17456.30174792994;17479.21343539544;17890.373836915645;30808.383832323227;31042.84478577638;31135.377292454024;31227.531587026213;31403.528947065814;9695.61217551304;10001.699949001542;10047.447390393598;10088.293819432569;10315.48422578883;8346.707865224687;8432.156784321518;8483.490990540464;8514.403991720521;8710.69512567057;8448.32413406926;8596.398252122292;8793.604287807064;8870.64517419296;8875.28997680184;3163.8418079095954;3375.4261775498226;3466.705330046924;3518.8240587971013;3572.821358932095;927.5779520318239;980.9068138526972;1010.6715317521688;1023.7798873242289;1024.7233247023412;18065.54836129081;18944.621107577772;19322.80677193238;19425;19744;960.9279304052224;975.8292298847673;986.2061040862031;1015.355249416611;1037.092544023979;10310;10518.631847885441;10749.301295415773;10801;10805.729856753644;439630;440355;440759;445895.01884303015;446517.6504701936;87035;90941;91303;92084;92554;1018.7453136715822;1028.9897101029044;1044.1229367331478;1074.248026381536;1084.1543595995136;16383.836161638232;16429.212558206196;16648.417305394254;17099.7435038477;17148.314067437164;39601;40232.79883600563;40691.7965410171;41182;43301.35047974346;54203.45796541984;55646.72176639091;56351.71824141017;57071.71464142653;57517.71241143768;8360.28937540316;8466.983961924609;8571.785705357415;8703;8790.692325768567;12816.743665126833;13030.54393096237;13046.282454465096;13114.409851556513;13335.733285334045;11318.773624527628;11363.54545818158;11364.261323013978;11868.287902725864;11881.940590296994;7074.646267686698;10976.176786741185;11055.949684779933;11301.830472543083;11635.534578617098;11310.377929213972;11381.54473821038;12007.339596322287;12040.698982525508;12071.75856482883;8445.282151017233;8460.492370457792;8495.74512764618;8574.22831945103;8924.286057115545;9940.353876997971;11188;11229.71925701864;11377.4880130396;11634.36011019402 13:08:47 INFO - PROCESS | 14285 | |3;mootools.html;1442.668186317147;1475.3213521779978;1595.8643515301198;1668.2576253567152;1743.1174331721734;7084.433245340373;7332.413406927446;7542.170361260264;8003.83992320154;8008.039035315763;7392.371648409879;7663.15705272421;7700.845983080335;7868.881966770488;7887;2220.888955552224;2244.0574958517464;2248.820094392453;2252.7521972583004;2254.233560589399;2221.577900198957;2255.4699645583273;2281.6919715838317;2285.942851428711;2289.553537060274;2222.8332875034357;2236.1167338901205;2244.551089782042;2250.7411647660483;2267.9433014174697;2199.5051113499494;2215.3132528916008;2219.4340443186966;2230.933072007826;2232.8325375596896;2170.576737536181;2172.446026263293;2206.9668954965687;2206.9889650551645;2223.4107961390246;7990.720324788663;8056.194380561956;8060;8063.758087257392;8091.109977902426;4804.975975120137;4957.256411538262;4967.826126085606;4975.353204083446;4983.202687569971;3127.014990278055;3132.263917979273;3346.397648423283;3385.8814941477176;3408.199073217792;1071.6677829872765;1073.581303291717;1105.6793529876406;1125.2798209146072;1148.6266963236899;10764.677059688222;10802.5678972841;10820.513076911559;10857.565697372174;10881.83677244834;4162.1259535497275;4354.629856462237;4395.7362558246605;4406.537313582092;4475.194464996332;9211.309151813506;9228.49243291612;9230.49232292217;9242.306826988002;9243.630254789734;5028.396592408862;5036.219385995177;5048.62135339851;5048.924266136011;5049.9495005049475;3888.202918401721;4277.572242775697;4562.064776720765;4582.289745089516;4666.043461090469;3609.1698909250495;3697.149655579232;3700.296943580711;3775.3770627846097;3815.847366105325;1199.802032664618;1209.3771707570609;1212.563477148226;1224.161449407159;1251.1742250115062;849.6516428264506;867.6355930509201;879.3448880584006;879.8108406692592;884.1026358246385;5023.673461225008;5066.797328106908;5106.463821298785;5273.815416460406;5294.867628309246;895.1853813030111;914.1772404835568;944.3719926248967;947.3605316411395;973.776031512756;3523.735719821024;3577.856885724542;3609.3683605368956;3632.9636703633155;3712.201876596545;9553.187979021723;9789.951050244703;9904.306698531034;9917.107460328605;9926.404415735078;9071.138241867013;9789.363691360039;9819.75450613726;9846.310758246855;9860.112589866947;7218.097737782778;7344.118705755343;7354.338109570164;7372.96313518429;7384.741534046282;5221.947780522298;5341.679499230058;5358.437364076716;5386.407495175606;5479.6164268500825;8837.116288371368;8936.955315223382;8965.641374345214;8984.371094023356;9062.909370906207;9135.63457461694;9173.174414302744;9183.632654693738;9206.309526785384;9356.157945784911;6479.514036447191;6694.899576506259;6746.325367463214;6901.585904845524;6992.0910281663055;7465.141508726566;7711.845763084595;7744.7676569703;7896.012998375203;7912.683492660229;6958.756443524452;7074.292570742885;7109.8578028438105;7163.212046674757;7272.345488906024;6953.826154346182;7082.150141982995;7084.893726594002;7109.146902371748;7157.57054576727;6011.549133815069;6162.630242185304;6278.434940855345;6278.497720182283;6296.874062518816;4693.624510039121;4730.881727956691;4795.784189711541;4806.158922188673;4818.494058123987;4469;4513.796879140512;4614.815407383667;4708.034852855225;4841.225403935354 13:08:47 INFO - PROCESS | 14285 | |4;prototype.html;327.6101439287248;332.9379280096492;338.3942742490941;338.72976338729774;346.11049602521496;5476.452354764527;5532.585056120787;5542.806001789938;5550.750216240273;5556.499915007648;5456.48163424474;5459.672419654824;5471.5896307776975;5484.890302193964;5485;4190.937135942948;4242.575742425748;4267.530571637133;4291.892702682427;4311.267084595611;4290.734233401138;4305.397244385773;4313.4176886120285;4321.611055005049;4338.522762496123;4278.4010238566625;4282.379055037033;4285.871423857274;4291.163223171483;4301.935470967938;4097.377678285914;4185.916281674349;4192.538820729717;4220.092680073799;4291.35629655551;3701.648343407372;3708.3485308004906;3713.2387860488534;3717.423799311111;3727.1986522897437;5324.041672498949;5367.892642147174;5390;5407.324084489439;5426.430224826416;4782.497837727024;4818.518148185189;4845.563899249049;4852.1508735971065;4871.585915197213;5683.715814209314;5684.237886255274;5684.442001099522;5712.714364281769;5718.914216286759;4085.8978525536804;4093.2603643451416;4094.815733291979;4100.630943215095;4101.26177288088;5759.68321742304;5951.226340575698;5956.166136740816;5958.523318134538;5987.550933679991;4164.2296175207075;4166.167006435592;4173.791310434466;4187.350960601112;4187.602177793105;4208.326667733148;4238.978805106017;4250.851220207278;4266.381374700651;4272.87181384559;4688.624910007191;4821.276808478756;4861.9027619447415;4870.975645121752;4879;5835.503982161564;5841.299044114733;5850.3564607893095;5869.589128761031;5871.823845284648;1476.6751314710746;1477.662715242707;1478.1131321207404;1478.9038712483655;1478.977815332771;884.707067966437;931.0735817861272;936.9437833729997;938.2119020023214;946.7207173883721;4871.5128487151715;4898.779554919965;4899.4365647950945;4915.754212289371;4925.75371231437;5085.644004919694;5173.2152407420135;5177.715225662625;5186.974065129726;5196.506331898464;4521.276595744665;4817.590504807061;4865.197242455026;4865.270209468608;4899.191633380452;2752.325680208362;2757.4485102979484;2765.834049957009;2769.6567164924995;2780.6385169928185;5277.8416647500635;5305.283786688825;5314.468553144732;5322.54758345545;5343.305370301836;5263.0000299942885;5264.210368444687;5630.943690563124;5986.5210783137245;6097.237845269341;6039.285839208855;6060;6159.168512250879;6170.722317495633;6173.41352571505;5643.689597072201;5974.970125149521;5982.41466011516;5983.311919129356;5984.952633289244;5789.1895134680335;5866.970665146647;5868.3251426084835;5891.204687367151;5900.229931020763;6116.724747386467;6121.969390153021;6142.846428839315;6151.3541078186145;6152.415520525543;4127.772972486542;4203.726757760735;4203.97898010508;4222.4088627591545;4227.450431443893;5913.408659134052;5917.822465326047;5944;5953.077273022688;5961.791337303173;5656.660600363992;5788.9131663024245;5813.360530341574;5848.4793953571525;5854.443827836349;5750.281214848144;5765.509931655856;5802.593818432838;5806.9419305806405;5811.56413268998;5762.7694892203845;5772.163036359789;5779.711014449176;5782.855428614318;5823.098523988853;5581.804636837691;5647.943520564741;5708.80019199326;5820.505257053198;5857.648541087548;5624.268845050117;5676.17695434168;5678.4605462480995;5682.318121825408;5689.317281926195 13:08:47 INFO - PROCESS | 14285 | |5;yui.html;731.3162193349223;739.2681245566889;746.813296675831;807.6850028488886;823.6499487717721;13898.583042508728;14538.781918271208;14541.927290363546;14545.054571452862;14559.490417835377;14573.562793116223;14798.40806367744;14818.259087045632;14826.110433374006;14844.332005059798;783.6277768060154;797.4975765267873;800.0918956983836;802.6909639788694;803.1968031968032;798.648594618366;806.415348872066;807.6002378822491;808.7290757596212;809.4253080312985;844.4173520271024;847.4322204123253;848.6520526584102;849.1720572441882;851.3189448441223;832.0722394530086;836.8159005018947;840.1850205300848;841.2428814067327;846.0904527632789;621.1366200980641;621.3662064694032;623.6133597169738;624.2758400255727;624.721998710574;12487.625371238786;12493.25040497573;12499.18755280913;12554.560590379384;13226.404811783494;12592.68518287041;12674.493020279178;12732.363381830872;12882;13283.3358332083;12523;12574.874251257463;12648.304343261118;12719.236845789283;13017.414216360192;4374.781260936972;4389.626881715058;4400.779961001969;4608.354830323724;4609.285560738091;67888.66055669739;67923;69527.65236173787;70280;71398;10447.791044179074;10581.894181058246;10589.205809564313;10680.732981675364;10919.39943303126;18810.90594547046;18818.623627527373;19052.71420928687;19211.23155073809;19275.51811204703;7666.348360389318;7718.729844455417;7854.960725196452;7942.126366099725;8098.4331096823835;4501.977490112594;4578.336141259499;4614.215583350839;4631.58315751584;4684.461286951976;3112.7354174895386;3144.166795799115;3161.225499752575;3203.759718021158;3204.7436205103536;570.6290910907943;579.2383016333508;589.9793507227226;590.0735844723743;598.3537779198455;640.2764875690533;645.2772894358349;645.7352485480931;647.4496677823906;653.6306986552582;8583.742487725378;8695.08701586337;8793.780155496164;9009.369344145847;9175.541222938826;566.7959534567552;577.5927970780674;630.7256343490596;642.8039447968415;651.6826027567366;4286.314189729628;4394.274944634163;4567.840125595655;4595.4025976622825;4621.813080659539;76380.61809691027;77231;79692.60153699195;81920.18079819245;92411.53794230986;44930;49968.25047624289;62556.68721656362;62599;74511;65691;66533.33466665368;67006;67751;69464.30535694578;9467.810643787223;9925.602975881173;9967.900320996698;10098.394096353948;10112.24158188124;35841;39489.81530554088;44476.777616111714;44742.3288650677;45367.31949020701;54633;57033;63096;63664.68167659132;65896.67051664711;11786.46960886745;12151.149419540547;12294.754104917673;12350.567730129402;12860.871391285968;13847.41918600288;14055.297235138407;14209.573712788633;14381.64045898861;14621.122732636077;13056.608301750963;13436.93281533586;13674.726505470035;13782.310884455937;14342.426302947766;13021.153625014344;13237.404316805574;13280.269585172908;13362.732745345233;14180.929095354457;12631.431585578488;13142.60572182836;13155.802662960255;13180.340982950622;13485.662858428617;10244.487775611338;10722.356658600509;10839.187060970617;10946.179036572448;10946.562137514411;9407.918089419803;9916.752081198028;10855.40295283767;11294;11402.258853174517 13:08:47 INFO - PROCESS | 14285 | __end_tp_report 13:08:47 INFO - PROCESS | 14285 | __start_cc_report 13:08:47 INFO - PROCESS | 14285 | _x_x_mozilla_cycle_collect,336 13:08:47 INFO - PROCESS | 14285 | __end_cc_report 13:08:47 INFO - PROCESS | 14285 | __startTimestamp1477771727229__endTimestamp 13:08:47 INFO - PROCESS | 14285 | 13:08:47 INFO - PROCESS | 14285 | ------- Summary: start ------- 13:08:47 INFO - PROCESS | 14285 | Number of tests: 6 13:08:47 INFO - PROCESS | 14285 | 13:08:47 INFO - PROCESS | 14285 | [#0] dojo.html Cycles:165 Average:5124.78 Median:5319.71 stddev:556.71 (10.5%) stddev-sans-first:532.90 13:08:47 INFO - PROCESS | 14285 | Values: 3000.7 3002.9 3005.1 3006.9 3021.2 5102.1 5153.7 5175.6 5247.9 5280.4 5093.0 5103.1 5145.0 5162.1 5189.6 4699.0 4720.3 4801.7 4814.2 4905.6 4644.9 4674.0 4820.5 4833.2 4836.3 4527.8 4786.9 4792.7 4806.2 4900.6 4558.6 4666.3 4669.4 4742.1 4814.2 4697.6 4708.6 4724.1 4732.1 4773.7 5143.9 5156.8 5174.3 5204.7 5246.0 5331.1 5387.9 5430.2 5481.6 5516.1 5604.5 5607.4 5609.5 5609.7 5628.2 5187.8 5216.3 5243.2 5246.7 5296.2 5331.8 5400.6 5603.1 5615.5 5637.5 5407.0 5410.3 5425.6 5434.8 5484.4 5491.5 5506.0 5529.1 5541.6 5543.3 5184.4 5247.2 5261.8 5316.0 5321.7 5454.7 5549.4 5572.9 5596.5 5655.9 4307.2 4309.3 4312.1 4323.6 4361.7 3727.2 3844.8 3863.9 3873.5 3907.0 5054.1 5084.8 5100.2 5133.4 5142.7 5360.5 5394.2 5396.9 5405.3 5409.2 5109.8 5128.3 5133.3 5136.8 5137.3 4701.2 4722.9 4725.2 4728.0 4730.4 5512.9 5519.8 5531.3 5539.4 5554.2 5394.7 5398.8 5443.8 5549.0 5589.9 5740.2 5740.7 5746.0 5746.4 5798.2 5512.5 5518.3 5519.8 5525.2 5525.5 5319.7 5378.1 5462.1 5493.1 5500.7 5417.9 5422.6 5433.0 5453.8 5479.9 5387.4 5389.1 5417.5 5428.4 5465.6 5185.6 5286.0 5360.5 5386.6 5402.2 5400.1 5498.3 5502.3 5550.1 5552.2 5292.3 5382.3 5386.4 5399.3 5400.0 13:08:47 INFO - PROCESS | 14285 | 13:08:47 INFO - PROCESS | 14285 | [#1] ext.html Cycles:180 Average:51816.25 Median:40258.10 stddev:93914.03 (233.3%) stddev-sans-first:94098.69 13:08:47 INFO - PROCESS | 14285 | Values: 580.2 581.3 589.5 596.9 631.9 37996.4 41800.8 41853.0 41884.8 42063.6 41522.2 42133.8 42144.4 42173.8 42270.0 8694.5 8890.2 8911.3 8912.5 8915.2 8678.6 8688.2 8717.7 8751.5 8767.6 8752.0 8759.8 8786.2 8807.9 8831.2 8720.3 8726.7 8770.1 8770.5 8810.4 8624.4 8658.6 8697.3 8702.4 8711.7 39715.4 40041.8 40076.4 40178.0 40278.6 3525.0 3528.0 3614.1 3676.6 3700.5 31108.7 31270.9 31457.8 31522.4 33105.7 4311.1 4384.1 4505.2 4586.5 4642.1 323649.0 328983.0 329668.0 331382.0 332117.0 55405.4 55647.4 55984.7 56140.2 56368.7 58420.0 58539.0 58621.4 59188.7 59368.0 16648.2 16831.6 16850.5 16888.4 16964.1 12508.0 12585.7 12624.4 12629.1 12706.4 16016.5 16098.0 16123.5 16291.3 16440.8 6031.8 6053.0 6144.3 6321.4 6341.7 967.9 1049.9 1073.5 1084.9 1171.6 31855.5 31999.8 32182.4 32496.7 32653.0 1116.9 1122.7 1130.2 1145.8 1217.9 16385.2 16895.9 16904.0 16908.0 17048.4 250174.0 252698.0 253424.0 253653.0 254093.0 56547.3 56803.7 57263.0 57399.7 57435.0 1267.5 1337.4 1347.1 1364.6 1365.1 29983.3 30811.4 31745.5 31782.5 31833.6 50694.2 50991.7 51369.7 51462.0 51567.7 451734.0 456195.0 456606.0 457281.0 458946.0 27427.7 27578.0 27697.6 27789.6 27914.2 45845.8 46942.5 47400.5 48403.3 48461.3 39127.6 41688.7 41706.6 41946.6 42368.5 39025.6 39918.8 39998.4 40332.2 40679.6 39964.0 40141.6 40237.6 40291.4 40331.4 34180.7 36231.5 36420.6 37016.8 37056.3 27898.2 28061.0 28328.3 28502.7 28735.0 13:08:47 INFO - PROCESS | 14285 | 13:08:47 INFO - PROCESS | 14285 | [#2] jquery.html Cycles:180 Average:28650.71 Median:31315.53 stddev:73457.74 (234.6%) stddev-sans-first:73633.13 13:08:47 INFO - PROCESS | 14285 | Values: 373.3 388.5 395.9 401.7 414.7 17874.2 19050.3 19383.6 19439.8 20044.2 17809.3 17833.6 18290.1 19238.6 19536.3 5528.8 5608.0 5701.5 5760.3 5833.9 5602.5 5643.0 5657.6 5710.4 5710.5 5619.6 5645.8 5672.1 5898.1 5930.3 5944.0 5948.0 5960.9 5966.6 5985.4 5639.3 5782.7 5806.9 5812.8 5825.8 13630.9 13879.9 17607.6 22728.5 23082.7 2257.6 2268.6 2340.2 2422.4 2505.2 10156.0 10273.8 10638.8 12081.7 14910.8 1916.6 2004.3 2140.4 2253.9 2307.8 90012.5 94559.0 97091.0 98623.5 99645.0 16554.8 17180.7 17456.3 17479.2 17890.4 30808.4 31042.8 31135.4 31227.5 31403.5 9695.6 10001.7 10047.4 10088.3 10315.5 8346.7 8432.2 8483.5 8514.4 8710.7 8448.3 8596.4 8793.6 8870.6 8875.3 3163.8 3375.4 3466.7 3518.8 3572.8 927.6 980.9 1010.7 1023.8 1024.7 18065.5 18944.6 19322.8 19425.0 19744.0 960.9 975.8 986.2 1015.4 1037.1 10310.0 10518.6 10749.3 10801.0 10805.7 439630.0 440355.0 440759.0 445895.0 446517.7 87035.0 90941.0 91303.0 92084.0 92554.0 1018.7 1029.0 1044.1 1074.2 1084.2 16383.8 16429.2 16648.4 17099.7 17148.3 39601.0 40232.8 40691.8 41182.0 43301.4 54203.5 55646.7 56351.7 57071.7 57517.7 8360.3 8467.0 8571.8 8703.0 8790.7 12816.7 13030.5 13046.3 13114.4 13335.7 11318.8 11363.5 11364.3 11868.3 11881.9 7074.6 10976.2 11055.9 11301.8 11635.5 11310.4 11381.5 12007.3 12040.7 12071.8 8445.3 8460.5 8495.7 8574.2 8924.3 9940.4 11188.0 11229.7 11377.5 11634.4 13:08:47 INFO - PROCESS | 14285 | 13:08:47 INFO - PROCESS | 14285 | [#3] mootools.html Cycles:180 Average:5262.61 Median:5058.37 stddev:2888.47 (57.1%) stddev-sans-first:2882.30 13:08:47 INFO - PROCESS | 14285 | Values: 1442.7 1475.3 1595.9 1668.3 1743.1 7084.4 7332.4 7542.2 8003.8 8008.0 7392.4 7663.2 7700.8 7868.9 7887.0 2220.9 2244.1 2248.8 2252.8 2254.2 2221.6 2255.5 2281.7 2285.9 2289.6 2222.8 2236.1 2244.6 2250.7 2267.9 2199.5 2215.3 2219.4 2230.9 2232.8 2170.6 2172.4 2207.0 2207.0 2223.4 7990.7 8056.2 8060.0 8063.8 8091.1 4805.0 4957.3 4967.8 4975.4 4983.2 3127.0 3132.3 3346.4 3385.9 3408.2 1071.7 1073.6 1105.7 1125.3 1148.6 10764.7 10802.6 10820.5 10857.6 10881.8 4162.1 4354.6 4395.7 4406.5 4475.2 9211.3 9228.5 9230.5 9242.3 9243.6 5028.4 5036.2 5048.6 5048.9 5049.9 3888.2 4277.6 4562.1 4582.3 4666.0 3609.2 3697.1 3700.3 3775.4 3815.8 1199.8 1209.4 1212.6 1224.2 1251.2 849.7 867.6 879.3 879.8 884.1 5023.7 5066.8 5106.5 5273.8 5294.9 895.2 914.2 944.4 947.4 973.8 3523.7 3577.9 3609.4 3633.0 3712.2 9553.2 9790.0 9904.3 9917.1 9926.4 9071.1 9789.4 9819.8 9846.3 9860.1 7218.1 7344.1 7354.3 7373.0 7384.7 5221.9 5341.7 5358.4 5386.4 5479.6 8837.1 8937.0 8965.6 8984.4 9062.9 9135.6 9173.2 9183.6 9206.3 9356.2 6479.5 6694.9 6746.3 6901.6 6992.1 7465.1 7711.8 7744.8 7896.0 7912.7 6958.8 7074.3 7109.9 7163.2 7272.3 6953.8 7082.2 7084.9 7109.1 7157.6 6011.5 6162.6 6278.4 6278.5 6296.9 4693.6 4730.9 4795.8 4806.2 4818.5 4469.0 4513.8 4614.8 4708.0 4841.2 13:08:47 INFO - PROCESS | 14285 | 13:08:47 INFO - PROCESS | 14285 | [#4] prototype.html Cycles:180 Average:4751.83 Median:5323.29 stddev:1412.93 (26.5%) stddev-sans-first:1377.32 13:08:47 INFO - PROCESS | 14285 | Values: 327.6 332.9 338.4 338.7 346.1 5476.5 5532.6 5542.8 5550.8 5556.5 5456.5 5459.7 5471.6 5484.9 5485.0 4190.9 4242.6 4267.5 4291.9 4311.3 4290.7 4305.4 4313.4 4321.6 4338.5 4278.4 4282.4 4285.9 4291.2 4301.9 4097.4 4185.9 4192.5 4220.1 4291.4 3701.6 3708.3 3713.2 3717.4 3727.2 5324.0 5367.9 5390.0 5407.3 5426.4 4782.5 4818.5 4845.6 4852.2 4871.6 5683.7 5684.2 5684.4 5712.7 5718.9 4085.9 4093.3 4094.8 4100.6 4101.3 5759.7 5951.2 5956.2 5958.5 5987.6 4164.2 4166.2 4173.8 4187.4 4187.6 4208.3 4239.0 4250.9 4266.4 4272.9 4688.6 4821.3 4861.9 4871.0 4879.0 5835.5 5841.3 5850.4 5869.6 5871.8 1476.7 1477.7 1478.1 1478.9 1479.0 884.7 931.1 936.9 938.2 946.7 4871.5 4898.8 4899.4 4915.8 4925.8 5085.6 5173.2 5177.7 5187.0 5196.5 4521.3 4817.6 4865.2 4865.3 4899.2 2752.3 2757.4 2765.8 2769.7 2780.6 5277.8 5305.3 5314.5 5322.5 5343.3 5263.0 5264.2 5630.9 5986.5 6097.2 6039.3 6060.0 6159.2 6170.7 6173.4 5643.7 5975.0 5982.4 5983.3 5985.0 5789.2 5867.0 5868.3 5891.2 5900.2 6116.7 6122.0 6142.8 6151.4 6152.4 4127.8 4203.7 4204.0 4222.4 4227.5 5913.4 5917.8 5944.0 5953.1 5961.8 5656.7 5788.9 5813.4 5848.5 5854.4 5750.3 5765.5 5802.6 5806.9 5811.6 5762.8 5772.2 5779.7 5782.9 5823.1 5581.8 5647.9 5708.8 5820.5 5857.6 5624.3 5676.2 5678.5 5682.3 5689.3 13:08:47 INFO - PROCESS | 14285 | 13:08:47 INFO - PROCESS | 14285 | [#5] yui.html Cycles:180 Average:17081.65 Median:4608.82 stddev:22062.86 (478.7%) stddev-sans-first:22090.59 13:08:47 INFO - PROCESS | 14285 | Values: 731.3 739.3 746.8 807.7 823.6 13898.6 14538.8 14541.9 14545.1 14559.5 14573.6 14798.4 14818.3 14826.1 14844.3 783.6 797.5 800.1 802.7 803.2 798.6 806.4 807.6 808.7 809.4 844.4 847.4 848.7 849.2 851.3 832.1 836.8 840.2 841.2 846.1 621.1 621.4 623.6 624.3 624.7 12487.6 12493.3 12499.2 12554.6 13226.4 12592.7 12674.5 12732.4 12882.0 13283.3 12523.0 12574.9 12648.3 12719.2 13017.4 4374.8 4389.6 4400.8 4608.4 4609.3 67888.7 67923.0 69527.7 70280.0 71398.0 10447.8 10581.9 10589.2 10680.7 10919.4 18810.9 18818.6 19052.7 19211.2 19275.5 7666.3 7718.7 7855.0 7942.1 8098.4 4502.0 4578.3 4614.2 4631.6 4684.5 3112.7 3144.2 3161.2 3203.8 3204.7 570.6 579.2 590.0 590.1 598.4 640.3 645.3 645.7 647.4 653.6 8583.7 8695.1 8793.8 9009.4 9175.5 566.8 577.6 630.7 642.8 651.7 4286.3 4394.3 4567.8 4595.4 4621.8 76380.6 77231.0 79692.6 81920.2 92411.5 44930.0 49968.3 62556.7 62599.0 74511.0 65691.0 66533.3 67006.0 67751.0 69464.3 9467.8 9925.6 9967.9 10098.4 10112.2 35841.0 39489.8 44476.8 44742.3 45367.3 54633.0 57033.0 63096.0 63664.7 65896.7 11786.5 12151.1 12294.8 12350.6 12860.9 13847.4 14055.3 14209.6 14381.6 14621.1 13056.6 13436.9 13674.7 13782.3 14342.4 13021.2 13237.4 13280.3 13362.7 14180.9 12631.4 13142.6 13155.8 13180.3 13485.7 10244.5 10722.4 10839.2 10946.2 10946.6 9407.9 9916.8 10855.4 11294.0 11402.3 13:08:47 INFO - PROCESS | 14285 | -------- Summary: end -------- 13:08:47 INFO - PROCESS | 14285 | 13:08:48 INFO - TEST-INFO | 14285: exit 0 13:08:48 INFO - TEST-OK | dromaeo_css | took 1115757ms 13:08:48 INFO - TEST-START | kraken 13:08:48 INFO - operating with platform_type : linux_ 13:08:48 INFO - Initialising browser for kraken test... 13:08:48 INFO - TEST-INFO | started process 14637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmywDWZ/profile http://localhost:34841/getInfo.html) 13:08:52 INFO - PROCESS | 14637 | __metrics Screen width/height:1600/1200 13:08:52 INFO - PROCESS | 14637 | colorDepth:24 13:08:52 INFO - PROCESS | 14637 | Browser inner width/height: 1024/697 13:08:52 INFO - PROCESS | 14637 | __metrics 13:08:53 ERROR - PROCESS | 14637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 13:08:54 INFO - TEST-INFO | 14637: exit 0 13:08:54 INFO - Browser initialized. 13:08:54 INFO - Running cycle 1/1 for kraken test... 13:08:54 INFO - TEST-INFO | started process 14761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmywDWZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:06 INFO - PROCESS | 14761 | RSS: Main: 185831424 13:09:06 INFO - PROCESS | 14761 | 13:09:09 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34841/tests/kraken/driver.html?testName=audio-beat-detection) 13:09:10 INFO - PROCESS | 14761 | RSS: Main: 198520832 13:09:10 INFO - PROCESS | 14761 | 13:09:13 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34841/tests/kraken/driver.html?testName=audio-dft) 13:09:13 INFO - PROCESS | 14761 | RSS: Main: 196546560 13:09:13 INFO - PROCESS | 14761 | 13:09:16 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34841/tests/kraken/driver.html?testName=audio-fft) 13:09:17 INFO - PROCESS | 14761 | RSS: Main: 193056768 13:09:17 INFO - PROCESS | 14761 | 13:09:19 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34841/tests/kraken/driver.html?testName=audio-oscillator) 13:09:19 INFO - PROCESS | 14761 | RSS: Main: 193974272 13:09:19 INFO - PROCESS | 14761 | 13:09:22 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34841/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:09:22 INFO - PROCESS | 14761 | RSS: Main: 193966080 13:09:22 INFO - PROCESS | 14761 | 13:09:25 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34841/tests/kraken/driver.html?testName=imaging-darkroom) 13:09:26 INFO - PROCESS | 14761 | RSS: Main: 194424832 13:09:26 INFO - PROCESS | 14761 | 13:09:29 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34841/tests/kraken/driver.html?testName=imaging-desaturate) 13:09:30 INFO - PROCESS | 14761 | RSS: Main: 194592768 13:09:30 INFO - PROCESS | 14761 | 13:09:33 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34841/tests/kraken/driver.html?testName=json-parse-financial) 13:09:33 INFO - PROCESS | 14761 | RSS: Main: 194359296 13:09:33 INFO - PROCESS | 14761 | 13:09:35 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34841/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:09:35 INFO - PROCESS | 14761 | RSS: Main: 194162688 13:09:35 INFO - PROCESS | 14761 | 13:09:37 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34841/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:09:38 INFO - PROCESS | 14761 | RSS: Main: 194273280 13:09:38 INFO - PROCESS | 14761 | 13:09:40 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34841/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:09:41 INFO - PROCESS | 14761 | RSS: Main: 194179072 13:09:41 INFO - PROCESS | 14761 | 13:09:43 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34841/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:09:44 INFO - PROCESS | 14761 | RSS: Main: 194449408 13:09:44 INFO - PROCESS | 14761 | 13:09:47 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34841/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:09:48 INFO - PROCESS | 14761 | RSS: Main: 194633728 13:09:48 INFO - PROCESS | 14761 | 13:09:49 INFO - PROCESS | 14761 | Cycle 1(1): loaded http://localhost:34841/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34841/tests/kraken/driver.html?testName=ai-astar) 13:09:50 INFO - PROCESS | 14761 | RSS: Main: 196026368 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | __start_tp_report 13:09:50 INFO - PROCESS | 14761 | _x_x_mozilla_page_load 13:09:50 INFO - PROCESS | 14761 | _x_x_mozilla_page_load_details 13:09:50 INFO - PROCESS | 14761 | |i|pagename|runs| 13:09:50 INFO - PROCESS | 14761 | |0;ai-astar;107;111;114;111;113;111;117;111;111;113 13:09:50 INFO - PROCESS | 14761 | |1;audio-beat-detection;157;125;123;181;127;124;125;124;159;131 13:09:50 INFO - PROCESS | 14761 | |2;audio-dft;165;165;161;166;171;164;162;162;160;163 13:09:50 INFO - PROCESS | 14761 | |3;audio-fft;77;77;76;111;76;77;76;76;110;76 13:09:50 INFO - PROCESS | 14761 | |4;audio-oscillator;84;85;113;83;83;82;104;85;83;123 13:09:50 INFO - PROCESS | 14761 | |5;imaging-gaussian-blur;119;119;118;119;118;117;119;117;119;117 13:09:50 INFO - PROCESS | 14761 | |6;imaging-darkroom;147;147;148;147;146;147;147;147;148;146 13:09:50 INFO - PROCESS | 14761 | |7;imaging-desaturate;85;85;86;85;86;85;85;85;85;85 13:09:50 INFO - PROCESS | 14761 | |8;json-parse-financial;53;55;54;52;55;54;55;55;55;55 13:09:50 INFO - PROCESS | 14761 | |9;json-stringify-tinderbox;61;61;61;60;66;60;62;61;61;61 13:09:50 INFO - PROCESS | 14761 | |10;stanford-crypto-aes;80;82;87;81;80;81;80;80;79;79 13:09:50 INFO - PROCESS | 14761 | |11;stanford-crypto-ccm;145;140;137;133;138;136;142;136;176;129 13:09:50 INFO - PROCESS | 14761 | |12;stanford-crypto-pbkdf2;177;169;185;183;168;167;167;167;171;173 13:09:50 INFO - PROCESS | 14761 | |13;stanford-crypto-sha256-iterative;65;73;65;64;65;64;64;67;67;73 13:09:50 INFO - PROCESS | 14761 | __end_tp_report 13:09:50 INFO - PROCESS | 14761 | __start_cc_report 13:09:50 INFO - PROCESS | 14761 | _x_x_mozilla_cycle_collect,783 13:09:50 INFO - PROCESS | 14761 | __end_cc_report 13:09:50 INFO - PROCESS | 14761 | __startTimestamp1477771790010__endTimestamp 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | ------- Summary: start ------- 13:09:50 INFO - PROCESS | 14761 | Number of tests: 14 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:2.60 (2.3%) stddev-sans-first:2.07 13:09:50 INFO - PROCESS | 14761 | Values: 107.0 111.0 114.0 111.0 113.0 111.0 117.0 111.0 111.0 113.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:129.00 stddev:20.48 (15.9%) stddev-sans-first:20.48 13:09:50 INFO - PROCESS | 14761 | Values: 157.0 125.0 123.0 181.0 127.0 124.0 125.0 124.0 159.0 131.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.50 stddev:3.14 (1.9%) stddev-sans-first:3.31 13:09:50 INFO - PROCESS | 14761 | Values: 165.0 165.0 161.0 166.0 171.0 164.0 162.0 162.0 160.0 163.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:14.40 (18.9%) stddev-sans-first:15.10 13:09:50 INFO - PROCESS | 14761 | Values: 77.0 77.0 76.0 111.0 76.0 77.0 76.0 76.0 110.0 76.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:83.00 stddev:15.09 (18.2%) stddev-sans-first:15.69 13:09:50 INFO - PROCESS | 14761 | Values: 84.0 85.0 113.0 83.0 83.0 82.0 104.0 85.0 83.0 123.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:119.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 13:09:50 INFO - PROCESS | 14761 | Values: 119.0 119.0 118.0 119.0 118.0 117.0 119.0 117.0 119.0 117.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:09:50 INFO - PROCESS | 14761 | Values: 147.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 148.0 146.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 13:09:50 INFO - PROCESS | 14761 | Values: 85.0 85.0 86.0 85.0 86.0 85.0 85.0 85.0 85.0 85.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.01 13:09:50 INFO - PROCESS | 14761 | Values: 53.0 55.0 54.0 52.0 55.0 54.0 55.0 55.0 55.0 55.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:1.71 (2.8%) stddev-sans-first:1.81 13:09:50 INFO - PROCESS | 14761 | Values: 61.0 61.0 61.0 60.0 66.0 60.0 62.0 61.0 61.0 61.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:2.33 (2.9%) stddev-sans-first:2.45 13:09:50 INFO - PROCESS | 14761 | Values: 80.0 82.0 87.0 81.0 80.0 81.0 80.0 80.0 79.0 79.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:139.00 stddev:13.02 (9.4%) stddev-sans-first:13.74 13:09:50 INFO - PROCESS | 14761 | Values: 145.0 140.0 137.0 133.0 138.0 136.0 142.0 136.0 176.0 129.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:172.00 stddev:6.77 (3.9%) stddev-sans-first:7.00 13:09:50 INFO - PROCESS | 14761 | Values: 177.0 169.0 185.0 183.0 168.0 167.0 167.0 167.0 171.0 173.0 13:09:50 INFO - PROCESS | 14761 | 13:09:50 INFO - PROCESS | 14761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:3.50 (5.3%) stddev-sans-first:3.66 13:09:50 INFO - PROCESS | 14761 | Values: 65.0 73.0 65.0 64.0 65.0 64.0 64.0 67.0 67.0 73.0 13:09:50 INFO - PROCESS | 14761 | -------- Summary: end -------- 13:09:50 INFO - PROCESS | 14761 | 13:09:51 INFO - TEST-INFO | 14761: exit 0 13:09:51 INFO - TEST-OK | kraken | took 62921ms 13:09:51 INFO - SUITE-END | took 1178s 13:09:51 INFO - Completed test suite (00:19:39) 13:09:51 INFO - javascript benchmark 13:09:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7072.250546773925, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3000.654924683662, 3002.864871080801, 3005.053408176426, 3006.8797248110072, 3021.2295864554535, 5102.081625307453, 5153.716545589996, 5175.560077393421, 5247.921281180776, 5280.392754833195, 5092.974535127329, 5103.106956282654, 5145.022445735308, 5162.070827251093, 5189.558887494568, 4698.953010469902, 4720.33915251865, 4801.73590452525, 4814.1575224335775, 4905.583025442842, 4644.883877903046, 4673.953260467403, 4820.542048505386, 4833.202521583935, 4836.274558816171, 4527.796249168795, 4786.904261914742, 4792.688475249132, 4806.231003039515, 4900.558949694527, 4558.635309175258, 4666.32338310943, 4669.439667239919, 4742.1227072991605, 4814.181589129821, 4697.600703940169, 4708.552687494683, 4724.078804633098, 4732.100900828831, 4773.665843390964, 5143.871403214912, 5156.767945442464, 5174.301469301634, 5204.719634993678, 5246.0, 5331.067063263952, 5387.9461205388225, 5430.239766432703, 5481.643693159972, 5516.089845175541, 5604.467575580314, 5607.355154157283, 5609.467100625475, 5609.663420194802, 5628.240187574707, 5187.766550505236, 5216.3218781558535, 5243.213517972296, 5246.658967167122, 5296.179092240709, 5331.813386531453, 5400.594955378362, 5603.075492543685, 5615.466530679579, 5637.548996080303, 5406.972965135149, 5410.296661433988, 5425.593080518976, 5434.809781657623, 5484.369297530755, 5491.478309560585, 5506.03644362243, 5529.060059789765, 5541.6120871539415, 5543.279373681396, 5184.429712731597, 5247.1866860636665, 5261.76322065508, 5315.973420132875, 5321.707306098125, 5454.727263636882, 5549.417311182348, 5572.916406253909, 5596.524295434933, 5655.886882262332, 4307.160103779733, 4309.267424537836, 4312.116016216668, 4323.567643235651, 4361.6510679145595, 3727.161388687578, 3844.750091244116, 3863.864764733221, 3873.477080594084, 3907.0427745202605, 5054.09026375256, 5084.847454576368, 5100.209467532539, 5133.409657889316, 5142.6914385137015, 5360.544353729899, 5394.244805727201, 5396.865078372994, 5405.324334458192, 5409.215663728737, 5109.795608175706, 5128.307678463434, 5133.332666753298, 5136.845894623092, 5137.33214682089, 4701.153792317347, 4722.881927951828, 4725.243960966229, 4728.0, 4730.361401210861, 5512.91730624041, 5519.806806761744, 5531.308586426697, 5539.362973258047, 5554.166874968787, 5394.676319420847, 5398.757055932414, 5443.8094666686475, 5549.0289199389135, 5589.888202236014, 5740.196372507936, 5740.741666624928, 5745.994450971147, 5746.396628353963, 5798.188253644577, 5512.5314348280845, 5518.255035570147, 5519.806806761744, 5525.171224316385, 5525.530329922001, 5319.707416092152, 5378.112611419072, 5462.126059830408, 5493.066178749702, 5500.669959802424, 5417.891642167214, 5422.566194704335, 5432.972835135799, 5453.809116680897, 5479.890402192013, 5387.380451248, 5389.083855744454, 5417.539509141609, 5428.402875683592, 5465.644733092496, 5185.637005409585, 5286.048511268009, 5360.544353729977, 5386.649867758583, 5402.216678581663, 5400.1089820180805, 5498.257735205696, 5502.339719233718, 5550.084236100998, 5552.194931734956, 5292.285541452009, 5382.273393091882, 5386.434424385383, 5399.2980912481125, 5399.973000134974], "value": 5088.799083017807, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.1587697838136, 581.2995340614558, 589.4694774702768, 596.9164316995618, 631.8609905820723, 37996.430053549186, 41800.790996045056, 41853.0, 41884.79057604712, 42063.57936420635, 41522.169556608926, 42133.78933105338, 42144.36783448251, 42173.78913105438, 42270.0, 8694.478331300143, 8890.155435233675, 8911.331650126234, 8912.509811960339, 8915.153060459246, 8678.566071696421, 8688.174623410765, 8717.694880679177, 8751.518666473341, 8767.649294028231, 8751.956240218822, 8759.824803503958, 8786.16531429513, 8807.911920880773, 8831.16103970125, 8720.29954158936, 8726.738197854074, 8770.079141690127, 8770.473771573726, 8810.427322224035, 8624.439411438236, 8658.610362533702, 8697.304215662733, 8702.390832641717, 8711.651533938699, 39715.40426893599, 40041.79979100115, 40076.398854017214, 40178.0, 40278.59721402778, 3524.9823750881337, 3527.982360088183, 3614.0784100054316, 3676.5955744868043, 3700.50043244164, 31108.688913111033, 31270.905518306976, 31457.8427107863, 31522.36955260905, 33105.66894331074, 4311.137772445523, 4384.101259241847, 4505.166544189336, 4586.472555656109, 4642.117997580449, 323649.0, 328983.0, 329668.0, 331382.0, 332117.0, 55405.44594554003, 55647.44352556504, 55984.72007639936, 56140.157897631565, 56368.718156408955, 58420.0, 58539.0, 58621.413785861594, 59188.704056479444, 59368.0, 16648.16759162061, 16831.57921051959, 16850.494485165465, 16888.40890568824, 16964.066976316175, 12508.0, 12585.685357866127, 12624.368781560885, 12629.115961882764, 12706.428210730539, 16016.519504414886, 16098.0, 16123.53344031039, 16291.266892989845, 16440.75338869918, 6031.849203769941, 6053.00125479291, 6144.262688477412, 6321.367863213642, 6341.682915854189, 967.9274054445804, 1049.8950104989592, 1073.544789125137, 1084.8752393474851, 1171.6426489920486, 31855.482788914847, 31999.840000799846, 32182.35635287328, 32496.675033249365, 32653.0, 1116.916231282657, 1122.7193201699574, 1130.1862658885589, 1145.7765735681628, 1217.9208351457128, 16385.180740963144, 16895.91552042232, 16904.0, 16908.0, 17048.403305884483, 250174.0, 252698.0, 253424.0, 253653.0, 254093.0, 56547.303580892636, 56803.71598142065, 57263.0, 57399.713001435564, 57435.0, 1267.4866678995022, 1337.3513845784787, 1347.1311004402105, 1364.5769811358512, 1365.1263191557412, 29983.250418739706, 30811.383772324876, 31745.523817143225, 31782.523262150622, 31833.62391033624, 50694.23958640697, 50991.74504127455, 51369.7431512855, 51462.0, 51567.74216128895, 451734.0, 456195.0, 456606.0, 457281.0, 458946.0, 27427.725722743315, 27578.0, 27697.58453623157, 27789.58315625227, 27914.16257512278, 45845.77077114593, 46942.53057469382, 47400.52599473961, 48403.27395089147, 48461.27308090452, 39127.60872391354, 41688.70183295996, 41706.58293417027, 41946.58053419427, 42368.457892526545, 39025.6097439022, 39918.80040599895, 39998.400103993146, 40332.1933561333, 40679.59320406758, 39964.0, 40141.59858401495, 40237.59762402456, 40291.39562906617, 40331.395029075175, 34180.658193417745, 36231.456528151575, 36420.635793641726, 37016.81491592525, 37056.25887482181, 27898.16305510838, 28061.0, 28328.291792705346, 28502.714972850004, 28735.0], "value": 19355.66184658199, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.2926105030966, 388.45034276498757, 395.90498280412703, 401.7167896632874, 414.72835292883155, 17874.195661195245, 19050.33323833666, 19383.612327753435, 19439.805601943994, 20044.1982320707, 17809.287628494843, 17833.554161145978, 18290.085495725227, 19238.615227695438, 19536.31622893199, 5528.75120619572, 5608.0, 5701.543876489871, 5760.251167348239, 5833.941660583382, 5602.4957753802355, 5642.999999999979, 5657.632253903504, 5710.428957104298, 5710.514606258473, 5619.550435965113, 5645.830625081254, 5672.06410942194, 5898.085796701518, 5930.258717660293, 5944.048952167675, 5948.0, 5960.910586341209, 5966.642001479925, 5985.401459854002, 5639.295088113986, 5782.681952492611, 5806.912896306559, 5812.767489300423, 5825.825225243207, 13630.863691363058, 13879.861201387957, 17607.647847042987, 22728.54542909149, 23082.65376019361, 2257.5710614983263, 2268.5689718953345, 2340.2394221877958, 2422.4200383061957, 2505.1983365323103, 10156.0, 10273.845892311621, 10638.840417393745, 12081.697957551043, 14910.776338354934, 1916.57835276239, 2004.2984955265686, 2140.4327853118934, 2253.864768113902, 2307.8153747700144, 90012.54993725054, 94559.0, 97091.0, 98623.50688246512, 99645.0, 16554.751678724828, 17180.742288865677, 17456.30174792994, 17479.21343539544, 17890.373836915645, 30808.383832323227, 31042.84478577638, 31135.377292454024, 31227.531587026213, 31403.528947065814, 9695.61217551304, 10001.699949001542, 10047.447390393598, 10088.293819432569, 10315.48422578883, 8346.707865224687, 8432.156784321518, 8483.490990540464, 8514.403991720521, 8710.69512567057, 8448.32413406926, 8596.398252122292, 8793.604287807064, 8870.64517419296, 8875.28997680184, 3163.8418079095954, 3375.4261775498226, 3466.705330046924, 3518.8240587971013, 3572.821358932095, 927.5779520318239, 980.9068138526972, 1010.6715317521688, 1023.7798873242289, 1024.7233247023412, 18065.54836129081, 18944.621107577772, 19322.80677193238, 19425.0, 19744.0, 960.9279304052224, 975.8292298847673, 986.2061040862031, 1015.355249416611, 1037.092544023979, 10310.0, 10518.631847885441, 10749.301295415773, 10801.0, 10805.729856753644, 439630.0, 440355.0, 440759.0, 445895.01884303015, 446517.6504701936, 87035.0, 90941.0, 91303.0, 92084.0, 92554.0, 1018.7453136715822, 1028.9897101029044, 1044.1229367331478, 1074.248026381536, 1084.1543595995136, 16383.836161638232, 16429.212558206196, 16648.417305394254, 17099.7435038477, 17148.314067437164, 39601.0, 40232.79883600563, 40691.7965410171, 41182.0, 43301.35047974346, 54203.45796541984, 55646.72176639091, 56351.71824141017, 57071.71464142653, 57517.71241143768, 8360.28937540316, 8466.983961924609, 8571.785705357415, 8703.0, 8790.692325768567, 12816.743665126833, 13030.54393096237, 13046.282454465096, 13114.409851556513, 13335.733285334045, 11318.773624527628, 11363.54545818158, 11364.261323013978, 11868.287902725864, 11881.940590296994, 7074.646267686698, 10976.176786741185, 11055.949684779933, 11301.830472543083, 11635.534578617098, 11310.377929213972, 11381.54473821038, 12007.339596322287, 12040.698982525508, 12071.75856482883, 8445.282151017233, 8460.492370457792, 8495.74512764618, 8574.22831945103, 8924.286057115545, 9940.353876997971, 11188.0, 11229.71925701864, 11377.4880130396, 11634.36011019402], "value": 9866.337075349187, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.668186317147, 1475.3213521779978, 1595.8643515301198, 1668.2576253567152, 1743.1174331721734, 7084.433245340373, 7332.413406927446, 7542.170361260264, 8003.83992320154, 8008.039035315763, 7392.371648409879, 7663.15705272421, 7700.845983080335, 7868.881966770488, 7887.0, 2220.888955552224, 2244.0574958517464, 2248.820094392453, 2252.7521972583004, 2254.233560589399, 2221.577900198957, 2255.4699645583273, 2281.6919715838317, 2285.942851428711, 2289.553537060274, 2222.8332875034357, 2236.1167338901205, 2244.551089782042, 2250.7411647660483, 2267.9433014174697, 2199.5051113499494, 2215.3132528916008, 2219.4340443186966, 2230.933072007826, 2232.8325375596896, 2170.576737536181, 2172.446026263293, 2206.9668954965687, 2206.9889650551645, 2223.4107961390246, 7990.720324788663, 8056.194380561956, 8060.0, 8063.758087257392, 8091.109977902426, 4804.975975120137, 4957.256411538262, 4967.826126085606, 4975.353204083446, 4983.202687569971, 3127.014990278055, 3132.263917979273, 3346.397648423283, 3385.8814941477176, 3408.199073217792, 1071.6677829872765, 1073.581303291717, 1105.6793529876406, 1125.2798209146072, 1148.6266963236899, 10764.677059688222, 10802.5678972841, 10820.513076911559, 10857.565697372174, 10881.83677244834, 4162.1259535497275, 4354.629856462237, 4395.7362558246605, 4406.537313582092, 4475.194464996332, 9211.309151813506, 9228.49243291612, 9230.49232292217, 9242.306826988002, 9243.630254789734, 5028.396592408862, 5036.219385995177, 5048.62135339851, 5048.924266136011, 5049.9495005049475, 3888.202918401721, 4277.572242775697, 4562.064776720765, 4582.289745089516, 4666.043461090469, 3609.1698909250495, 3697.149655579232, 3700.296943580711, 3775.3770627846097, 3815.847366105325, 1199.802032664618, 1209.3771707570609, 1212.563477148226, 1224.161449407159, 1251.1742250115062, 849.6516428264506, 867.6355930509201, 879.3448880584006, 879.8108406692592, 884.1026358246385, 5023.673461225008, 5066.797328106908, 5106.463821298785, 5273.815416460406, 5294.867628309246, 895.1853813030111, 914.1772404835568, 944.3719926248967, 947.3605316411395, 973.776031512756, 3523.735719821024, 3577.856885724542, 3609.3683605368956, 3632.9636703633155, 3712.201876596545, 9553.187979021723, 9789.951050244703, 9904.306698531034, 9917.107460328605, 9926.404415735078, 9071.138241867013, 9789.363691360039, 9819.75450613726, 9846.310758246855, 9860.112589866947, 7218.097737782778, 7344.118705755343, 7354.338109570164, 7372.96313518429, 7384.741534046282, 5221.947780522298, 5341.679499230058, 5358.437364076716, 5386.407495175606, 5479.6164268500825, 8837.116288371368, 8936.955315223382, 8965.641374345214, 8984.371094023356, 9062.909370906207, 9135.63457461694, 9173.174414302744, 9183.632654693738, 9206.309526785384, 9356.157945784911, 6479.514036447191, 6694.899576506259, 6746.325367463214, 6901.585904845524, 6992.0910281663055, 7465.141508726566, 7711.845763084595, 7744.7676569703, 7896.012998375203, 7912.683492660229, 6958.756443524452, 7074.292570742885, 7109.8578028438105, 7163.212046674757, 7272.345488906024, 6953.826154346182, 7082.150141982995, 7084.893726594002, 7109.146902371748, 7157.57054576727, 6011.549133815069, 6162.630242185304, 6278.434940855345, 6278.497720182283, 6296.874062518816, 4693.624510039121, 4730.881727956691, 4795.784189711541, 4806.158922188673, 4818.494058123987, 4469.0, 4513.796879140512, 4614.815407383667, 4708.034852855225, 4841.225403935354], "value": 4282.650160686239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.6101439287248, 332.9379280096492, 338.3942742490941, 338.72976338729774, 346.11049602521496, 5476.452354764527, 5532.585056120787, 5542.806001789938, 5550.750216240273, 5556.499915007648, 5456.48163424474, 5459.672419654824, 5471.5896307776975, 5484.890302193964, 5485.0, 4190.937135942948, 4242.575742425748, 4267.530571637133, 4291.892702682427, 4311.267084595611, 4290.734233401138, 4305.397244385773, 4313.4176886120285, 4321.611055005049, 4338.522762496123, 4278.4010238566625, 4282.379055037033, 4285.871423857274, 4291.163223171483, 4301.935470967938, 4097.377678285914, 4185.916281674349, 4192.538820729717, 4220.092680073799, 4291.35629655551, 3701.648343407372, 3708.3485308004906, 3713.2387860488534, 3717.423799311111, 3727.1986522897437, 5324.041672498949, 5367.892642147174, 5390.0, 5407.324084489439, 5426.430224826416, 4782.497837727024, 4818.518148185189, 4845.563899249049, 4852.1508735971065, 4871.585915197213, 5683.715814209314, 5684.237886255274, 5684.442001099522, 5712.714364281769, 5718.914216286759, 4085.8978525536804, 4093.2603643451416, 4094.815733291979, 4100.630943215095, 4101.26177288088, 5759.68321742304, 5951.226340575698, 5956.166136740816, 5958.523318134538, 5987.550933679991, 4164.2296175207075, 4166.167006435592, 4173.791310434466, 4187.350960601112, 4187.602177793105, 4208.326667733148, 4238.978805106017, 4250.851220207278, 4266.381374700651, 4272.87181384559, 4688.624910007191, 4821.276808478756, 4861.9027619447415, 4870.975645121752, 4879.0, 5835.503982161564, 5841.299044114733, 5850.3564607893095, 5869.589128761031, 5871.823845284648, 1476.6751314710746, 1477.662715242707, 1478.1131321207404, 1478.9038712483655, 1478.977815332771, 884.707067966437, 931.0735817861272, 936.9437833729997, 938.2119020023214, 946.7207173883721, 4871.5128487151715, 4898.779554919965, 4899.4365647950945, 4915.754212289371, 4925.75371231437, 5085.644004919694, 5173.2152407420135, 5177.715225662625, 5186.974065129726, 5196.506331898464, 4521.276595744665, 4817.590504807061, 4865.197242455026, 4865.270209468608, 4899.191633380452, 2752.325680208362, 2757.4485102979484, 2765.834049957009, 2769.6567164924995, 2780.6385169928185, 5277.8416647500635, 5305.283786688825, 5314.468553144732, 5322.54758345545, 5343.305370301836, 5263.0000299942885, 5264.210368444687, 5630.943690563124, 5986.5210783137245, 6097.237845269341, 6039.285839208855, 6060.0, 6159.168512250879, 6170.722317495633, 6173.41352571505, 5643.689597072201, 5974.970125149521, 5982.41466011516, 5983.311919129356, 5984.952633289244, 5789.1895134680335, 5866.970665146647, 5868.3251426084835, 5891.204687367151, 5900.229931020763, 6116.724747386467, 6121.969390153021, 6142.846428839315, 6151.3541078186145, 6152.415520525543, 4127.772972486542, 4203.726757760735, 4203.97898010508, 4222.4088627591545, 4227.450431443893, 5913.408659134052, 5917.822465326047, 5944.0, 5953.077273022688, 5961.791337303173, 5656.660600363992, 5788.9131663024245, 5813.360530341574, 5848.4793953571525, 5854.443827836349, 5750.281214848144, 5765.509931655856, 5802.593818432838, 5806.9419305806405, 5811.56413268998, 5762.7694892203845, 5772.163036359789, 5779.711014449176, 5782.855428614318, 5823.098523988853, 5581.804636837691, 5647.943520564741, 5708.80019199326, 5820.505257053198, 5857.648541087548, 5624.268845050117, 5676.17695434168, 5678.4605462480995, 5682.318121825408, 5689.317281926195], "value": 4299.957910660594, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.3162193349223, 739.2681245566889, 746.813296675831, 807.6850028488886, 823.6499487717721, 13898.583042508728, 14538.781918271208, 14541.927290363546, 14545.054571452862, 14559.490417835377, 14573.562793116223, 14798.40806367744, 14818.259087045632, 14826.110433374006, 14844.332005059798, 783.6277768060154, 797.4975765267873, 800.0918956983836, 802.6909639788694, 803.1968031968032, 798.648594618366, 806.415348872066, 807.6002378822491, 808.7290757596212, 809.4253080312985, 844.4173520271024, 847.4322204123253, 848.6520526584102, 849.1720572441882, 851.3189448441223, 832.0722394530086, 836.8159005018947, 840.1850205300848, 841.2428814067327, 846.0904527632789, 621.1366200980641, 621.3662064694032, 623.6133597169738, 624.2758400255727, 624.721998710574, 12487.625371238786, 12493.25040497573, 12499.18755280913, 12554.560590379384, 13226.404811783494, 12592.68518287041, 12674.493020279178, 12732.363381830872, 12882.0, 13283.3358332083, 12523.0, 12574.874251257463, 12648.304343261118, 12719.236845789283, 13017.414216360192, 4374.781260936972, 4389.626881715058, 4400.779961001969, 4608.354830323724, 4609.285560738091, 67888.66055669739, 67923.0, 69527.65236173787, 70280.0, 71398.0, 10447.791044179074, 10581.894181058246, 10589.205809564313, 10680.732981675364, 10919.39943303126, 18810.90594547046, 18818.623627527373, 19052.71420928687, 19211.23155073809, 19275.51811204703, 7666.348360389318, 7718.729844455417, 7854.960725196452, 7942.126366099725, 8098.4331096823835, 4501.977490112594, 4578.336141259499, 4614.215583350839, 4631.58315751584, 4684.461286951976, 3112.7354174895386, 3144.166795799115, 3161.225499752575, 3203.759718021158, 3204.7436205103536, 570.6290910907943, 579.2383016333508, 589.9793507227226, 590.0735844723743, 598.3537779198455, 640.2764875690533, 645.2772894358349, 645.7352485480931, 647.4496677823906, 653.6306986552582, 8583.742487725378, 8695.08701586337, 8793.780155496164, 9009.369344145847, 9175.541222938826, 566.7959534567552, 577.5927970780674, 630.7256343490596, 642.8039447968415, 651.6826027567366, 4286.314189729628, 4394.274944634163, 4567.840125595655, 4595.4025976622825, 4621.813080659539, 76380.61809691027, 77231.0, 79692.60153699195, 81920.18079819245, 92411.53794230986, 44930.0, 49968.25047624289, 62556.68721656362, 62599.0, 74511.0, 65691.0, 66533.33466665368, 67006.0, 67751.0, 69464.30535694578, 9467.810643787223, 9925.602975881173, 9967.900320996698, 10098.394096353948, 10112.24158188124, 35841.0, 39489.81530554088, 44476.777616111714, 44742.3288650677, 45367.31949020701, 54633.0, 57033.0, 63096.0, 63664.68167659132, 65896.67051664711, 11786.46960886745, 12151.149419540547, 12294.754104917673, 12350.567730129402, 12860.871391285968, 13847.41918600288, 14055.297235138407, 14209.573712788633, 14381.64045898861, 14621.122732636077, 13056.608301750963, 13436.93281533586, 13674.726505470035, 13782.310884455937, 14342.426302947766, 13021.153625014344, 13237.404316805574, 13280.269585172908, 13362.732745345233, 14180.929095354457, 12631.431585578488, 13142.60572182836, 13155.802662960255, 13180.340982950622, 13485.662858428617, 10244.487775611338, 10722.356658600509, 10839.187060970617, 10946.179036572448, 10946.562137514411, 9407.918089419803, 9916.752081198028, 10855.40295283767, 11294.0, 11402.258853174517], "value": 6991.041484444642, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 114.0, 111.0, 113.0, 111.0, 117.0, 111.0, 111.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 123.0, 181.0, 127.0, 124.0, 125.0, 124.0, 159.0, 131.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 161.0, 166.0, 171.0, 164.0, 162.0, 162.0, 160.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 111.0, 76.0, 77.0, 76.0, 76.0, 110.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 113.0, 83.0, 83.0, 82.0, 104.0, 85.0, 83.0, 123.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 119.0, 118.0, 117.0, 119.0, 117.0, 119.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 52.0, 55.0, 54.0, 55.0, 55.0, 55.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 66.0, 60.0, 62.0, 61.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 87.0, 81.0, 80.0, 81.0, 80.0, 80.0, 79.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 140.0, 137.0, 133.0, 138.0, 136.0, 142.0, 136.0, 176.0, 129.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 169.0, 185.0, 183.0, 168.0, 167.0, 167.0, 167.0, 171.0, 173.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 65.0, 64.0, 65.0, 64.0, 64.0, 67.0, 67.0, 73.0], "value": 66.7, "unit": "score"}]}]} 13:09:51 INFO - Return code: 0 13:09:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:09:51 ERROR - # TBPL SUCCESS # 13:09:51 INFO - Running post-action listener: _resource_record_post_action 13:09:51 INFO - [mozharness: 2016-10-29 20:09:51.825064Z] Finished run-tests step (success) 13:09:51 INFO - Running post-run listener: _resource_record_post_run 13:09:51 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401575936; Read time: 24; Write time: 597740 13:09:51 INFO - TinderboxPrint: CPU usage
13.5% 13:09:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 13:09:51 INFO - TinderboxPrint: I/O write bytes / time
401,575,936 / 597,740 13:09:51 INFO - TinderboxPrint: CPU idle
8,251.4 (86.5%) 13:09:51 INFO - TinderboxPrint: CPU user
1,217.4 (12.8%) 13:09:51 INFO - TinderboxPrint: Swap in / out
0 / 0 13:09:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113315840; Read time: 0; Write time: 186688 13:09:51 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288260096; Read time: 0; Write time: 411052 13:09:52 INFO - Running post-run listener: _upload_blobber_files 13:09:52 INFO - Blob upload gear active. 13:09:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:09:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:09:52 INFO - (blobuploader) - INFO - Open directory for files ... 13:09:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:09:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:55 INFO - (blobuploader) - INFO - Done attempting. 13:09:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:09:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:56 INFO - (blobuploader) - INFO - Done attempting. 13:09:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:09:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:09:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:09:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:09:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:09:57 INFO - (blobuploader) - INFO - Done attempting. 13:09:57 INFO - (blobuploader) - INFO - Iteration through files over. 13:09:57 INFO - Return code: 0 13:09:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:09:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:09:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b45d71cffbf884e1c64dfc9f04d28ec1c30e5354599f3d1b34e337a6344b244761f96bb8299f5744bacb8c1e8d7b3c3d7928cd418f23862db20634e2cd3c372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/024dd85f4b8995bbbe7efcba7d844e112fa4a72e95f67a841eee79249c333b8dc4d0d9e552935e00890503ede2f9e75bad36fa1091cf72533f02b245cd618155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a61462bf433cb92061e5804489502b80781120b5edd711cfdb4d84c838a300226bf101cb3649932030533f8b8a665d23bede27ebb6c274540d37868f68681247"} 13:09:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:09:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:09:57 INFO - Contents: 13:09:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b45d71cffbf884e1c64dfc9f04d28ec1c30e5354599f3d1b34e337a6344b244761f96bb8299f5744bacb8c1e8d7b3c3d7928cd418f23862db20634e2cd3c372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/024dd85f4b8995bbbe7efcba7d844e112fa4a72e95f67a841eee79249c333b8dc4d0d9e552935e00890503ede2f9e75bad36fa1091cf72533f02b245cd618155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a61462bf433cb92061e5804489502b80781120b5edd711cfdb4d84c838a300226bf101cb3649932030533f8b8a665d23bede27ebb6c274540d37868f68681247"} 13:09:57 INFO - Running post-run listener: copy_logs_to_upload_dir 13:09:57 INFO - Copying logs to upload dir... 13:09:57 INFO - mkdir: /builds/slave/test/build/upload/logs 13:09:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.673726 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-29 13:09:57.255775) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 13:09:57.259699) ========= 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=af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982 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/3b45d71cffbf884e1c64dfc9f04d28ec1c30e5354599f3d1b34e337a6344b244761f96bb8299f5744bacb8c1e8d7b3c3d7928cd418f23862db20634e2cd3c372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/024dd85f4b8995bbbe7efcba7d844e112fa4a72e95f67a841eee79249c333b8dc4d0d9e552935e00890503ede2f9e75bad36fa1091cf72533f02b245cd618155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a61462bf433cb92061e5804489502b80781120b5edd711cfdb4d84c838a300226bf101cb3649932030533f8b8a665d23bede27ebb6c274540d37868f68681247"} build_url:https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/a5QDpTXHSmqB-wpQTWaziQ/artifacts/public/build/firefox-52.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/3b45d71cffbf884e1c64dfc9f04d28ec1c30e5354599f3d1b34e337a6344b244761f96bb8299f5744bacb8c1e8d7b3c3d7928cd418f23862db20634e2cd3c372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/024dd85f4b8995bbbe7efcba7d844e112fa4a72e95f67a841eee79249c333b8dc4d0d9e552935e00890503ede2f9e75bad36fa1091cf72533f02b245cd618155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a61462bf433cb92061e5804489502b80781120b5edd711cfdb4d84c838a300226bf101cb3649932030533f8b8a665d23bede27ebb6c274540d37868f68681247"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 13:09:57.284467) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:09:57.284774) ========= 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=af724c981e2a0f424dbabf99000001e7-1477770555.393570-2119451982 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:09:57.370059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 13:09:57.370386) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 13:09:57.370666) ========= ========= Total master_lag: 0.17 =========