builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1477934053.0 results: success (0) buildid: 20161031083421 builduid: 324b0128a35b4e38ab0d855b46fdfd21 revision: 655b506d7bfa0cfef1c5aba195a2903e7faf95fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:13.004970) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:13.005492) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:13.005798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:13.021155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:13.021670) ========= 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=eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 10:14:13-- 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% 87.5M=0s 2016-10-31 10:14:13 (87.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137900 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:13.174027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:13.174607) ========= 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=eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013188 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:13.224672) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:13.225052) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 655b506d7bfa0cfef1c5aba195a2903e7faf95fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 655b506d7bfa0cfef1c5aba195a2903e7faf95fb --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=eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 10:14:13,416 truncating revision to first 12 chars 2016-10-31 10:14:13,417 Setting DEBUG logging. 2016-10-31 10:14:13,417 attempt 1/10 2016-10-31 10:14:13,417 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/655b506d7bfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 10:14:13,881 unpacking tar archive at: mozilla-central-655b506d7bfa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.781212 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:14.020186) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:14.020544) ========= script_repo_revision: 655b506d7bfa0cfef1c5aba195a2903e7faf95fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:14.020951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:14.021220) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 10:14:14.032758) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-31 10:14:14.033147) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:14:14 INFO - MultiFileLogger online at 20161031 10:14:14 in /builds/slave/test 10:14:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:14:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:14:14 INFO - {'append_to_log': False, 10:14:14 INFO - 'base_work_dir': '/builds/slave/test', 10:14:14 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:14:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:14:14 INFO - 'branch': 'Firefox-Non-PGO', 10:14:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:14 INFO - 'config_files': ('talos/linux_config.py',), 10:14:14 INFO - 'default_actions': ('clobber', 10:14:14 INFO - 'read-buildbot-config', 10:14:14 INFO - 'download-and-extract', 10:14:14 INFO - 'populate-webroot', 10:14:14 INFO - 'create-virtualenv', 10:14:14 INFO - 'install', 10:14:14 INFO - 'run-tests'), 10:14:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:14 INFO - 'download_minidump_stackwalk': True, 10:14:14 INFO - 'download_symbols': 'ondemand', 10:14:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:14 INFO - 'installer_path': 'installer.exe', 10:14:14 INFO - 'log_level': 'info', 10:14:14 INFO - 'log_name': 'talos', 10:14:14 INFO - 'log_to_console': True, 10:14:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:14:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:14:14 INFO - 'opt_config_files': (), 10:14:14 INFO - 'pip_index': False, 10:14:14 INFO - 'sps_profile': False, 10:14:14 INFO - 'sps_profile_interval': 0, 10:14:14 INFO - 'suite': 'dromaeojs', 10:14:14 INFO - 'system_bits': '32', 10:14:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:14 INFO - 'title': 'talos-linux64-ix-010', 10:14:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:14 INFO - 'use_talos_json': True, 10:14:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:14:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:14 INFO - 'work_dir': 'build'} 10:14:14 INFO - [mozharness: 2016-10-31 17:14:14.326146Z] Running clobber step. 10:14:14 INFO - Running pre-action listener: _resource_record_pre_action 10:14:14 INFO - Running main action method: clobber 10:14:14 INFO - rmtree: /builds/slave/test/build 10:14:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:14:14 INFO - Running post-action listener: _resource_record_post_action 10:14:14 INFO - [mozharness: 2016-10-31 17:14:14.798112Z] Finished clobber step (success) 10:14:14 INFO - [mozharness: 2016-10-31 17:14:14.798212Z] Running read-buildbot-config step. 10:14:14 INFO - Running pre-action listener: _resource_record_pre_action 10:14:14 INFO - Running main action method: read_buildbot_config 10:14:14 INFO - Using buildbot properties: 10:14:14 INFO - { 10:14:14 INFO - "project": "", 10:14:14 INFO - "product": "firefox", 10:14:14 INFO - "script_repo_revision": "production", 10:14:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:14:14 INFO - "repository": "", 10:14:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 10:14:14 INFO - "buildid": "20161031083421", 10:14:14 INFO - "pgo_build": "False", 10:14:14 INFO - "basedir": "/builds/slave/test", 10:14:14 INFO - "buildnumber": 277, 10:14:14 INFO - "slavename": "talos-linux64-ix-010", 10:14:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:14:14 INFO - "platform": "ubuntu64_hw", 10:14:14 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 10:14:14 INFO - "branch": "mozilla-central", 10:14:14 INFO - "repo_path": "mozilla-central", 10:14:14 INFO - "revision": "655b506d7bfa0cfef1c5aba195a2903e7faf95fb", 10:14:14 INFO - "stage_platform": "linux64", 10:14:14 INFO - "builduid": "324b0128a35b4e38ab0d855b46fdfd21", 10:14:14 INFO - "slavebuilddir": "test" 10:14:14 INFO - } 10:14:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:14:14 INFO - Running post-action listener: _resource_record_post_action 10:14:14 INFO - [mozharness: 2016-10-31 17:14:14.800598Z] Finished read-buildbot-config step (success) 10:14:14 INFO - [mozharness: 2016-10-31 17:14:14.800685Z] Running download-and-extract step. 10:14:14 INFO - Running pre-action listener: _resource_record_pre_action 10:14:14 INFO - Running main action method: download_and_extract 10:14:14 INFO - mkdir: /builds/slave/test/build/tests 10:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:14 INFO - trying https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:14:14 INFO - Downloading https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/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 10:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/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 10:14:15 INFO - Downloaded 1361 bytes. 10:14:15 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:14:15 INFO - Using the following test package requirements: 10:14:15 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:15 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:14:15 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:14:15 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:15 INFO - u'jsshell-linux-x86_64.zip'], 10:14:15 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:14:15 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:15 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:14:15 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:14:15 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:14:15 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:15 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:14:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:14:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:14:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:15 INFO - Fetch https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:14:15 INFO - Http code: 200 10:14:15 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 10:14:15 INFO - x-amz-cf-id: 8GWLBL2-MbJx3QbR26WFAikIz-LtCWKbFdTpMRP2tF8VoGArj3DrFw== 10:14:15 INFO - x-amz-version-id: KDwqIN1Jw_JZJ81tusu7JHK.Bu3C7079 10:14:16 INFO - Expected file size: 20439429 10:14:16 INFO - Obtained file size: 20439429 10:14:20 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 10:14:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:14:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:20 INFO - Fetch https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:14:20 INFO - Http code: 200 10:14:20 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 10:14:20 INFO - x-amz-cf-id: Bqp0cIoN102LlCI5LrrfcreHL-dXiCNAGYThZw7P7qfkGSY3TWvSIg== 10:14:20 INFO - x-amz-version-id: KDwqIN1Jw_JZJ81tusu7JHK.Bu3C7079 10:14:21 INFO - Expected file size: 20439429 10:14:21 INFO - Obtained file size: 20439429 10:14:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:14:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:14:25 INFO - Fetch https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:14:25 INFO - Http code: 200 10:14:25 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 10:14:25 INFO - x-amz-cf-id: o9NWThQJLw6rbm1Ik8O5thB02L24SJiVrhxwBsP3yKhYeOoRGQwAHw== 10:14:25 INFO - x-amz-version-id: esldd3pvDO726VAgAZmMFQiCrOi76E38 10:14:26 INFO - Expected file size: 14409038 10:14:26 INFO - Obtained file size: 14409038 10:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:26 INFO - trying https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:14:26 INFO - Downloading https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/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 10:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/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 10:14:27 INFO - Downloaded 55800496 bytes. 10:14:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:14:27 INFO - mkdir: /builds/slave/test/properties 10:14:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:14:27 INFO - Writing to file /builds/slave/test/properties/build_url 10:14:27 INFO - Contents: 10:14:27 INFO - build_url:https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:14:28 INFO - Running post-action listener: _resource_record_post_action 10:14:28 INFO - Running post-action listener: set_extra_try_arguments 10:14:28 INFO - [mozharness: 2016-10-31 17:14:28.179759Z] Finished download-and-extract step (success) 10:14:28 INFO - [mozharness: 2016-10-31 17:14:28.179983Z] Running populate-webroot step. 10:14:28 INFO - Running pre-action listener: _resource_record_pre_action 10:14:28 INFO - Running main action method: populate_webroot 10:14:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:14:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:14:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:14:28 INFO - '--tppagecycles', 10:14:28 INFO - '7'], 10:14:28 INFO - 'tests': ['tsvgm']}}, 10:14:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:14:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:14:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:14:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:14:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:28 INFO - 'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:28 INFO - 'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['damp', 'tps']}, 10:14:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:28 INFO - 'tests': ['damp', 'tps']}, 10:14:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['dromaeo_dom']}, 10:14:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:14:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['basic_compositor_video']}, 10:14:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:14:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'other-e10s': {'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['a11yr', 10:14:28 INFO - 'ts_paint', 10:14:28 INFO - 'tpaint', 10:14:28 INFO - 'sessionrestore', 10:14:28 INFO - 'sessionrestore_no_auto_restore', 10:14:28 INFO - 'tabpaint']}, 10:14:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['tsvgx', 10:14:28 INFO - 'tsvgr_opacity', 10:14:28 INFO - 'tart', 10:14:28 INFO - 'tscrollx', 10:14:28 INFO - 'cart']}, 10:14:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:14:28 INFO - 'tsvgr_opacity', 10:14:28 INFO - 'tart', 10:14:28 INFO - 'tscrollx', 10:14:28 INFO - 'cart']}, 10:14:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:28 INFO - 'talos_options': ['--disable-e10s'], 10:14:28 INFO - 'tests': ['tp5o']}, 10:14:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:28 INFO - 'tests': ['tp5o']}, 10:14:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:28 INFO - 'talos_options': ['--disable-e10s', 10:14:28 INFO - '--xperf_path', 10:14:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:28 INFO - 'tests': ['tp5n']}, 10:14:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:28 INFO - 'talos_options': ['--xperf_path', 10:14:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:28 INFO - 'tests': ['tp5n']}}, 10:14:28 INFO - 'talos.zip': {'path': '', 10:14:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:14:28 INFO - Running post-action listener: _resource_record_post_action 10:14:28 INFO - [mozharness: 2016-10-31 17:14:28.199365Z] Finished populate-webroot step (success) 10:14:28 INFO - [mozharness: 2016-10-31 17:14:28.199451Z] Running create-virtualenv step. 10:14:28 INFO - Running pre-action listener: _resource_record_pre_action 10:14:28 INFO - Running main action method: create_virtualenv 10:14:28 INFO - Creating virtualenv /builds/slave/test/build/venv 10:14:28 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 10:14:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:14:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:14:28 INFO - Using real prefix '/usr' 10:14:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:14:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:14:30 INFO - Installing pip.................done. 10:14:30 INFO - Return code: 0 10:14:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:14:30 INFO - Reading from file tmpfile_stdout 10:14:30 INFO - Output received: 10:14:30 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) 10:14:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:30 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 0x7f43848ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', '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 10:14:30 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 10:14:30 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 10:14:30 INFO - Using env: {'DISPLAY': ':0', 10:14:30 INFO - 'HOME': '/home/cltbld', 10:14:30 INFO - 'LANG': 'en_US.UTF-8', 10:14:30 INFO - 'LANGUAGE': 'en_US:en', 10:14:30 INFO - 'LOGNAME': 'cltbld', 10:14:30 INFO - 'MAIL': '/var/mail/cltbld', 10:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:30 INFO - 'MOZ_NO_REMOTE': '1', 10:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:30 INFO - 'NO_EM_RESTART': '1', 10:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:31 INFO - 'PWD': '/builds/slave/test', 10:14:31 INFO - 'SHELL': '/bin/bash', 10:14:31 INFO - 'SHLVL': '1', 10:14:31 INFO - 'TERM': 'linux', 10:14:31 INFO - 'TMOUT': '86400', 10:14:31 INFO - 'USER': 'cltbld', 10:14:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:31 INFO - '_': '/tools/buildbot/bin/python'} 10:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:31 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 10:14:31 INFO - Cleaning up... 10:14:31 INFO - Return code: 0 10:14:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f43848ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', '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 10:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:14:31 INFO - Using env: {'DISPLAY': ':0', 10:14:31 INFO - 'HOME': '/home/cltbld', 10:14:31 INFO - 'LANG': 'en_US.UTF-8', 10:14:31 INFO - 'LANGUAGE': 'en_US:en', 10:14:31 INFO - 'LOGNAME': 'cltbld', 10:14:31 INFO - 'MAIL': '/var/mail/cltbld', 10:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:31 INFO - 'MOZ_NO_REMOTE': '1', 10:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:31 INFO - 'NO_EM_RESTART': '1', 10:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:31 INFO - 'PWD': '/builds/slave/test', 10:14:31 INFO - 'SHELL': '/bin/bash', 10:14:31 INFO - 'SHLVL': '1', 10:14:31 INFO - 'TERM': 'linux', 10:14:31 INFO - 'TMOUT': '86400', 10:14:31 INFO - 'USER': 'cltbld', 10:14:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:31 INFO - '_': '/tools/buildbot/bin/python'} 10:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:31 INFO - Downloading/unpacking psutil>=3.1.1 10:14:31 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 10:14:31 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 10:14:31 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 10:14:31 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 10:14:31 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 10:14:31 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 10:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:33 INFO - Installing collected packages: psutil 10:14:33 INFO - Running setup.py install for psutil 10:14:33 INFO - building 'psutil._psutil_linux' extension 10:14:33 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 10:14:33 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 10:14:33 INFO - building 'psutil._psutil_posix' extension 10:14:33 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 10:14:33 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 10:14:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:33 INFO - Successfully installed psutil 10:14:33 INFO - Cleaning up... 10:14:34 INFO - Return code: 0 10:14:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43848ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', '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 10:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:14:34 INFO - Using env: {'DISPLAY': ':0', 10:14:34 INFO - 'HOME': '/home/cltbld', 10:14:34 INFO - 'LANG': 'en_US.UTF-8', 10:14:34 INFO - 'LANGUAGE': 'en_US:en', 10:14:34 INFO - 'LOGNAME': 'cltbld', 10:14:34 INFO - 'MAIL': '/var/mail/cltbld', 10:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:34 INFO - 'MOZ_NO_REMOTE': '1', 10:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:34 INFO - 'NO_EM_RESTART': '1', 10:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:34 INFO - 'PWD': '/builds/slave/test', 10:14:34 INFO - 'SHELL': '/bin/bash', 10:14:34 INFO - 'SHLVL': '1', 10:14:34 INFO - 'TERM': 'linux', 10:14:34 INFO - 'TMOUT': '86400', 10:14:34 INFO - 'USER': 'cltbld', 10:14:34 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:34 INFO - '_': '/tools/buildbot/bin/python'} 10:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:14:36 INFO - Installing collected packages: mozsystemmonitor 10:14:36 INFO - Running setup.py install for mozsystemmonitor 10:14:36 INFO - Successfully installed mozsystemmonitor 10:14:36 INFO - Cleaning up... 10:14:36 INFO - Return code: 0 10:14:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:14:36 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')]} 10:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 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')]} 10:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 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 0x7f43848ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', '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 10:14:36 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 10:14:36 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 10:14:36 INFO - Using env: {'DISPLAY': ':0', 10:14:36 INFO - 'HOME': '/home/cltbld', 10:14:36 INFO - 'LANG': 'en_US.UTF-8', 10:14:36 INFO - 'LANGUAGE': 'en_US:en', 10:14:36 INFO - 'LOGNAME': 'cltbld', 10:14:36 INFO - 'MAIL': '/var/mail/cltbld', 10:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:36 INFO - 'MOZ_NO_REMOTE': '1', 10:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:36 INFO - 'NO_EM_RESTART': '1', 10:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:36 INFO - 'PWD': '/builds/slave/test', 10:14:36 INFO - 'SHELL': '/bin/bash', 10:14:36 INFO - 'SHLVL': '1', 10:14:36 INFO - 'TERM': 'linux', 10:14:36 INFO - 'TMOUT': '86400', 10:14:36 INFO - 'USER': 'cltbld', 10:14:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:36 INFO - '_': '/tools/buildbot/bin/python'} 10:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:36 INFO - Downloading/unpacking jsonschema==2.5.1 10:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14: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 10:14:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:38 INFO - warning: no files found matching '*.txt' 10:14:38 INFO - no previously-included directories found matching 'build' 10:14:38 INFO - no previously-included directories found matching 'dist' 10:14:38 INFO - no previously-included directories found matching '.git*' 10:14:38 INFO - Installing collected packages: jsonschema, functools32 10:14:38 INFO - Running setup.py install for functools32 10:14:38 INFO - warning: no files found matching '*.txt' 10:14:38 INFO - no previously-included directories found matching 'build' 10:14:38 INFO - no previously-included directories found matching 'dist' 10:14:38 INFO - no previously-included directories found matching '.git*' 10:14:38 INFO - Successfully installed jsonschema functools32 10:14:38 INFO - Cleaning up... 10:14:38 INFO - Return code: 0 10:14:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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', '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 0x7f43848ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', '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 10:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:14: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 functools32==3.2.3-2 10:14:38 INFO - Using env: {'DISPLAY': ':0', 10:14:38 INFO - 'HOME': '/home/cltbld', 10:14:38 INFO - 'LANG': 'en_US.UTF-8', 10:14:38 INFO - 'LANGUAGE': 'en_US:en', 10:14:38 INFO - 'LOGNAME': 'cltbld', 10:14:38 INFO - 'MAIL': '/var/mail/cltbld', 10:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:38 INFO - 'MOZ_NO_REMOTE': '1', 10:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:38 INFO - 'NO_EM_RESTART': '1', 10:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:38 INFO - 'PWD': '/builds/slave/test', 10:14:38 INFO - 'SHELL': '/bin/bash', 10:14:39 INFO - 'SHLVL': '1', 10:14:39 INFO - 'TERM': 'linux', 10:14:39 INFO - 'TMOUT': '86400', 10:14:39 INFO - 'USER': 'cltbld', 10:14:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:39 INFO - '_': '/tools/buildbot/bin/python'} 10:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:14:39 INFO - Cleaning up... 10:14:39 INFO - Return code: 0 10:14:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:14:39 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')]} 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:39 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')]} 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:39 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 0x7f43848ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', '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 10:14:39 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 10:14:39 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 10:14:39 INFO - Using env: {'DISPLAY': ':0', 10:14:39 INFO - 'HOME': '/home/cltbld', 10:14:39 INFO - 'LANG': 'en_US.UTF-8', 10:14:39 INFO - 'LANGUAGE': 'en_US:en', 10:14:39 INFO - 'LOGNAME': 'cltbld', 10:14:39 INFO - 'MAIL': '/var/mail/cltbld', 10:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:39 INFO - 'MOZ_NO_REMOTE': '1', 10:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:39 INFO - 'NO_EM_RESTART': '1', 10:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:39 INFO - 'PWD': '/builds/slave/test', 10:14:39 INFO - 'SHELL': '/bin/bash', 10:14:39 INFO - 'SHLVL': '1', 10:14:39 INFO - 'TERM': 'linux', 10:14:39 INFO - 'TMOUT': '86400', 10:14:39 INFO - 'USER': 'cltbld', 10:14:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:39 INFO - '_': '/tools/buildbot/bin/python'} 10:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:14:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:42 INFO - Downloading docopt-0.6.1.tar.gz 10:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:42 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:42 INFO - Running setup.py install for blobuploader 10:14:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:14:42 INFO - Running setup.py install for requests 10:14:42 INFO - Running setup.py install for docopt 10:14:42 INFO - Successfully installed blobuploader requests docopt 10:14:42 INFO - Cleaning up... 10:14:42 INFO - Return code: 0 10:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:42 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')]} 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:42 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')]} 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:42 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 0x7f43848ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', '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 10:14:42 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 10:14:42 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 10:14:42 INFO - Using env: {'DISPLAY': ':0', 10:14:42 INFO - 'HOME': '/home/cltbld', 10:14:42 INFO - 'LANG': 'en_US.UTF-8', 10:14:42 INFO - 'LANGUAGE': 'en_US:en', 10:14:42 INFO - 'LOGNAME': 'cltbld', 10:14:42 INFO - 'MAIL': '/var/mail/cltbld', 10:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:42 INFO - 'MOZ_NO_REMOTE': '1', 10:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:42 INFO - 'NO_EM_RESTART': '1', 10:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:42 INFO - 'PWD': '/builds/slave/test', 10:14:42 INFO - 'SHELL': '/bin/bash', 10:14:42 INFO - 'SHLVL': '1', 10:14:42 INFO - 'TERM': 'linux', 10:14:42 INFO - 'TMOUT': '86400', 10:14:42 INFO - 'USER': 'cltbld', 10:14:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:42 INFO - '_': '/tools/buildbot/bin/python'} 10:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:42 INFO - Running setup.py (path:/tmp/pip-lnvKBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:43 INFO - Running setup.py (path:/tmp/pip-4pu6JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:43 INFO - Running setup.py (path:/tmp/pip-Reer1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:43 INFO - Running setup.py (path:/tmp/pip-NPJCd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:43 INFO - Running setup.py (path:/tmp/pip-XoXmOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:43 INFO - Running setup.py (path:/tmp/pip-qdJxQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:43 INFO - Running setup.py (path:/tmp/pip-bK7FyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:43 INFO - Running setup.py (path:/tmp/pip-n9_bML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:43 INFO - Running setup.py (path:/tmp/pip-sCE5pL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:43 INFO - Running setup.py (path:/tmp/pip-26KOfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:43 INFO - Running setup.py (path:/tmp/pip-8MT9iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:43 INFO - Running setup.py (path:/tmp/pip-izArNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:43 INFO - Running setup.py (path:/tmp/pip-w0vdzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:43 INFO - Running setup.py (path:/tmp/pip-MbUWux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:43 INFO - Running setup.py (path:/tmp/pip-v2K02n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:44 INFO - Running setup.py (path:/tmp/pip-7oJnms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:44 INFO - Running setup.py (path:/tmp/pip-y0LAhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:44 INFO - Running setup.py install for manifestparser 10:14:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Running setup.py install for mozcrash 10:14:44 INFO - Running setup.py install for mozdebug 10:14:44 INFO - Running setup.py install for mozdevice 10:14:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Running setup.py install for mozfile 10:14:44 INFO - Running setup.py install for mozhttpd 10:14:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Running setup.py install for mozinfo 10:14:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Running setup.py install for mozInstall 10:14:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:14:44 INFO - Running setup.py install for mozleak 10:14:45 INFO - Running setup.py install for mozlog 10:14:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for moznetwork 10:14:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for mozprocess 10:14:45 INFO - Running setup.py install for mozprofile 10:14:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for mozrunner 10:14:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Running setup.py install for mozscreenshot 10:14:45 INFO - Running setup.py install for moztest 10:14:45 INFO - Running setup.py install for mozversion 10:14:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:14:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:45 INFO - Cleaning up... 10:14:45 INFO - Return code: 0 10:14:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:46 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 0x7f43848ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', '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 10:14:46 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 10:14:46 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 10:14:46 INFO - Using env: {'DISPLAY': ':0', 10:14:46 INFO - 'HOME': '/home/cltbld', 10:14:46 INFO - 'LANG': 'en_US.UTF-8', 10:14:46 INFO - 'LANGUAGE': 'en_US:en', 10:14:46 INFO - 'LOGNAME': 'cltbld', 10:14:46 INFO - 'MAIL': '/var/mail/cltbld', 10:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:46 INFO - 'MOZ_NO_REMOTE': '1', 10:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:46 INFO - 'NO_EM_RESTART': '1', 10:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:46 INFO - 'PWD': '/builds/slave/test', 10:14:46 INFO - 'SHELL': '/bin/bash', 10:14:46 INFO - 'SHLVL': '1', 10:14:46 INFO - 'TERM': 'linux', 10:14:46 INFO - 'TMOUT': '86400', 10:14:46 INFO - 'USER': 'cltbld', 10:14:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:46 INFO - '_': '/tools/buildbot/bin/python'} 10:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:46 INFO - Running setup.py (path:/tmp/pip-txErlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:46 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)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:46 INFO - Running setup.py (path:/tmp/pip-571G0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:46 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)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:46 INFO - Running setup.py (path:/tmp/pip-EPEGDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:46 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)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:46 INFO - Running setup.py (path:/tmp/pip-U_tBdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:46 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)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:46 INFO - Running setup.py (path:/tmp/pip-41AkX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:46 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)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:46 INFO - Running setup.py (path:/tmp/pip-3Y2F2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:46 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)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:46 INFO - Running setup.py (path:/tmp/pip-F2c5gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:46 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)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:46 INFO - Running setup.py (path:/tmp/pip-iy2ePA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:46 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)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:46 INFO - Running setup.py (path:/tmp/pip-kdIagR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:46 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)) 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:46 INFO - Running setup.py (path:/tmp/pip-9TAACS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:47 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)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:47 INFO - Running setup.py (path:/tmp/pip-Vdn8cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:47 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)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:47 INFO - Running setup.py (path:/tmp/pip-tp1hS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:47 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)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:47 INFO - Running setup.py (path:/tmp/pip-zTGWdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:47 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)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:47 INFO - Running setup.py (path:/tmp/pip-r5eiy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:47 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)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:47 INFO - Running setup.py (path:/tmp/pip-znpTUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:47 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)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:47 INFO - Running setup.py (path:/tmp/pip-DsGpQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:47 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)) 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:47 INFO - Running setup.py (path:/tmp/pip-fAB6q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:47 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)) 10:14:47 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)) 10:14:47 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)) 10:14:47 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)) 10:14:47 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)) 10:14:47 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)) 10:14:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:47 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 10:14:47 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 10:14:47 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 10:14:47 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 10:14:47 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 10:14:47 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 10:14:49 INFO - Downloading blessings-1.6.tar.gz 10:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:49 INFO - Installing collected packages: blessings 10:14:49 INFO - Running setup.py install for blessings 10:14:49 INFO - Successfully installed blessings 10:14:49 INFO - Cleaning up... 10:14:49 INFO - Return code: 0 10:14:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:49 INFO - Reading from file tmpfile_stdout 10:14:49 INFO - Current package versions: 10:14:49 INFO - argparse == 1.2.1 10:14:49 INFO - blessings == 1.6 10:14:49 INFO - blobuploader == 1.2.4 10:14:49 INFO - docopt == 0.6.1 10:14:49 INFO - functools32 == 3.2.3-2 10:14:49 INFO - jsonschema == 2.5.1 10:14:49 INFO - manifestparser == 1.1 10:14:49 INFO - mozInstall == 1.12 10:14:49 INFO - mozcrash == 0.17 10:14:49 INFO - mozdebug == 0.1 10:14:49 INFO - mozdevice == 0.48 10:14:49 INFO - mozfile == 1.2 10:14:49 INFO - mozhttpd == 0.7 10:14:49 INFO - mozinfo == 0.9 10:14:49 INFO - mozleak == 0.1 10:14:49 INFO - mozlog == 3.4 10:14:49 INFO - moznetwork == 0.27 10:14:49 INFO - mozprocess == 0.23 10:14:49 INFO - mozprofile == 0.28 10:14:49 INFO - mozrunner == 6.12 10:14:49 INFO - mozscreenshot == 0.1 10:14:49 INFO - mozsystemmonitor == 0.3 10:14:49 INFO - moztest == 0.7 10:14:49 INFO - mozversion == 1.4 10:14:49 INFO - psutil == 3.1.1 10:14:49 INFO - requests == 1.2.3 10:14:49 INFO - wsgiref == 0.1.2 10:14:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:49 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')]} 10:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:49 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')]} 10:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:49 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 0x7f43848ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', '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 10:14:49 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 10:14:49 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 10:14:49 INFO - Using env: {'DISPLAY': ':0', 10:14:49 INFO - 'HOME': '/home/cltbld', 10:14:49 INFO - 'LANG': 'en_US.UTF-8', 10:14:49 INFO - 'LANGUAGE': 'en_US:en', 10:14:49 INFO - 'LOGNAME': 'cltbld', 10:14:49 INFO - 'MAIL': '/var/mail/cltbld', 10:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:49 INFO - 'MOZ_NO_REMOTE': '1', 10:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:49 INFO - 'NO_EM_RESTART': '1', 10:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:49 INFO - 'PWD': '/builds/slave/test', 10:14:49 INFO - 'SHELL': '/bin/bash', 10:14:49 INFO - 'SHLVL': '1', 10:14:49 INFO - 'TERM': 'linux', 10:14:49 INFO - 'TMOUT': '86400', 10:14:49 INFO - 'USER': 'cltbld', 10:14:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:49 INFO - '_': '/tools/buildbot/bin/python'} 10:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:50 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)) 10:14:50 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)) 10:14:50 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)) 10:14:50 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)) 10:14:50 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)) 10:14:50 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)) 10:14:50 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)) 10:14:50 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)) 10:14:50 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)) 10:14:50 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)) 10:14:50 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)) 10:14:50 INFO - Cleaning up... 10:14:50 INFO - Return code: 0 10:14:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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')]} 10:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:50 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 0x7f43848ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, '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': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', '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 10:14:50 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 10:14:50 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 10:14:50 INFO - Using env: {'DISPLAY': ':0', 10:14:50 INFO - 'HOME': '/home/cltbld', 10:14:50 INFO - 'LANG': 'en_US.UTF-8', 10:14:50 INFO - 'LANGUAGE': 'en_US:en', 10:14:50 INFO - 'LOGNAME': 'cltbld', 10:14:50 INFO - 'MAIL': '/var/mail/cltbld', 10:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:50 INFO - 'MOZ_NO_REMOTE': '1', 10:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:50 INFO - 'NO_EM_RESTART': '1', 10:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:50 INFO - 'PWD': '/builds/slave/test', 10:14:50 INFO - 'SHELL': '/bin/bash', 10:14:50 INFO - 'SHLVL': '1', 10:14:50 INFO - 'TERM': 'linux', 10:14:50 INFO - 'TMOUT': '86400', 10:14:50 INFO - 'USER': 'cltbld', 10:14:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:50 INFO - '_': '/tools/buildbot/bin/python'} 10:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:14:50 INFO - Cleaning up... 10:14:50 INFO - Return code: 0 10:14:50 INFO - Running post-action listener: _resource_record_post_action 10:14:50 INFO - Running post-action listener: _start_resource_monitoring 10:14:50 INFO - Starting resource monitoring. 10:14:50 INFO - [mozharness: 2016-10-31 17:14:50.453299Z] Finished create-virtualenv step (success) 10:14:50 INFO - [mozharness: 2016-10-31 17:14:50.453802Z] Running install step. 10:14:50 INFO - Running pre-action listener: _resource_record_pre_action 10:14:50 INFO - Running main action method: install 10:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:50 INFO - Reading from file tmpfile_stdout 10:14:50 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:14:50 INFO - Reading from file tmpfile_stdout 10:14:50 INFO - Output received: 10:14:50 INFO - Usage: mozinstall [options] installer 10:14:50 INFO - Options: 10:14:50 INFO - -h, --help show this help message and exit 10:14:50 INFO - -d DEST, --destination=DEST 10:14:50 INFO - Directory to install application into. [default: 10:14:50 INFO - "/builds/slave/test"] 10:14:50 INFO - --app=APP Application being installed. [default: firefox] 10:14:50 INFO - mkdir: /builds/slave/test/build/application 10:14:50 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'] 10:14:50 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 10:15:06 INFO - Reading from file tmpfile_stdout 10:15:06 INFO - Output received: 10:15:06 INFO - /builds/slave/test/build/application/firefox/firefox 10:15:06 INFO - Running post-action listener: _resource_record_post_action 10:15:06 INFO - [mozharness: 2016-10-31 17:15:06.850380Z] Finished install step (success) 10:15:06 INFO - [mozharness: 2016-10-31 17:15:06.850622Z] Running run-tests step. 10:15:06 INFO - Running pre-action listener: _resource_record_pre_action 10:15:06 INFO - Running main action method: run_tests 10:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:15:06 INFO - Python 2.7.3 10:15:06 INFO - Return code: 0 10:15:06 INFO - grabbing minidump binary from tooltool 10:15:06 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')]} 10:15:06 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 0x25a0f60>, '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 0x25a1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:15:06 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 10:15:06 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 10:15:06 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 10:15:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:15:06 INFO - Return code: 0 10:15:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:15:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:15:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:15:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:15:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:15:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:15:06 INFO - Using env: {'DISPLAY': ':0', 10:15:06 INFO - 'HOME': '/home/cltbld', 10:15:06 INFO - 'LANG': 'en_US.UTF-8', 10:15:06 INFO - 'LANGUAGE': 'en_US:en', 10:15:06 INFO - 'LOGNAME': 'cltbld', 10:15:06 INFO - 'MAIL': '/var/mail/cltbld', 10:15:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:15:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:06 INFO - 'MOZ_NO_REMOTE': '1', 10:15:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:06 INFO - 'NO_EM_RESTART': '1', 10:15:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:06 INFO - 'PWD': '/builds/slave/test', 10:15:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:15:06 INFO - 'SHELL': '/bin/bash', 10:15:06 INFO - 'SHLVL': '1', 10:15:06 INFO - 'TERM': 'linux', 10:15:06 INFO - 'TMOUT': '86400', 10:15:06 INFO - 'USER': 'cltbld', 10:15:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101', 10:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:06 INFO - '_': '/tools/buildbot/bin/python'} 10:15:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:15:07 INFO - mozversion application_buildid: 20161031083421 10:15:07 INFO - mozversion application_changeset: 655b506d7bfa0cfef1c5aba195a2903e7faf95fb 10:15:07 INFO - mozversion application_display_name: Nightly 10:15:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:15:07 INFO - mozversion application_name: Firefox 10:15:07 INFO - mozversion application_remotingname: firefox 10:15:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:15:07 INFO - mozversion application_vendor: Mozilla 10:15:07 INFO - mozversion application_version: 52.0a1 10:15:07 INFO - mozversion platform_buildid: 20161031083421 10:15:07 INFO - mozversion platform_changeset: 655b506d7bfa0cfef1c5aba195a2903e7faf95fb 10:15:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:15:07 INFO - mozversion platform_version: 52.0a1 10:15:07 INFO - using testdate: 1477934107 10:15:07 INFO - actual date: 1477934107 10:15:07 INFO - starting webserver on 'localhost:41532' 10:15:07 INFO - SUITE-START | Running 2 tests 10:15:07 INFO - TEST-START | dromaeo_css 10:15:07 INFO - operating with platform_type : linux_ 10:15:07 INFO - Initialising browser for dromaeo_css test... 10:15:07 INFO - TEST-INFO | started process 7821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0dkyEq/profile http://localhost:41532/getInfo.html) 10:15:11 INFO - PROCESS | 7821 | __metrics Screen width/height:1600/1200 10:15:11 INFO - PROCESS | 7821 | colorDepth:24 10:15:11 INFO - PROCESS | 7821 | Browser inner width/height: 1024/697 10:15:11 INFO - PROCESS | 7821 | __metrics 10:15:12 INFO - PROCESS | 7821 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:15:12 INFO - PROCESS | 7821 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:13 INFO - PROCESS | 7821 | console.error: PushService: 10:15:13 INFO - PROCESS | 7821 | stateChangeProcessEnqueue: Error transitioning state 10:15:13 INFO - PROCESS | 7821 | UnknownError 10:15:14 INFO - TEST-INFO | 7821: exit 0 10:15:14 INFO - Browser initialized. 10:15:14 INFO - Running cycle 1/1 for dromaeo_css test... 10:15:14 INFO - TEST-INFO | started process 7903 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0dkyEq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:26 INFO - PROCESS | 7903 | RSS: Main: 176066560 10:15:26 INFO - PROCESS | 7903 | 10:16:18 INFO - PROCESS | 7903 | 1477934178056 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] 10:18:31 INFO - PROCESS | 7903 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41532/tests/dromaeo/cssquery-ext.html) 10:18:33 INFO - PROCESS | 7903 | RSS: Main: 296886272 10:18:33 INFO - PROCESS | 7903 | 10:21:36 INFO - PROCESS | 7903 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-ext.html (next: http://localhost:41532/tests/dromaeo/cssquery-jquery.html) 10:21:36 INFO - PROCESS | 7903 | RSS: Main: 285155328 10:21:36 INFO - PROCESS | 7903 | 10:24:39 INFO - PROCESS | 7903 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41532/tests/dromaeo/cssquery-mootools.html) 10:24:39 INFO - PROCESS | 7903 | RSS: Main: 251904000 10:24:39 INFO - PROCESS | 7903 | 10:27:41 INFO - PROCESS | 7903 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41532/tests/dromaeo/cssquery-prototype.html) 10:27:42 INFO - PROCESS | 7903 | RSS: Main: 221253632 10:27:42 INFO - PROCESS | 7903 | 10:30:45 INFO - PROCESS | 7903 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41532/tests/dromaeo/cssquery-yui.html) 10:30:46 INFO - PROCESS | 7903 | RSS: Main: 220872704 10:30:46 INFO - PROCESS | 7903 | 10:33:49 INFO - PROCESS | 7903 | Cycle 1(1): loaded http://localhost:41532/tests/dromaeo/cssquery-yui.html (next: http://localhost:41532/tests/dromaeo/cssquery-dojo.html) 10:33:49 INFO - PROCESS | 7903 | RSS: Main: 299814912 10:33:49 INFO - PROCESS | 7903 | 10:33:49 INFO - PROCESS | 7903 | __start_tp_report 10:33:49 INFO - PROCESS | 7903 | _x_x_mozilla_page_load 10:33:49 INFO - PROCESS | 7903 | _x_x_mozilla_page_load_details 10:33:49 INFO - PROCESS | 7903 | |i|pagename|runs| 10:33:49 INFO - PROCESS | 7903 | |0;dojo.html;2535.695716514018;2556.2331300609812;2585.1598230575064;2590.9611355829666;2605.452854900472;4483.529229430904;4574.885627859305;4622.58396744293;4625.953740462594;4643.117807616551;4551.294549344857;4588.197065513538;4605.746683932391;4615.676902616819;4641.651876109288;4122.773247471388;4136.193442278757;4182.975171083089;4195.286801243796;4272.9145417091795;4209.0529630833125;4249.575042495757;4298.806553705091;4303.806328715215;4341.39220509129;4157.272477316487;4204.642605378546;4244.342126970325;4312.029793296515;4354.499232588261;4225.471816022997;4235;4241.2365774160635;4244.151169766059;4246.278132717414;4222.387753775685;4224.683148763855;4229.238737027334;4230.407742915994;4234.9364759528635;4510.188166130095;4544.7045942013665;4547.340635607851;4568.862934111982;4571.519990401027;4805.711657300573;4824.035192961422;4828.951710482886;4878.487758785312;4946.802127914915;4899.657024008321;4899.779509922062;4906.656534042619;4908;4965.354503914504;4448.466184057934;4493.932591011137;4548.88627784308;4567.954320456819;4619.099275641218;5001.399832020181;5017.272495488207;5019.749012549358;5020.046191223656;5080.314157588752;4785.330053792402;4823.517648235148;4825.855224343275;4830.7101573905675;4863.902721945541;4790.8323208688225;4825.879353016203;4836.879078023077;4897.632677549198;4973.975130124326;4795.688280261772;4826.058918510927;4828.251620998751;4834.564889159992;4900.583450406755;4803.495632958489;4809.470958194595;4820.68665536746;4850.102730994707;4871.561559459666;3922.5489068757456;4066.6949978751713;4069.9389509157386;4073.246449406869;4127.545969943304;3494.4932984717075;3546.4857595648486;3568.107973006748;3576.5529308836394;3604.5314109166166;4203.894902627398;4205.432266643964;4207.305794543927;4251.914961700811;4256.212600668886;4857.247126695368;4876.195427754381;4879.4388645305535;4887.706737595685;4938.654294199371;4073.6944729145434;4137.937930931039;4140.979295103505;4183.037901282722;4191.434156388909;4284.1645879053285;4310.159518893848;4329.220740266719;4332.393464914914;4340.934885976713;4537.727736335764;4544.613707834739;4547.090581883703;4547.477040140427;4547.909041819079;4834.540718631724;4841.443234028132;4845.055214233191;4845.248986407112;4849.369581954324;4527.1172121436;4532.864014079583;4535.9773201133785;4547.1815073287125;4548.090381923695;4772.475027746876;4785.665003449725;4804.711717296974;4846.636502262415;4851.9514804852915;4846.660733748604;4849.884526558841;4856.951430485791;4861.756912154307;4921.089598424303;4711.670183087288;4722.338872557913;4728.101660684459;4734.360861283682;4791.209450440639;4559.612432943104;4607.884802879955;4612.446506419117;4654.604358629555;4692.178868698033;4674.766261686834;4676.836310729108;4684.273937539687;4707.082118986765;4723.126221649006;4751.928721069117;4755.453122890912;4755.524447555355;4799.736014519095;4801;4554.294084416921;4601.217792975269;4604.1712491751805;4640.767961601974;4650.883727906694 10:33:49 INFO - PROCESS | 7903 | |1;ext.html;545.6644163839239;548.0874344216882;554.706005816917;558.2212813125687;568.6360729133355;27492;37776;38513.80743096288;38656.42015369772;42813;38997.61002389975;39573.60426395735;39578.01054973627;39632;39636.60363396365;7434.479586428952;7645;7795.532268063906;7796.220377962187;7797.727079552217;7363.116426028857;9604.471754053558;9840.950795246014;9857.802843943116;10257.846132307985;10044.146247568966;10053.798924021516;10090.495475226246;10090.798184036315;10130.74673133174;9842.655507057254;9881.654142105064;9894.604215831358;9896.653617123438;9908.256880733938;9799.755006124904;9844.507774611313;9858.80282394348;9859.211263098934;9873.111419972165;36016;36192.457113143326;36254.09364765875;36315;36324.27351452956;2835.9858200709073;2928.282570770175;2974.464596372652;3196.952045719316;3428.8971330860113;27108.59337109945;27343.316417089733;27357.589636155473;27806.860965695243;27937.860310698317;3272.656371081026;3331.5502407175204;3358.865645374182;3368.208471009311;3419.692227699519;251645;252779;254183;255447.99999999814;255484;30734.692653073183;51934.740326298124;52635.473645263824;52695.73652131715;52742.208866867026;30949.845250773604;32312.192195195308;32471.67528324734;32500.512492312635;32537.674623253937;12181.756364872654;12264.754704905852;12289.201201922026;12293.815592766116;12307.830756078158;9114.726558203265;9380.343375963754;10066.993300669874;10111.191104711605;10134.54394552247;7445.553266804009;7656.042994625672;7683.884741728879;7740.961295193488;7802.414818888606;3036.417027907091;3066.0955018269665;3069.739072178845;3100.5969224001187;3136.325689976666;815.975520734367;870.1168314161132;937.7468083617522;966.2366730283138;981.4749109226673;27202.863985679945;27342;27636;27844.860775695994;28362.2909427266;939.178219058324;948.7865230323122;949.7055912667096;966.8308046091905;986.753311672082;13842.792358114637;14192.929035354964;14447.277636118151;14856.92571537157;14948.626284342761;382237;385729;386771;387583;388947;48642.75678621584;49246.75376623094;49258.26112608314;49259.02963881476;49302.50697492979;1034.4465710844813;1109.9500522476508;1154.982675259855;1193.3078814287692;1195.730960533873;26428.339291517867;28293.858530707214;28404.108324895402;29174;29228.415431691672;41165.58834411618;41582.376264356666;41822.372664410665;41837.58162418337;41848.581514184465;286054;287331;287717;287899;288147;21482.677759833303;22253.888730556242;22282.777172228718;22284.442888927908;24495.510089797746;37162.256754865295;37543.81228093842;37617;38027.61972380241;38534.6146538531;32101.35797284088;32270.35459290848;32402.189945251557;32626.83686581552;32682;29798.851005744833;32335.19162020874;32445.51331729979;32464.675353246166;33527.83236083804;31849.36301274008;32428.35143297168;32536.186595335304;32551.18622034468;33124.33751325008;28941.276468087624;29582;29784.851075745348;29834.850825745732;30294.697053029187;23254.418639534146;23278.3016509505;23512;23631.881840590686;23666.29001129969 10:33:49 INFO - PROCESS | 7903 | |2;jquery.html;342.09623445525665;348.70534398433324;350.25745419710216;354.5001547817577;367.2746326006138;12407.131500794949;15876.603084922883;16181.838181618195;17515.386961456352;17676.46970590881;16498.34006639733;16940.3223871045;17259.137043147854;17370.739438908426;17389.39137130201;4989.65072444929;4992.276119962621;5148.304978827848;5174.042802081608;5179.19722443022;3664.267146570683;3852.8073596320214;5113.207452844815;5124.92312615311;5796.855078623047;6075.179850720163;6095.939040609582;6102.511799056065;6103.6032657877095;6109.205803245594;5820.243368362107;6007.909881351783;6029.517638588903;6030.276366836008;6072.9696351518405;5256.500632439912;5260.500252476008;5260.789568417259;5263.894722105575;5270.288511050997;19781.703274450894;20074.498137546532;20221.39335819928;20274;20348.796512034838;1736.3417935871212;2315.050829160053;2421.7093948726088;2463.618139188429;2465.285067330472;12841.67895802603;12885.935570322183;12894.613161605166;13164.736705265937;13550.119242249222;1682.2093616000461;1700.8129105798353;1701.2514493622766;1716.9828301716948;1741.3644019932633;66912;67453;67722.3227767716;67849;68544.6572767133;9093.681721139861;9300.255979521757;9403.90596094044;9437.76405589852;9456.57445414958;12689.49242030327;12704.364781760874;12738;12769.170003949714;12779.424925878358;6457.5479716419395;6621.503387245976;6656.667166641649;6793.66031698423;6810.31896810315;6191.690415479298;6229.53278504114;6381.872362552723;6404.743810247631;6430.614163150226;5582.748776305076;5585.916211256835;5647.237622920935;5713.143028545752;5884.529237660977;1593.792806935091;1694.7966244050792;1697.932082716702;1705.4457301377101;1728.6629107324202;828.411827602397;846.9068402475723;852.1861622150831;855.4525103933488;867;16444.588885277724;16546;17163.656726865644;17196.570085747706;17542.912285438746;858.3219256787069;862.8015556422058;867.6442658509981;868.0494858130337;926.1433174313732;9425.811483770287;9626.614935402506;10075.3954762713;10189.643362482277;10267.332623379605;358179;388384;389518;391618;395345;76303;79911.20088799037;80197;82226;82268.12782466142;893.6844307618807;903.9231665308522;920.9447433153898;921.6958403726888;939.6523286383945;15403.537893863202;15457.61355966065;16104.355825766837;16350.182490875171;16401.91799041045;35257.29485410226;35423.64576354204;35965;36100.638993609726;37058.44412333871;48695.26957095575;50856.237156441945;51044.23433648424;52085.73957130342;52111.478885210665;7096.325849044332;7187.353138217585;7281.927180728337;7372.299631534996;7407.481476296607;9595.424274543271;11314;11367.658970230907;11726.296422214695;11813.881861181279;9128.954355228447;9739.951300243454;9757.219422446045;10066.054422448487;10203.38779673222;9601.903980960102;10121.746956326151;10242.487875606339;10371.481425928825;10668.972895150207;5418.160185171305;8057.355411567178;9767.951160244153;10151.340162889388;10643.201759867887;5867.9413205869105;6550.443212327005;7072.787816365517;7154.284571542804;7536.623168841426;7729.690812367442;9471.19494842946;9632.325737198329;9749.951250243703;9958.452285124387 10:33:49 INFO - PROCESS | 7903 | |3;mootools.html;1227.680802991222;1359.8776110150088;1403.5578792680305;1473.4327283995658;1689.349600403845;6061.787837425691;6450.806475805727;6672.499562532806;6917.688704008319;6921.1002569666;6921.169459664835;6998.125234345707;7004.5096843221;7007.439404847612;7010.263922288163;2026.6959956006606;2050.5181282398626;2055.157385471957;2055.879545647618;2059.7837227091163;2048.9077991490344;2059.6704527275638;2061.391889392625;2110.7783682713325;2113.894305284737;2042.9387118386471;2086.54096098858;2102.7792081831417;2103.4005308487085;2108.630989576818;2015.4860510569783;2069.4515953272394;2072.7927207279304;2074.52285974226;2078.6778049402365;2024.4635171679517;2040.2757021257537;2059.8867062311565;2062.5359294158843;2065.452655046414;6837.931620683829;6890.31096890312;6910.896336554955;6974.895376569356;7020.613866237355;4123.670106391482;4268.082362292091;4271.722338048048;4308.763018034007;4318.244307246251;2609.739026097394;2775.764060054898;2845.7518560337307;2851.0448999585165;2852.1301003194017;872.6640243506232;878.1613559051091;887.2547060469172;889.1597440418807;920.5719340506696;8920.509371984539;8997.775055623597;9021.097890210993;9029.864552031724;9039.7288081357;3493.5807703075793;3632.9636703633155;3661.377565813818;3693.372126738461;3715.275521273326;7308.780736577911;7310.086239220098;7310.890336644955;7311.232320606367;7313.780586582411;4180.205760905418;4196.433481480022;4197.538270790211;4198.6641068714425;4203.390508376329;3419.709324707378;3519.454484554898;3807.828647710804;3808.8857334280015;3860.517435320585;3083.152133163353;3085.444619968427;3149.889753858604;3222.371637530706;3238.9838050809594;977.2572844637984;990.663174520652;992.062500936608;993.0665174735725;1002.6791426743519;795.6896810244009;798.6805277888891;802.8675268580619;808.8099296665279;810.4772421787914;4528.275475923836;4551.704139230939;4598.172328980816;4696.530346965276;4903.558679718771;387.44595228823056;397.4118304908751;403.5943876404195;408.6975638027838;410.5073911306444;3168.186705962004;3222.5649537312634;3224.129485039073;3272.443684573628;3331.350386674575;7820.804479888048;8197.590120493951;8310.70912518059;8314.41799074059;8319.417640765088;7707.4604777666145;7947.562884041433;8012.879806802903;8252.917470825216;8255.091939886728;6373.267074286424;6426.35736426363;6542.214934207926;6544.051112588648;6547;4821.252705830602;4938.728369939688;4986.526280003394;5022.070916880389;5181.455947125648;7393.186749457448;7424.443166762407;7437.442191835526;7527.096748390229;7621.428392870446;7504.099508059068;7564.432667549846;7583.05211848519;7595.506292090997;7675.616219188906;5505.834824955257;5895.673473468435;5989.460948514655;5989.700514974321;5994.07091900756;5937.851553711192;6470.805875823545;6525.412712855676;6662.966685166543;6663.666816659244;5846;5959.642421454727;6016.939830601638;6053.727582258721;6131.54013449002;5804.506616937608;5821.970890145522;5836.503897168618;5851.765929362778;5962.135490353961;5594.13290939905;5692;5752.28096487939;5760.855978600569;5765.5675824314185;4072.959270407258;4114.526829414655;4146.709730318969;4172.207280616673;4334.45819272591;4030.3349947258375;4039.2729308723538;4114.794260286913;4187.455630768102;4298.075913678574 10:33:49 INFO - PROCESS | 7903 | |4;prototype.html;276.5657917070199;282.4576812519961;288.0465658669803;292.2154016465788;295.2309234444274;4740.17047016772;4750.28745688147;4757.881897754025;4769.8807529811775;4777.733900516366;4448.421705178331;4703.65945705474;4730.19586670266;4748.548887855657;4751.695427717563;3616.2405894762132;3643.180284435994;3710.5176327077443;3727.310447567209;3731.141837377405;3709.369407200769;3718.9628103718887;3725.1245957200035;3728.5712143103483;3735.4396840473873;3546.7517273790845;3691.50164727761;3707.518022657051;3712.7586706864104;3719.479272901782;3613.6567026132607;3641.4355774854807;3662.322470342995;3678.1172518595613;3693.8153092345274;3245.367153405087;3251.349730053999;3253.755968302387;3255.300110476235;3256.0882952773263;4623.30650402439;4626.838060667894;4627.745473998929;4628.83799067031;4640.32715256286;4038.596140385938;4176.350341615075;4193.874183774492;4195.7063005589625;4276.5723427656985;4865.832200271944;4927.50724927508;4930.876728081791;4934.950650493485;4955.801767929279;3575;3585.175409655794;3586.8923932282073;3605.5132557104716;3611.4402267648557;5066.442691303953;5158.690478571298;5166.191832858507;5206.921896171561;5238.109521381374;3662.688671462902;3680.208755117609;3692.261547690419;3694.612065733113;3696.8706095287075;3741.0273328934127;3759.1353988582778;3759.736818422739;3761.887143385703;3768.8492460301827;4245.448091748053;4247.044415006599;4252.277112890754;4256.510501292391;4291.163223171514;4748.501407352247;4891.633127515451;4897.363342765418;4920.827771027997;4955.306257124005;1272.1540175783;1279.878411550901;1281.1992504684572;1281.4681907008674;1288.2592509307185;836.8786525953702;841.3815845353782;846.1453931529077;854.6325080215566;866.6793286484042;4275.187714334266;4317.287647538184;4320.746983374786;4324.870253892388;4389.714668546598;5097.1844504879045;5104.464031276662;5105.2342148678;5121.769520371592;5128.6666366686795;4268.658507319407;4395.714278571946;4400.823967041347;4402.669799765031;4406.801693923781;2660.2285337252365;2665.560182569893;2701.8378897265834;2704.2563295093614;2707.945841083167;4777.181462936884;4777.832775852898;4782.378290822171;4786.712797232177;4837.879053023632;4997.525235102659;5212.687238765686;5224.477552244745;5226.477352264743;5230.555402790729;4813.663043586986;4822.373091498082;4837.153498137812;4842.4020073376405;4847.80608775645;5086.18621020635;5106.080905436908;5109.7700603472185;5135.2553879687985;5153.484651534816;4852.2479015752615;5001;5046.713088162495;5047.823326183566;5069.239614057921;4761.809527618995;4784.808607655655;4798.2082956311815;4802.591779698625;4822.252550854623;3563.1982803868923;3577.1398872585587;3578.302231064917;3579.785212887235;3610.9458358124125;4915.852524424273;5090.974545127398;5121.667091639031;5125.8466844959585;5161.470879269056;4892.339534162842;4937.777799998937;4943.431505376928;4945.975270123627;4961.164369183425;4926.753662316798;4933.925991110064;4945.307656928105;4956.083124621957;4966.528179822911;4782.545658162469;4890.779914903766;4894.608431325557;4928.67963582366;4930.4822993586595;4761.2382018876815;4878.170710979071;4880.95119048805;4948.752562371939;5023.654538823818;4888.753367891165;4891.315215869852;4917.778699958439;4924.187509060965;4924.285978533164 10:33:49 INFO - PROCESS | 7903 | |5;yui.html;655.8983357579575;682.106440562863;696.3454352908266;719.1370355573314;739.8039519527323;12136.453859576319;12991.2205267684;13075.28085955272;13085.93457032716;13111.54109606164;11953.342566158857;12231.327276999762;12273.220383044476;12279.079069069832;12279.508819647204;622.2626187967251;635.6027482823235;770.4106358635648;776.4797585617649;795.7652492514693;779.6803310642638;782.7182214402839;783.0485959559135;783.2519943453988;783.2793829676683;849.4393700157897;850.7362717557577;851.0680804519042;851.7827953871785;852.0159216105408;650.2814390098944;668.1214203322663;812.1675282835082;830.9293710034655;840.8360369727906;616.0605077257173;616.1681729664916;616.2204810914197;616.2820314333795;616.2881871438495;12428.56500022495;12454.875451245553;12464.314462704548;12531.122821402505;12548;11772.646820595395;11783.646490605295;12078.939605301917;12156.756864862653;12548.686282842911;10602.840957385646;10684.305520141166;10967;11170.888291117148;11431.657050288504;3934.7015484889916;3941.5467221269632;3950.4271880577444;4054.2971951780028;4056.6957478189256;48323.75838120822;48443.14672245314;48490.5150948493;49171.262431063566;49273.260901086156;9423;9619.951900240454;9715.805683886283;9759.804803904024;9926.404415735078;17501.47495575135;17571.648567028842;17615.559611009572;17642.2061007255;17833.732494012602;6291.622502649764;6298.905516417258;6374.362563743682;6382.776602818972;6445.806625801233;3391.69474747269;3470.201853573692;3480.686738193524;3480.704140148065;3555.2356243407276;2561.244432892301;2612.9608055879175;2644.378571035805;2648.549746543092;2656.40230948039;464.22706194186304;472.1736960319441;474.9525047495223;475.81681052794926;477.74918167962096;483.9661223714377;485.2866286558753;542.3979382884994;552.6545908806995;553.3885057012025;7443.106827180773;7586.886196707053;7776.1057478389575;7919.406044546682;7966.203379661987;557.8842315369261;586.9471747542742;613.6134235431739;614.0641454768402;622.2843729710869;3620.31214069326;3623.7644553103964;3698.278835627027;3720.3489389356755;3908.355121404993;65822.34177658257;68393.65803171053;68432;68638.3136168642;68712;37435.38469229637;39840.800795995834;59445.70277148586;62102.37897620966;62628.37371626226;54838.45161548333;56064.43935560592;56631;57009.14486282709;58617.12074318888;7141.500094993508;7197.640117994184;7206.639668016683;7542.208068152984;7615.6953721850505;37129.814350929155;38030.619693802706;38143.23713525658;39250;39471.407928881665;45093.54906450894;50550.241746373096;51174.74412627913;51905;52369.214461783864;9097.363184577016;9327.253819694273;10097.091261786474;10257.33327333721;10386.11718003978;10270.831573665084;10289.382637041801;10379.06588407047;10480;10725.678229653124;9446;11479.196456248317;11677.708057298636;11712.297262164297;12115.515379384726;11079.113670906147;11239.157063220127;11555.71110722205;12016.459259333176;12058.276503409823;11082.168837337393;11304.83042754343;11375.715607109889;11977.760444790882;12168.330741809286;9375;9448.669296574586;9521.190698790404;9582.185514231089;9885.703428897144;9052.3790483807;9731.659391921248;9967.700968970943;10108.241881859038;10137.189024877845 10:33:49 INFO - PROCESS | 7903 | __end_tp_report 10:33:49 INFO - PROCESS | 7903 | __start_cc_report 10:33:49 INFO - PROCESS | 7903 | _x_x_mozilla_cycle_collect,1292 10:33:49 INFO - PROCESS | 7903 | __end_cc_report 10:33:49 INFO - PROCESS | 7903 | __startTimestamp1477935229695__endTimestamp 10:33:49 INFO - PROCESS | 7903 | 10:33:49 INFO - PROCESS | 7903 | ------- Summary: start ------- 10:33:49 INFO - PROCESS | 7903 | Number of tests: 6 10:33:49 INFO - PROCESS | 7903 | 10:33:49 INFO - PROCESS | 7903 | [#0] dojo.html Cycles:165 Average:4497.74 Median:4605.75 stddev:468.18 (10.2%) stddev-sans-first:443.59 10:33:49 INFO - PROCESS | 7903 | Values: 2535.7 2556.2 2585.2 2591.0 2605.5 4483.5 4574.9 4622.6 4626.0 4643.1 4551.3 4588.2 4605.7 4615.7 4641.7 4122.8 4136.2 4183.0 4195.3 4272.9 4209.1 4249.6 4298.8 4303.8 4341.4 4157.3 4204.6 4244.3 4312.0 4354.5 4225.5 4235.0 4241.2 4244.2 4246.3 4222.4 4224.7 4229.2 4230.4 4234.9 4510.2 4544.7 4547.3 4568.9 4571.5 4805.7 4824.0 4829.0 4878.5 4946.8 4899.7 4899.8 4906.7 4908.0 4965.4 4448.5 4493.9 4548.9 4568.0 4619.1 5001.4 5017.3 5019.7 5020.0 5080.3 4785.3 4823.5 4825.9 4830.7 4863.9 4790.8 4825.9 4836.9 4897.6 4974.0 4795.7 4826.1 4828.3 4834.6 4900.6 4803.5 4809.5 4820.7 4850.1 4871.6 3922.5 4066.7 4069.9 4073.2 4127.5 3494.5 3546.5 3568.1 3576.6 3604.5 4203.9 4205.4 4207.3 4251.9 4256.2 4857.2 4876.2 4879.4 4887.7 4938.7 4073.7 4137.9 4141.0 4183.0 4191.4 4284.2 4310.2 4329.2 4332.4 4340.9 4537.7 4544.6 4547.1 4547.5 4547.9 4834.5 4841.4 4845.1 4845.2 4849.4 4527.1 4532.9 4536.0 4547.2 4548.1 4772.5 4785.7 4804.7 4846.6 4852.0 4846.7 4849.9 4857.0 4861.8 4921.1 4711.7 4722.3 4728.1 4734.4 4791.2 4559.6 4607.9 4612.4 4654.6 4692.2 4674.8 4676.8 4684.3 4707.1 4723.1 4751.9 4755.5 4755.5 4799.7 4801.0 4554.3 4601.2 4604.2 4640.8 4650.9 10:33:49 INFO - PROCESS | 7903 | 10:33:49 INFO - PROCESS | 7903 | [#1] ext.html Cycles:180 Average:44710.34 Median:32589.01 stddev:82893.77 (254.4%) stddev-sans-first:83059.98 10:33:49 INFO - PROCESS | 7903 | Values: 545.7 548.1 554.7 558.2 568.6 27492.0 37776.0 38513.8 38656.4 42813.0 38997.6 39573.6 39578.0 39632.0 39636.6 7434.5 7645.0 7795.5 7796.2 7797.7 7363.1 9604.5 9841.0 9857.8 10257.8 10044.1 10053.8 10090.5 10090.8 10130.7 9842.7 9881.7 9894.6 9896.7 9908.3 9799.8 9844.5 9858.8 9859.2 9873.1 36016.0 36192.5 36254.1 36315.0 36324.3 2836.0 2928.3 2974.5 3197.0 3428.9 27108.6 27343.3 27357.6 27806.9 27937.9 3272.7 3331.6 3358.9 3368.2 3419.7 251645.0 252779.0 254183.0 255448.0 255484.0 30734.7 51934.7 52635.5 52695.7 52742.2 30949.8 32312.2 32471.7 32500.5 32537.7 12181.8 12264.8 12289.2 12293.8 12307.8 9114.7 9380.3 10067.0 10111.2 10134.5 7445.6 7656.0 7683.9 7741.0 7802.4 3036.4 3066.1 3069.7 3100.6 3136.3 816.0 870.1 937.7 966.2 981.5 27202.9 27342.0 27636.0 27844.9 28362.3 939.2 948.8 949.7 966.8 986.8 13842.8 14192.9 14447.3 14856.9 14948.6 382237.0 385729.0 386771.0 387583.0 388947.0 48642.8 49246.8 49258.3 49259.0 49302.5 1034.4 1110.0 1155.0 1193.3 1195.7 26428.3 28293.9 28404.1 29174.0 29228.4 41165.6 41582.4 41822.4 41837.6 41848.6 286054.0 287331.0 287717.0 287899.0 288147.0 21482.7 22253.9 22282.8 22284.4 24495.5 37162.3 37543.8 37617.0 38027.6 38534.6 32101.4 32270.4 32402.2 32626.8 32682.0 29798.9 32335.2 32445.5 32464.7 33527.8 31849.4 32428.4 32536.2 32551.2 33124.3 28941.3 29582.0 29784.9 29834.9 30294.7 23254.4 23278.3 23512.0 23631.9 23666.3 10:33:49 INFO - PROCESS | 7903 | 10:33:49 INFO - PROCESS | 7903 | [#2] jquery.html Cycles:180 Average:24122.80 Median:5176.62 stddev:63631.85 (1229.2%) stddev-sans-first:63785.30 10:33:49 INFO - PROCESS | 7903 | Values: 342.1 348.7 350.3 354.5 367.3 12407.1 15876.6 16181.8 17515.4 17676.5 16498.3 16940.3 17259.1 17370.7 17389.4 4989.7 4992.3 5148.3 5174.0 5179.2 3664.3 3852.8 5113.2 5124.9 5796.9 6075.2 6095.9 6102.5 6103.6 6109.2 5820.2 6007.9 6029.5 6030.3 6073.0 5256.5 5260.5 5260.8 5263.9 5270.3 19781.7 20074.5 20221.4 20274.0 20348.8 1736.3 2315.1 2421.7 2463.6 2465.3 12841.7 12885.9 12894.6 13164.7 13550.1 1682.2 1700.8 1701.3 1717.0 1741.4 66912.0 67453.0 67722.3 67849.0 68544.7 9093.7 9300.3 9403.9 9437.8 9456.6 12689.5 12704.4 12738.0 12769.2 12779.4 6457.5 6621.5 6656.7 6793.7 6810.3 6191.7 6229.5 6381.9 6404.7 6430.6 5582.7 5585.9 5647.2 5713.1 5884.5 1593.8 1694.8 1697.9 1705.4 1728.7 828.4 846.9 852.2 855.5 867.0 16444.6 16546.0 17163.7 17196.6 17542.9 858.3 862.8 867.6 868.0 926.1 9425.8 9626.6 10075.4 10189.6 10267.3 358179.0 388384.0 389518.0 391618.0 395345.0 76303.0 79911.2 80197.0 82226.0 82268.1 893.7 903.9 920.9 921.7 939.7 15403.5 15457.6 16104.4 16350.2 16401.9 35257.3 35423.6 35965.0 36100.6 37058.4 48695.3 50856.2 51044.2 52085.7 52111.5 7096.3 7187.4 7281.9 7372.3 7407.5 9595.4 11314.0 11367.7 11726.3 11813.9 9129.0 9740.0 9757.2 10066.1 10203.4 9601.9 10121.7 10242.5 10371.5 10669.0 5418.2 8057.4 9768.0 10151.3 10643.2 5867.9 6550.4 7072.8 7154.3 7536.6 7729.7 9471.2 9632.3 9750.0 9958.5 10:33:49 INFO - PROCESS | 7903 | 10:33:49 INFO - PROCESS | 7903 | [#3] mootools.html Cycles:180 Average:4507.39 Median:5343.65 stddev:2411.13 (45.1%) stddev-sans-first:2405.29 10:33:49 INFO - PROCESS | 7903 | Values: 1227.7 1359.9 1403.6 1473.4 1689.3 6061.8 6450.8 6672.5 6917.7 6921.1 6921.2 6998.1 7004.5 7007.4 7010.3 2026.7 2050.5 2055.2 2055.9 2059.8 2048.9 2059.7 2061.4 2110.8 2113.9 2042.9 2086.5 2102.8 2103.4 2108.6 2015.5 2069.5 2072.8 2074.5 2078.7 2024.5 2040.3 2059.9 2062.5 2065.5 6837.9 6890.3 6910.9 6974.9 7020.6 4123.7 4268.1 4271.7 4308.8 4318.2 2609.7 2775.8 2845.8 2851.0 2852.1 872.7 878.2 887.3 889.2 920.6 8920.5 8997.8 9021.1 9029.9 9039.7 3493.6 3633.0 3661.4 3693.4 3715.3 7308.8 7310.1 7310.9 7311.2 7313.8 4180.2 4196.4 4197.5 4198.7 4203.4 3419.7 3519.5 3807.8 3808.9 3860.5 3083.2 3085.4 3149.9 3222.4 3239.0 977.3 990.7 992.1 993.1 1002.7 795.7 798.7 802.9 808.8 810.5 4528.3 4551.7 4598.2 4696.5 4903.6 387.4 397.4 403.6 408.7 410.5 3168.2 3222.6 3224.1 3272.4 3331.4 7820.8 8197.6 8310.7 8314.4 8319.4 7707.5 7947.6 8012.9 8252.9 8255.1 6373.3 6426.4 6542.2 6544.1 6547.0 4821.3 4938.7 4986.5 5022.1 5181.5 7393.2 7424.4 7437.4 7527.1 7621.4 7504.1 7564.4 7583.1 7595.5 7675.6 5505.8 5895.7 5989.5 5989.7 5994.1 5937.9 6470.8 6525.4 6663.0 6663.7 5846.0 5959.6 6016.9 6053.7 6131.5 5804.5 5822.0 5836.5 5851.8 5962.1 5594.1 5692.0 5752.3 5760.9 5765.6 4073.0 4114.5 4146.7 4172.2 4334.5 4030.3 4039.3 4114.8 4187.5 4298.1 10:33:49 INFO - PROCESS | 7903 | 10:33:49 INFO - PROCESS | 7903 | [#4] prototype.html Cycles:180 Average:4121.66 Median:4749.42 stddev:1191.14 (25.1%) stddev-sans-first:1158.99 10:33:49 INFO - PROCESS | 7903 | Values: 276.6 282.5 288.0 292.2 295.2 4740.2 4750.3 4757.9 4769.9 4777.7 4448.4 4703.7 4730.2 4748.5 4751.7 3616.2 3643.2 3710.5 3727.3 3731.1 3709.4 3719.0 3725.1 3728.6 3735.4 3546.8 3691.5 3707.5 3712.8 3719.5 3613.7 3641.4 3662.3 3678.1 3693.8 3245.4 3251.3 3253.8 3255.3 3256.1 4623.3 4626.8 4627.7 4628.8 4640.3 4038.6 4176.4 4193.9 4195.7 4276.6 4865.8 4927.5 4930.9 4935.0 4955.8 3575.0 3585.2 3586.9 3605.5 3611.4 5066.4 5158.7 5166.2 5206.9 5238.1 3662.7 3680.2 3692.3 3694.6 3696.9 3741.0 3759.1 3759.7 3761.9 3768.8 4245.4 4247.0 4252.3 4256.5 4291.2 4748.5 4891.6 4897.4 4920.8 4955.3 1272.2 1279.9 1281.2 1281.5 1288.3 836.9 841.4 846.1 854.6 866.7 4275.2 4317.3 4320.7 4324.9 4389.7 5097.2 5104.5 5105.2 5121.8 5128.7 4268.7 4395.7 4400.8 4402.7 4406.8 2660.2 2665.6 2701.8 2704.3 2707.9 4777.2 4777.8 4782.4 4786.7 4837.9 4997.5 5212.7 5224.5 5226.5 5230.6 4813.7 4822.4 4837.2 4842.4 4847.8 5086.2 5106.1 5109.8 5135.3 5153.5 4852.2 5001.0 5046.7 5047.8 5069.2 4761.8 4784.8 4798.2 4802.6 4822.3 3563.2 3577.1 3578.3 3579.8 3610.9 4915.9 5091.0 5121.7 5125.8 5161.5 4892.3 4937.8 4943.4 4946.0 4961.2 4926.8 4933.9 4945.3 4956.1 4966.5 4782.5 4890.8 4894.6 4928.7 4930.5 4761.2 4878.2 4881.0 4948.8 5023.7 4888.8 4891.3 4917.8 4924.2 4924.3 10:33:49 INFO - PROCESS | 7903 | 10:33:49 INFO - PROCESS | 7903 | [#5] yui.html Cycles:180 Average:14376.73 Median:24487.90 stddev:18134.45 (74.1%) stddev-sans-first:18156.05 10:33:49 INFO - PROCESS | 7903 | Values: 655.9 682.1 696.3 719.1 739.8 12136.5 12991.2 13075.3 13085.9 13111.5 11953.3 12231.3 12273.2 12279.1 12279.5 622.3 635.6 770.4 776.5 795.8 779.7 782.7 783.0 783.3 783.3 849.4 850.7 851.1 851.8 852.0 650.3 668.1 812.2 830.9 840.8 616.1 616.2 616.2 616.3 616.3 12428.6 12454.9 12464.3 12531.1 12548.0 11772.6 11783.6 12078.9 12156.8 12548.7 10602.8 10684.3 10967.0 11170.9 11431.7 3934.7 3941.5 3950.4 4054.3 4056.7 48323.8 48443.1 48490.5 49171.3 49273.3 9423.0 9620.0 9715.8 9759.8 9926.4 17501.5 17571.6 17615.6 17642.2 17833.7 6291.6 6298.9 6374.4 6382.8 6445.8 3391.7 3470.2 3480.7 3480.7 3555.2 2561.2 2613.0 2644.4 2648.5 2656.4 464.2 472.2 475.0 475.8 477.7 484.0 485.3 542.4 552.7 553.4 7443.1 7586.9 7776.1 7919.4 7966.2 557.9 586.9 613.6 614.1 622.3 3620.3 3623.8 3698.3 3720.3 3908.4 65822.3 68393.7 68432.0 68638.3 68712.0 37435.4 39840.8 59445.7 62102.4 62628.4 54838.5 56064.4 56631.0 57009.1 58617.1 7141.5 7197.6 7206.6 7542.2 7615.7 37129.8 38030.6 38143.2 39250.0 39471.4 45093.5 50550.2 51174.7 51905.0 52369.2 9097.4 9327.3 10097.1 10257.3 10386.1 10270.8 10289.4 10379.1 10480.0 10725.7 9446.0 11479.2 11677.7 11712.3 12115.5 11079.1 11239.2 11555.7 12016.5 12058.3 11082.2 11304.8 11375.7 11977.8 12168.3 9375.0 9448.7 9521.2 9582.2 9885.7 9052.4 9731.7 9967.7 10108.2 10137.2 10:33:49 INFO - PROCESS | 7903 | -------- Summary: end -------- 10:33:49 INFO - PROCESS | 7903 | 10:33:50 INFO - TEST-INFO | 7903: exit 0 10:33:50 INFO - TEST-OK | dromaeo_css | took 1123569ms 10:33:50 INFO - TEST-START | kraken 10:33:50 INFO - operating with platform_type : linux_ 10:33:50 INFO - Initialising browser for kraken test... 10:33:50 INFO - TEST-INFO | started process 8215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQrTAwk/profile http://localhost:41532/getInfo.html) 10:33:55 INFO - PROCESS | 8215 | __metrics Screen width/height:1600/1200 10:33:55 INFO - PROCESS | 8215 | colorDepth:24 10:33:55 INFO - PROCESS | 8215 | Browser inner width/height: 1024/697 10:33:55 INFO - PROCESS | 8215 | __metrics 10:33:56 INFO - PROCESS | 8215 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:33:56 INFO - PROCESS | 8215 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:33:56 INFO - PROCESS | 8215 | console.error: PushService: 10:33:56 INFO - PROCESS | 8215 | stateChangeProcessEnqueue: Error transitioning state 10:33:56 INFO - PROCESS | 8215 | UnknownError 10:33:57 INFO - TEST-INFO | 8215: exit 0 10:33:57 INFO - Browser initialized. 10:33:57 INFO - Running cycle 1/1 for kraken test... 10:33:57 INFO - TEST-INFO | started process 8297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQrTAwk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:09 INFO - PROCESS | 8297 | RSS: Main: 175779840 10:34:09 INFO - PROCESS | 8297 | 10:34:12 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41532/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:13 INFO - PROCESS | 8297 | RSS: Main: 235896832 10:34:13 INFO - PROCESS | 8297 | 10:34:16 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41532/tests/kraken/driver.html?testName=audio-dft) 10:34:17 INFO - PROCESS | 8297 | RSS: Main: 219029504 10:34:17 INFO - PROCESS | 8297 | 10:34:20 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41532/tests/kraken/driver.html?testName=audio-fft) 10:34:20 INFO - PROCESS | 8297 | RSS: Main: 301969408 10:34:20 INFO - PROCESS | 8297 | 10:34:23 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41532/tests/kraken/driver.html?testName=audio-oscillator) 10:34:23 INFO - PROCESS | 8297 | RSS: Main: 212922368 10:34:23 INFO - PROCESS | 8297 | 10:34:26 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:34:26 INFO - PROCESS | 8297 | RSS: Main: 215191552 10:34:26 INFO - PROCESS | 8297 | 10:34:29 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41532/tests/kraken/driver.html?testName=imaging-darkroom) 10:34:30 INFO - PROCESS | 8297 | RSS: Main: 251019264 10:34:30 INFO - PROCESS | 8297 | 10:34:33 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41532/tests/kraken/driver.html?testName=imaging-desaturate) 10:34:34 INFO - PROCESS | 8297 | RSS: Main: 249700352 10:34:34 INFO - PROCESS | 8297 | 10:34:37 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41532/tests/kraken/driver.html?testName=json-parse-financial) 10:34:37 INFO - PROCESS | 8297 | RSS: Main: 248864768 10:34:37 INFO - PROCESS | 8297 | 10:34:39 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:34:40 INFO - PROCESS | 8297 | RSS: Main: 211484672 10:34:40 INFO - PROCESS | 8297 | 10:34:42 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:42 INFO - PROCESS | 8297 | RSS: Main: 219578368 10:34:42 INFO - PROCESS | 8297 | 10:34:44 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:45 INFO - PROCESS | 8297 | RSS: Main: 228225024 10:34:45 INFO - PROCESS | 8297 | 10:34:48 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:49 INFO - PROCESS | 8297 | RSS: Main: 236019712 10:34:49 INFO - PROCESS | 8297 | 10:34:52 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:52 INFO - PROCESS | 8297 | RSS: Main: 233545728 10:34:52 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | Cycle 1(1): loaded http://localhost:41532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41532/tests/kraken/driver.html?testName=ai-astar) 10:34:54 INFO - PROCESS | 8297 | RSS: Main: 284504064 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | __start_tp_report 10:34:54 INFO - PROCESS | 8297 | _x_x_mozilla_page_load 10:34:54 INFO - PROCESS | 8297 | _x_x_mozilla_page_load_details 10:34:54 INFO - PROCESS | 8297 | |i|pagename|runs| 10:34:54 INFO - PROCESS | 8297 | |0;ai-astar;108;117;114;115;115;115;114;116;115;115 10:34:54 INFO - PROCESS | 8297 | |1;audio-beat-detection;150;129;131;172;129;127;127;127;163;129 10:34:54 INFO - PROCESS | 8297 | |2;audio-dft;162;162;161;162;164;163;163;161;160;160 10:34:54 INFO - PROCESS | 8297 | |3;audio-fft;77;76;77;114;76;76;77;76;102;75 10:34:54 INFO - PROCESS | 8297 | |4;audio-oscillator;83;82;123;83;83;83;117;84;84;120 10:34:54 INFO - PROCESS | 8297 | |5;imaging-gaussian-blur;119;117;117;116;117;117;116;117;117;118 10:34:54 INFO - PROCESS | 8297 | |6;imaging-darkroom;147;147;146;146;147;146;146;146;146;147 10:34:54 INFO - PROCESS | 8297 | |7;imaging-desaturate;86;85;85;85;87;85;86;85;85;86 10:34:54 INFO - PROCESS | 8297 | |8;json-parse-financial;72;61;62;61;62;65;64;63;64;62 10:34:54 INFO - PROCESS | 8297 | |9;json-stringify-tinderbox;67;67;65;66;67;67;66;66;67;66 10:34:54 INFO - PROCESS | 8297 | |10;stanford-crypto-aes;88;91;85;84;85;83;91;84;83;92 10:34:54 INFO - PROCESS | 8297 | |11;stanford-crypto-ccm;147;146;144;140;141;140;142;142;188;151 10:34:54 INFO - PROCESS | 8297 | |12;stanford-crypto-pbkdf2;175;175;176;176;190;193;181;179;176;176 10:34:54 INFO - PROCESS | 8297 | |13;stanford-crypto-sha256-iterative;72;73;68;69;70;69;69;70;72;70 10:34:54 INFO - PROCESS | 8297 | __end_tp_report 10:34:54 INFO - PROCESS | 8297 | __start_cc_report 10:34:54 INFO - PROCESS | 8297 | _x_x_mozilla_cycle_collect,1994 10:34:54 INFO - PROCESS | 8297 | __end_cc_report 10:34:54 INFO - PROCESS | 8297 | __startTimestamp1477935294860__endTimestamp 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | ------- Summary: start ------- 10:34:54 INFO - PROCESS | 8297 | Number of tests: 14 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:2.41 (2.1%) stddev-sans-first:0.93 10:34:54 INFO - PROCESS | 8297 | Values: 108.0 117.0 114.0 115.0 115.0 115.0 114.0 116.0 115.0 115.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:130.00 stddev:16.93 (13.0%) stddev-sans-first:17.42 10:34:54 INFO - PROCESS | 8297 | Values: 150.0 129.0 131.0 172.0 129.0 127.0 127.0 127.0 163.0 129.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 10:34:54 INFO - PROCESS | 8297 | Values: 162.0 162.0 161.0 162.0 164.0 163.0 163.0 161.0 160.0 160.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:13.70 (18.0%) stddev-sans-first:14.38 10:34:54 INFO - PROCESS | 8297 | Values: 77.0 76.0 77.0 114.0 76.0 76.0 77.0 76.0 102.0 75.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:83.00 stddev:17.87 (21.5%) stddev-sans-first:18.49 10:34:54 INFO - PROCESS | 8297 | Values: 83.0 82.0 123.0 83.0 83.0 83.0 117.0 84.0 84.0 120.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.60 10:34:54 INFO - PROCESS | 8297 | Values: 119.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 118.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:34:54 INFO - PROCESS | 8297 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 10:34:54 INFO - PROCESS | 8297 | Values: 86.0 85.0 85.0 85.0 87.0 85.0 86.0 85.0 85.0 86.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.50 stddev:3.24 (5.1%) stddev-sans-first:1.41 10:34:54 INFO - PROCESS | 8297 | Values: 72.0 61.0 62.0 61.0 62.0 65.0 64.0 63.0 64.0 62.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 10:34:54 INFO - PROCESS | 8297 | Values: 67.0 67.0 65.0 66.0 67.0 67.0 66.0 66.0 67.0 66.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.50 stddev:3.57 (4.1%) stddev-sans-first:3.75 10:34:54 INFO - PROCESS | 8297 | Values: 88.0 91.0 85.0 84.0 85.0 83.0 91.0 84.0 83.0 92.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:145.00 stddev:14.45 (10.0%) stddev-sans-first:15.32 10:34:54 INFO - PROCESS | 8297 | Values: 147.0 146.0 144.0 140.0 141.0 140.0 142.0 142.0 188.0 151.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:177.50 stddev:6.53 (3.7%) stddev-sans-first:6.70 10:34:54 INFO - PROCESS | 8297 | Values: 175.0 175.0 176.0 176.0 190.0 193.0 181.0 179.0 176.0 176.0 10:34:54 INFO - PROCESS | 8297 | 10:34:54 INFO - PROCESS | 8297 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.62 (2.3%) stddev-sans-first:1.58 10:34:54 INFO - PROCESS | 8297 | Values: 72.0 73.0 68.0 69.0 70.0 69.0 69.0 70.0 72.0 70.0 10:34:54 INFO - PROCESS | 8297 | -------- Summary: end -------- 10:34:54 INFO - PROCESS | 8297 | 10:34:56 INFO - TEST-INFO | 8297: exit 0 10:34:56 INFO - TEST-OK | kraken | took 65518ms 10:34:56 INFO - SUITE-END | took 1189s 10:34:56 INFO - Completed test suite (00:19:49) 10:34:56 INFO - javascript benchmark 10:34:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2535.695716514018, 2556.2331300609812, 2585.1598230575064, 2590.9611355829666, 2605.452854900472, 4483.529229430904, 4574.885627859305, 4622.58396744293, 4625.953740462594, 4643.117807616551, 4551.294549344857, 4588.197065513538, 4605.746683932391, 4615.676902616819, 4641.651876109288, 4122.773247471388, 4136.193442278757, 4182.975171083089, 4195.286801243796, 4272.9145417091795, 4209.0529630833125, 4249.575042495757, 4298.806553705091, 4303.806328715215, 4341.39220509129, 4157.272477316487, 4204.642605378546, 4244.342126970325, 4312.029793296515, 4354.499232588261, 4225.471816022997, 4235.0, 4241.2365774160635, 4244.151169766059, 4246.278132717414, 4222.387753775685, 4224.683148763855, 4229.238737027334, 4230.407742915994, 4234.9364759528635, 4510.188166130095, 4544.7045942013665, 4547.340635607851, 4568.862934111982, 4571.519990401027, 4805.711657300573, 4824.035192961422, 4828.951710482886, 4878.487758785312, 4946.802127914915, 4899.657024008321, 4899.779509922062, 4906.656534042619, 4908.0, 4965.354503914504, 4448.466184057934, 4493.932591011137, 4548.88627784308, 4567.954320456819, 4619.099275641218, 5001.399832020181, 5017.272495488207, 5019.749012549358, 5020.046191223656, 5080.314157588752, 4785.330053792402, 4823.517648235148, 4825.855224343275, 4830.7101573905675, 4863.902721945541, 4790.8323208688225, 4825.879353016203, 4836.879078023077, 4897.632677549198, 4973.975130124326, 4795.688280261772, 4826.058918510927, 4828.251620998751, 4834.564889159992, 4900.583450406755, 4803.495632958489, 4809.470958194595, 4820.68665536746, 4850.102730994707, 4871.561559459666, 3922.5489068757456, 4066.6949978751713, 4069.9389509157386, 4073.246449406869, 4127.545969943304, 3494.4932984717075, 3546.4857595648486, 3568.107973006748, 3576.5529308836394, 3604.5314109166166, 4203.894902627398, 4205.432266643964, 4207.305794543927, 4251.914961700811, 4256.212600668886, 4857.247126695368, 4876.195427754381, 4879.4388645305535, 4887.706737595685, 4938.654294199371, 4073.6944729145434, 4137.937930931039, 4140.979295103505, 4183.037901282722, 4191.434156388909, 4284.1645879053285, 4310.159518893848, 4329.220740266719, 4332.393464914914, 4340.934885976713, 4537.727736335764, 4544.613707834739, 4547.090581883703, 4547.477040140427, 4547.909041819079, 4834.540718631724, 4841.443234028132, 4845.055214233191, 4845.248986407112, 4849.369581954324, 4527.1172121436, 4532.864014079583, 4535.9773201133785, 4547.1815073287125, 4548.090381923695, 4772.475027746876, 4785.665003449725, 4804.711717296974, 4846.636502262415, 4851.9514804852915, 4846.660733748604, 4849.884526558841, 4856.951430485791, 4861.756912154307, 4921.089598424303, 4711.670183087288, 4722.338872557913, 4728.101660684459, 4734.360861283682, 4791.209450440639, 4559.612432943104, 4607.884802879955, 4612.446506419117, 4654.604358629555, 4692.178868698033, 4674.766261686834, 4676.836310729108, 4684.273937539687, 4707.082118986765, 4723.126221649006, 4751.928721069117, 4755.453122890912, 4755.524447555355, 4799.736014519095, 4801.0, 4554.294084416921, 4601.217792975269, 4604.1712491751805, 4640.767961601974, 4650.883727906694], "value": 4468.162780276955, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.6644163839239, 548.0874344216882, 554.706005816917, 558.2212813125687, 568.6360729133355, 27492.0, 37776.0, 38513.80743096288, 38656.42015369772, 42813.0, 38997.61002389975, 39573.60426395735, 39578.01054973627, 39632.0, 39636.60363396365, 7434.479586428952, 7645.0, 7795.532268063906, 7796.220377962187, 7797.727079552217, 7363.116426028857, 9604.471754053558, 9840.950795246014, 9857.802843943116, 10257.846132307985, 10044.146247568966, 10053.798924021516, 10090.495475226246, 10090.798184036315, 10130.74673133174, 9842.655507057254, 9881.654142105064, 9894.604215831358, 9896.653617123438, 9908.256880733938, 9799.755006124904, 9844.507774611313, 9858.80282394348, 9859.211263098934, 9873.111419972165, 36016.0, 36192.457113143326, 36254.09364765875, 36315.0, 36324.27351452956, 2835.9858200709073, 2928.282570770175, 2974.464596372652, 3196.952045719316, 3428.8971330860113, 27108.59337109945, 27343.316417089733, 27357.589636155473, 27806.860965695243, 27937.860310698317, 3272.656371081026, 3331.5502407175204, 3358.865645374182, 3368.208471009311, 3419.692227699519, 251645.0, 252779.0, 254183.0, 255447.99999999814, 255484.0, 30734.692653073183, 51934.740326298124, 52635.473645263824, 52695.73652131715, 52742.208866867026, 30949.845250773604, 32312.192195195308, 32471.67528324734, 32500.512492312635, 32537.674623253937, 12181.756364872654, 12264.754704905852, 12289.201201922026, 12293.815592766116, 12307.830756078158, 9114.726558203265, 9380.343375963754, 10066.993300669874, 10111.191104711605, 10134.54394552247, 7445.553266804009, 7656.042994625672, 7683.884741728879, 7740.961295193488, 7802.414818888606, 3036.417027907091, 3066.0955018269665, 3069.739072178845, 3100.5969224001187, 3136.325689976666, 815.975520734367, 870.1168314161132, 937.7468083617522, 966.2366730283138, 981.4749109226673, 27202.863985679945, 27342.0, 27636.0, 27844.860775695994, 28362.2909427266, 939.178219058324, 948.7865230323122, 949.7055912667096, 966.8308046091905, 986.753311672082, 13842.792358114637, 14192.929035354964, 14447.277636118151, 14856.92571537157, 14948.626284342761, 382237.0, 385729.0, 386771.0, 387583.0, 388947.0, 48642.75678621584, 49246.75376623094, 49258.26112608314, 49259.02963881476, 49302.50697492979, 1034.4465710844813, 1109.9500522476508, 1154.982675259855, 1193.3078814287692, 1195.730960533873, 26428.339291517867, 28293.858530707214, 28404.108324895402, 29174.0, 29228.415431691672, 41165.58834411618, 41582.376264356666, 41822.372664410665, 41837.58162418337, 41848.581514184465, 286054.0, 287331.0, 287717.0, 287899.0, 288147.0, 21482.677759833303, 22253.888730556242, 22282.777172228718, 22284.442888927908, 24495.510089797746, 37162.256754865295, 37543.81228093842, 37617.0, 38027.61972380241, 38534.6146538531, 32101.35797284088, 32270.35459290848, 32402.189945251557, 32626.83686581552, 32682.0, 29798.851005744833, 32335.19162020874, 32445.51331729979, 32464.675353246166, 33527.83236083804, 31849.36301274008, 32428.35143297168, 32536.186595335304, 32551.18622034468, 33124.33751325008, 28941.276468087624, 29582.0, 29784.851075745348, 29834.850825745732, 30294.697053029187, 23254.418639534146, 23278.3016509505, 23512.0, 23631.881840590686, 23666.29001129969], "value": 16188.513817016901, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.09623445525665, 348.70534398433324, 350.25745419710216, 354.5001547817577, 367.2746326006138, 12407.131500794949, 15876.603084922883, 16181.838181618195, 17515.386961456352, 17676.46970590881, 16498.34006639733, 16940.3223871045, 17259.137043147854, 17370.739438908426, 17389.39137130201, 4989.65072444929, 4992.276119962621, 5148.304978827848, 5174.042802081608, 5179.19722443022, 3664.267146570683, 3852.8073596320214, 5113.207452844815, 5124.92312615311, 5796.855078623047, 6075.179850720163, 6095.939040609582, 6102.511799056065, 6103.6032657877095, 6109.205803245594, 5820.243368362107, 6007.909881351783, 6029.517638588903, 6030.276366836008, 6072.9696351518405, 5256.500632439912, 5260.500252476008, 5260.789568417259, 5263.894722105575, 5270.288511050997, 19781.703274450894, 20074.498137546532, 20221.39335819928, 20274.0, 20348.796512034838, 1736.3417935871212, 2315.050829160053, 2421.7093948726088, 2463.618139188429, 2465.285067330472, 12841.67895802603, 12885.935570322183, 12894.613161605166, 13164.736705265937, 13550.119242249222, 1682.2093616000461, 1700.8129105798353, 1701.2514493622766, 1716.9828301716948, 1741.3644019932633, 66912.0, 67453.0, 67722.3227767716, 67849.0, 68544.6572767133, 9093.681721139861, 9300.255979521757, 9403.90596094044, 9437.76405589852, 9456.57445414958, 12689.49242030327, 12704.364781760874, 12738.0, 12769.170003949714, 12779.424925878358, 6457.5479716419395, 6621.503387245976, 6656.667166641649, 6793.66031698423, 6810.31896810315, 6191.690415479298, 6229.53278504114, 6381.872362552723, 6404.743810247631, 6430.614163150226, 5582.748776305076, 5585.916211256835, 5647.237622920935, 5713.143028545752, 5884.529237660977, 1593.792806935091, 1694.7966244050792, 1697.932082716702, 1705.4457301377101, 1728.6629107324202, 828.411827602397, 846.9068402475723, 852.1861622150831, 855.4525103933488, 867.0, 16444.588885277724, 16546.0, 17163.656726865644, 17196.570085747706, 17542.912285438746, 858.3219256787069, 862.8015556422058, 867.6442658509981, 868.0494858130337, 926.1433174313732, 9425.811483770287, 9626.614935402506, 10075.3954762713, 10189.643362482277, 10267.332623379605, 358179.0, 388384.0, 389518.0, 391618.0, 395345.0, 76303.0, 79911.20088799037, 80197.0, 82226.0, 82268.12782466142, 893.6844307618807, 903.9231665308522, 920.9447433153898, 921.6958403726888, 939.6523286383945, 15403.537893863202, 15457.61355966065, 16104.355825766837, 16350.182490875171, 16401.91799041045, 35257.29485410226, 35423.64576354204, 35965.0, 36100.638993609726, 37058.44412333871, 48695.26957095575, 50856.237156441945, 51044.23433648424, 52085.73957130342, 52111.478885210665, 7096.325849044332, 7187.353138217585, 7281.927180728337, 7372.299631534996, 7407.481476296607, 9595.424274543271, 11314.0, 11367.658970230907, 11726.296422214695, 11813.881861181279, 9128.954355228447, 9739.951300243454, 9757.219422446045, 10066.054422448487, 10203.38779673222, 9601.903980960102, 10121.746956326151, 10242.487875606339, 10371.481425928825, 10668.972895150207, 5418.160185171305, 8057.355411567178, 9767.951160244153, 10151.340162889388, 10643.201759867887, 5867.9413205869105, 6550.443212327005, 7072.787816365517, 7154.284571542804, 7536.623168841426, 7729.690812367442, 9471.19494842946, 9632.325737198329, 9749.951250243703, 9958.452285124387], "value": 8172.162666204395, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.680802991222, 1359.8776110150088, 1403.5578792680305, 1473.4327283995658, 1689.349600403845, 6061.787837425691, 6450.806475805727, 6672.499562532806, 6917.688704008319, 6921.1002569666, 6921.169459664835, 6998.125234345707, 7004.5096843221, 7007.439404847612, 7010.263922288163, 2026.6959956006606, 2050.5181282398626, 2055.157385471957, 2055.879545647618, 2059.7837227091163, 2048.9077991490344, 2059.6704527275638, 2061.391889392625, 2110.7783682713325, 2113.894305284737, 2042.9387118386471, 2086.54096098858, 2102.7792081831417, 2103.4005308487085, 2108.630989576818, 2015.4860510569783, 2069.4515953272394, 2072.7927207279304, 2074.52285974226, 2078.6778049402365, 2024.4635171679517, 2040.2757021257537, 2059.8867062311565, 2062.5359294158843, 2065.452655046414, 6837.931620683829, 6890.31096890312, 6910.896336554955, 6974.895376569356, 7020.613866237355, 4123.670106391482, 4268.082362292091, 4271.722338048048, 4308.763018034007, 4318.244307246251, 2609.739026097394, 2775.764060054898, 2845.7518560337307, 2851.0448999585165, 2852.1301003194017, 872.6640243506232, 878.1613559051091, 887.2547060469172, 889.1597440418807, 920.5719340506696, 8920.509371984539, 8997.775055623597, 9021.097890210993, 9029.864552031724, 9039.7288081357, 3493.5807703075793, 3632.9636703633155, 3661.377565813818, 3693.372126738461, 3715.275521273326, 7308.780736577911, 7310.086239220098, 7310.890336644955, 7311.232320606367, 7313.780586582411, 4180.205760905418, 4196.433481480022, 4197.538270790211, 4198.6641068714425, 4203.390508376329, 3419.709324707378, 3519.454484554898, 3807.828647710804, 3808.8857334280015, 3860.517435320585, 3083.152133163353, 3085.444619968427, 3149.889753858604, 3222.371637530706, 3238.9838050809594, 977.2572844637984, 990.663174520652, 992.062500936608, 993.0665174735725, 1002.6791426743519, 795.6896810244009, 798.6805277888891, 802.8675268580619, 808.8099296665279, 810.4772421787914, 4528.275475923836, 4551.704139230939, 4598.172328980816, 4696.530346965276, 4903.558679718771, 387.44595228823056, 397.4118304908751, 403.5943876404195, 408.6975638027838, 410.5073911306444, 3168.186705962004, 3222.5649537312634, 3224.129485039073, 3272.443684573628, 3331.350386674575, 7820.804479888048, 8197.590120493951, 8310.70912518059, 8314.41799074059, 8319.417640765088, 7707.4604777666145, 7947.562884041433, 8012.879806802903, 8252.917470825216, 8255.091939886728, 6373.267074286424, 6426.35736426363, 6542.214934207926, 6544.051112588648, 6547.0, 4821.252705830602, 4938.728369939688, 4986.526280003394, 5022.070916880389, 5181.455947125648, 7393.186749457448, 7424.443166762407, 7437.442191835526, 7527.096748390229, 7621.428392870446, 7504.099508059068, 7564.432667549846, 7583.05211848519, 7595.506292090997, 7675.616219188906, 5505.834824955257, 5895.673473468435, 5989.460948514655, 5989.700514974321, 5994.07091900756, 5937.851553711192, 6470.805875823545, 6525.412712855676, 6662.966685166543, 6663.666816659244, 5846.0, 5959.642421454727, 6016.939830601638, 6053.727582258721, 6131.54013449002, 5804.506616937608, 5821.970890145522, 5836.503897168618, 5851.765929362778, 5962.135490353961, 5594.13290939905, 5692.0, 5752.28096487939, 5760.855978600569, 5765.5675824314185, 4072.959270407258, 4114.526829414655, 4146.709730318969, 4172.207280616673, 4334.45819272591, 4030.3349947258375, 4039.2729308723538, 4114.794260286913, 4187.455630768102, 4298.075913678574], "value": 3643.0179751522173, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.5657917070199, 282.4576812519961, 288.0465658669803, 292.2154016465788, 295.2309234444274, 4740.17047016772, 4750.28745688147, 4757.881897754025, 4769.8807529811775, 4777.733900516366, 4448.421705178331, 4703.65945705474, 4730.19586670266, 4748.548887855657, 4751.695427717563, 3616.2405894762132, 3643.180284435994, 3710.5176327077443, 3727.310447567209, 3731.141837377405, 3709.369407200769, 3718.9628103718887, 3725.1245957200035, 3728.5712143103483, 3735.4396840473873, 3546.7517273790845, 3691.50164727761, 3707.518022657051, 3712.7586706864104, 3719.479272901782, 3613.6567026132607, 3641.4355774854807, 3662.322470342995, 3678.1172518595613, 3693.8153092345274, 3245.367153405087, 3251.349730053999, 3253.755968302387, 3255.300110476235, 3256.0882952773263, 4623.30650402439, 4626.838060667894, 4627.745473998929, 4628.83799067031, 4640.32715256286, 4038.596140385938, 4176.350341615075, 4193.874183774492, 4195.7063005589625, 4276.5723427656985, 4865.832200271944, 4927.50724927508, 4930.876728081791, 4934.950650493485, 4955.801767929279, 3575.0, 3585.175409655794, 3586.8923932282073, 3605.5132557104716, 3611.4402267648557, 5066.442691303953, 5158.690478571298, 5166.191832858507, 5206.921896171561, 5238.109521381374, 3662.688671462902, 3680.208755117609, 3692.261547690419, 3694.612065733113, 3696.8706095287075, 3741.0273328934127, 3759.1353988582778, 3759.736818422739, 3761.887143385703, 3768.8492460301827, 4245.448091748053, 4247.044415006599, 4252.277112890754, 4256.510501292391, 4291.163223171514, 4748.501407352247, 4891.633127515451, 4897.363342765418, 4920.827771027997, 4955.306257124005, 1272.1540175783, 1279.878411550901, 1281.1992504684572, 1281.4681907008674, 1288.2592509307185, 836.8786525953702, 841.3815845353782, 846.1453931529077, 854.6325080215566, 866.6793286484042, 4275.187714334266, 4317.287647538184, 4320.746983374786, 4324.870253892388, 4389.714668546598, 5097.1844504879045, 5104.464031276662, 5105.2342148678, 5121.769520371592, 5128.6666366686795, 4268.658507319407, 4395.714278571946, 4400.823967041347, 4402.669799765031, 4406.801693923781, 2660.2285337252365, 2665.560182569893, 2701.8378897265834, 2704.2563295093614, 2707.945841083167, 4777.181462936884, 4777.832775852898, 4782.378290822171, 4786.712797232177, 4837.879053023632, 4997.525235102659, 5212.687238765686, 5224.477552244745, 5226.477352264743, 5230.555402790729, 4813.663043586986, 4822.373091498082, 4837.153498137812, 4842.4020073376405, 4847.80608775645, 5086.18621020635, 5106.080905436908, 5109.7700603472185, 5135.2553879687985, 5153.484651534816, 4852.2479015752615, 5001.0, 5046.713088162495, 5047.823326183566, 5069.239614057921, 4761.809527618995, 4784.808607655655, 4798.2082956311815, 4802.591779698625, 4822.252550854623, 3563.1982803868923, 3577.1398872585587, 3578.302231064917, 3579.785212887235, 3610.9458358124125, 4915.852524424273, 5090.974545127398, 5121.667091639031, 5125.8466844959585, 5161.470879269056, 4892.339534162842, 4937.777799998937, 4943.431505376928, 4945.975270123627, 4961.164369183425, 4926.753662316798, 4933.925991110064, 4945.307656928105, 4956.083124621957, 4966.528179822911, 4782.545658162469, 4890.779914903766, 4894.608431325557, 4928.67963582366, 4930.4822993586595, 4761.2382018876815, 4878.170710979071, 4880.95119048805, 4948.752562371939, 5023.654538823818, 4888.753367891165, 4891.315215869852, 4917.778699958439, 4924.187509060965, 4924.285978533164], "value": 3741.2845248228364, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.8983357579575, 682.106440562863, 696.3454352908266, 719.1370355573314, 739.8039519527323, 12136.453859576319, 12991.2205267684, 13075.28085955272, 13085.93457032716, 13111.54109606164, 11953.342566158857, 12231.327276999762, 12273.220383044476, 12279.079069069832, 12279.508819647204, 622.2626187967251, 635.6027482823235, 770.4106358635648, 776.4797585617649, 795.7652492514693, 779.6803310642638, 782.7182214402839, 783.0485959559135, 783.2519943453988, 783.2793829676683, 849.4393700157897, 850.7362717557577, 851.0680804519042, 851.7827953871785, 852.0159216105408, 650.2814390098944, 668.1214203322663, 812.1675282835082, 830.9293710034655, 840.8360369727906, 616.0605077257173, 616.1681729664916, 616.2204810914197, 616.2820314333795, 616.2881871438495, 12428.56500022495, 12454.875451245553, 12464.314462704548, 12531.122821402505, 12548.0, 11772.646820595395, 11783.646490605295, 12078.939605301917, 12156.756864862653, 12548.686282842911, 10602.840957385646, 10684.305520141166, 10967.0, 11170.888291117148, 11431.657050288504, 3934.7015484889916, 3941.5467221269632, 3950.4271880577444, 4054.2971951780028, 4056.6957478189256, 48323.75838120822, 48443.14672245314, 48490.5150948493, 49171.262431063566, 49273.260901086156, 9423.0, 9619.951900240454, 9715.805683886283, 9759.804803904024, 9926.404415735078, 17501.47495575135, 17571.648567028842, 17615.559611009572, 17642.2061007255, 17833.732494012602, 6291.622502649764, 6298.905516417258, 6374.362563743682, 6382.776602818972, 6445.806625801233, 3391.69474747269, 3470.201853573692, 3480.686738193524, 3480.704140148065, 3555.2356243407276, 2561.244432892301, 2612.9608055879175, 2644.378571035805, 2648.549746543092, 2656.40230948039, 464.22706194186304, 472.1736960319441, 474.9525047495223, 475.81681052794926, 477.74918167962096, 483.9661223714377, 485.2866286558753, 542.3979382884994, 552.6545908806995, 553.3885057012025, 7443.106827180773, 7586.886196707053, 7776.1057478389575, 7919.406044546682, 7966.203379661987, 557.8842315369261, 586.9471747542742, 613.6134235431739, 614.0641454768402, 622.2843729710869, 3620.31214069326, 3623.7644553103964, 3698.278835627027, 3720.3489389356755, 3908.355121404993, 65822.34177658257, 68393.65803171053, 68432.0, 68638.3136168642, 68712.0, 37435.38469229637, 39840.800795995834, 59445.70277148586, 62102.37897620966, 62628.37371626226, 54838.45161548333, 56064.43935560592, 56631.0, 57009.14486282709, 58617.12074318888, 7141.500094993508, 7197.640117994184, 7206.639668016683, 7542.208068152984, 7615.6953721850505, 37129.814350929155, 38030.619693802706, 38143.23713525658, 39250.0, 39471.407928881665, 45093.54906450894, 50550.241746373096, 51174.74412627913, 51905.0, 52369.214461783864, 9097.363184577016, 9327.253819694273, 10097.091261786474, 10257.33327333721, 10386.11718003978, 10270.831573665084, 10289.382637041801, 10379.06588407047, 10480.0, 10725.678229653124, 9446.0, 11479.196456248317, 11677.708057298636, 11712.297262164297, 12115.515379384726, 11079.113670906147, 11239.157063220127, 11555.71110722205, 12016.459259333176, 12058.276503409823, 11082.168837337393, 11304.83042754343, 11375.715607109889, 11977.760444790882, 12168.330741809286, 9375.0, 9448.669296574586, 9521.190698790404, 9582.185514231089, 9885.703428897144, 9052.3790483807, 9731.659391921248, 9967.700968970943, 10108.241881859038, 10137.189024877845], "value": 6051.759287449432, "unit": "score"}], "name": "dromaeo_css", "value": 6044.331767885631, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 114.0, 115.0, 115.0, 115.0, 114.0, 116.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 129.0, 131.0, 172.0, 129.0, 127.0, 127.0, 127.0, 163.0, 129.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 164.0, 163.0, 163.0, 161.0, 160.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 114.0, 76.0, 76.0, 77.0, 76.0, 102.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 123.0, 83.0, 83.0, 83.0, 117.0, 84.0, 84.0, 120.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 87.0, 85.0, 86.0, 85.0, 85.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 61.0, 62.0, 61.0, 62.0, 65.0, 64.0, 63.0, 64.0, 62.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 85.0, 84.0, 85.0, 83.0, 91.0, 84.0, 83.0, 92.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 144.0, 140.0, 141.0, 140.0, 142.0, 142.0, 188.0, 151.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 176.0, 176.0, 190.0, 193.0, 181.0, 179.0, 176.0, 176.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 68.0, 69.0, 70.0, 69.0, 69.0, 70.0, 72.0, 70.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1555.0, "alertThreshold": 2.0}]} 10:34:56 INFO - Return code: 0 10:34:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:34:56 INFO - # TBPL SUCCESS # 10:34:56 INFO - Running post-action listener: _resource_record_post_action 10:34:56 INFO - [mozharness: 2016-10-31 17:34:56.650825Z] Finished run-tests step (success) 10:34:56 INFO - Running post-run listener: _resource_record_post_run 10:34:56 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390283264; Read time: 16; Write time: 385052 10:34:56 INFO - TinderboxPrint: CPU usage
13.0% 10:34:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:34:56 INFO - TinderboxPrint: I/O write bytes / time
390,283,264 / 385,052 10:34:56 INFO - TinderboxPrint: CPU idle
8,367.3 (86.9%) 10:34:56 INFO - TinderboxPrint: CPU user
1,203.0 (12.5%) 10:34:56 INFO - TinderboxPrint: Swap in / out
0 / 0 10:34:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99459072; Read time: 0; Write time: 92912 10:34:56 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 288620544; Read time: 0; Write time: 291896 10:34:57 INFO - Running post-run listener: _upload_blobber_files 10:34:57 INFO - Blob upload gear active. 10:34:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:34:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:34:57 INFO - (blobuploader) - INFO - Open directory for files ... 10:34:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:34:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:34:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:58 INFO - (blobuploader) - INFO - Done attempting. 10:34:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:34:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:35:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:01 INFO - (blobuploader) - INFO - Done attempting. 10:35:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:35:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:35:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:02 INFO - (blobuploader) - INFO - Done attempting. 10:35:02 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:02 INFO - Return code: 0 10:35:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f359b3df1227c528a237d14693b62c02a66bc824512cd622c2dd87e8d74a432456e09a81e91c2a9faa68101c0dfc68ea10d6935f98d33f99b90314012db05d14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/723e5869a610df9bf5bce212f336631eca2d8b39d47bb34a9df130bc84bb1f00211f854911fd4616b19b0e06a78365df841c3fdfb1b77431ea2f2801c0f0b05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b753d8896e23331c2ba0892234fc8b14b143446fde0d2530e8205b515683449db6762f687f416ebf5d2a1c446ec28f44871a5296736f07746c2a2774772fee8"} 10:35:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:02 INFO - Contents: 10:35:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f359b3df1227c528a237d14693b62c02a66bc824512cd622c2dd87e8d74a432456e09a81e91c2a9faa68101c0dfc68ea10d6935f98d33f99b90314012db05d14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/723e5869a610df9bf5bce212f336631eca2d8b39d47bb34a9df130bc84bb1f00211f854911fd4616b19b0e06a78365df841c3fdfb1b77431ea2f2801c0f0b05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b753d8896e23331c2ba0892234fc8b14b143446fde0d2530e8205b515683449db6762f687f416ebf5d2a1c446ec28f44871a5296736f07746c2a2774772fee8"} 10:35:02 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:02 INFO - Copying logs to upload dir... 10:35:02 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.427491 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-31 10:35:02.520150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 10:35:02.523635) ========= 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=eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f359b3df1227c528a237d14693b62c02a66bc824512cd622c2dd87e8d74a432456e09a81e91c2a9faa68101c0dfc68ea10d6935f98d33f99b90314012db05d14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/723e5869a610df9bf5bce212f336631eca2d8b39d47bb34a9df130bc84bb1f00211f854911fd4616b19b0e06a78365df841c3fdfb1b77431ea2f2801c0f0b05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b753d8896e23331c2ba0892234fc8b14b143446fde0d2530e8205b515683449db6762f687f416ebf5d2a1c446ec28f44871a5296736f07746c2a2774772fee8"} build_url:https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011094 build_url: 'https://queue.taskcluster.net/v1/task/AthPRgmETBC15EYSvmoDBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f359b3df1227c528a237d14693b62c02a66bc824512cd622c2dd87e8d74a432456e09a81e91c2a9faa68101c0dfc68ea10d6935f98d33f99b90314012db05d14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/723e5869a610df9bf5bce212f336631eca2d8b39d47bb34a9df130bc84bb1f00211f854911fd4616b19b0e06a78365df841c3fdfb1b77431ea2f2801c0f0b05d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8b753d8896e23331c2ba0892234fc8b14b143446fde0d2530e8205b515683449db6762f687f416ebf5d2a1c446ec28f44871a5296736f07746c2a2774772fee8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 10:35:02.547797) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:35:02.548085) ========= 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=eca2ab57546de7b41f256b19000001ef-1477934052.407471-549917101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:35:02.631942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 10:35:02.632258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 10:35:02.632543) ========= ========= Total master_lag: 0.22 =========