builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1479892087.38 results: success (0) buildid: 20161122223006 builduid: 85c223cf9e4a449aa9dfd03a8830837e revision: 0ddfec7126ec503b54df9c4b7c3b988906f6c882 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:07.384724) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:07.385112) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:07.385398) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:07.447962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:07.448231) ========= 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=523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 01:08:08-- 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% 41.2M=0s 2016-11-23 01:08:08 (41.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094863 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:07.565766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:07.566140) ========= 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=523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013368 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:07.619828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:07.620172) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ddfec7126ec503b54df9c4b7c3b988906f6c882 --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 0ddfec7126ec503b54df9c4b7c3b988906f6c882 --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=523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 01:08:08,780 truncating revision to first 12 chars 2016-11-23 01:08:08,780 Setting DEBUG logging. 2016-11-23 01:08:08,780 attempt 1/10 2016-11-23 01:08:08,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ddfec7126ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 01:08:09,086 unpacking tar archive at: mozilla-central-0ddfec7126ec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:08.264002) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:08.264333) ========= script_repo_revision: 0ddfec7126ec503b54df9c4b7c3b988906f6c882 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:08.264707) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:08.264990) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 01:08:08.286218) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-23 01:08:08.286522) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:08:09 INFO - MultiFileLogger online at 20161123 01:08:09 in /builds/slave/test 01:08:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:08:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:08:09 INFO - {'append_to_log': False, 01:08:09 INFO - 'base_work_dir': '/builds/slave/test', 01:08:09 INFO - 'blob_upload_branch': 'Firefox', 01:08:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:08:09 INFO - 'branch': 'Firefox', 01:08:09 INFO - 'buildbot_json_path': 'buildprops.json', 01:08:09 INFO - 'config_files': ('talos/linux_config.py',), 01:08:09 INFO - 'default_actions': ('clobber', 01:08:09 INFO - 'read-buildbot-config', 01:08:09 INFO - 'download-and-extract', 01:08:09 INFO - 'populate-webroot', 01:08:09 INFO - 'create-virtualenv', 01:08:09 INFO - 'install', 01:08:09 INFO - 'run-tests'), 01:08:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:08:09 INFO - 'download_minidump_stackwalk': True, 01:08:09 INFO - 'download_symbols': 'ondemand', 01:08:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:08:09 INFO - 'tooltool.py': '/tools/tooltool.py', 01:08:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:08:09 INFO - '/tools/misc-python/virtualenv.py')}, 01:08:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:08:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:08:09 INFO - 'installer_path': 'installer.exe', 01:08:09 INFO - 'log_level': 'info', 01:08:09 INFO - 'log_name': 'talos', 01:08:09 INFO - 'log_to_console': True, 01:08:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:08:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:08:09 INFO - 'opt_config_files': (), 01:08:09 INFO - 'pip_index': False, 01:08:09 INFO - 'sps_profile': False, 01:08:09 INFO - 'sps_profile_interval': 0, 01:08:09 INFO - 'suite': 'dromaeojs-e10s', 01:08:09 INFO - 'system_bits': '32', 01:08:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:08:09 INFO - 'title': 'talos-linux64-ix-065', 01:08:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:08:09 INFO - 'use_talos_json': True, 01:08:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:08:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:08:09 INFO - 'work_dir': 'build'} 01:08:09 INFO - [mozharness: 2016-11-23 09:08:09.543327Z] Running clobber step. 01:08:09 INFO - Running pre-action listener: _resource_record_pre_action 01:08:09 INFO - Running main action method: clobber 01:08:09 INFO - rmtree: /builds/slave/test/build 01:08:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:08:10 INFO - Running post-action listener: _resource_record_post_action 01:08:10 INFO - [mozharness: 2016-11-23 09:08:10.008146Z] Finished clobber step (success) 01:08:10 INFO - [mozharness: 2016-11-23 09:08:10.008246Z] Running read-buildbot-config step. 01:08:10 INFO - Running pre-action listener: _resource_record_pre_action 01:08:10 INFO - Running main action method: read_buildbot_config 01:08:10 INFO - Using buildbot properties: 01:08:10 INFO - { 01:08:10 INFO - "project": "", 01:08:10 INFO - "product": "firefox", 01:08:10 INFO - "script_repo_revision": "production", 01:08:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:08:10 INFO - "repository": "", 01:08:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 01:08:10 INFO - "buildid": "20161122223006", 01:08:10 INFO - "pgo_build": "True", 01:08:10 INFO - "basedir": "/builds/slave/test", 01:08:10 INFO - "buildnumber": 3, 01:08:10 INFO - "slavename": "talos-linux64-ix-065", 01:08:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:08:10 INFO - "platform": "ubuntu64_hw", 01:08:10 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 01:08:10 INFO - "branch": "mozilla-central", 01:08:10 INFO - "repo_path": "mozilla-central", 01:08:10 INFO - "revision": "0ddfec7126ec503b54df9c4b7c3b988906f6c882", 01:08:10 INFO - "stage_platform": "linux64-pgo", 01:08:10 INFO - "builduid": "85c223cf9e4a449aa9dfd03a8830837e", 01:08:10 INFO - "slavebuilddir": "test" 01:08:10 INFO - } 01:08:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 01:08:10 INFO - Running post-action listener: _resource_record_post_action 01:08:10 INFO - [mozharness: 2016-11-23 09:08:10.010706Z] Finished read-buildbot-config step (success) 01:08:10 INFO - [mozharness: 2016-11-23 09:08:10.010793Z] Running download-and-extract step. 01:08:10 INFO - Running pre-action listener: _resource_record_pre_action 01:08:10 INFO - Running main action method: download_and_extract 01:08:10 INFO - mkdir: /builds/slave/test/build/tests 01:08:10 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')]} 01:08:10 INFO - trying https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:08:10 INFO - Downloading https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:08:10 INFO - Downloaded 1361 bytes. 01:08:10 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 01:08:10 INFO - Using the following test package requirements: 01:08:10 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:10 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:08:10 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:08:10 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:10 INFO - u'jsshell-linux-x86_64.zip'], 01:08:10 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:08:10 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:10 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:08:10 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:08:10 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:08:10 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:10 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:08:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:08:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:08:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:08:10 INFO - Fetch https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:08:11 INFO - Http code: 200 01:08:11 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 01:08:11 INFO - x-amz-cf-id: 3uXl5fEp88ODjwDjKdGNfuxfpZbdPOKTdMvOsO1g1u7bAnZrkhXFTA== 01:08:11 INFO - x-amz-version-id: KEX2VoxyqIuuQaI3CdIU07zIQUo35Ld6 01:08:11 INFO - Expected file size: 21764881 01:08:11 INFO - Obtained file size: 21764881 01:08:15 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:08:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 01:08:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:08:15 INFO - Fetch https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:08:16 INFO - Http code: 200 01:08:16 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 01:08:16 INFO - x-amz-cf-id: ZNmOC3CIPRG3D4-MbEsNHHRbOZKW7dZaw9fuBiOlmEIKMI0WOcY2kQ== 01:08:16 INFO - x-amz-version-id: KEX2VoxyqIuuQaI3CdIU07zIQUo35Ld6 01:08:16 INFO - Expected file size: 21764881 01:08:16 INFO - Obtained file size: 21764881 01:08:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 01:08:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:08:20 INFO - Fetch https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:08:21 INFO - Http code: 200 01:08:21 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 01:08:21 INFO - x-amz-cf-id: s4vB-78B_vsd8djGHPUtnIsd3mopiAt1eR-zWztEflkJqKNVEUfV1w== 01:08:21 INFO - x-amz-version-id: MmMoz4G9KfMmPXybt.4z8YX8q1kFw7wm 01:08:22 INFO - Expected file size: 14409506 01:08:22 INFO - Obtained file size: 14409506 01:08:22 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')]} 01:08:22 INFO - trying https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:08:22 INFO - Downloading https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:08:25 INFO - Downloaded 59725940 bytes. 01:08:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:08:25 INFO - mkdir: /builds/slave/test/properties 01:08:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:08:25 INFO - Writing to file /builds/slave/test/properties/build_url 01:08:25 INFO - Contents: 01:08:25 INFO - build_url:https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 01:08:25 INFO - Running post-action listener: _resource_record_post_action 01:08:25 INFO - Running post-action listener: set_extra_try_arguments 01:08:25 INFO - [mozharness: 2016-11-23 09:08:25.855880Z] Finished download-and-extract step (success) 01:08:25 INFO - [mozharness: 2016-11-23 09:08:25.856106Z] Running populate-webroot step. 01:08:25 INFO - Running pre-action listener: _resource_record_pre_action 01:08:25 INFO - Running main action method: populate_webroot 01:08:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:08:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:08:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:08:25 INFO - '--tppagecycles', 01:08:25 INFO - '7'], 01:08:25 INFO - 'tests': ['tsvgm']}}, 01:08:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:08:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:08:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:08:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:08:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:08:25 INFO - 'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:08:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:08:25 INFO - 'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['damp', 'tps']}, 01:08:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:08:25 INFO - 'tests': ['damp', 'tps']}, 01:08:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['dromaeo_dom']}, 01:08:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:08:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['basic_compositor_video']}, 01:08:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:08:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['a11yr', 01:08:25 INFO - 'ts_paint', 01:08:25 INFO - 'tpaint', 01:08:25 INFO - 'sessionrestore', 01:08:25 INFO - 'sessionrestore_no_auto_restore', 01:08:25 INFO - 'tabpaint']}, 01:08:25 INFO - 'other-e10s': {'tests': ['a11yr', 01:08:25 INFO - 'ts_paint', 01:08:25 INFO - 'tpaint', 01:08:25 INFO - 'sessionrestore', 01:08:25 INFO - 'sessionrestore_no_auto_restore', 01:08:25 INFO - 'tabpaint']}, 01:08:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:08:25 INFO - 'ts_paint', 01:08:25 INFO - 'tpaint', 01:08:25 INFO - 'sessionrestore', 01:08:25 INFO - 'sessionrestore_no_auto_restore', 01:08:25 INFO - 'tabpaint']}, 01:08:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:08:25 INFO - 'ts_paint', 01:08:25 INFO - 'tpaint', 01:08:25 INFO - 'sessionrestore', 01:08:25 INFO - 'sessionrestore_no_auto_restore', 01:08:25 INFO - 'tabpaint']}, 01:08:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['a11yr', 01:08:25 INFO - 'ts_paint', 01:08:25 INFO - 'tpaint', 01:08:25 INFO - 'sessionrestore', 01:08:25 INFO - 'sessionrestore_no_auto_restore', 01:08:25 INFO - 'tabpaint']}, 01:08:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['a11yr', 01:08:25 INFO - 'ts_paint', 01:08:25 INFO - 'tpaint', 01:08:25 INFO - 'sessionrestore', 01:08:25 INFO - 'sessionrestore_no_auto_restore', 01:08:25 INFO - 'tabpaint']}, 01:08:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['tsvgx', 01:08:25 INFO - 'tsvgr_opacity', 01:08:25 INFO - 'tart', 01:08:25 INFO - 'tscrollx', 01:08:25 INFO - 'cart']}, 01:08:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:08:25 INFO - 'tsvgr_opacity', 01:08:25 INFO - 'tart', 01:08:25 INFO - 'tscrollx', 01:08:25 INFO - 'cart']}, 01:08:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:08:25 INFO - 'talos_options': ['--disable-e10s'], 01:08:25 INFO - 'tests': ['tp5o']}, 01:08:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:08:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:08:25 INFO - 'talos_options': ['--disable-e10s', 01:08:25 INFO - '--xperf_path', 01:08:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:25 INFO - 'tests': ['tp5n']}, 01:08:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:08:25 INFO - 'talos_options': ['--xperf_path', 01:08:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:25 INFO - 'tests': ['tp5n']}}, 01:08:25 INFO - 'talos.zip': {'path': '', 01:08:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:08:25 INFO - Running post-action listener: _resource_record_post_action 01:08:25 INFO - [mozharness: 2016-11-23 09:08:25.873462Z] Finished populate-webroot step (success) 01:08:25 INFO - [mozharness: 2016-11-23 09:08:25.873549Z] Running create-virtualenv step. 01:08:25 INFO - Running pre-action listener: _resource_record_pre_action 01:08:25 INFO - Running main action method: create_virtualenv 01:08:25 INFO - Creating virtualenv /builds/slave/test/build/venv 01:08:25 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 01:08:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:08:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:08:25 INFO - Using real prefix '/usr' 01:08:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:08:26 INFO - Installing distribute.............................................................................................................................................................................................done. 01:08:28 INFO - Installing pip.................done. 01:08:28 INFO - Return code: 0 01:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:08:28 INFO - Reading from file tmpfile_stdout 01:08:28 INFO - Output received: 01:08:28 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) 01:08:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:08:28 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')]} 01:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:28 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')]} 01:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:28 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 0x7fb188936e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2279b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2415130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, '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': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', '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 01:08:28 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 01:08:28 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 01:08:28 INFO - Using env: {'DISPLAY': ':0', 01:08:28 INFO - 'HOME': '/home/cltbld', 01:08:28 INFO - 'LANG': 'en_US.UTF-8', 01:08:28 INFO - 'LANGUAGE': 'en_US:en', 01:08:28 INFO - 'LOGNAME': 'cltbld', 01:08:28 INFO - 'MAIL': '/var/mail/cltbld', 01:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:28 INFO - 'MOZ_NO_REMOTE': '1', 01:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:28 INFO - 'NO_EM_RESTART': '1', 01:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:28 INFO - 'PWD': '/builds/slave/test', 01:08:28 INFO - 'SHELL': '/bin/bash', 01:08:28 INFO - 'SHLVL': '1', 01:08:28 INFO - 'TERM': 'linux', 01:08:28 INFO - 'TMOUT': '86400', 01:08:28 INFO - 'USER': 'cltbld', 01:08:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:28 INFO - '_': '/tools/buildbot/bin/python'} 01:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:28 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 01:08:28 INFO - Cleaning up... 01:08:28 INFO - Return code: 0 01:08:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:08:28 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')]} 01:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:28 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')]} 01:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:28 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 0x7fb188936e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2279b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2415130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, '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': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', '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 01:08:28 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 01:08:28 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 01:08:28 INFO - Using env: {'DISPLAY': ':0', 01:08:28 INFO - 'HOME': '/home/cltbld', 01:08:28 INFO - 'LANG': 'en_US.UTF-8', 01:08:28 INFO - 'LANGUAGE': 'en_US:en', 01:08:28 INFO - 'LOGNAME': 'cltbld', 01:08:28 INFO - 'MAIL': '/var/mail/cltbld', 01:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:28 INFO - 'MOZ_NO_REMOTE': '1', 01:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:28 INFO - 'NO_EM_RESTART': '1', 01:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:28 INFO - 'PWD': '/builds/slave/test', 01:08:28 INFO - 'SHELL': '/bin/bash', 01:08:28 INFO - 'SHLVL': '1', 01:08:28 INFO - 'TERM': 'linux', 01:08:28 INFO - 'TMOUT': '86400', 01:08:28 INFO - 'USER': 'cltbld', 01:08:28 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:28 INFO - '_': '/tools/buildbot/bin/python'} 01:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:29 INFO - Downloading/unpacking psutil>=3.1.1 01:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:31 INFO - Installing collected packages: psutil 01:08:31 INFO - Running setup.py install for psutil 01:08:31 INFO - building 'psutil._psutil_linux' extension 01:08:31 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 01:08:31 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 01:08:31 INFO - building 'psutil._psutil_posix' extension 01:08:31 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 01:08:31 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 01:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:31 INFO - Successfully installed psutil 01:08:31 INFO - Cleaning up... 01:08:31 INFO - Return code: 0 01:08:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb188936e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2279b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2415130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, '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': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', '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 01:08: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:08: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 mozsystemmonitor==0.3 01:08:31 INFO - Using env: {'DISPLAY': ':0', 01:08:31 INFO - 'HOME': '/home/cltbld', 01:08:31 INFO - 'LANG': 'en_US.UTF-8', 01:08:31 INFO - 'LANGUAGE': 'en_US:en', 01:08:31 INFO - 'LOGNAME': 'cltbld', 01:08:31 INFO - 'MAIL': '/var/mail/cltbld', 01:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:31 INFO - 'MOZ_NO_REMOTE': '1', 01:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:31 INFO - 'NO_EM_RESTART': '1', 01:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:31 INFO - 'PWD': '/builds/slave/test', 01:08:31 INFO - 'SHELL': '/bin/bash', 01:08:31 INFO - 'SHLVL': '1', 01:08:31 INFO - 'TERM': 'linux', 01:08:31 INFO - 'TMOUT': '86400', 01:08:31 INFO - 'USER': 'cltbld', 01:08:31 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:31 INFO - '_': '/tools/buildbot/bin/python'} 01:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:08:33 INFO - Installing collected packages: mozsystemmonitor 01:08:33 INFO - Running setup.py install for mozsystemmonitor 01:08:34 INFO - Successfully installed mozsystemmonitor 01:08:34 INFO - Cleaning up... 01:08:34 INFO - Return code: 0 01:08:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:08: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')]} 01:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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')]} 01:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb188936e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2279b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2415130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, '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': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', '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 01:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:08:34 INFO - Using env: {'DISPLAY': ':0', 01:08:34 INFO - 'HOME': '/home/cltbld', 01:08:34 INFO - 'LANG': 'en_US.UTF-8', 01:08:34 INFO - 'LANGUAGE': 'en_US:en', 01:08:34 INFO - 'LOGNAME': 'cltbld', 01:08:34 INFO - 'MAIL': '/var/mail/cltbld', 01:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:34 INFO - 'MOZ_NO_REMOTE': '1', 01:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:34 INFO - 'NO_EM_RESTART': '1', 01:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:34 INFO - 'PWD': '/builds/slave/test', 01:08:34 INFO - 'SHELL': '/bin/bash', 01:08:34 INFO - 'SHLVL': '1', 01:08:34 INFO - 'TERM': 'linux', 01:08:34 INFO - 'TMOUT': '86400', 01:08:34 INFO - 'USER': 'cltbld', 01:08:34 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:34 INFO - '_': '/tools/buildbot/bin/python'} 01:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:34 INFO - Downloading/unpacking jsonschema==2.5.1 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:08:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:36 INFO - Downloading functools32-3.2.3-2.tar.gz 01:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:08:36 INFO - warning: no files found matching '*.txt' 01:08:36 INFO - no previously-included directories found matching 'build' 01:08:36 INFO - no previously-included directories found matching 'dist' 01:08:36 INFO - no previously-included directories found matching '.git*' 01:08:36 INFO - Installing collected packages: jsonschema, functools32 01:08:36 INFO - Running setup.py install for functools32 01:08:36 INFO - warning: no files found matching '*.txt' 01:08:36 INFO - no previously-included directories found matching 'build' 01:08:36 INFO - no previously-included directories found matching 'dist' 01:08:36 INFO - no previously-included directories found matching '.git*' 01:08:36 INFO - Successfully installed jsonschema functools32 01:08:36 INFO - Cleaning up... 01:08:36 INFO - Return code: 0 01:08:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:08: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')]} 01:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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')]} 01:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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', '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 0x7fb188936e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2279b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2415130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, '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': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', '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 01:08: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:08: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 functools32==3.2.3-2 01:08:36 INFO - Using env: {'DISPLAY': ':0', 01:08:36 INFO - 'HOME': '/home/cltbld', 01:08:36 INFO - 'LANG': 'en_US.UTF-8', 01:08:36 INFO - 'LANGUAGE': 'en_US:en', 01:08:36 INFO - 'LOGNAME': 'cltbld', 01:08:36 INFO - 'MAIL': '/var/mail/cltbld', 01:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:36 INFO - 'MOZ_NO_REMOTE': '1', 01:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:36 INFO - 'NO_EM_RESTART': '1', 01:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:36 INFO - 'PWD': '/builds/slave/test', 01:08:36 INFO - 'SHELL': '/bin/bash', 01:08:36 INFO - 'SHLVL': '1', 01:08:36 INFO - 'TERM': 'linux', 01:08:36 INFO - 'TMOUT': '86400', 01:08:36 INFO - 'USER': 'cltbld', 01:08:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:36 INFO - '_': '/tools/buildbot/bin/python'} 01:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:08:36 INFO - Cleaning up... 01:08:36 INFO - Return code: 0 01:08:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:08: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')]} 01:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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')]} 01:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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', '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 0x7fb188936e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2279b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2415130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, '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': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', '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 01:08: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:08: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 blobuploader==1.2.4 01:08:36 INFO - Using env: {'DISPLAY': ':0', 01:08:36 INFO - 'HOME': '/home/cltbld', 01:08:36 INFO - 'LANG': 'en_US.UTF-8', 01:08:36 INFO - 'LANGUAGE': 'en_US:en', 01:08:36 INFO - 'LOGNAME': 'cltbld', 01:08:36 INFO - 'MAIL': '/var/mail/cltbld', 01:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:36 INFO - 'MOZ_NO_REMOTE': '1', 01:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:36 INFO - 'NO_EM_RESTART': '1', 01:08:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:36 INFO - 'PWD': '/builds/slave/test', 01:08:36 INFO - 'SHELL': '/bin/bash', 01:08:36 INFO - 'SHLVL': '1', 01:08:36 INFO - 'TERM': 'linux', 01:08:36 INFO - 'TMOUT': '86400', 01:08:36 INFO - 'USER': 'cltbld', 01:08:36 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:36 INFO - '_': '/tools/buildbot/bin/python'} 01:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:37 INFO - Downloading/unpacking blobuploader==1.2.4 01:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:39 INFO - Downloading blobuploader-1.2.4.tar.gz 01:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:08:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:08:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08: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 01:08:39 INFO - Downloading docopt-0.6.1.tar.gz 01:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:08:39 INFO - Installing collected packages: blobuploader, requests, docopt 01:08:39 INFO - Running setup.py install for blobuploader 01:08:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:08:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:08:39 INFO - Running setup.py install for requests 01:08:40 INFO - Running setup.py install for docopt 01:08:40 INFO - Successfully installed blobuploader requests docopt 01:08:40 INFO - Cleaning up... 01:08:40 INFO - Return code: 0 01:08:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:40 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 0x7fb188936e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2279b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2415130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, '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': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', '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 01:08:40 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 01:08:40 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 01:08:40 INFO - Using env: {'DISPLAY': ':0', 01:08:40 INFO - 'HOME': '/home/cltbld', 01:08:40 INFO - 'LANG': 'en_US.UTF-8', 01:08:40 INFO - 'LANGUAGE': 'en_US:en', 01:08:40 INFO - 'LOGNAME': 'cltbld', 01:08:40 INFO - 'MAIL': '/var/mail/cltbld', 01:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:40 INFO - 'MOZ_NO_REMOTE': '1', 01:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:40 INFO - 'NO_EM_RESTART': '1', 01:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:40 INFO - 'PWD': '/builds/slave/test', 01:08:40 INFO - 'SHELL': '/bin/bash', 01:08:40 INFO - 'SHLVL': '1', 01:08:40 INFO - 'TERM': 'linux', 01:08:40 INFO - 'TMOUT': '86400', 01:08:40 INFO - 'USER': 'cltbld', 01:08:40 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:40 INFO - '_': '/tools/buildbot/bin/python'} 01:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:08:40 INFO - Running setup.py (path:/tmp/pip-tZ86lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:08:40 INFO - Running setup.py (path:/tmp/pip-dlF7aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:08:40 INFO - Running setup.py (path:/tmp/pip-rMZmKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:08:40 INFO - Running setup.py (path:/tmp/pip-Gv4iG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:08:41 INFO - Running setup.py (path:/tmp/pip-KsbAcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:08:41 INFO - Running setup.py (path:/tmp/pip-UUqtlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:08:41 INFO - Running setup.py (path:/tmp/pip-lWnvnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:08:41 INFO - Running setup.py (path:/tmp/pip-UUWzPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:08:41 INFO - Running setup.py (path:/tmp/pip-fXbcbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:08:41 INFO - Running setup.py (path:/tmp/pip-xNMeqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:08:41 INFO - Running setup.py (path:/tmp/pip-jtIEWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:08:41 INFO - Running setup.py (path:/tmp/pip-cKHa_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:08:41 INFO - Running setup.py (path:/tmp/pip-N0DD7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:08:41 INFO - Running setup.py (path:/tmp/pip-wlyhWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:41 INFO - Running setup.py (path:/tmp/pip-M2_fr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:08:41 INFO - Running setup.py (path:/tmp/pip-lAG2dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:08:41 INFO - Running setup.py (path:/tmp/pip-G_MHcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:08:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:08:41 INFO - Running setup.py install for manifestparser 01:08:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:08:42 INFO - Running setup.py install for mozcrash 01:08:42 INFO - Running setup.py install for mozdebug 01:08:42 INFO - Running setup.py install for mozdevice 01:08:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:08:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:08:42 INFO - Running setup.py install for mozfile 01:08:42 INFO - Running setup.py install for mozhttpd 01:08:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:08:42 INFO - Running setup.py install for mozinfo 01:08:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:08:42 INFO - Running setup.py install for mozInstall 01:08:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:08:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:08:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:08:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:08:42 INFO - Running setup.py install for mozleak 01:08:42 INFO - Running setup.py install for mozlog 01:08:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:08:42 INFO - Running setup.py install for moznetwork 01:08:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:08:43 INFO - Running setup.py install for mozprocess 01:08:43 INFO - Running setup.py install for mozprofile 01:08:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:08:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:08:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:08:43 INFO - Running setup.py install for mozrunner 01:08:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:08:43 INFO - Running setup.py install for mozscreenshot 01:08:43 INFO - Running setup.py install for moztest 01:08:43 INFO - Running setup.py install for mozversion 01:08:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:08:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:08:43 INFO - Cleaning up... 01:08:43 INFO - Return code: 0 01:08:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:43 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 0x7fb188936e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2279b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2415130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, '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': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', '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 01:08:43 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 01:08:43 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 01:08:43 INFO - Using env: {'DISPLAY': ':0', 01:08:43 INFO - 'HOME': '/home/cltbld', 01:08:43 INFO - 'LANG': 'en_US.UTF-8', 01:08:43 INFO - 'LANGUAGE': 'en_US:en', 01:08:43 INFO - 'LOGNAME': 'cltbld', 01:08:43 INFO - 'MAIL': '/var/mail/cltbld', 01:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:43 INFO - 'MOZ_NO_REMOTE': '1', 01:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:43 INFO - 'NO_EM_RESTART': '1', 01:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:43 INFO - 'PWD': '/builds/slave/test', 01:08:43 INFO - 'SHELL': '/bin/bash', 01:08:43 INFO - 'SHLVL': '1', 01:08:43 INFO - 'TERM': 'linux', 01:08:43 INFO - 'TMOUT': '86400', 01:08:43 INFO - 'USER': 'cltbld', 01:08:43 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:43 INFO - '_': '/tools/buildbot/bin/python'} 01:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:08:43 INFO - Running setup.py (path:/tmp/pip-JTLEl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:08:44 INFO - Running setup.py (path:/tmp/pip-yESEqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:08:44 INFO - Running setup.py (path:/tmp/pip-aqAnnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:08:44 INFO - Running setup.py (path:/tmp/pip-wAkj2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:08:44 INFO - Running setup.py (path:/tmp/pip-hlg5rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:08:44 INFO - Running setup.py (path:/tmp/pip-y5FH7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:08:44 INFO - Running setup.py (path:/tmp/pip-1tFmHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:08:44 INFO - Running setup.py (path:/tmp/pip-c8YhXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:08:44 INFO - Running setup.py (path:/tmp/pip-7zTUFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:08:44 INFO - Running setup.py (path:/tmp/pip-eqBdsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:08:44 INFO - Running setup.py (path:/tmp/pip-LONAi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:08:44 INFO - Running setup.py (path:/tmp/pip-TWgn1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:08:44 INFO - Running setup.py (path:/tmp/pip-conpmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:08:44 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)) 01:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:08:44 INFO - Running setup.py (path:/tmp/pip-l9sRNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 01:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:45 INFO - Running setup.py (path:/tmp/pip-MS4KME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:08:45 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)) 01:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:08:45 INFO - Running setup.py (path:/tmp/pip-40oeLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:08:45 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)) 01:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:08:45 INFO - Running setup.py (path:/tmp/pip-F8PJn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:08:45 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)) 01:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:08:45 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)) 01:08:45 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:08:45 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:08:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:47 INFO - Downloading blessings-1.6.tar.gz 01:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:08:47 INFO - Installing collected packages: blessings 01:08:47 INFO - Running setup.py install for blessings 01:08:47 INFO - Successfully installed blessings 01:08:47 INFO - Cleaning up... 01:08:47 INFO - Return code: 0 01:08:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:08:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:08:47 INFO - Reading from file tmpfile_stdout 01:08:47 INFO - Current package versions: 01:08:47 INFO - argparse == 1.2.1 01:08:47 INFO - blessings == 1.6 01:08:47 INFO - blobuploader == 1.2.4 01:08:47 INFO - docopt == 0.6.1 01:08:47 INFO - functools32 == 3.2.3-2 01:08:47 INFO - jsonschema == 2.5.1 01:08:47 INFO - manifestparser == 1.1 01:08:47 INFO - mozInstall == 1.12 01:08:47 INFO - mozcrash == 1.0 01:08:47 INFO - mozdebug == 0.1 01:08:47 INFO - mozdevice == 0.49 01:08:47 INFO - mozfile == 1.2 01:08:47 INFO - mozhttpd == 0.7 01:08:47 INFO - mozinfo == 0.9 01:08:47 INFO - mozleak == 0.1 01:08:47 INFO - mozlog == 3.4 01:08:47 INFO - moznetwork == 0.27 01:08:47 INFO - mozprocess == 0.23 01:08:47 INFO - mozprofile == 0.28 01:08:47 INFO - mozrunner == 6.13 01:08:47 INFO - mozscreenshot == 0.1 01:08:47 INFO - mozsystemmonitor == 0.3 01:08:47 INFO - moztest == 0.7 01:08:47 INFO - mozversion == 1.4 01:08:47 INFO - psutil == 3.1.1 01:08:47 INFO - requests == 1.2.3 01:08:47 INFO - wsgiref == 0.1.2 01:08:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:47 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 0x7fb188936e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2279b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2415130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, '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': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', '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 01:08:47 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 01:08:47 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 01:08:47 INFO - Using env: {'DISPLAY': ':0', 01:08:47 INFO - 'HOME': '/home/cltbld', 01:08:47 INFO - 'LANG': 'en_US.UTF-8', 01:08:47 INFO - 'LANGUAGE': 'en_US:en', 01:08:47 INFO - 'LOGNAME': 'cltbld', 01:08:47 INFO - 'MAIL': '/var/mail/cltbld', 01:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:47 INFO - 'MOZ_NO_REMOTE': '1', 01:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:47 INFO - 'NO_EM_RESTART': '1', 01:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:47 INFO - 'PWD': '/builds/slave/test', 01:08:47 INFO - 'SHELL': '/bin/bash', 01:08:47 INFO - 'SHLVL': '1', 01:08:47 INFO - 'TERM': 'linux', 01:08:47 INFO - 'TMOUT': '86400', 01:08:47 INFO - 'USER': 'cltbld', 01:08:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:47 INFO - '_': '/tools/buildbot/bin/python'} 01:08:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:47 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)) 01:08:47 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)) 01:08:47 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)) 01:08:47 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)) 01:08:47 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)) 01:08:47 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)) 01:08:47 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)) 01:08:47 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)) 01:08:47 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)) 01:08:47 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)) 01:08:47 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)) 01:08:47 INFO - Cleaning up... 01:08:47 INFO - Return code: 0 01:08:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:08:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:47 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 0x7fb188936e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2279b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2415130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, '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': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', '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 01:08:47 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 01:08:47 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 01:08:47 INFO - Using env: {'DISPLAY': ':0', 01:08:47 INFO - 'HOME': '/home/cltbld', 01:08:47 INFO - 'LANG': 'en_US.UTF-8', 01:08:47 INFO - 'LANGUAGE': 'en_US:en', 01:08:47 INFO - 'LOGNAME': 'cltbld', 01:08:47 INFO - 'MAIL': '/var/mail/cltbld', 01:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:47 INFO - 'MOZ_NO_REMOTE': '1', 01:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:47 INFO - 'NO_EM_RESTART': '1', 01:08:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:47 INFO - 'PWD': '/builds/slave/test', 01:08:47 INFO - 'SHELL': '/bin/bash', 01:08:47 INFO - 'SHLVL': '1', 01:08:47 INFO - 'TERM': 'linux', 01:08:47 INFO - 'TMOUT': '86400', 01:08:47 INFO - 'USER': 'cltbld', 01:08:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:47 INFO - '_': '/tools/buildbot/bin/python'} 01:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:08:48 INFO - Cleaning up... 01:08:48 INFO - Return code: 0 01:08:48 INFO - Running post-action listener: _resource_record_post_action 01:08:48 INFO - Running post-action listener: _start_resource_monitoring 01:08:48 INFO - Starting resource monitoring. 01:08:48 INFO - [mozharness: 2016-11-23 09:08:48.152477Z] Finished create-virtualenv step (success) 01:08:48 INFO - [mozharness: 2016-11-23 09:08:48.152945Z] Running install step. 01:08:48 INFO - Running pre-action listener: _resource_record_pre_action 01:08:48 INFO - Running main action method: install 01:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:08:48 INFO - Reading from file tmpfile_stdout 01:08:48 INFO - Detecting whether we're running mozinstall >=1.0... 01:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:08:48 INFO - Reading from file tmpfile_stdout 01:08:48 INFO - Output received: 01:08:48 INFO - Usage: mozinstall [options] installer 01:08:48 INFO - Options: 01:08:48 INFO - -h, --help show this help message and exit 01:08:48 INFO - -d DEST, --destination=DEST 01:08:48 INFO - Directory to install application into. [default: 01:08:48 INFO - "/builds/slave/test"] 01:08:48 INFO - --app=APP Application being installed. [default: firefox] 01:08:48 INFO - mkdir: /builds/slave/test/build/application 01:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:09:05 INFO - Reading from file tmpfile_stdout 01:09:05 INFO - Output received: 01:09:05 INFO - /builds/slave/test/build/application/firefox/firefox 01:09:05 INFO - Running post-action listener: _resource_record_post_action 01:09:05 INFO - [mozharness: 2016-11-23 09:09:05.924140Z] Finished install step (success) 01:09:05 INFO - [mozharness: 2016-11-23 09:09:05.924379Z] Running run-tests step. 01:09:05 INFO - Running pre-action listener: _resource_record_pre_action 01:09:05 INFO - Running main action method: run_tests 01:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:09:05 INFO - Python 2.7.3 01:09:05 INFO - Return code: 0 01:09:05 INFO - grabbing minidump binary from tooltool 01:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:09:05 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 0x24a3fc0>, '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 0x24a4ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a5350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:09:05 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 01:09:05 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 01:09:05 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 01:09:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:09:06 INFO - Return code: 0 01:09:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:09:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:09:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:09:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:09:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:09:06 INFO - Using env: {'DISPLAY': ':0', 01:09:06 INFO - 'HOME': '/home/cltbld', 01:09:06 INFO - 'LANG': 'en_US.UTF-8', 01:09:06 INFO - 'LANGUAGE': 'en_US:en', 01:09:06 INFO - 'LOGNAME': 'cltbld', 01:09:06 INFO - 'MAIL': '/var/mail/cltbld', 01:09:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:09:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:06 INFO - 'MOZ_NO_REMOTE': '1', 01:09:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:06 INFO - 'NO_EM_RESTART': '1', 01:09:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:06 INFO - 'PWD': '/builds/slave/test', 01:09:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:09:06 INFO - 'SHELL': '/bin/bash', 01:09:06 INFO - 'SHLVL': '1', 01:09:06 INFO - 'TERM': 'linux', 01:09:06 INFO - 'TMOUT': '86400', 01:09:06 INFO - 'USER': 'cltbld', 01:09:06 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871', 01:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:06 INFO - '_': '/tools/buildbot/bin/python'} 01:09:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:09:06 INFO - mozversion application_buildid: 20161122223006 01:09:06 INFO - mozversion application_changeset: 0ddfec7126ec503b54df9c4b7c3b988906f6c882 01:09:06 INFO - mozversion application_display_name: Nightly 01:09:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:09:06 INFO - mozversion application_name: Firefox 01:09:06 INFO - mozversion application_remotingname: firefox 01:09:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:09:06 INFO - mozversion application_vendor: Mozilla 01:09:06 INFO - mozversion application_version: 53.0a1 01:09:06 INFO - mozversion platform_buildid: 20161122223006 01:09:06 INFO - mozversion platform_changeset: 0ddfec7126ec503b54df9c4b7c3b988906f6c882 01:09:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:09:06 INFO - mozversion platform_version: 53.0a1 01:09:06 INFO - using testdate: 1479892146 01:09:06 INFO - actual date: 1479892146 01:09:06 INFO - starting webserver on 'localhost:50008' 01:09:06 INFO - SUITE-START | Running 2 tests 01:09:06 INFO - TEST-START | dromaeo_css 01:09:06 INFO - operating with platform_type : linux_ 01:09:06 INFO - Initialising browser for dromaeo_css test... 01:09:06 INFO - TEST-INFO | started process 14697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphfUSax/profile http://localhost:50008/getInfo.html) 01:09:10 INFO - PROCESS | 14697 | __metrics Screen width/height:1600/1200 01:09:10 INFO - PROCESS | 14697 | colorDepth:24 01:09:10 INFO - PROCESS | 14697 | Browser inner width/height: 1024/697 01:09:10 INFO - PROCESS | 14697 | __metrics 01:09:10 ERROR - PROCESS | 14697 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 01:09:11 INFO - TEST-INFO | 14697: exit 0 01:09:11 INFO - Browser initialized. 01:09:11 INFO - Running cycle 1/1 for dromaeo_css test... 01:09:11 INFO - TEST-INFO | started process 14825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphfUSax/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:23 INFO - PROCESS | 14825 | RSS: Main: 186122240 01:09:23 INFO - PROCESS | 14825 | 01:10:13 INFO - PROCESS | 14825 | 1479892213653 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] 01:12:24 INFO - PROCESS | 14825 | Cycle 1(1): loaded http://localhost:50008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50008/tests/dromaeo/cssquery-ext.html) 01:12:26 INFO - PROCESS | 14825 | RSS: Main: 197922816 01:12:26 INFO - PROCESS | 14825 | 01:15:28 INFO - PROCESS | 14825 | Cycle 1(1): loaded http://localhost:50008/tests/dromaeo/cssquery-ext.html (next: http://localhost:50008/tests/dromaeo/cssquery-jquery.html) 01:15:29 INFO - PROCESS | 14825 | RSS: Main: 197279744 01:15:29 INFO - PROCESS | 14825 | 01:18:31 INFO - PROCESS | 14825 | Cycle 1(1): loaded http://localhost:50008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50008/tests/dromaeo/cssquery-mootools.html) 01:18:32 INFO - PROCESS | 14825 | RSS: Main: 203534336 01:18:32 INFO - PROCESS | 14825 | 01:21:33 INFO - PROCESS | 14825 | Cycle 1(1): loaded http://localhost:50008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50008/tests/dromaeo/cssquery-prototype.html) 01:21:34 INFO - PROCESS | 14825 | RSS: Main: 200302592 01:21:34 INFO - PROCESS | 14825 | 01:24:37 INFO - PROCESS | 14825 | Cycle 1(1): loaded http://localhost:50008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50008/tests/dromaeo/cssquery-yui.html) 01:24:37 INFO - PROCESS | 14825 | RSS: Main: 204156928 01:24:37 INFO - PROCESS | 14825 | 01:27:40 INFO - PROCESS | 14825 | Cycle 1(1): loaded http://localhost:50008/tests/dromaeo/cssquery-yui.html (next: http://localhost:50008/tests/dromaeo/cssquery-dojo.html) 01:27:41 INFO - PROCESS | 14825 | RSS: Main: 204218368 01:27:41 INFO - PROCESS | 14825 | 01:27:41 INFO - PROCESS | 14825 | __start_tp_report 01:27:41 INFO - PROCESS | 14825 | _x_x_mozilla_page_load 01:27:41 INFO - PROCESS | 14825 | _x_x_mozilla_page_load_details 01:27:41 INFO - PROCESS | 14825 | |i|pagename|runs| 01:27:41 INFO - PROCESS | 14825 | |0;dojo.html;3087.8301693406866;3090.2737856603694;3099.411111888742;3115.7974731642435;3122.2818751687128;5338.652987555806;5445.863853403662;5528.530074943635;5535.6955367454775;5542.612017158801;5346.759395827187;5415.13357862741;5418.4039755626845;5424.0236757383755;5430.83707488776;4882.804687812483;4940.555350018498;4981.203007518798;5005.2492126181;5050;4981.053599816041;4999.650024498286;5025.698458092508;5039.143345631252;5041.747912604355;332.4518031561734;4933.555979961785;4935.9753201234125;5053.772580233898;5107.233914912756;4336.631386332134;4974.77613507393;5004.874878128039;5005.174146265862;5043.268726034741;4958.504149585049;4960.255961605788;4968.080905032581;4972.378452693413;5006.799728010875;5236;5298.602604804655;5389.299391079135;5428.240046393508;5524.8342549723575;5808.651480911159;5869.735861886183;5884.823455296348;5902.439268269508;5927.288725352985;5905.468507834273;5907.527397808165;5909.438603332676;5920.5559583031445;5930.347661757203;5271.920921186185;5297.470252974749;5503.752331145068;5508.008558459475;5520.91718624221;5923.052311630205;5948.375420580776;5950.166976623276;5950.732217050243;5952.226210592596;5718.714064296769;5722.2561067061015;5723.627964182315;5724.599278050497;5734.168545560954;5763.7982670606325;5795.594308398456;5808.07070868659;5808.5062769665055;5813.011787996051;5750.683712395775;5757.280339957505;5782.392848750905;5783.537317014629;5783.624064435799;5733.369329373765;5787.189793428924;5793.449622285876;5794.21778059965;5798.536117110621;4335.913281734348;4393.945453091235;4404.757738324359;4407.206702793528;4411.448568928884;3964.801759911993;3975.1056012397557;3979.6617287530307;4019.7588144711412;4074.0018695419813;5632.887342253132;5634.239377684042;5636.774529018793;5646.830595082154;5714.628549144375;5698.059820129715;5714.200011998323;5727.742251598688;5811.302643682785;5834.912476312858;5445.074337362658;5481;5512.448755124536;5595.888082238333;5608.6073974821375;5060.49395060491;5083.364579427572;5083.644144909895;5088.898222035538;5096.847094587169;6064.939350606525;6084.878302433926;6085.9695701521205;6103.42017508336;6107.816765497042;5660.235868157746;5671.6597004179885;5699;5751.079827227623;5852.736626851887;6019.277686677627;6105.793350785129;6110.467630727307;6111.926012480528;6119.502553941512;5722.542196624343;5767.365589785037;5827.213326201078;5837.5038121758425;5860.970695146668;5686;5736.885262294814;5854.711963368052;5934.851628709317;5940.970295148497;5693.572982026281;5696.629719068247;5730.054541000688;5771.913421298768;5779.988502012047;5728.627639203605;5732.340780810094;5734.856628584152;5735.11105778605;5740.540756739368;5462.20797984298;5588.133839254922;5672.716364181857;5688.516476099578;5689.487946084707;5642.689652069175;5762.654240745569;5817;5839.328477225174;5892.322382926019;5727.02640551099;5734;5742.5405967521665;5744.4829965303325;5748.712564371681 01:27:41 INFO - PROCESS | 14825 | |1;ext.html;561.1666674987642;574.1359254322244;582.1471544187764;587.4067192135941;602.3223873142714;38982.80508597456;40938.59061409385;40952.38571421431;45220.77389613047;45267;43330.56669433305;43493.7825310873;43521.782391088076;43760.343594846105;43950;8432.53621050842;8569.742907712747;8574.914250857506;8578.056413794478;9899.802003959952;9861.161801246866;10098.646547370843;10105.090541851232;10214;10224.386536807779;10188.847167292497;10258.17934565233;10281.485925703684;10342.120919721796;10346.948265258701;10141.391516508997;10202.285839991204;10237.59049638021;10248;10258.640947566799;10026.69919902404;10104.797904041878;10115.79768404635;10116.747081322952;10120.240981926385;41057.79471102655;41338;41427;41518;41565.79217103895;3359.412102881986;3382.374260761767;3416.28258065804;3444.500547420635;3444.8277586120844;30591.847040764875;30914;30943;31004.844975775202;31076.027835546203;4061.517546095654;4136.379543068534;4159.521655009682;4163.3130533461945;4262.658495245765;324122;328532.9999999976;330295;330979;331337;55125;55665.721671392195;56079.71960140255;56191.71904140453;56405.15392269119;58987;59136.70431647814;59274.11088833671;59330.11004834931;59384.7030764852;15334.23328833554;15364.385424582892;15471.845281547265;15759.212039397984;15830.683386332208;11477.713057173638;11711.297322160697;12630.242185468718;12637.93681031589;12936.935315323552;18013.459596212135;18081.819181808278;18131.728024079384;18144.818551814576;18406.81593184051;6817.420519255918;6912.481563882729;6937;6956;7063.117110361205;920.3281604428804;995.770972676274;1024.329064462778;1047.6176195688672;1052.7105046112226;30355.544666830014;30592.23519411988;31005.534916976263;31381.843090784856;32916.67083329184;1064.489045258265;1077.472038701031;1093.781243751253;1163.8603367595774;1173.8473998380157;16070.303830119137;16137.435189768301;16146.541383446714;16168.35326586947;16253;479347;483522;483668;483783;484344;53740;53907.46092539103;54095.72952135214;54125.1881221782;54270.72864635652;1295.95464158754;1330.9933450332687;1342.4965637885794;1346.8518462969066;1347.555306748751;28431.147065588066;29335;29740.85129574338;30047.69952300449;30476.84761576178;47800.52199477961;48587.27119093287;48590;48665;48673.513264868314;443364;444891;445771;446636;447821;26420.339491512867;26443.735562644128;27457;27489.450210996067;28526.144215673565;43431.34852977144;43679.78160109179;44960.32559511544;45013.549864502245;45540;37768.244635107694;38124.2375152501;38457.807710962385;38906.80546597249;40176.1964760709;37361.25277494489;37504.624953751205;37754.62245377511;38400.42399363956;38507.80746096252;37326.37853949329;37809;39279.21441571095;39438.408423873094;39502.60497394989;30832.537511937786;33512.1621959453;34721.826390867885;35164.82417587896;35497.82251088728;26682;26800.195994120208;26836;27045.72954270432;27047.459050819267 01:27:41 INFO - PROCESS | 14825 | |2;jquery.html;390.3715018819702;397.29678469109666;398.29501781846153;400.6154092071611;416.27568031624963;15977.121258330788;16292.10393428361;17259.39592114276;18757.968311742865;18804.62390752186;11891.762164756721;12239.449224784883;12621.621351359474;12654.240745555273;18538.81461185388;5123.590112790967;5311.9468805311835;5315.0432922074015;5318.414974352818;5337.626366154371;5190.06578815813;5249.973750131244;5311.9468805311835;5343.171808369709;5377.7580008899495;5298.708571028592;5307.1243244864745;5319.069162896497;5319.867003324928;5331.760070796823;5156.20078887773;5201.713905735202;5242.475752424765;5310.20346947957;5344.732763361816;5127.9230811537855;5137.460566640524;5169.172932330846;5172.043172013152;5187.844364669066;13557.59327220185;13896.374663140183;14109.929450352785;14119.505817296345;14146.929265353607;2173.7065496157975;2318.8840557972203;2354.4702441950594;2376.940576485584;2711.159540542438;9640;9924.15644670204;10366.326188797779;10610.151187905027;10786.298890572089;1797.5326415132029;1821.1167583721885;1851.453821122772;1856.5822689894665;1899.5915878086278;79969.60015199886;82146.58926705387;83567;83772.99999999939;85416;10590.604898966842;10654.200934929911;10663.360198388122;10913.072388847037;11186;15319.387224510894;15330.616734581501;15331.080135191702;15345.923270383577;15379.154146522049;8020.759377218693;8053;8134.715284965117;8138.674453021931;8242.29940455068;7438.888416673754;7555.248687393466;7754.612269386621;7816.374690024898;8182.345412366996;4629.65277604181;4652.883677908079;4739.431268247832;4834.081524510332;4891.437484689235;1915.9521011974812;1973.3882496426154;1977.3079422202113;2020.7069974853564;2034.3185033014106;869.5956380283199;896.8699538566872;907.582512044467;911.5305617606938;954.2842867849113;17902.91048544749;18689;19308.517287067934;19570.21719131219;20082.19671213135;955.7897262602216;963.9036096390305;965.6427121964917;967.4630580028152;981.2885657897967;10167.796644067077;10908.23642345044;10930.653765041558;10993.725156870982;10999.120070394349;154453;409330;442738;449363;450795;50743.746281269094;88498;90826.09173908176;90955.09044909598;91028;955.2358113509165;961.6297725375781;989.5052473763119;995.9352642078242;1002.9247806414548;16383.754243686593;16511.422100226435;17173.398931037354;17218.569535761708;17311.3941012069;27295.45409091847;37613.81193094017;39383.60616393799;40298.59701402948;44479.77760111179;55118.72440637771;55589.722051389486;55848.44151558432;62693.37306627058;63534.682326588074;6446.903296450463;7304.817379565553;7444.776656700307;7661.616919153908;7717.961410192913;11201.887981120084;12090;12447;12587;12925.806112908125;10505.159587233156;10802.513886874953;10931.344119352547;11086.667399978014;11121.610743623934;10808.783824323313;10948;10983.450827458435;11007;11099.44502774842;10708.946455267986;10953.34279943206;11007.284526505751;11008.669739907815;11307.660770176908;7522.210167932289;7590.582517961565;7690.769276921701;7696.307332340116;7714.3442807362;8285.792855178668;9832.705018849447;10957.945210273898;11067.225294229327;11383.317000979967 01:27:41 INFO - PROCESS | 14825 | |3;mootools.html;1473.13085279685;1477.0768269831356;1619.7489389144687;1724.5085150732036;1742.2072956804654;8294.29498492628;8431.915680843189;8705.434146780455;8849.38054336196;8851.513166775825;8666.176713212251;8721.825563488743;8824.735257942257;8847.823043539125;8848.38061335705;2392.1268736911074;2409.8795060247007;2420.213430635051;2426.757324267568;2431.185552839801;2360.704911886014;2428.7449817769143;2429.4898071404937;2439.658447817307;2444.046821739523;2378.6907701998803;2405.7594240575977;2408.6266628672583;2425.0299880047946;2428.854268743872;2296.701428814252;2316.224064938248;2319.060780383947;2321.6401457774073;2370.881455927214;2291.049214575949;2311.5492478966607;2333.288347054148;2337.240396871007;2344.9296521104225;8485.236328730443;8553.40126191167;8590.1839325264;8651.567421628957;8673.956630216871;5287.154055351125;5364.302640656729;5391.946080539184;5433.565314774809;5442.0476416627325;3479.938618721289;3498.9475157872653;3560.3413368526903;3587.587427445851;3612.3317186320614;1047.460557812727;1059.7615536504225;1089.9509522071446;1102.2669924500199;1106.5131342209484;11362.715932101764;11392.316461012366;11405.657830265105;11444.313341199555;11446.885531144666;4373.978130109329;4536;4587.747673877902;4594.448666160082;4682.672212945061;9510.809783804285;9512.667056652985;9513.04869513057;9513.143817056498;9516.571754270935;5298.602604804578;5312.282841816383;5312.7343632818975;5315.043292207362;5336.1195402758885;4324.221640104812;4334.21984042869;4832.661713680009;4931.852044438672;4995.425526064549;3729.254149170177;3789.8673546425744;3794.8102594870697;3852.4221366794645;3870.6903447724117;1215.471269997554;1245.3959829482694;1252.6242127361936;1254.8055051467038;1260.5462033668055;941.8398872191743;961.1925982175006;965.1506674126864;975.658519518163;993.4630133720248;5765.423457654201;5868.943590153814;6053.424924632153;6091.086337049478;6098.817035488943;460.8571342883717;466.5101643274548;466.8879468927501;470.79285114549486;479.24518882759094;4162.791860406967;4173.311403618369;4177.5195852476745;4202.642775364128;4207.852725154666;10102.898971010343;10525.315854469434;10642.946785266178;10676.572937082585;10678.839817402744;9887.653932112342;10481.842772358421;10488.632897848538;10553.683389498174;10555.419451930218;7719.150893401721;7798.415118866108;7864.4888082274465;7872.842543149105;7889.644965976545;5839.124131380327;5854.180414742024;5884.882302354014;5943.791967281124;6000.489713517641;9736.221102311656;9793.80412391734;9804.705858824247;9805.705828825146;9813.705588832347;9309.162175404246;9742.9025709742;9867.654632087842;9997.800043998934;10014.599416023277;7333.889991650023;7517.1355294139685;7660.731874384593;7699.345555627834;7869.567173805495;8348.165183481604;8456.66173353059;8457.703980360659;8459.196376344238;8460.407771455939;7237.384822289953;7382.9630851845395;7459.738909138154;7464.813379665552;7696.615169241628;7327.450441217036;7409.222031686595;7467.551946883204;7484.925150748423;7786.61066946639;6880.518363714492;6925.58446493212;7000.054992575937;7004.334588214111;7026.754063607749;4861.149298872612;4941.481144479922;4987.875303117451;4994.4755800640405;5238.790448382022;5117.718525481134;5120.3343565337755;5123.410807757006;5150.510701483503;5154 01:27:41 INFO - PROCESS | 14825 | |4;prototype.html;340.02921658664513;346.3022010648544;353.1189681744049;353.1647653299946;355.2238359185182;5432.8913421731595;5493.807716729915;5517.862053448655;5534.418886016961;5542.889142217154;5406.59450541209;5421.918671219935;5422.123181924923;5427.782888684458;5440.510354068133;3949.9210015799667;4035.3341698619765;4154.584541545852;4163.729357591762;4190.685698572619;4156.875293741193;4168.812403441837;4180.9372859406985;4210.200061988213;4214.894627634319;4195.538490766014;4205.285101532747;4221.620054195122;4225.556316586761;4247.787610619472;4135.503739551243;4191.266528357556;4207.621314081717;4216.704830661855;4219.662427005863;3709.2766910452474;3712.1276500022473;3734.1971476132762;3746.2132952080096;3750.2499500099816;5166.302549155891;5208.458248391093;5217.58259339252;5230.267762513251;5234.162533994542;4714.481407045222;4754.833580824655;4806.639502037361;4815.638827087947;4819.42166939966;5582.8325150245555;5594.2447769551;5623.184638227475;5640.756564975115;5641.323041235037;4119.299719047769;4133.318002529579;4133.4626498555;4146.569433545422;4173.290540608104;5652.915206271868;5810;5840.7734375781565;5871.911921321183;5910.763569457216;4250.893727656833;4251.596098370712;4261.978690106592;4262.422903525653;4271.167122411162;4299.226139294894;4308.224519586442;4322.919270182454;4333.653307735373;4353.1293741251875;4724.149653062482;4833.453294945583;4845;4874.8537543873745;4885.853424397274;5628.889166562539;5645.661260324311;5653.575981801381;5667.829965101054;5693.629914055573;1431.9642008949652;1436.2531483628454;1438.4318194313187;1443.2062365698823;1447.7032208397463;953.122348972523;955.498363359228;1001.8278614021613;1005.2410430125354;1022.9846552301722;5239.397469291004;5280.788768449296;5295.867603309871;5296.073187192226;5299.761510732026;5627.774889004476;5642.6614403135945;5657.20799088128;5669.376368599451;5669.829905102853;5198.4801519847715;5317.760700768397;5370.570354371641;5376.301080859464;5505.862353441196;2989.671136175019;3020.0788759428583;3024.5311976643657;3028.500892058445;3043;5883.117532370179;5884.588078834526;5896.174535565025;5908.763649453974;5912.586118971717;5490.588205884575;5714.5999780015;5769.922827781995;5776.971115144397;5822.7962021329895;5822.534197264209;5863.355030946593;5877.353491115974;5908.291005079246;5910.615809972338;5565.415631358649;5676.489115979582;5700.714964251853;5737.34020587621;5857.94142058591;5823.475887170175;5841.94158058414;5859.824205273849;5864.589478736448;5865.73604187804;6023.66869822164;6081.452669259788;6112.602680825732;6117.357677443804;6148.52435415506;3975.495437874121;4189.748615083105;4210.7473551587;4212.262854000599;4222.408862759277;5891.262077687007;5891.468218263368;5893.675847828411;5907.970460147843;5961;5606.065907261988;5631.493165615114;5766.221560089502;5815.273090863642;5819.709014549171;5661.612904838341;5730;5738.770449181986;5738.96698594257;5747.310322761128;5656.953463609246;5675.148727690879;5685.744141513559;5686.203931449518;5689.118186681071;5440.319960004999;5462.289902312674;5471.206675032177;5672.5745569081655;5758.11327354026;5600.747966341606;5602.439756024365;5612.85967850807;5662.178984047207;5698.515626171822 01:27:41 INFO - PROCESS | 14825 | |5;yui.html;648.4002297874465;691.8062942376137;708.0229283588646;761.851438969401;791.6516732637641;13770.793438098424;14685.486007989723;14695.412183512673;14729;14739.410423583056;13549.729005419886;13715.862841371583;13760.174389536634;13766;13784.241866697328;651.423490211163;664.4551467796384;766.1266156581502;781.7303030454513;795.8129839487716;793.0245797668871;794.8688466403037;794.9046114466272;794.9562774047425;795.6618437164211;842.1073661918356;844.6536919862857;846.1327139681845;848.1984524624232;848.3128665780706;838.5220424358118;842.4902933725069;845.9450135741157;846.018618402653;846.2257034813108;608.3065305551675;610.9327973922865;612.4090252905967;614.1494030767375;614.5053232148119;13440.798388024188;13957.720845583031;13966.162030278216;13995;14036.578902632937;13269;13974.580762577038;14043.578692639136;14058.92970535151;14142.434302627882;10847.938891610569;10960.342379457179;11010.953959373926;11061.834072488919;11190.104791616652;3467.150548115728;3688.704903607732;3701.796401197933;3706.110533471974;3706.944395834065;59113;62259.37740622581;62712.37287627111;63056;63100.68449657768;10267.589296428208;10794.190435717195;10887.83668244977;11083.944580277048;11258;18100.818991809912;18373.63252734938;19948.90025549892;20148.597028059357;20259.493512662302;7927.3658107351275;8143.79640508992;8212.63043163059;8355.916440835636;8385.706500272583;4496.527864574173;4563.498015218323;4622.514635963243;4683.625309975194;4696.835610753607;3465.220325426759;3489.180042689966;3530.3292374448774;3531.611522732497;3537.9292414151573;613.3345320327405;622.3776223776224;623.2085251730277;625.634004107593;635.5328833307515;658.2956236826645;665.766981556461;683.1733602341222;713.9571625702474;717.2039036669292;9026.774330641787;9469.14777670013;9495.43027418357;9674.661386851427;9793.21654267657;683.2757277285993;683.6991723641581;702.9261927497539;705.9752908648172;712.6223101756077;4432.889177770581;4503.166914120898;4651.837185698552;4701.976490117528;4787.16224660683;87636.12363876407;88104.11895881087;88358.55820720983;88581.55709221541;92350;44502;71119.28880711127;76075;76129.61935190289;76837.92648294117;61521.38478615157;69757.65121174362;69855;70159;72115.63942180255;8966.551672416483;9043.412178208395;9143.405678630868;9145.176934075966;9236.307276954121;47818.63173944476;48343.758281209775;49053.50946490489;49270.26094608512;49447.50552494573;61900.69049654723;65162;66272.33727662661;67797;68070.65964670145;11044.889551104387;11132;11165.162612804235;11427.428628568705;11556.497655304756;12257.877421225674;12339.62981110568;12676.809847852106;12816.166949148275;13068.934655327042;11033.172512061788;11610;11668.533258669559;11831.230969986924;12438.19151755133;10989.945050274697;11053.540587219202;11565;11608.593699220486;11919.642410727693;11114.610988615359;11358.85361735415;11679.766404671689;12157.574484892986;12176.208546444454;9273.443593384418;9639.277054221102;10078.546465409221;10081.193504519768;10141.898581014095;9290.674826381044;9864.556094975887;9870;9919.553620087258;9959.900400995897 01:27:41 INFO - PROCESS | 14825 | __end_tp_report 01:27:41 INFO - PROCESS | 14825 | __start_cc_report 01:27:41 INFO - PROCESS | 14825 | _x_x_mozilla_cycle_collect,324 01:27:41 INFO - PROCESS | 14825 | __end_cc_report 01:27:41 INFO - PROCESS | 14825 | __startTimestamp1479893261144__endTimestamp 01:27:41 INFO - PROCESS | 14825 | 01:27:41 INFO - PROCESS | 14825 | ------- Summary: start ------- 01:27:41 INFO - PROCESS | 14825 | Number of tests: 6 01:27:41 INFO - PROCESS | 14825 | 01:27:41 INFO - PROCESS | 14825 | [#0] dojo.html Cycles:165 Average:5396.47 Median:5689.49 stddev:742.04 (13.0%) stddev-sans-first:721.88 01:27:41 INFO - PROCESS | 14825 | Values: 3087.8 3090.3 3099.4 3115.8 3122.3 5338.7 5445.9 5528.5 5535.7 5542.6 5346.8 5415.1 5418.4 5424.0 5430.8 4882.8 4940.6 4981.2 5005.2 5050.0 4981.1 4999.7 5025.7 5039.1 5041.7 332.5 4933.6 4936.0 5053.8 5107.2 4336.6 4974.8 5004.9 5005.2 5043.3 4958.5 4960.3 4968.1 4972.4 5006.8 5236.0 5298.6 5389.3 5428.2 5524.8 5808.7 5869.7 5884.8 5902.4 5927.3 5905.5 5907.5 5909.4 5920.6 5930.3 5271.9 5297.5 5503.8 5508.0 5520.9 5923.1 5948.4 5950.2 5950.7 5952.2 5718.7 5722.3 5723.6 5724.6 5734.2 5763.8 5795.6 5808.1 5808.5 5813.0 5750.7 5757.3 5782.4 5783.5 5783.6 5733.4 5787.2 5793.4 5794.2 5798.5 4335.9 4393.9 4404.8 4407.2 4411.4 3964.8 3975.1 3979.7 4019.8 4074.0 5632.9 5634.2 5636.8 5646.8 5714.6 5698.1 5714.2 5727.7 5811.3 5834.9 5445.1 5481.0 5512.4 5595.9 5608.6 5060.5 5083.4 5083.6 5088.9 5096.8 6064.9 6084.9 6086.0 6103.4 6107.8 5660.2 5671.7 5699.0 5751.1 5852.7 6019.3 6105.8 6110.5 6111.9 6119.5 5722.5 5767.4 5827.2 5837.5 5861.0 5686.0 5736.9 5854.7 5934.9 5941.0 5693.6 5696.6 5730.1 5771.9 5780.0 5728.6 5732.3 5734.9 5735.1 5740.5 5462.2 5588.1 5672.7 5688.5 5689.5 5642.7 5762.7 5817.0 5839.3 5892.3 5727.0 5734.0 5742.5 5744.5 5748.7 01:27:41 INFO - PROCESS | 14825 | 01:27:41 INFO - PROCESS | 14825 | [#1] ext.html Cycles:180 Average:57566.47 Median:35331.32 stddev:112310.38 (317.9%) stddev-sans-first:112543.89 01:27:41 INFO - PROCESS | 14825 | Values: 561.2 574.1 582.1 587.4 602.3 38982.8 40938.6 40952.4 45220.8 45267.0 43330.6 43493.8 43521.8 43760.3 43950.0 8432.5 8569.7 8574.9 8578.1 9899.8 9861.2 10098.6 10105.1 10214.0 10224.4 10188.8 10258.2 10281.5 10342.1 10346.9 10141.4 10202.3 10237.6 10248.0 10258.6 10026.7 10104.8 10115.8 10116.7 10120.2 41057.8 41338.0 41427.0 41518.0 41565.8 3359.4 3382.4 3416.3 3444.5 3444.8 30591.8 30914.0 30943.0 31004.8 31076.0 4061.5 4136.4 4159.5 4163.3 4262.7 324122.0 328533.0 330295.0 330979.0 331337.0 55125.0 55665.7 56079.7 56191.7 56405.2 58987.0 59136.7 59274.1 59330.1 59384.7 15334.2 15364.4 15471.8 15759.2 15830.7 11477.7 11711.3 12630.2 12637.9 12936.9 18013.5 18081.8 18131.7 18144.8 18406.8 6817.4 6912.5 6937.0 6956.0 7063.1 920.3 995.8 1024.3 1047.6 1052.7 30355.5 30592.2 31005.5 31381.8 32916.7 1064.5 1077.5 1093.8 1163.9 1173.8 16070.3 16137.4 16146.5 16168.4 16253.0 479347.0 483522.0 483668.0 483783.0 484344.0 53740.0 53907.5 54095.7 54125.2 54270.7 1296.0 1331.0 1342.5 1346.9 1347.6 28431.1 29335.0 29740.9 30047.7 30476.8 47800.5 48587.3 48590.0 48665.0 48673.5 443364.0 444891.0 445771.0 446636.0 447821.0 26420.3 26443.7 27457.0 27489.5 28526.1 43431.3 43679.8 44960.3 45013.5 45540.0 37768.2 38124.2 38457.8 38906.8 40176.2 37361.3 37504.6 37754.6 38400.4 38507.8 37326.4 37809.0 39279.2 39438.4 39502.6 30832.5 33512.2 34721.8 35164.8 35497.8 26682.0 26800.2 26836.0 27045.7 27047.5 01:27:41 INFO - PROCESS | 14825 | 01:27:41 INFO - PROCESS | 14825 | [#2] jquery.html Cycles:180 Average:24946.23 Median:224814.30 stddev:66411.83 (29.5%) stddev-sans-first:66572.54 01:27:41 INFO - PROCESS | 14825 | Values: 390.4 397.3 398.3 400.6 416.3 15977.1 16292.1 17259.4 18758.0 18804.6 11891.8 12239.4 12621.6 12654.2 18538.8 5123.6 5311.9 5315.0 5318.4 5337.6 5190.1 5250.0 5311.9 5343.2 5377.8 5298.7 5307.1 5319.1 5319.9 5331.8 5156.2 5201.7 5242.5 5310.2 5344.7 5127.9 5137.5 5169.2 5172.0 5187.8 13557.6 13896.4 14109.9 14119.5 14146.9 2173.7 2318.9 2354.5 2376.9 2711.2 9640.0 9924.2 10366.3 10610.2 10786.3 1797.5 1821.1 1851.5 1856.6 1899.6 79969.6 82146.6 83567.0 83773.0 85416.0 10590.6 10654.2 10663.4 10913.1 11186.0 15319.4 15330.6 15331.1 15345.9 15379.2 8020.8 8053.0 8134.7 8138.7 8242.3 7438.9 7555.2 7754.6 7816.4 8182.3 4629.7 4652.9 4739.4 4834.1 4891.4 1916.0 1973.4 1977.3 2020.7 2034.3 869.6 896.9 907.6 911.5 954.3 17902.9 18689.0 19308.5 19570.2 20082.2 955.8 963.9 965.6 967.5 981.3 10167.8 10908.2 10930.7 10993.7 10999.1 154453.0 409330.0 442738.0 449363.0 450795.0 50743.7 88498.0 90826.1 90955.1 91028.0 955.2 961.6 989.5 995.9 1002.9 16383.8 16511.4 17173.4 17218.6 17311.4 27295.5 37613.8 39383.6 40298.6 44479.8 55118.7 55589.7 55848.4 62693.4 63534.7 6446.9 7304.8 7444.8 7661.6 7718.0 11201.9 12090.0 12447.0 12587.0 12925.8 10505.2 10802.5 10931.3 11086.7 11121.6 10808.8 10948.0 10983.5 11007.0 11099.4 10708.9 10953.3 11007.3 11008.7 11307.7 7522.2 7590.6 7690.8 7696.3 7714.3 8285.8 9832.7 10957.9 11067.2 11383.3 01:27:41 INFO - PROCESS | 14825 | 01:27:41 INFO - PROCESS | 14825 | [#3] mootools.html Cycles:180 Average:5665.88 Median:5121.87 stddev:3141.04 (61.3%) stddev-sans-first:3134.05 01:27:41 INFO - PROCESS | 14825 | Values: 1473.1 1477.1 1619.7 1724.5 1742.2 8294.3 8431.9 8705.4 8849.4 8851.5 8666.2 8721.8 8824.7 8847.8 8848.4 2392.1 2409.9 2420.2 2426.8 2431.2 2360.7 2428.7 2429.5 2439.7 2444.0 2378.7 2405.8 2408.6 2425.0 2428.9 2296.7 2316.2 2319.1 2321.6 2370.9 2291.0 2311.5 2333.3 2337.2 2344.9 8485.2 8553.4 8590.2 8651.6 8674.0 5287.2 5364.3 5391.9 5433.6 5442.0 3479.9 3498.9 3560.3 3587.6 3612.3 1047.5 1059.8 1090.0 1102.3 1106.5 11362.7 11392.3 11405.7 11444.3 11446.9 4374.0 4536.0 4587.7 4594.4 4682.7 9510.8 9512.7 9513.0 9513.1 9516.6 5298.6 5312.3 5312.7 5315.0 5336.1 4324.2 4334.2 4832.7 4931.9 4995.4 3729.3 3789.9 3794.8 3852.4 3870.7 1215.5 1245.4 1252.6 1254.8 1260.5 941.8 961.2 965.2 975.7 993.5 5765.4 5868.9 6053.4 6091.1 6098.8 460.9 466.5 466.9 470.8 479.2 4162.8 4173.3 4177.5 4202.6 4207.9 10102.9 10525.3 10642.9 10676.6 10678.8 9887.7 10481.8 10488.6 10553.7 10555.4 7719.2 7798.4 7864.5 7872.8 7889.6 5839.1 5854.2 5884.9 5943.8 6000.5 9736.2 9793.8 9804.7 9805.7 9813.7 9309.2 9742.9 9867.7 9997.8 10014.6 7333.9 7517.1 7660.7 7699.3 7869.6 8348.2 8456.7 8457.7 8459.2 8460.4 7237.4 7383.0 7459.7 7464.8 7696.6 7327.5 7409.2 7467.6 7484.9 7786.6 6880.5 6925.6 7000.1 7004.3 7026.8 4861.1 4941.5 4987.9 4994.5 5238.8 5117.7 5120.3 5123.4 5150.5 5154.0 01:27:41 INFO - PROCESS | 14825 | 01:27:41 INFO - PROCESS | 14825 | [#4] prototype.html Cycles:180 Average:4767.44 Median:5430.34 stddev:1393.32 (25.7%) stddev-sans-first:1357.02 01:27:41 INFO - PROCESS | 14825 | Values: 340.0 346.3 353.1 353.2 355.2 5432.9 5493.8 5517.9 5534.4 5542.9 5406.6 5421.9 5422.1 5427.8 5440.5 3949.9 4035.3 4154.6 4163.7 4190.7 4156.9 4168.8 4180.9 4210.2 4214.9 4195.5 4205.3 4221.6 4225.6 4247.8 4135.5 4191.3 4207.6 4216.7 4219.7 3709.3 3712.1 3734.2 3746.2 3750.2 5166.3 5208.5 5217.6 5230.3 5234.2 4714.5 4754.8 4806.6 4815.6 4819.4 5582.8 5594.2 5623.2 5640.8 5641.3 4119.3 4133.3 4133.5 4146.6 4173.3 5652.9 5810.0 5840.8 5871.9 5910.8 4250.9 4251.6 4262.0 4262.4 4271.2 4299.2 4308.2 4322.9 4333.7 4353.1 4724.1 4833.5 4845.0 4874.9 4885.9 5628.9 5645.7 5653.6 5667.8 5693.6 1432.0 1436.3 1438.4 1443.2 1447.7 953.1 955.5 1001.8 1005.2 1023.0 5239.4 5280.8 5295.9 5296.1 5299.8 5627.8 5642.7 5657.2 5669.4 5669.8 5198.5 5317.8 5370.6 5376.3 5505.9 2989.7 3020.1 3024.5 3028.5 3043.0 5883.1 5884.6 5896.2 5908.8 5912.6 5490.6 5714.6 5769.9 5777.0 5822.8 5822.5 5863.4 5877.4 5908.3 5910.6 5565.4 5676.5 5700.7 5737.3 5857.9 5823.5 5841.9 5859.8 5864.6 5865.7 6023.7 6081.5 6112.6 6117.4 6148.5 3975.5 4189.7 4210.7 4212.3 4222.4 5891.3 5891.5 5893.7 5908.0 5961.0 5606.1 5631.5 5766.2 5815.3 5819.7 5661.6 5730.0 5738.8 5739.0 5747.3 5657.0 5675.1 5685.7 5686.2 5689.1 5440.3 5462.3 5471.2 5672.6 5758.1 5600.7 5602.4 5612.9 5662.2 5698.5 01:27:41 INFO - PROCESS | 14825 | 01:27:41 INFO - PROCESS | 14825 | [#5] yui.html Cycles:180 Average:17463.00 Median:609.62 stddev:23489.94 (3853.2%) stddev-sans-first:23521.90 01:27:41 INFO - PROCESS | 14825 | Values: 648.4 691.8 708.0 761.9 791.7 13770.8 14685.5 14695.4 14729.0 14739.4 13549.7 13715.9 13760.2 13766.0 13784.2 651.4 664.5 766.1 781.7 795.8 793.0 794.9 794.9 795.0 795.7 842.1 844.7 846.1 848.2 848.3 838.5 842.5 845.9 846.0 846.2 608.3 610.9 612.4 614.1 614.5 13440.8 13957.7 13966.2 13995.0 14036.6 13269.0 13974.6 14043.6 14058.9 14142.4 10847.9 10960.3 11011.0 11061.8 11190.1 3467.2 3688.7 3701.8 3706.1 3706.9 59113.0 62259.4 62712.4 63056.0 63100.7 10267.6 10794.2 10887.8 11083.9 11258.0 18100.8 18373.6 19948.9 20148.6 20259.5 7927.4 8143.8 8212.6 8355.9 8385.7 4496.5 4563.5 4622.5 4683.6 4696.8 3465.2 3489.2 3530.3 3531.6 3537.9 613.3 622.4 623.2 625.6 635.5 658.3 665.8 683.2 714.0 717.2 9026.8 9469.1 9495.4 9674.7 9793.2 683.3 683.7 702.9 706.0 712.6 4432.9 4503.2 4651.8 4702.0 4787.2 87636.1 88104.1 88358.6 88581.6 92350.0 44502.0 71119.3 76075.0 76129.6 76837.9 61521.4 69757.7 69855.0 70159.0 72115.6 8966.6 9043.4 9143.4 9145.2 9236.3 47818.6 48343.8 49053.5 49270.3 49447.5 61900.7 65162.0 66272.3 67797.0 68070.7 11044.9 11132.0 11165.2 11427.4 11556.5 12257.9 12339.6 12676.8 12816.2 13068.9 11033.2 11610.0 11668.5 11831.2 12438.2 10989.9 11053.5 11565.0 11608.6 11919.6 11114.6 11358.9 11679.8 12157.6 12176.2 9273.4 9639.3 10078.5 10081.2 10141.9 9290.7 9864.6 9870.0 9919.6 9959.9 01:27:41 INFO - PROCESS | 14825 | -------- Summary: end -------- 01:27:41 INFO - PROCESS | 14825 | 01:27:42 INFO - TEST-INFO | 14825: exit 0 01:27:42 INFO - TEST-OK | dromaeo_css | took 1115972ms 01:27:42 INFO - TEST-START | kraken 01:27:42 INFO - operating with platform_type : linux_ 01:27:42 INFO - Initialising browser for kraken test... 01:27:42 INFO - TEST-INFO | started process 15178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprQkVoz/profile http://localhost:50008/getInfo.html) 01:27:46 INFO - PROCESS | 15178 | __metrics Screen width/height:1600/1200 01:27:46 INFO - PROCESS | 15178 | colorDepth:24 01:27:46 INFO - PROCESS | 15178 | Browser inner width/height: 1024/697 01:27:46 INFO - PROCESS | 15178 | __metrics 01:27:46 ERROR - PROCESS | 15178 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 01:27:47 INFO - TEST-INFO | 15178: exit 0 01:27:47 INFO - Browser initialized. 01:27:47 INFO - Running cycle 1/1 for kraken test... 01:27:47 INFO - TEST-INFO | started process 15305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprQkVoz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:27:59 INFO - PROCESS | 15305 | RSS: Main: 185896960 01:27:59 INFO - PROCESS | 15305 | 01:28:02 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50008/tests/kraken/driver.html?testName=audio-beat-detection) 01:28:03 INFO - PROCESS | 15305 | RSS: Main: 199004160 01:28:03 INFO - PROCESS | 15305 | 01:28:06 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50008/tests/kraken/driver.html?testName=audio-dft) 01:28:06 INFO - PROCESS | 15305 | RSS: Main: 197185536 01:28:06 INFO - PROCESS | 15305 | 01:28:09 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50008/tests/kraken/driver.html?testName=audio-fft) 01:28:10 INFO - PROCESS | 15305 | RSS: Main: 193810432 01:28:10 INFO - PROCESS | 15305 | 01:28:12 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50008/tests/kraken/driver.html?testName=audio-oscillator) 01:28:13 INFO - PROCESS | 15305 | RSS: Main: 194371584 01:28:13 INFO - PROCESS | 15305 | 01:28:15 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:28:15 INFO - PROCESS | 15305 | RSS: Main: 194265088 01:28:15 INFO - PROCESS | 15305 | 01:28:18 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50008/tests/kraken/driver.html?testName=imaging-darkroom) 01:28:19 INFO - PROCESS | 15305 | RSS: Main: 198787072 01:28:19 INFO - PROCESS | 15305 | 01:28:23 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50008/tests/kraken/driver.html?testName=imaging-desaturate) 01:28:23 INFO - PROCESS | 15305 | RSS: Main: 198459392 01:28:23 INFO - PROCESS | 15305 | 01:28:26 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50008/tests/kraken/driver.html?testName=json-parse-financial) 01:28:27 INFO - PROCESS | 15305 | RSS: Main: 198037504 01:28:27 INFO - PROCESS | 15305 | 01:28:28 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:28:29 INFO - PROCESS | 15305 | RSS: Main: 197681152 01:28:29 INFO - PROCESS | 15305 | 01:28:31 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50008/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:28:31 INFO - PROCESS | 15305 | RSS: Main: 197910528 01:28:31 INFO - PROCESS | 15305 | 01:28:33 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:28:34 INFO - PROCESS | 15305 | RSS: Main: 197922816 01:28:34 INFO - PROCESS | 15305 | 01:28:37 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:28:38 INFO - PROCESS | 15305 | RSS: Main: 197959680 01:28:38 INFO - PROCESS | 15305 | 01:28:40 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:28:41 INFO - PROCESS | 15305 | RSS: Main: 198094848 01:28:41 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | Cycle 1(1): loaded http://localhost:50008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50008/tests/kraken/driver.html?testName=ai-astar) 01:28:43 INFO - PROCESS | 15305 | RSS: Main: 199626752 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | __start_tp_report 01:28:43 INFO - PROCESS | 15305 | _x_x_mozilla_page_load 01:28:43 INFO - PROCESS | 15305 | _x_x_mozilla_page_load_details 01:28:43 INFO - PROCESS | 15305 | |i|pagename|runs| 01:28:43 INFO - PROCESS | 15305 | |0;ai-astar;106;112;115;112;112;113;113;113;112;112 01:28:43 INFO - PROCESS | 15305 | |1;audio-beat-detection;152;131;130;177;125;125;127;128;144;126 01:28:43 INFO - PROCESS | 15305 | |2;audio-dft;162;166;164;166;173;165;163;166;163;162 01:28:43 INFO - PROCESS | 15305 | |3;audio-fft;76;76;78;125;77;77;76;76;99;76 01:28:43 INFO - PROCESS | 15305 | |4;audio-oscillator;83;82;110;82;83;83;103;83;82;110 01:28:43 INFO - PROCESS | 15305 | |5;imaging-gaussian-blur;119;119;117;118;118;118;119;123;117;118 01:28:43 INFO - PROCESS | 15305 | |6;imaging-darkroom;147;148;150;149;149;151;149;148;150;149 01:28:43 INFO - PROCESS | 15305 | |7;imaging-desaturate;97;96;96;96;96;97;96;96;96;96 01:28:43 INFO - PROCESS | 15305 | |8;json-parse-financial;53;53;58;54;54;54;54;55;55;54 01:28:43 INFO - PROCESS | 15305 | |9;json-stringify-tinderbox;64;63;63;63;64;64;63;63;64;63 01:28:43 INFO - PROCESS | 15305 | |10;stanford-crypto-aes;89;86;82;85;86;82;83;82;82;83 01:28:43 INFO - PROCESS | 15305 | |11;stanford-crypto-ccm;143;144;141;135;140;137;137;134;173;151 01:28:43 INFO - PROCESS | 15305 | |12;stanford-crypto-pbkdf2;168;170;170;170;173;168;167;168;166;169 01:28:43 INFO - PROCESS | 15305 | |13;stanford-crypto-sha256-iterative;73;67;65;66;67;66;68;66;65;65 01:28:43 INFO - PROCESS | 15305 | __end_tp_report 01:28:43 INFO - PROCESS | 15305 | __start_cc_report 01:28:43 INFO - PROCESS | 15305 | _x_x_mozilla_cycle_collect,826 01:28:43 INFO - PROCESS | 15305 | __end_cc_report 01:28:43 INFO - PROCESS | 15305 | __startTimestamp1479893323435__endTimestamp 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | ------- Summary: start ------- 01:28:43 INFO - PROCESS | 15305 | Number of tests: 14 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.50 stddev:2.31 (2.1%) stddev-sans-first:1.00 01:28:43 INFO - PROCESS | 15305 | Values: 106.0 112.0 115.0 112.0 112.0 113.0 113.0 113.0 112.0 112.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:130.50 stddev:16.82 (12.9%) stddev-sans-first:16.88 01:28:43 INFO - PROCESS | 15305 | Values: 152.0 131.0 130.0 177.0 125.0 125.0 127.0 128.0 144.0 126.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.50 stddev:3.23 (2.0%) stddev-sans-first:3.24 01:28:43 INFO - PROCESS | 15305 | Values: 162.0 166.0 164.0 166.0 173.0 165.0 163.0 166.0 163.0 162.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.50 stddev:16.19 (21.2%) stddev-sans-first:16.93 01:28:43 INFO - PROCESS | 15305 | Values: 76.0 76.0 78.0 125.0 77.0 77.0 76.0 76.0 99.0 76.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.50 stddev:12.28 (14.9%) stddev-sans-first:12.75 01:28:43 INFO - PROCESS | 15305 | Values: 83.0 82.0 110.0 82.0 83.0 83.0 103.0 83.0 82.0 110.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.50 stddev:1.71 (1.4%) stddev-sans-first:1.81 01:28:43 INFO - PROCESS | 15305 | Values: 119.0 119.0 117.0 118.0 118.0 118.0 119.0 123.0 117.0 118.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.15 (0.8%) stddev-sans-first:0.97 01:28:43 INFO - PROCESS | 15305 | Values: 147.0 148.0 150.0 149.0 149.0 151.0 149.0 148.0 150.0 149.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 01:28:43 INFO - PROCESS | 15305 | Values: 97.0 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:1.43 (2.6%) stddev-sans-first:1.42 01:28:43 INFO - PROCESS | 15305 | Values: 53.0 53.0 58.0 54.0 54.0 54.0 54.0 55.0 55.0 54.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 01:28:43 INFO - PROCESS | 15305 | Values: 64.0 63.0 63.0 63.0 64.0 64.0 63.0 63.0 64.0 63.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:2.40 (2.9%) stddev-sans-first:1.74 01:28:43 INFO - PROCESS | 15305 | Values: 89.0 86.0 82.0 85.0 86.0 82.0 83.0 82.0 82.0 83.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:142.00 stddev:11.51 (8.1%) stddev-sans-first:12.21 01:28:43 INFO - PROCESS | 15305 | Values: 143.0 144.0 141.0 135.0 140.0 137.0 137.0 134.0 173.0 151.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:169.50 stddev:1.97 (1.2%) stddev-sans-first:2.06 01:28:43 INFO - PROCESS | 15305 | Values: 168.0 170.0 170.0 170.0 173.0 168.0 167.0 168.0 166.0 169.0 01:28:43 INFO - PROCESS | 15305 | 01:28:43 INFO - PROCESS | 15305 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:2.39 (3.6%) stddev-sans-first:1.05 01:28:43 INFO - PROCESS | 15305 | Values: 73.0 67.0 65.0 66.0 67.0 66.0 68.0 66.0 65.0 65.0 01:28:43 INFO - PROCESS | 15305 | -------- Summary: end -------- 01:28:43 INFO - PROCESS | 15305 | 01:28:44 INFO - TEST-INFO | 15305: exit 0 01:28:44 INFO - TEST-OK | kraken | took 62497ms 01:28:44 INFO - SUITE-END | took 1178s 01:28:45 INFO - Completed test suite (00:19:38) 01:28:45 INFO - javascript benchmark 01:28:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7038.261560265442, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.8301693406866, 3090.2737856603694, 3099.411111888742, 3115.7974731642435, 3122.2818751687128, 5338.652987555806, 5445.863853403662, 5528.530074943635, 5535.6955367454775, 5542.612017158801, 5346.759395827187, 5415.13357862741, 5418.4039755626845, 5424.0236757383755, 5430.83707488776, 4882.804687812483, 4940.555350018498, 4981.203007518798, 5005.2492126181, 5050.0, 4981.053599816041, 4999.650024498286, 5025.698458092508, 5039.143345631252, 5041.747912604355, 332.4518031561734, 4933.555979961785, 4935.9753201234125, 5053.772580233898, 5107.233914912756, 4336.631386332134, 4974.77613507393, 5004.874878128039, 5005.174146265862, 5043.268726034741, 4958.504149585049, 4960.255961605788, 4968.080905032581, 4972.378452693413, 5006.799728010875, 5236.0, 5298.602604804655, 5389.299391079135, 5428.240046393508, 5524.8342549723575, 5808.651480911159, 5869.735861886183, 5884.823455296348, 5902.439268269508, 5927.288725352985, 5905.468507834273, 5907.527397808165, 5909.438603332676, 5920.5559583031445, 5930.347661757203, 5271.920921186185, 5297.470252974749, 5503.752331145068, 5508.008558459475, 5520.91718624221, 5923.052311630205, 5948.375420580776, 5950.166976623276, 5950.732217050243, 5952.226210592596, 5718.714064296769, 5722.2561067061015, 5723.627964182315, 5724.599278050497, 5734.168545560954, 5763.7982670606325, 5795.594308398456, 5808.07070868659, 5808.5062769665055, 5813.011787996051, 5750.683712395775, 5757.280339957505, 5782.392848750905, 5783.537317014629, 5783.624064435799, 5733.369329373765, 5787.189793428924, 5793.449622285876, 5794.21778059965, 5798.536117110621, 4335.913281734348, 4393.945453091235, 4404.757738324359, 4407.206702793528, 4411.448568928884, 3964.801759911993, 3975.1056012397557, 3979.6617287530307, 4019.7588144711412, 4074.0018695419813, 5632.887342253132, 5634.239377684042, 5636.774529018793, 5646.830595082154, 5714.628549144375, 5698.059820129715, 5714.200011998323, 5727.742251598688, 5811.302643682785, 5834.912476312858, 5445.074337362658, 5481.0, 5512.448755124536, 5595.888082238333, 5608.6073974821375, 5060.49395060491, 5083.364579427572, 5083.644144909895, 5088.898222035538, 5096.847094587169, 6064.939350606525, 6084.878302433926, 6085.9695701521205, 6103.42017508336, 6107.816765497042, 5660.235868157746, 5671.6597004179885, 5699.0, 5751.079827227623, 5852.736626851887, 6019.277686677627, 6105.793350785129, 6110.467630727307, 6111.926012480528, 6119.502553941512, 5722.542196624343, 5767.365589785037, 5827.213326201078, 5837.5038121758425, 5860.970695146668, 5686.0, 5736.885262294814, 5854.711963368052, 5934.851628709317, 5940.970295148497, 5693.572982026281, 5696.629719068247, 5730.054541000688, 5771.913421298768, 5779.988502012047, 5728.627639203605, 5732.340780810094, 5734.856628584152, 5735.11105778605, 5740.540756739368, 5462.20797984298, 5588.133839254922, 5672.716364181857, 5688.516476099578, 5689.487946084707, 5642.689652069175, 5762.654240745569, 5817.0, 5839.328477225174, 5892.322382926019, 5727.02640551099, 5734.0, 5742.5405967521665, 5744.4829965303325, 5748.712564371681], "value": 5347.886152871419, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1666674987642, 574.1359254322244, 582.1471544187764, 587.4067192135941, 602.3223873142714, 38982.80508597456, 40938.59061409385, 40952.38571421431, 45220.77389613047, 45267.0, 43330.56669433305, 43493.7825310873, 43521.782391088076, 43760.343594846105, 43950.0, 8432.53621050842, 8569.742907712747, 8574.914250857506, 8578.056413794478, 9899.802003959952, 9861.161801246866, 10098.646547370843, 10105.090541851232, 10214.0, 10224.386536807779, 10188.847167292497, 10258.17934565233, 10281.485925703684, 10342.120919721796, 10346.948265258701, 10141.391516508997, 10202.285839991204, 10237.59049638021, 10248.0, 10258.640947566799, 10026.69919902404, 10104.797904041878, 10115.79768404635, 10116.747081322952, 10120.240981926385, 41057.79471102655, 41338.0, 41427.0, 41518.0, 41565.79217103895, 3359.412102881986, 3382.374260761767, 3416.28258065804, 3444.500547420635, 3444.8277586120844, 30591.847040764875, 30914.0, 30943.0, 31004.844975775202, 31076.027835546203, 4061.517546095654, 4136.379543068534, 4159.521655009682, 4163.3130533461945, 4262.658495245765, 324122.0, 328532.9999999976, 330295.0, 330979.0, 331337.0, 55125.0, 55665.721671392195, 56079.71960140255, 56191.71904140453, 56405.15392269119, 58987.0, 59136.70431647814, 59274.11088833671, 59330.11004834931, 59384.7030764852, 15334.23328833554, 15364.385424582892, 15471.845281547265, 15759.212039397984, 15830.683386332208, 11477.713057173638, 11711.297322160697, 12630.242185468718, 12637.93681031589, 12936.935315323552, 18013.459596212135, 18081.819181808278, 18131.728024079384, 18144.818551814576, 18406.81593184051, 6817.420519255918, 6912.481563882729, 6937.0, 6956.0, 7063.117110361205, 920.3281604428804, 995.770972676274, 1024.329064462778, 1047.6176195688672, 1052.7105046112226, 30355.544666830014, 30592.23519411988, 31005.534916976263, 31381.843090784856, 32916.67083329184, 1064.489045258265, 1077.472038701031, 1093.781243751253, 1163.8603367595774, 1173.8473998380157, 16070.303830119137, 16137.435189768301, 16146.541383446714, 16168.35326586947, 16253.0, 479347.0, 483522.0, 483668.0, 483783.0, 484344.0, 53740.0, 53907.46092539103, 54095.72952135214, 54125.1881221782, 54270.72864635652, 1295.95464158754, 1330.9933450332687, 1342.4965637885794, 1346.8518462969066, 1347.555306748751, 28431.147065588066, 29335.0, 29740.85129574338, 30047.69952300449, 30476.84761576178, 47800.52199477961, 48587.27119093287, 48590.0, 48665.0, 48673.513264868314, 443364.0, 444891.0, 445771.0, 446636.0, 447821.0, 26420.339491512867, 26443.735562644128, 27457.0, 27489.450210996067, 28526.144215673565, 43431.34852977144, 43679.78160109179, 44960.32559511544, 45013.549864502245, 45540.0, 37768.244635107694, 38124.2375152501, 38457.807710962385, 38906.80546597249, 40176.1964760709, 37361.25277494489, 37504.624953751205, 37754.62245377511, 38400.42399363956, 38507.80746096252, 37326.37853949329, 37809.0, 39279.21441571095, 39438.408423873094, 39502.60497394989, 30832.537511937786, 33512.1621959453, 34721.826390867885, 35164.82417587896, 35497.82251088728, 26682.0, 26800.195994120208, 26836.0, 27045.72954270432, 27047.459050819267], "value": 19677.305309304604, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.3715018819702, 397.29678469109666, 398.29501781846153, 400.6154092071611, 416.27568031624963, 15977.121258330788, 16292.10393428361, 17259.39592114276, 18757.968311742865, 18804.62390752186, 11891.762164756721, 12239.449224784883, 12621.621351359474, 12654.240745555273, 18538.81461185388, 5123.590112790967, 5311.9468805311835, 5315.0432922074015, 5318.414974352818, 5337.626366154371, 5190.06578815813, 5249.973750131244, 5311.9468805311835, 5343.171808369709, 5377.7580008899495, 5298.708571028592, 5307.1243244864745, 5319.069162896497, 5319.867003324928, 5331.760070796823, 5156.20078887773, 5201.713905735202, 5242.475752424765, 5310.20346947957, 5344.732763361816, 5127.9230811537855, 5137.460566640524, 5169.172932330846, 5172.043172013152, 5187.844364669066, 13557.59327220185, 13896.374663140183, 14109.929450352785, 14119.505817296345, 14146.929265353607, 2173.7065496157975, 2318.8840557972203, 2354.4702441950594, 2376.940576485584, 2711.159540542438, 9640.0, 9924.15644670204, 10366.326188797779, 10610.151187905027, 10786.298890572089, 1797.5326415132029, 1821.1167583721885, 1851.453821122772, 1856.5822689894665, 1899.5915878086278, 79969.60015199886, 82146.58926705387, 83567.0, 83772.99999999939, 85416.0, 10590.604898966842, 10654.200934929911, 10663.360198388122, 10913.072388847037, 11186.0, 15319.387224510894, 15330.616734581501, 15331.080135191702, 15345.923270383577, 15379.154146522049, 8020.759377218693, 8053.0, 8134.715284965117, 8138.674453021931, 8242.29940455068, 7438.888416673754, 7555.248687393466, 7754.612269386621, 7816.374690024898, 8182.345412366996, 4629.65277604181, 4652.883677908079, 4739.431268247832, 4834.081524510332, 4891.437484689235, 1915.9521011974812, 1973.3882496426154, 1977.3079422202113, 2020.7069974853564, 2034.3185033014106, 869.5956380283199, 896.8699538566872, 907.582512044467, 911.5305617606938, 954.2842867849113, 17902.91048544749, 18689.0, 19308.517287067934, 19570.21719131219, 20082.19671213135, 955.7897262602216, 963.9036096390305, 965.6427121964917, 967.4630580028152, 981.2885657897967, 10167.796644067077, 10908.23642345044, 10930.653765041558, 10993.725156870982, 10999.120070394349, 154453.0, 409330.0, 442738.0, 449363.0, 450795.0, 50743.746281269094, 88498.0, 90826.09173908176, 90955.09044909598, 91028.0, 955.2358113509165, 961.6297725375781, 989.5052473763119, 995.9352642078242, 1002.9247806414548, 16383.754243686593, 16511.422100226435, 17173.398931037354, 17218.569535761708, 17311.3941012069, 27295.45409091847, 37613.81193094017, 39383.60616393799, 40298.59701402948, 44479.77760111179, 55118.72440637771, 55589.722051389486, 55848.44151558432, 62693.37306627058, 63534.682326588074, 6446.903296450463, 7304.817379565553, 7444.776656700307, 7661.616919153908, 7717.961410192913, 11201.887981120084, 12090.0, 12447.0, 12587.0, 12925.806112908125, 10505.159587233156, 10802.513886874953, 10931.344119352547, 11086.667399978014, 11121.610743623934, 10808.783824323313, 10948.0, 10983.450827458435, 11007.0, 11099.44502774842, 10708.946455267986, 10953.34279943206, 11007.284526505751, 11008.669739907815, 11307.660770176908, 7522.210167932289, 7590.582517961565, 7690.769276921701, 7696.307332340116, 7714.3442807362, 8285.792855178668, 9832.705018849447, 10957.945210273898, 11067.225294229327, 11383.317000979967], "value": 8568.076454484459, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.13085279685, 1477.0768269831356, 1619.7489389144687, 1724.5085150732036, 1742.2072956804654, 8294.29498492628, 8431.915680843189, 8705.434146780455, 8849.38054336196, 8851.513166775825, 8666.176713212251, 8721.825563488743, 8824.735257942257, 8847.823043539125, 8848.38061335705, 2392.1268736911074, 2409.8795060247007, 2420.213430635051, 2426.757324267568, 2431.185552839801, 2360.704911886014, 2428.7449817769143, 2429.4898071404937, 2439.658447817307, 2444.046821739523, 2378.6907701998803, 2405.7594240575977, 2408.6266628672583, 2425.0299880047946, 2428.854268743872, 2296.701428814252, 2316.224064938248, 2319.060780383947, 2321.6401457774073, 2370.881455927214, 2291.049214575949, 2311.5492478966607, 2333.288347054148, 2337.240396871007, 2344.9296521104225, 8485.236328730443, 8553.40126191167, 8590.1839325264, 8651.567421628957, 8673.956630216871, 5287.154055351125, 5364.302640656729, 5391.946080539184, 5433.565314774809, 5442.0476416627325, 3479.938618721289, 3498.9475157872653, 3560.3413368526903, 3587.587427445851, 3612.3317186320614, 1047.460557812727, 1059.7615536504225, 1089.9509522071446, 1102.2669924500199, 1106.5131342209484, 11362.715932101764, 11392.316461012366, 11405.657830265105, 11444.313341199555, 11446.885531144666, 4373.978130109329, 4536.0, 4587.747673877902, 4594.448666160082, 4682.672212945061, 9510.809783804285, 9512.667056652985, 9513.04869513057, 9513.143817056498, 9516.571754270935, 5298.602604804578, 5312.282841816383, 5312.7343632818975, 5315.043292207362, 5336.1195402758885, 4324.221640104812, 4334.21984042869, 4832.661713680009, 4931.852044438672, 4995.425526064549, 3729.254149170177, 3789.8673546425744, 3794.8102594870697, 3852.4221366794645, 3870.6903447724117, 1215.471269997554, 1245.3959829482694, 1252.6242127361936, 1254.8055051467038, 1260.5462033668055, 941.8398872191743, 961.1925982175006, 965.1506674126864, 975.658519518163, 993.4630133720248, 5765.423457654201, 5868.943590153814, 6053.424924632153, 6091.086337049478, 6098.817035488943, 460.8571342883717, 466.5101643274548, 466.8879468927501, 470.79285114549486, 479.24518882759094, 4162.791860406967, 4173.311403618369, 4177.5195852476745, 4202.642775364128, 4207.852725154666, 10102.898971010343, 10525.315854469434, 10642.946785266178, 10676.572937082585, 10678.839817402744, 9887.653932112342, 10481.842772358421, 10488.632897848538, 10553.683389498174, 10555.419451930218, 7719.150893401721, 7798.415118866108, 7864.4888082274465, 7872.842543149105, 7889.644965976545, 5839.124131380327, 5854.180414742024, 5884.882302354014, 5943.791967281124, 6000.489713517641, 9736.221102311656, 9793.80412391734, 9804.705858824247, 9805.705828825146, 9813.705588832347, 9309.162175404246, 9742.9025709742, 9867.654632087842, 9997.800043998934, 10014.599416023277, 7333.889991650023, 7517.1355294139685, 7660.731874384593, 7699.345555627834, 7869.567173805495, 8348.165183481604, 8456.66173353059, 8457.703980360659, 8459.196376344238, 8460.407771455939, 7237.384822289953, 7382.9630851845395, 7459.738909138154, 7464.813379665552, 7696.615169241628, 7327.450441217036, 7409.222031686595, 7467.551946883204, 7484.925150748423, 7786.61066946639, 6880.518363714492, 6925.58446493212, 7000.054992575937, 7004.334588214111, 7026.754063607749, 4861.149298872612, 4941.481144479922, 4987.875303117451, 4994.4755800640405, 5238.790448382022, 5117.718525481134, 5120.3343565337755, 5123.410807757006, 5150.510701483503, 5154.0], "value": 4504.561847668086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.02921658664513, 346.3022010648544, 353.1189681744049, 353.1647653299946, 355.2238359185182, 5432.8913421731595, 5493.807716729915, 5517.862053448655, 5534.418886016961, 5542.889142217154, 5406.59450541209, 5421.918671219935, 5422.123181924923, 5427.782888684458, 5440.510354068133, 3949.9210015799667, 4035.3341698619765, 4154.584541545852, 4163.729357591762, 4190.685698572619, 4156.875293741193, 4168.812403441837, 4180.9372859406985, 4210.200061988213, 4214.894627634319, 4195.538490766014, 4205.285101532747, 4221.620054195122, 4225.556316586761, 4247.787610619472, 4135.503739551243, 4191.266528357556, 4207.621314081717, 4216.704830661855, 4219.662427005863, 3709.2766910452474, 3712.1276500022473, 3734.1971476132762, 3746.2132952080096, 3750.2499500099816, 5166.302549155891, 5208.458248391093, 5217.58259339252, 5230.267762513251, 5234.162533994542, 4714.481407045222, 4754.833580824655, 4806.639502037361, 4815.638827087947, 4819.42166939966, 5582.8325150245555, 5594.2447769551, 5623.184638227475, 5640.756564975115, 5641.323041235037, 4119.299719047769, 4133.318002529579, 4133.4626498555, 4146.569433545422, 4173.290540608104, 5652.915206271868, 5810.0, 5840.7734375781565, 5871.911921321183, 5910.763569457216, 4250.893727656833, 4251.596098370712, 4261.978690106592, 4262.422903525653, 4271.167122411162, 4299.226139294894, 4308.224519586442, 4322.919270182454, 4333.653307735373, 4353.1293741251875, 4724.149653062482, 4833.453294945583, 4845.0, 4874.8537543873745, 4885.853424397274, 5628.889166562539, 5645.661260324311, 5653.575981801381, 5667.829965101054, 5693.629914055573, 1431.9642008949652, 1436.2531483628454, 1438.4318194313187, 1443.2062365698823, 1447.7032208397463, 953.122348972523, 955.498363359228, 1001.8278614021613, 1005.2410430125354, 1022.9846552301722, 5239.397469291004, 5280.788768449296, 5295.867603309871, 5296.073187192226, 5299.761510732026, 5627.774889004476, 5642.6614403135945, 5657.20799088128, 5669.376368599451, 5669.829905102853, 5198.4801519847715, 5317.760700768397, 5370.570354371641, 5376.301080859464, 5505.862353441196, 2989.671136175019, 3020.0788759428583, 3024.5311976643657, 3028.500892058445, 3043.0, 5883.117532370179, 5884.588078834526, 5896.174535565025, 5908.763649453974, 5912.586118971717, 5490.588205884575, 5714.5999780015, 5769.922827781995, 5776.971115144397, 5822.7962021329895, 5822.534197264209, 5863.355030946593, 5877.353491115974, 5908.291005079246, 5910.615809972338, 5565.415631358649, 5676.489115979582, 5700.714964251853, 5737.34020587621, 5857.94142058591, 5823.475887170175, 5841.94158058414, 5859.824205273849, 5864.589478736448, 5865.73604187804, 6023.66869822164, 6081.452669259788, 6112.602680825732, 6117.357677443804, 6148.52435415506, 3975.495437874121, 4189.748615083105, 4210.7473551587, 4212.262854000599, 4222.408862759277, 5891.262077687007, 5891.468218263368, 5893.675847828411, 5907.970460147843, 5961.0, 5606.065907261988, 5631.493165615114, 5766.221560089502, 5815.273090863642, 5819.709014549171, 5661.612904838341, 5730.0, 5738.770449181986, 5738.96698594257, 5747.310322761128, 5656.953463609246, 5675.148727690879, 5685.744141513559, 5686.203931449518, 5689.118186681071, 5440.319960004999, 5462.289902312674, 5471.206675032177, 5672.5745569081655, 5758.11327354026, 5600.747966341606, 5602.439756024365, 5612.85967850807, 5662.178984047207, 5698.515626171822], "value": 4327.074961228808, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.4002297874465, 691.8062942376137, 708.0229283588646, 761.851438969401, 791.6516732637641, 13770.793438098424, 14685.486007989723, 14695.412183512673, 14729.0, 14739.410423583056, 13549.729005419886, 13715.862841371583, 13760.174389536634, 13766.0, 13784.241866697328, 651.423490211163, 664.4551467796384, 766.1266156581502, 781.7303030454513, 795.8129839487716, 793.0245797668871, 794.8688466403037, 794.9046114466272, 794.9562774047425, 795.6618437164211, 842.1073661918356, 844.6536919862857, 846.1327139681845, 848.1984524624232, 848.3128665780706, 838.5220424358118, 842.4902933725069, 845.9450135741157, 846.018618402653, 846.2257034813108, 608.3065305551675, 610.9327973922865, 612.4090252905967, 614.1494030767375, 614.5053232148119, 13440.798388024188, 13957.720845583031, 13966.162030278216, 13995.0, 14036.578902632937, 13269.0, 13974.580762577038, 14043.578692639136, 14058.92970535151, 14142.434302627882, 10847.938891610569, 10960.342379457179, 11010.953959373926, 11061.834072488919, 11190.104791616652, 3467.150548115728, 3688.704903607732, 3701.796401197933, 3706.110533471974, 3706.944395834065, 59113.0, 62259.37740622581, 62712.37287627111, 63056.0, 63100.68449657768, 10267.589296428208, 10794.190435717195, 10887.83668244977, 11083.944580277048, 11258.0, 18100.818991809912, 18373.63252734938, 19948.90025549892, 20148.597028059357, 20259.493512662302, 7927.3658107351275, 8143.79640508992, 8212.63043163059, 8355.916440835636, 8385.706500272583, 4496.527864574173, 4563.498015218323, 4622.514635963243, 4683.625309975194, 4696.835610753607, 3465.220325426759, 3489.180042689966, 3530.3292374448774, 3531.611522732497, 3537.9292414151573, 613.3345320327405, 622.3776223776224, 623.2085251730277, 625.634004107593, 635.5328833307515, 658.2956236826645, 665.766981556461, 683.1733602341222, 713.9571625702474, 717.2039036669292, 9026.774330641787, 9469.14777670013, 9495.43027418357, 9674.661386851427, 9793.21654267657, 683.2757277285993, 683.6991723641581, 702.9261927497539, 705.9752908648172, 712.6223101756077, 4432.889177770581, 4503.166914120898, 4651.837185698552, 4701.976490117528, 4787.16224660683, 87636.12363876407, 88104.11895881087, 88358.55820720983, 88581.55709221541, 92350.0, 44502.0, 71119.28880711127, 76075.0, 76129.61935190289, 76837.92648294117, 61521.38478615157, 69757.65121174362, 69855.0, 70159.0, 72115.63942180255, 8966.551672416483, 9043.412178208395, 9143.405678630868, 9145.176934075966, 9236.307276954121, 47818.63173944476, 48343.758281209775, 49053.50946490489, 49270.26094608512, 49447.50552494573, 61900.69049654723, 65162.0, 66272.33727662661, 67797.0, 68070.65964670145, 11044.889551104387, 11132.0, 11165.162612804235, 11427.428628568705, 11556.497655304756, 12257.877421225674, 12339.62981110568, 12676.809847852106, 12816.166949148275, 13068.934655327042, 11033.172512061788, 11610.0, 11668.533258669559, 11831.230969986924, 12438.19151755133, 10989.945050274697, 11053.540587219202, 11565.0, 11608.593699220486, 11919.642410727693, 11114.610988615359, 11358.85361735415, 11679.766404671689, 12157.574484892986, 12176.208546444454, 9273.443593384418, 9639.277054221102, 10078.546465409221, 10081.193504519768, 10141.898581014095, 9290.674826381044, 9864.556094975887, 9870.0, 9919.553620087258, 9959.900400995897], "value": 6916.255547651273, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 115.0, 112.0, 112.0, 113.0, 113.0, 113.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 130.0, 177.0, 125.0, 125.0, 127.0, 128.0, 144.0, 126.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 164.0, 166.0, 173.0, 165.0, 163.0, 166.0, 163.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 125.0, 77.0, 77.0, 76.0, 76.0, 99.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 110.0, 82.0, 83.0, 83.0, 103.0, 83.0, 82.0, 110.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 118.0, 118.0, 118.0, 119.0, 123.0, 117.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 150.0, 149.0, 149.0, 151.0, 149.0, 148.0, 150.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 58.0, 54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 64.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 82.0, 85.0, 86.0, 82.0, 83.0, 82.0, 82.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 141.0, 135.0, 140.0, 137.0, 137.0, 134.0, 173.0, 151.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 170.0, 170.0, 173.0, 168.0, 167.0, 168.0, 166.0, 169.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 67.0, 65.0, 66.0, 67.0, 66.0, 68.0, 66.0, 65.0, 65.0], "value": 66.8, "unit": "score"}]}]} 01:28:45 INFO - Return code: 0 01:28:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:28:45 ERROR - # TBPL SUCCESS # 01:28:45 INFO - Running post-action listener: _resource_record_post_action 01:28:45 INFO - [mozharness: 2016-11-23 09:28:45.234977Z] Finished run-tests step (success) 01:28:45 INFO - Running post-run listener: _resource_record_post_run 01:28:45 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404426752; Read time: 16; Write time: 241976 01:28:45 INFO - TinderboxPrint: CPU usage
13.4% 01:28:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:28:45 INFO - TinderboxPrint: I/O write bytes / time
404,426,752 / 241,976 01:28:45 INFO - TinderboxPrint: CPU idle
8,265.2 (86.6%) 01:28:45 INFO - TinderboxPrint: CPU user
1,216.5 (12.7%) 01:28:45 INFO - TinderboxPrint: Swap in / out
0 / 0 01:28:45 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103927808; Read time: 0; Write time: 74020 01:28:45 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289226752; Read time: 16; Write time: 165640 01:28:45 INFO - Running post-run listener: _upload_blobber_files 01:28:45 INFO - Blob upload gear active. 01:28:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:28:45 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 01:28:45 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:28:45 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:28:46 INFO - (blobuploader) - INFO - Open directory for files ... 01:28:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:28:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:28:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:28:47 INFO - (blobuploader) - INFO - Done attempting. 01:28:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:28:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:28:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:28:48 INFO - (blobuploader) - INFO - Done attempting. 01:28:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:28:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:28:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:28:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:28:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:28:52 INFO - (blobuploader) - INFO - Done attempting. 01:28:52 INFO - (blobuploader) - INFO - Iteration through files over. 01:28:52 INFO - Return code: 0 01:28:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:28:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:28:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef23423c25a792e1b77857f06febda10cdc91861f356a3219146a750616ea8e88df642a9e6c6ff1523f32f4ff2fdf3976d32e122ebf013dc92aaf4f4f325bf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73f0c9b072b32c0fdceb7c800632ab7890d172dbd087814da8b689f09b17cbdd259fd9dea39fc39d1dde051e7c8220fc5d4592855154fac0d79369e7b16b101d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ca7c5b3ffe05f7faea8c4acb6af920158bbf646706553b14860e25e2b914faa49520c58d5a7a9186b5f42138f8502a9131b4fe5b738fc2da95ac611cdb36fb6"} 01:28:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:28:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:28:52 INFO - Contents: 01:28:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef23423c25a792e1b77857f06febda10cdc91861f356a3219146a750616ea8e88df642a9e6c6ff1523f32f4ff2fdf3976d32e122ebf013dc92aaf4f4f325bf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73f0c9b072b32c0fdceb7c800632ab7890d172dbd087814da8b689f09b17cbdd259fd9dea39fc39d1dde051e7c8220fc5d4592855154fac0d79369e7b16b101d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ca7c5b3ffe05f7faea8c4acb6af920158bbf646706553b14860e25e2b914faa49520c58d5a7a9186b5f42138f8502a9131b4fe5b738fc2da95ac611cdb36fb6"} 01:28:52 INFO - Running post-run listener: copy_logs_to_upload_dir 01:28:52 INFO - Copying logs to upload dir... 01:28:52 INFO - mkdir: /builds/slave/test/build/upload/logs 01:28:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.661382 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-23 01:28:50.951874) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 01:28:50.957830) ========= 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=523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef23423c25a792e1b77857f06febda10cdc91861f356a3219146a750616ea8e88df642a9e6c6ff1523f32f4ff2fdf3976d32e122ebf013dc92aaf4f4f325bf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73f0c9b072b32c0fdceb7c800632ab7890d172dbd087814da8b689f09b17cbdd259fd9dea39fc39d1dde051e7c8220fc5d4592855154fac0d79369e7b16b101d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ca7c5b3ffe05f7faea8c4acb6af920158bbf646706553b14860e25e2b914faa49520c58d5a7a9186b5f42138f8502a9131b4fe5b738fc2da95ac611cdb36fb6"} build_url:https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011466 build_url: 'https://queue.taskcluster.net/v1/task/fZh1FEW_QQSKYEDgCz1N9g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aef23423c25a792e1b77857f06febda10cdc91861f356a3219146a750616ea8e88df642a9e6c6ff1523f32f4ff2fdf3976d32e122ebf013dc92aaf4f4f325bf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73f0c9b072b32c0fdceb7c800632ab7890d172dbd087814da8b689f09b17cbdd259fd9dea39fc39d1dde051e7c8220fc5d4592855154fac0d79369e7b16b101d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ca7c5b3ffe05f7faea8c4acb6af920158bbf646706553b14860e25e2b914faa49520c58d5a7a9186b5f42138f8502a9131b4fe5b738fc2da95ac611cdb36fb6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 01:28:50.983807) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 01:28:50.984136) ========= 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=523ca41ca1e0623de333ad52000001bf-1479891189.664022-783753871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 01:28:51.067092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 01:28:51.067414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 01:28:51.067758) ========= ========= Total master_lag: 0.18 =========