builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1477589429.41 results: success (0) buildid: 20161027073001 builduid: 2a54c55854794a4c97cbc6b8bb63cfc4 revision: ca5956d3e4de98ec9e1aff413c7a651757b3c300 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:29.413309) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:29.413835) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:29.414164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:29.429072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:29.429385) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 10:30:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.5M=0s 2016-10-27 10:30:30 (65.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109314 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:29.551396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:29.551707) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016469 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:29.601071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 10:30:29.601609) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ca5956d3e4de98ec9e1aff413c7a651757b3c300 --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 ca5956d3e4de98ec9e1aff413c7a651757b3c300 --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=5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 10:30:30,509 truncating revision to first 12 chars 2016-10-27 10:30:30,509 Setting DEBUG logging. 2016-10-27 10:30:30,509 attempt 1/10 2016-10-27 10:30:30,509 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ca5956d3e4de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 10:30:31,798 unpacking tar archive at: mozilla-central-ca5956d3e4de/testing/mozharness/ program finished with exit code 0 elapsedTime=1.616026 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 10:30:31.235991) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:31.236323) ========= script_repo_revision: ca5956d3e4de98ec9e1aff413c7a651757b3c300 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:31.236791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:31.237056) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 10:30:31.244764) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-27 10:30:31.245029) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:30:32 INFO - MultiFileLogger online at 20161027 10:30:32 in /builds/slave/test 10:30:32 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 10:30:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:30:32 INFO - {'append_to_log': False, 10:30:32 INFO - 'base_work_dir': '/builds/slave/test', 10:30:32 INFO - 'blob_upload_branch': 'Firefox', 10:30:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:30:32 INFO - 'branch': 'Firefox', 10:30:32 INFO - 'buildbot_json_path': 'buildprops.json', 10:30:32 INFO - 'config_files': ('talos/linux_config.py',), 10:30:32 INFO - 'default_actions': ('clobber', 10:30:32 INFO - 'read-buildbot-config', 10:30:32 INFO - 'download-and-extract', 10:30:32 INFO - 'populate-webroot', 10:30:32 INFO - 'create-virtualenv', 10:30:32 INFO - 'install', 10:30:32 INFO - 'run-tests'), 10:30:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:30:32 INFO - 'download_minidump_stackwalk': True, 10:30:32 INFO - 'download_symbols': 'ondemand', 10:30:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:30:32 INFO - 'tooltool.py': '/tools/tooltool.py', 10:30:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:30:32 INFO - '/tools/misc-python/virtualenv.py')}, 10:30:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:30:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:30:32 INFO - 'installer_path': 'installer.exe', 10:30:32 INFO - 'log_level': 'info', 10:30:32 INFO - 'log_name': 'talos', 10:30:32 INFO - 'log_to_console': True, 10:30:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:30:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:30:32 INFO - 'opt_config_files': (), 10:30:32 INFO - 'pip_index': False, 10:30:32 INFO - 'sps_profile': False, 10:30:32 INFO - 'sps_profile_interval': 0, 10:30:32 INFO - 'suite': 'dromaeojs-e10s', 10:30:32 INFO - 'system_bits': '32', 10:30:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:30:32 INFO - 'title': 'talos-linux64-ix-051', 10:30:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:30:32 INFO - 'use_talos_json': True, 10:30:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:30:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:30:32 INFO - 'work_dir': 'build'} 10:30:32 INFO - [mozharness: 2016-10-27 17:30:32.244494Z] Running clobber step. 10:30:32 INFO - Running pre-action listener: _resource_record_pre_action 10:30:32 INFO - Running main action method: clobber 10:30:32 INFO - rmtree: /builds/slave/test/build 10:30:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:30:33 INFO - Running post-action listener: _resource_record_post_action 10:30:33 INFO - [mozharness: 2016-10-27 17:30:33.213824Z] Finished clobber step (success) 10:30:33 INFO - [mozharness: 2016-10-27 17:30:33.213923Z] Running read-buildbot-config step. 10:30:33 INFO - Running pre-action listener: _resource_record_pre_action 10:30:33 INFO - Running main action method: read_buildbot_config 10:30:33 INFO - Using buildbot properties: 10:30:33 INFO - { 10:30:33 INFO - "project": "", 10:30:33 INFO - "product": "firefox", 10:30:33 INFO - "script_repo_revision": "production", 10:30:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:30:33 INFO - "repository": "", 10:30:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:30:33 INFO - "buildid": "20161027073001", 10:30:33 INFO - "pgo_build": "True", 10:30:33 INFO - "basedir": "/builds/slave/test", 10:30:33 INFO - "buildnumber": 403, 10:30:33 INFO - "slavename": "talos-linux64-ix-051", 10:30:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:30:33 INFO - "platform": "ubuntu64_hw", 10:30:33 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:30:33 INFO - "branch": "mozilla-central", 10:30:33 INFO - "repo_path": "mozilla-central", 10:30:33 INFO - "revision": "ca5956d3e4de98ec9e1aff413c7a651757b3c300", 10:30:33 INFO - "stage_platform": "linux64-pgo", 10:30:33 INFO - "builduid": "2a54c55854794a4c97cbc6b8bb63cfc4", 10:30:33 INFO - "slavebuilddir": "test" 10:30:33 INFO - } 10:30:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:30:33 INFO - Running post-action listener: _resource_record_post_action 10:30:33 INFO - [mozharness: 2016-10-27 17:30:33.216392Z] Finished read-buildbot-config step (success) 10:30:33 INFO - [mozharness: 2016-10-27 17:30:33.216481Z] Running download-and-extract step. 10:30:33 INFO - Running pre-action listener: _resource_record_pre_action 10:30:33 INFO - Running main action method: download_and_extract 10:30:33 INFO - mkdir: /builds/slave/test/build/tests 10:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:33 INFO - trying https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:30:33 INFO - Downloading https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:30:33 INFO - Downloaded 1361 bytes. 10:30:33 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:30:33 INFO - Using the following test package requirements: 10:30:33 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:30:33 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:30:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:30:33 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:30:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:30:33 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:30:33 INFO - u'jsshell-linux-x86_64.zip'], 10:30:33 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:30:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:30:33 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:30:33 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:30:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:30:33 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:30:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:30:33 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:30:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:30:33 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:30:33 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:30:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:30:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:30:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:30:33 INFO - Fetch https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:30:34 INFO - Http code: 200 10:30:34 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 10:30:34 INFO - x-amz-cf-id: yjnAVV_7mSmAJSO938mwTRWVRs3C0sLZ8BvgdsX8Mz081AC9QL5HTg== 10:30:34 INFO - x-amz-version-id: nJEARLc5YusRJKuc_.7fECSBoO69XeBV 10:30:34 INFO - Expected file size: 21992551 10:30:34 INFO - Obtained file size: 21992551 10:30:38 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:30:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:30:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:30:38 INFO - Fetch https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:30:39 INFO - Http code: 200 10:30:39 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 10:30:39 INFO - x-amz-cf-id: Ud2GNiJnlsHCBNhL3AmXTGuvuRcSDNTNckU-whm31WslauNdQHtuOg== 10:30:39 INFO - x-amz-version-id: nJEARLc5YusRJKuc_.7fECSBoO69XeBV 10:30:39 INFO - Expected file size: 21992551 10:30:39 INFO - Obtained file size: 21992551 10:30:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:30:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:30:44 INFO - Fetch https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:30:44 INFO - Http code: 200 10:30:44 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 10:30:44 INFO - x-amz-cf-id: ZbXgDT5CdZFeONa5pkWUte0_1t97uzVr_OENbYhppNA6Cg6QrfKRGA== 10:30:44 INFO - x-amz-version-id: hS_S8sE0UTFHOhcrotX9tYfhXj8dJ0C0 10:30:44 INFO - Expected file size: 14409028 10:30:44 INFO - Obtained file size: 14409028 10:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:45 INFO - trying https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:30:45 INFO - Downloading https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:30:46 INFO - Downloaded 59362896 bytes. 10:30:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:30:46 INFO - mkdir: /builds/slave/test/properties 10:30:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:30:46 INFO - Writing to file /builds/slave/test/properties/build_url 10:30:46 INFO - Contents: 10:30:46 INFO - build_url:https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:30:47 INFO - Running post-action listener: _resource_record_post_action 10:30:47 INFO - Running post-action listener: set_extra_try_arguments 10:30:47 INFO - [mozharness: 2016-10-27 17:30:47.067728Z] Finished download-and-extract step (success) 10:30:47 INFO - [mozharness: 2016-10-27 17:30:47.067955Z] Running populate-webroot step. 10:30:47 INFO - Running pre-action listener: _resource_record_pre_action 10:30:47 INFO - Running main action method: populate_webroot 10:30:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:30:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:30:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:30:47 INFO - '--tppagecycles', 10:30:47 INFO - '7'], 10:30:47 INFO - 'tests': ['tsvgm']}}, 10:30:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:30:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:30:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:30:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:30:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:47 INFO - 'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:30:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:30:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:47 INFO - 'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['damp', 'tps']}, 10:30:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:47 INFO - 'tests': ['damp', 'tps']}, 10:30:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['dromaeo_dom']}, 10:30:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:30:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['basic_compositor_video']}, 10:30:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:30:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['a11yr', 10:30:47 INFO - 'ts_paint', 10:30:47 INFO - 'tpaint', 10:30:47 INFO - 'sessionrestore', 10:30:47 INFO - 'sessionrestore_no_auto_restore', 10:30:47 INFO - 'tabpaint']}, 10:30:47 INFO - 'other-e10s': {'tests': ['a11yr', 10:30:47 INFO - 'ts_paint', 10:30:47 INFO - 'tpaint', 10:30:47 INFO - 'sessionrestore', 10:30:47 INFO - 'sessionrestore_no_auto_restore', 10:30:47 INFO - 'tabpaint']}, 10:30:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:30:47 INFO - 'ts_paint', 10:30:47 INFO - 'tpaint', 10:30:47 INFO - 'sessionrestore', 10:30:47 INFO - 'sessionrestore_no_auto_restore', 10:30:47 INFO - 'tabpaint']}, 10:30:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:30:47 INFO - 'ts_paint', 10:30:47 INFO - 'tpaint', 10:30:47 INFO - 'sessionrestore', 10:30:47 INFO - 'sessionrestore_no_auto_restore', 10:30:47 INFO - 'tabpaint']}, 10:30:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['a11yr', 10:30:47 INFO - 'ts_paint', 10:30:47 INFO - 'tpaint', 10:30:47 INFO - 'sessionrestore', 10:30:47 INFO - 'sessionrestore_no_auto_restore', 10:30:47 INFO - 'tabpaint']}, 10:30:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['a11yr', 10:30:47 INFO - 'ts_paint', 10:30:47 INFO - 'tpaint', 10:30:47 INFO - 'sessionrestore', 10:30:47 INFO - 'sessionrestore_no_auto_restore', 10:30:47 INFO - 'tabpaint']}, 10:30:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['tsvgx', 10:30:47 INFO - 'tsvgr_opacity', 10:30:47 INFO - 'tart', 10:30:47 INFO - 'tscrollx', 10:30:47 INFO - 'cart']}, 10:30:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:30:47 INFO - 'tsvgr_opacity', 10:30:47 INFO - 'tart', 10:30:47 INFO - 'tscrollx', 10:30:47 INFO - 'cart']}, 10:30:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:47 INFO - 'talos_options': ['--disable-e10s'], 10:30:47 INFO - 'tests': ['tp5o']}, 10:30:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:47 INFO - 'tests': ['tp5o']}, 10:30:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:47 INFO - 'talos_options': ['--disable-e10s', 10:30:47 INFO - '--xperf_path', 10:30:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:30:47 INFO - 'tests': ['tp5n']}, 10:30:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:30:47 INFO - 'talos_options': ['--xperf_path', 10:30:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:30:47 INFO - 'tests': ['tp5n']}}, 10:30:47 INFO - 'talos.zip': {'path': '', 10:30:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:30:47 INFO - Running post-action listener: _resource_record_post_action 10:30:47 INFO - [mozharness: 2016-10-27 17:30:47.083279Z] Finished populate-webroot step (success) 10:30:47 INFO - [mozharness: 2016-10-27 17:30:47.083367Z] Running create-virtualenv step. 10:30:47 INFO - Running pre-action listener: _resource_record_pre_action 10:30:47 INFO - Running main action method: create_virtualenv 10:30:47 INFO - Creating virtualenv /builds/slave/test/build/venv 10:30:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:30:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:30:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:30:47 INFO - Using real prefix '/usr' 10:30:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:30:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:30:49 INFO - Installing pip.................done. 10:30:49 INFO - Return code: 0 10:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:30:49 INFO - Reading from file tmpfile_stdout 10:30:49 INFO - Output received: 10:30:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:30:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:49 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 0x7fd038b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1371790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:30:49 INFO - Using env: {'DISPLAY': ':0', 10:30:49 INFO - 'HOME': '/home/cltbld', 10:30:49 INFO - 'LANG': 'en_US.UTF-8', 10:30:49 INFO - 'LANGUAGE': 'en_US:en', 10:30:49 INFO - 'LOGNAME': 'cltbld', 10:30:49 INFO - 'MAIL': '/var/mail/cltbld', 10:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:49 INFO - 'MOZ_NO_REMOTE': '1', 10:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:49 INFO - 'NO_EM_RESTART': '1', 10:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:49 INFO - 'PWD': '/builds/slave/test', 10:30:49 INFO - 'SHELL': '/bin/bash', 10:30:49 INFO - 'SHLVL': '1', 10:30:49 INFO - 'TERM': 'linux', 10:30:49 INFO - 'TMOUT': '86400', 10:30:49 INFO - 'USER': 'cltbld', 10:30:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:49 INFO - '_': '/tools/buildbot/bin/python'} 10:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:30:50 INFO - Cleaning up... 10:30:50 INFO - Return code: 0 10:30:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd038b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1371790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:30:50 INFO - Using env: {'DISPLAY': ':0', 10:30:50 INFO - 'HOME': '/home/cltbld', 10:30:50 INFO - 'LANG': 'en_US.UTF-8', 10:30:50 INFO - 'LANGUAGE': 'en_US:en', 10:30:50 INFO - 'LOGNAME': 'cltbld', 10:30:50 INFO - 'MAIL': '/var/mail/cltbld', 10:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:50 INFO - 'MOZ_NO_REMOTE': '1', 10:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:50 INFO - 'NO_EM_RESTART': '1', 10:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:50 INFO - 'PWD': '/builds/slave/test', 10:30:50 INFO - 'SHELL': '/bin/bash', 10:30:50 INFO - 'SHLVL': '1', 10:30:50 INFO - 'TERM': 'linux', 10:30:50 INFO - 'TMOUT': '86400', 10:30:50 INFO - 'USER': 'cltbld', 10:30:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:50 INFO - '_': '/tools/buildbot/bin/python'} 10:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:50 INFO - Downloading/unpacking psutil>=3.1.1 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:30:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:30:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:30:52 INFO - Installing collected packages: psutil 10:30:52 INFO - Running setup.py install for psutil 10:30:52 INFO - building 'psutil._psutil_linux' extension 10:30:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:30:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:30:52 INFO - building 'psutil._psutil_posix' extension 10:30:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:30:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:30:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:30:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:30:52 INFO - Successfully installed psutil 10:30:52 INFO - Cleaning up... 10:30:52 INFO - Return code: 0 10:30:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:52 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 0x7fd038b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1371790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:30:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:30:52 INFO - Using env: {'DISPLAY': ':0', 10:30:52 INFO - 'HOME': '/home/cltbld', 10:30:52 INFO - 'LANG': 'en_US.UTF-8', 10:30:52 INFO - 'LANGUAGE': 'en_US:en', 10:30:52 INFO - 'LOGNAME': 'cltbld', 10:30:52 INFO - 'MAIL': '/var/mail/cltbld', 10:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:52 INFO - 'MOZ_NO_REMOTE': '1', 10:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:52 INFO - 'NO_EM_RESTART': '1', 10:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:52 INFO - 'PWD': '/builds/slave/test', 10:30:52 INFO - 'SHELL': '/bin/bash', 10:30:52 INFO - 'SHLVL': '1', 10:30:52 INFO - 'TERM': 'linux', 10:30:52 INFO - 'TMOUT': '86400', 10:30:52 INFO - 'USER': 'cltbld', 10:30:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:52 INFO - '_': '/tools/buildbot/bin/python'} 10:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:30:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:30:55 INFO - Installing collected packages: mozsystemmonitor 10:30:55 INFO - Running setup.py install for mozsystemmonitor 10:30:55 INFO - Successfully installed mozsystemmonitor 10:30:55 INFO - Cleaning up... 10:30:55 INFO - Return code: 0 10:30:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:55 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 0x7fd038b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1371790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:30:55 INFO - Using env: {'DISPLAY': ':0', 10:30:55 INFO - 'HOME': '/home/cltbld', 10:30:55 INFO - 'LANG': 'en_US.UTF-8', 10:30:55 INFO - 'LANGUAGE': 'en_US:en', 10:30:55 INFO - 'LOGNAME': 'cltbld', 10:30:55 INFO - 'MAIL': '/var/mail/cltbld', 10:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:55 INFO - 'MOZ_NO_REMOTE': '1', 10:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:55 INFO - 'NO_EM_RESTART': '1', 10:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:55 INFO - 'PWD': '/builds/slave/test', 10:30:55 INFO - 'SHELL': '/bin/bash', 10:30:55 INFO - 'SHLVL': '1', 10:30:55 INFO - 'TERM': 'linux', 10:30:55 INFO - 'TMOUT': '86400', 10:30:55 INFO - 'USER': 'cltbld', 10:30:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:55 INFO - '_': '/tools/buildbot/bin/python'} 10:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:55 INFO - Downloading/unpacking jsonschema==2.5.1 10:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:30:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:57 INFO - Downloading functools32-3.2.3-2.tar.gz 10:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:30:57 INFO - warning: no files found matching '*.txt' 10:30:57 INFO - no previously-included directories found matching 'build' 10:30:57 INFO - no previously-included directories found matching 'dist' 10:30:57 INFO - no previously-included directories found matching '.git*' 10:30:57 INFO - Installing collected packages: jsonschema, functools32 10:30:57 INFO - Running setup.py install for functools32 10:30:57 INFO - warning: no files found matching '*.txt' 10:30:57 INFO - no previously-included directories found matching 'build' 10:30:57 INFO - no previously-included directories found matching 'dist' 10:30:57 INFO - no previously-included directories found matching '.git*' 10:30:57 INFO - Successfully installed jsonschema functools32 10:30:57 INFO - Cleaning up... 10:30:57 INFO - Return code: 0 10:30:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:57 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 0x7fd038b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1371790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:30:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:30:57 INFO - Using env: {'DISPLAY': ':0', 10:30:57 INFO - 'HOME': '/home/cltbld', 10:30:57 INFO - 'LANG': 'en_US.UTF-8', 10:30:57 INFO - 'LANGUAGE': 'en_US:en', 10:30:57 INFO - 'LOGNAME': 'cltbld', 10:30:57 INFO - 'MAIL': '/var/mail/cltbld', 10:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:57 INFO - 'MOZ_NO_REMOTE': '1', 10:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:57 INFO - 'NO_EM_RESTART': '1', 10:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:57 INFO - 'PWD': '/builds/slave/test', 10:30:57 INFO - 'SHELL': '/bin/bash', 10:30:57 INFO - 'SHLVL': '1', 10:30:57 INFO - 'TERM': 'linux', 10:30:57 INFO - 'TMOUT': '86400', 10:30:57 INFO - 'USER': 'cltbld', 10:30:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:57 INFO - '_': '/tools/buildbot/bin/python'} 10:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:30:58 INFO - Cleaning up... 10:30:58 INFO - Return code: 0 10:30:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:30:58 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 0x7fd038b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1371790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:30:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:30:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:30:58 INFO - Using env: {'DISPLAY': ':0', 10:30:58 INFO - 'HOME': '/home/cltbld', 10:30:58 INFO - 'LANG': 'en_US.UTF-8', 10:30:58 INFO - 'LANGUAGE': 'en_US:en', 10:30:58 INFO - 'LOGNAME': 'cltbld', 10:30:58 INFO - 'MAIL': '/var/mail/cltbld', 10:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:58 INFO - 'MOZ_NO_REMOTE': '1', 10:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:58 INFO - 'NO_EM_RESTART': '1', 10:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:58 INFO - 'PWD': '/builds/slave/test', 10:30:58 INFO - 'SHELL': '/bin/bash', 10:30:58 INFO - 'SHLVL': '1', 10:30:58 INFO - 'TERM': 'linux', 10:30:58 INFO - 'TMOUT': '86400', 10:30:58 INFO - 'USER': 'cltbld', 10:30:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:58 INFO - '_': '/tools/buildbot/bin/python'} 10:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:30:58 INFO - Downloading/unpacking blobuploader==1.2.4 10:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:30:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:30:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:00 INFO - Downloading blobuploader-1.2.4.tar.gz 10:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:31:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:31:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:00 INFO - Downloading docopt-0.6.1.tar.gz 10:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:31:00 INFO - Installing collected packages: blobuploader, requests, docopt 10:31:00 INFO - Running setup.py install for blobuploader 10:31:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:31:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:31:01 INFO - Running setup.py install for requests 10:31:01 INFO - Running setup.py install for docopt 10:31:01 INFO - Successfully installed blobuploader requests docopt 10:31:01 INFO - Cleaning up... 10:31:01 INFO - Return code: 0 10:31:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:01 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 0x7fd038b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1371790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:31:01 INFO - Using env: {'DISPLAY': ':0', 10:31:01 INFO - 'HOME': '/home/cltbld', 10:31:01 INFO - 'LANG': 'en_US.UTF-8', 10:31:01 INFO - 'LANGUAGE': 'en_US:en', 10:31:01 INFO - 'LOGNAME': 'cltbld', 10:31:01 INFO - 'MAIL': '/var/mail/cltbld', 10:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:01 INFO - 'MOZ_NO_REMOTE': '1', 10:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:01 INFO - 'NO_EM_RESTART': '1', 10:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:01 INFO - 'PWD': '/builds/slave/test', 10:31:01 INFO - 'SHELL': '/bin/bash', 10:31:01 INFO - 'SHLVL': '1', 10:31:01 INFO - 'TERM': 'linux', 10:31:01 INFO - 'TMOUT': '86400', 10:31:01 INFO - 'USER': 'cltbld', 10:31:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:01 INFO - '_': '/tools/buildbot/bin/python'} 10:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:01 INFO - Running setup.py (path:/tmp/pip-H3knYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:01 INFO - Running setup.py (path:/tmp/pip-b76M5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:01 INFO - Running setup.py (path:/tmp/pip-pG4G4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:02 INFO - Running setup.py (path:/tmp/pip-zCdjuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:02 INFO - Running setup.py (path:/tmp/pip-pl8kim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:02 INFO - Running setup.py (path:/tmp/pip-2lA8zG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:02 INFO - Running setup.py (path:/tmp/pip-oj6RqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:02 INFO - Running setup.py (path:/tmp/pip-ILYUug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:02 INFO - Running setup.py (path:/tmp/pip-sriPmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:02 INFO - Running setup.py (path:/tmp/pip-UG3Dkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:02 INFO - Running setup.py (path:/tmp/pip-kJ2FFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:02 INFO - Running setup.py (path:/tmp/pip-Dsfhd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:02 INFO - Running setup.py (path:/tmp/pip-OBWpdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:02 INFO - Running setup.py (path:/tmp/pip-yNhxLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:02 INFO - Running setup.py (path:/tmp/pip-m3Zwgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:02 INFO - Running setup.py (path:/tmp/pip-vGmxn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:02 INFO - Running setup.py (path:/tmp/pip-t5Upso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:31:03 INFO - Running setup.py install for manifestparser 10:31:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Running setup.py install for mozcrash 10:31:03 INFO - Running setup.py install for mozdebug 10:31:03 INFO - Running setup.py install for mozdevice 10:31:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Running setup.py install for mozfile 10:31:03 INFO - Running setup.py install for mozhttpd 10:31:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Running setup.py install for mozinfo 10:31:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Running setup.py install for mozInstall 10:31:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:31:03 INFO - Running setup.py install for mozleak 10:31:04 INFO - Running setup.py install for mozlog 10:31:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:31:04 INFO - Running setup.py install for moznetwork 10:31:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:31:04 INFO - Running setup.py install for mozprocess 10:31:04 INFO - Running setup.py install for mozprofile 10:31:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:31:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:31:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:31:04 INFO - Running setup.py install for mozrunner 10:31:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:31:04 INFO - Running setup.py install for mozscreenshot 10:31:04 INFO - Running setup.py install for moztest 10:31:04 INFO - Running setup.py install for mozversion 10:31:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:31:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:31:04 INFO - Cleaning up... 10:31:04 INFO - Return code: 0 10:31:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:04 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 0x7fd038b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1371790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:31:04 INFO - Using env: {'DISPLAY': ':0', 10:31:04 INFO - 'HOME': '/home/cltbld', 10:31:04 INFO - 'LANG': 'en_US.UTF-8', 10:31:04 INFO - 'LANGUAGE': 'en_US:en', 10:31:04 INFO - 'LOGNAME': 'cltbld', 10:31:04 INFO - 'MAIL': '/var/mail/cltbld', 10:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:04 INFO - 'MOZ_NO_REMOTE': '1', 10:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:04 INFO - 'NO_EM_RESTART': '1', 10:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:04 INFO - 'PWD': '/builds/slave/test', 10:31:04 INFO - 'SHELL': '/bin/bash', 10:31:04 INFO - 'SHLVL': '1', 10:31:04 INFO - 'TERM': 'linux', 10:31:04 INFO - 'TMOUT': '86400', 10:31:04 INFO - 'USER': 'cltbld', 10:31:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:04 INFO - '_': '/tools/buildbot/bin/python'} 10:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:05 INFO - Running setup.py (path:/tmp/pip-9iqcY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:05 INFO - Running setup.py (path:/tmp/pip-JXie8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:05 INFO - Running setup.py (path:/tmp/pip-LGexUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:05 INFO - Running setup.py (path:/tmp/pip-UT6X3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:05 INFO - Running setup.py (path:/tmp/pip-7Hj2OU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:05 INFO - Running setup.py (path:/tmp/pip-pkqiAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:05 INFO - Running setup.py (path:/tmp/pip-Fq3733-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:05 INFO - Running setup.py (path:/tmp/pip-HPiPt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:05 INFO - Running setup.py (path:/tmp/pip-_frKtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:05 INFO - Running setup.py (path:/tmp/pip-aSnIMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:05 INFO - Running setup.py (path:/tmp/pip-wHUbdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:05 INFO - Running setup.py (path:/tmp/pip-2TPxxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:06 INFO - Running setup.py (path:/tmp/pip-jMZPLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:06 INFO - Running setup.py (path:/tmp/pip-9gmAyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:06 INFO - Running setup.py (path:/tmp/pip-HTys5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:06 INFO - Running setup.py (path:/tmp/pip-phpWOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:06 INFO - Running setup.py (path:/tmp/pip-hlQlrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:31:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:08 INFO - Downloading blessings-1.6.tar.gz 10:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:31:08 INFO - Installing collected packages: blessings 10:31:08 INFO - Running setup.py install for blessings 10:31:08 INFO - Successfully installed blessings 10:31:08 INFO - Cleaning up... 10:31:08 INFO - Return code: 0 10:31:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:08 INFO - Reading from file tmpfile_stdout 10:31:08 INFO - Current package versions: 10:31:08 INFO - argparse == 1.2.1 10:31:08 INFO - blessings == 1.6 10:31:08 INFO - blobuploader == 1.2.4 10:31:08 INFO - docopt == 0.6.1 10:31:08 INFO - functools32 == 3.2.3-2 10:31:08 INFO - jsonschema == 2.5.1 10:31:08 INFO - manifestparser == 1.1 10:31:08 INFO - mozInstall == 1.12 10:31:08 INFO - mozcrash == 0.17 10:31:08 INFO - mozdebug == 0.1 10:31:08 INFO - mozdevice == 0.48 10:31:08 INFO - mozfile == 1.2 10:31:08 INFO - mozhttpd == 0.7 10:31:08 INFO - mozinfo == 0.9 10:31:08 INFO - mozleak == 0.1 10:31:08 INFO - mozlog == 3.4 10:31:08 INFO - moznetwork == 0.27 10:31:08 INFO - mozprocess == 0.23 10:31:08 INFO - mozprofile == 0.28 10:31:08 INFO - mozrunner == 6.12 10:31:08 INFO - mozscreenshot == 0.1 10:31:08 INFO - mozsystemmonitor == 0.3 10:31:08 INFO - moztest == 0.7 10:31:08 INFO - mozversion == 1.4 10:31:08 INFO - psutil == 3.1.1 10:31:08 INFO - requests == 1.2.3 10:31:08 INFO - wsgiref == 0.1.2 10:31:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:08 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 0x7fd038b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1371790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:31:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:31:08 INFO - Using env: {'DISPLAY': ':0', 10:31:08 INFO - 'HOME': '/home/cltbld', 10:31:08 INFO - 'LANG': 'en_US.UTF-8', 10:31:08 INFO - 'LANGUAGE': 'en_US:en', 10:31:08 INFO - 'LOGNAME': 'cltbld', 10:31:08 INFO - 'MAIL': '/var/mail/cltbld', 10:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:08 INFO - 'MOZ_NO_REMOTE': '1', 10:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:08 INFO - 'NO_EM_RESTART': '1', 10:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:08 INFO - 'PWD': '/builds/slave/test', 10:31:08 INFO - 'SHELL': '/bin/bash', 10:31:08 INFO - 'SHLVL': '1', 10:31:08 INFO - 'TERM': 'linux', 10:31:08 INFO - 'TMOUT': '86400', 10:31:08 INFO - 'USER': 'cltbld', 10:31:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:08 INFO - '_': '/tools/buildbot/bin/python'} 10:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:31:09 INFO - Cleaning up... 10:31:09 INFO - Return code: 0 10:31:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:09 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 0x7fd038b34f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1371790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:31:09 INFO - Using env: {'DISPLAY': ':0', 10:31:09 INFO - 'HOME': '/home/cltbld', 10:31:09 INFO - 'LANG': 'en_US.UTF-8', 10:31:09 INFO - 'LANGUAGE': 'en_US:en', 10:31:09 INFO - 'LOGNAME': 'cltbld', 10:31:09 INFO - 'MAIL': '/var/mail/cltbld', 10:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:09 INFO - 'MOZ_NO_REMOTE': '1', 10:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:09 INFO - 'NO_EM_RESTART': '1', 10:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:09 INFO - 'PWD': '/builds/slave/test', 10:31:09 INFO - 'SHELL': '/bin/bash', 10:31:09 INFO - 'SHLVL': '1', 10:31:09 INFO - 'TERM': 'linux', 10:31:09 INFO - 'TMOUT': '86400', 10:31:09 INFO - 'USER': 'cltbld', 10:31:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:09 INFO - '_': '/tools/buildbot/bin/python'} 10:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:31:09 INFO - Cleaning up... 10:31:09 INFO - Return code: 0 10:31:09 INFO - Running post-action listener: _resource_record_post_action 10:31:09 INFO - Running post-action listener: _start_resource_monitoring 10:31:09 INFO - Starting resource monitoring. 10:31:09 INFO - [mozharness: 2016-10-27 17:31:09.276217Z] Finished create-virtualenv step (success) 10:31:09 INFO - [mozharness: 2016-10-27 17:31:09.276680Z] Running install step. 10:31:09 INFO - Running pre-action listener: _resource_record_pre_action 10:31:09 INFO - Running main action method: install 10:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:09 INFO - Reading from file tmpfile_stdout 10:31:09 INFO - Detecting whether we're running mozinstall >=1.0... 10:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:31:09 INFO - Reading from file tmpfile_stdout 10:31:09 INFO - Output received: 10:31:09 INFO - Usage: mozinstall [options] installer 10:31:09 INFO - Options: 10:31:09 INFO - -h, --help show this help message and exit 10:31:09 INFO - -d DEST, --destination=DEST 10:31:09 INFO - Directory to install application into. [default: 10:31:09 INFO - "/builds/slave/test"] 10:31:09 INFO - --app=APP Application being installed. [default: firefox] 10:31:09 INFO - mkdir: /builds/slave/test/build/application 10:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:31:26 INFO - Reading from file tmpfile_stdout 10:31:26 INFO - Output received: 10:31:26 INFO - /builds/slave/test/build/application/firefox/firefox 10:31:26 INFO - Running post-action listener: _resource_record_post_action 10:31:26 INFO - [mozharness: 2016-10-27 17:31:26.604791Z] Finished install step (success) 10:31:26 INFO - [mozharness: 2016-10-27 17:31:26.605036Z] Running run-tests step. 10:31:26 INFO - Running pre-action listener: _resource_record_pre_action 10:31:26 INFO - Running main action method: run_tests 10:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:31:26 INFO - Python 2.7.3 10:31:26 INFO - Return code: 0 10:31:26 INFO - grabbing minidump binary from tooltool 10:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:26 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 0x136e930>, '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 0x136f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x136fcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:31:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:31:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:31:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:31:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:31:26 INFO - Return code: 0 10:31:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:31:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:31:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:31:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:31:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:31:26 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/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 10:31:26 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/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 10:31:26 INFO - Using env: {'DISPLAY': ':0', 10:31:26 INFO - 'HOME': '/home/cltbld', 10:31:26 INFO - 'LANG': 'en_US.UTF-8', 10:31:26 INFO - 'LANGUAGE': 'en_US:en', 10:31:26 INFO - 'LOGNAME': 'cltbld', 10:31:26 INFO - 'MAIL': '/var/mail/cltbld', 10:31:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:31:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:26 INFO - 'MOZ_NO_REMOTE': '1', 10:31:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:31:26 INFO - 'NO_EM_RESTART': '1', 10:31:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:26 INFO - 'PWD': '/builds/slave/test', 10:31:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:31:26 INFO - 'SHELL': '/bin/bash', 10:31:26 INFO - 'SHLVL': '1', 10:31:26 INFO - 'TERM': 'linux', 10:31:26 INFO - 'TMOUT': '86400', 10:31:26 INFO - 'USER': 'cltbld', 10:31:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504', 10:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:26 INFO - '_': '/tools/buildbot/bin/python'} 10:31:26 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/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 10:31:26 INFO - mozversion application_buildid: 20161027073001 10:31:26 INFO - mozversion application_changeset: ca5956d3e4de98ec9e1aff413c7a651757b3c300 10:31:26 INFO - mozversion application_display_name: Nightly 10:31:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:31:26 INFO - mozversion application_name: Firefox 10:31:26 INFO - mozversion application_remotingname: firefox 10:31:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:31:26 INFO - mozversion application_vendor: Mozilla 10:31:26 INFO - mozversion application_version: 52.0a1 10:31:26 INFO - mozversion platform_buildid: 20161027073001 10:31:26 INFO - mozversion platform_changeset: ca5956d3e4de98ec9e1aff413c7a651757b3c300 10:31:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:31:26 INFO - mozversion platform_version: 52.0a1 10:31:26 INFO - using testdate: 1477589486 10:31:26 INFO - actual date: 1477589486 10:31:26 INFO - starting webserver on 'localhost:53792' 10:31:26 INFO - SUITE-START | Running 2 tests 10:31:26 INFO - TEST-START | dromaeo_css 10:31:26 INFO - operating with platform_type : linux_ 10:31:26 INFO - Initialising browser for dromaeo_css test... 10:31:26 INFO - TEST-INFO | started process 12864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk2WWFx/profile http://localhost:53792/getInfo.html) 10:31:31 INFO - PROCESS | 12864 | __metrics Screen width/height:1600/1200 10:31:31 INFO - PROCESS | 12864 | colorDepth:24 10:31:31 INFO - PROCESS | 12864 | Browser inner width/height: 1024/697 10:31:31 INFO - PROCESS | 12864 | __metrics 10:31:31 ERROR - PROCESS | 12864 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 10:31:32 INFO - TEST-INFO | 12864: exit 0 10:31:32 INFO - Browser initialized. 10:31:32 INFO - Running cycle 1/1 for dromaeo_css test... 10:31:32 INFO - TEST-INFO | started process 12990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk2WWFx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:44 INFO - PROCESS | 12990 | RSS: Main: 183001088 10:31:44 INFO - PROCESS | 12990 | 10:32:34 INFO - PROCESS | 12990 | 1477589554373 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:34:45 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:53792/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53792/tests/dromaeo/cssquery-ext.html) 10:34:46 INFO - PROCESS | 12990 | RSS: Main: 197091328 10:34:46 INFO - PROCESS | 12990 | 10:37:48 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:53792/tests/dromaeo/cssquery-ext.html (next: http://localhost:53792/tests/dromaeo/cssquery-jquery.html) 10:37:49 INFO - PROCESS | 12990 | RSS: Main: 194531328 10:37:49 INFO - PROCESS | 12990 | 10:40:51 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:53792/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53792/tests/dromaeo/cssquery-mootools.html) 10:40:52 INFO - PROCESS | 12990 | RSS: Main: 196968448 10:40:52 INFO - PROCESS | 12990 | 10:43:54 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:53792/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53792/tests/dromaeo/cssquery-prototype.html) 10:43:54 INFO - PROCESS | 12990 | RSS: Main: 193404928 10:43:54 INFO - PROCESS | 12990 | 10:46:57 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:53792/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53792/tests/dromaeo/cssquery-yui.html) 10:46:57 INFO - PROCESS | 12990 | RSS: Main: 197111808 10:46:57 INFO - PROCESS | 12990 | 10:50:00 INFO - PROCESS | 12990 | Cycle 1(1): loaded http://localhost:53792/tests/dromaeo/cssquery-yui.html (next: http://localhost:53792/tests/dromaeo/cssquery-dojo.html) 10:50:00 INFO - PROCESS | 12990 | RSS: Main: 196784128 10:50:00 INFO - PROCESS | 12990 | 10:50:00 INFO - PROCESS | 12990 | __start_tp_report 10:50:00 INFO - PROCESS | 12990 | _x_x_mozilla_page_load 10:50:00 INFO - PROCESS | 12990 | _x_x_mozilla_page_load_details 10:50:00 INFO - PROCESS | 12990 | |i|pagename|runs| 10:50:00 INFO - PROCESS | 12990 | |0;dojo.html;3087.7066678665524;3094;3101.6743241959593;3118.251619611291;3141.670124636913;5280.9207861882105;5419.539339156171;5449.673019618821;5470.288862447881;5500.326391899509;5372.113601255788;5372.140457526796;5442.210879422481;5522.751476183571;5538.9169162462495;4841.588464980481;4871.878203044926;4955.281484184791;4986.276989836471;5009.899802003958;4961.751912404366;5029.798808047692;5068.239764035387;5086.898262034757;5107.974460127694;4786.904261914742;4820.276958456225;5025.899482010376;5073.441921388644;5081.491850814926;4839.685420447659;4903.362562866804;4904.337914381548;4938.827141050082;4955.653104282702;4821.493743156953;4842.322074909515;4853.830115945925;4877.34155888954;4930.531599498042;5326.174442961347;5381.892362152735;5409.5672346212605;5411.404745477994;5422.267993820823;5665.603407761459;5751.884962300773;5768.711564421762;5787.33445653751;5863.2670916135485;5828.1549175369755;5838.678872662002;5840.269966254218;5842.269716285465;5845;5416.891662166813;5417.59368047398;5425.348958124971;5437.592180586472;5450.672959622435;5856.443637854397;5912.3496415394275;5929.407059294036;5938.435848594377;5959.344472108065;5657.094864821609;5722.484976352065;5728.112142617901;5728.341240757283;5778.16216648592;5774.191613174159;5813.157092221689;5830;5830.067189249699;5833.270841144857;5631.267935168484;5669.943300566942;5739.885202295931;5759.510441612426;5760.481556659921;5806.129080637938;5808.79669211584;5818.709064546756;5844.912326315109;5854.531637468992;4361.06237159006;4368;4413.404190434315;4440.933385999213;4460.1525710114975;3881.107345310594;3899.66852817508;3933.527976642821;3978.840846366171;4010.318245898204;5525.889482210333;5548.750306236229;5568.9721551392795;5605.187247849039;5626.943730562723;5825.941740582624;5866.73599688015;5881.3530511643685;5891.057430811135;5897.911531327033;5323.893522129536;5341.81303654378;5514.448555144453;5557.638753481092;5564.304461942257;5058.570021548209;5085.3134826797905;5093.032323858455;5138.922916156261;5142.665726727751;6000.849978750566;6015.3383127855905;6019.969900150471;6032.788852390146;6033.728482218398;5634.070378387521;5636.210930469655;5873;5885.588008839341;5899.321578018583;5917.763289468373;5952.732127054206;5981.461668449686;5988.910166347421;6069.696515174312;5695.202671626059;5731.426857314235;5744.712764361681;5745.9425405745405;5761.56788240892;5697.401772813795;5760.1359796029255;5806.883862322815;5813.476787089182;5821.155932389865;5600.551955843604;5609.607327487037;5669.518090962314;5703.230063941315;5784.016717158009;5663.433656634304;5678.574106942078;5679.77280908759;5685.090385538294;5697.857553561194;5473.370562385217;5534.640248383842;5623.803166889139;5668.773249069991;5696.971515142398;5584.916226256691;5624.381318055092;5659.886802263849;5677.77288908439;5748.367679555162;5491.615586908878;5542.168674698827;5543.445655434424;5548.195511650869;5550.417206193291 10:50:00 INFO - PROCESS | 12990 | |1;ext.html;574.1416582209596;598.4643743849255;608.7139044649014;626.7399029402798;628.9559331509695;37079;40870;40932;40986;41043.79478102605;41574.37638435426;42232.15535689292;42232.78883605578;42240.788796056055;42277;8665.61350183969;8820.33847461443;8833.779155521099;8839.602217900177;8855.380123391333;8707.608157632922;8812.074732153127;8818.603162857655;8821.691240806573;8824.294056475499;8827.867581986275;8838.248748856355;8884.378093533454;8897.555122243863;8963.462192268453;8749.212570868653;8799.076097009818;8800.679898015285;8809.735707928772;8880.955595222014;8648.697295594688;8658.220760131555;8678.86981695275;8726.171013753683;8740.956295218546;33340.83329583361;33526.1618459538;33588.49617255743;33631.15922101967;33761.32477350439;3368.511565822942;3586.4799604057525;3680.0615842959874;3845.5000849889334;3989.8204580793936;31061.689383106106;31478.685213148034;31625.20936976571;31625.8418707905;31633.84183079093;4212.515560710527;4264.808083636244;4306.935395969063;4313.870583882489;4386.429764130675;255553;258882;328647;328796;329767.9999999976;61622.69188654028;61860.38139618546;62095.68952155301;62191;62622;65698.34301657017;66438.00342994859;66632;66814.33185668178;66839;16159.515214543582;16323;16349.100799456144;16403.42588009414;16413.67172656564;12172.14794964344;12188.451519681636;12308.692282693004;12316.137870349168;12327.815082773766;18625.541125540967;19851.106700198525;19882.707624004393;19953;20032;7173.175084865203;7543.396528277724;7619.238076192337;7706.499077559941;7866.960665196638;862.185234952976;921.995390023059;1031.6234574380446;1077.5851297250615;1086.4567716141928;31836.824410396966;32157.51763723546;32361.35277294441;32554.83722581372;32903.67096329054;1059.9629012984508;1080.400377790334;1082.8917108289108;1116.5198964445367;1135.7217481717032;16413.343466261216;17120.229589668244;17158.742618860728;17181.65636687284;17422.390216342366;485096;490280;491992;492818;494548;56250.43749562534;56454;56556.43443565594;56704.71647641818;56894.14658780122;1313.1530163044783;1316.493150137204;1337.9264140472173;1342.7515909556764;1358.4498278197345;30558.388832223674;32442;33049;33562.83218583989;33960.490592640635;48414.51585484241;49724.254136187265;49753.751231243616;49792.25311620256;49804;397997;401774;402132;402335;403216;27097.864510677322;27704.445911082068;27813.582796257666;27937.44125117527;28077.859610701817;47018.29472557983;47081.52918470772;47936.5206347932;48178.27732584084;48629.75685121552;38984.41523377208;39022;39789.60210397859;40879.795601021804;41986;38977.41533876937;40119.799401002805;40453.63709032821;40461.79769101136;40534.797326013184;39697.603023969394;40559.78320650385;40640;40795.796021019705;44029.55970440255;32815.835920820246;36447.27105457929;36608;37099.25801484009;37536.436953445176;27750.44499110047;28258.434831302846;28450.57324140098;28623.284417889718;28844.42311153807 10:50:00 INFO - PROCESS | 12990 | |2;jquery.html;370.91283548366147;384.4982298100978;384.8670284416735;392.87428023032635;417.4864916153132;14306.14163150209;17681.823181768177;18076.4577062688;19021.524461888443;19074.42776716699;18073.7288940666;18432.95428451622;18711.438656840284;18947;19142;5646.745896434671;5704.914426283609;5840;5840.561957853157;5885.293764748236;5807.506361959238;5909.822705318826;5911;5911.290645122592;5920.88158236835;5576.1356989666665;5725.4847063764255;5738.31140263169;5744.6840423776675;5747.109198074284;5589.580781441367;5736.942630573703;5762.654240745548;5773.740181691834;5790.942090579082;5083.491650834924;5122.5133612307145;5143.639945203838;5146.433892271847;5146.639735218536;22074.779252207434;22545;22816;22837.77162228373;22918.427039323982;2183.661532462471;2343.1447521654645;2493.7007559093026;2588.5987671910884;2671.839689618629;10244.795104097951;10395;10431.843522347172;10654.200934929833;10786.946065269623;1876.9155388007573;1964.99017504913;1975.654260504406;1983.1274239334646;1987.1554589299635;70535;76942.6152869232;78903.60548197222;80785.19214807835;81352.59323703403;10649.254552181428;10832.404217768099;11029.889701103048;11110.555577776799;11200.54392928914;12076.275423474444;14547.3453694584;15261.694766104616;15313.693726125637;15384.769228461582;7268.127824660969;7275.381592564586;7561.621918904033;7596;7710.7686769397005;7114.359707626339;7286.781396558112;7374.889376659355;7414.295641914009;7583.355414789694;3725.161838586296;3893.8637147699696;4013.8394464221687;4066.2477441672795;4125.154343359664;1934.7484826972404;1973.615145046702;2017.767956685;2036.8166864982222;2037.8267847232855;928.9814203716023;950.9001554836781;975.7902051059057;996.9152622027063;1034.891336409666;19506.219751210076;19592;19760.308389206308;19928.20287188496;20056;949.8575213717997;976.414151509103;986.2356673577891;989.0603926270072;1021.269792098653;10465.37207767521;10495.580176792995;10936.507857146447;11079.72300692473;11083.334999899871;469991;471722;474196;485011;492652.3673816295;89944;90781.09218907858;91290;92253;92397;1026.7022563456514;1106.7509810292781;1136.7953768321781;1138.0269869261826;1141.19545720267;17732.468025959242;17769.55576110556;18508.722369164203;18525.90737046306;18814.341498047503;37923;39857.60142398539;40090.599094008685;40158.59841401548;40888;55484.72257638686;57949.420505796086;58795.70602146962;60182.69908650429;61090.69454652698;7170.175429825428;7487.363574096045;8274.710385136492;8374.413791034569;8558.186972237627;12107.636770896886;12849.614511564669;12886;12940.482380704667;13286.402111904794;11013.852298801658;11506.252093613888;11615.709607259887;11692.590759323382;11835.52657893709;11151.553937842395;11283.605073822377;11359.375234362189;11879.346635935106;12034.63896083119;11387.316760994367;11669.76660466769;11706;11894.464749086139;12430.937845310715;7343.669534871051;7570.772876813704;7604.581748003913;7699.615019249127;7722.420818438752;10806.335780402196;11151.10791136691;11563.190576659554;11657.88342116568;12033.699157521132 10:50:00 INFO - PROCESS | 12990 | |3;mootools.html;1472.5287907869483;1503.1281856523215;1674.3888480704538;1770.238797317153;1802.5043113143884;7642.121156067054;8031.9598402007905;8527.616257268422;9106.863397049041;9186.26509879209;8488.53313067781;8844.513551754651;8848.823023539526;9045.005049444573;9077.319201059914;2333.4516388648653;2349.6710460535455;2357.3752955466816;2360.1739391213023;2362;2298.977010229901;2340.426595484109;2353.0470159585393;2353.964690529635;2373.667686523888;2264.7657026920288;2315.2822624986225;2320.3155069254526;2322.3149170994598;2341.086976079322;2261.457250259926;2270.7048083749173;2281.4752606900424;2292.266474728088;2324.2097686786574;2264.4112530742127;2279.2592407467473;2280.623697089978;2294.850834695756;2310.607196776552;8811;8922.86615700765;8927.642894284221;9016;9079.636814527412;5195.116830138885;5296.735163241822;5341.706206158659;5351.518363347279;5354.170103633904;3139.827309497977;3155.2900597365638;3378.1554611347165;3390.593128824557;3394.7963122212745;1035.4770840725384;1045.9406236757454;1055.9915280906716;1067.7917806027829;1068.5458680060942;12559.686007849785;12582.43379047945;12660.873391266061;12697.365131743469;12699.238045717195;4470.798814053375;4577.29051996941;4647.18674232008;4689.718616882929;4715.528447155326;10517.737056573647;10526;10552.419616921143;10564.366138031743;10620.575176992988;5317.335333083364;5340.626156169109;5347.983883062206;5356.812511562077;5363.061464243741;4829.203181475017;4897.045076210176;4933.925991110136;5024.120778863684;5055.368078990126;3486.91282717929;3541.309444658267;3724.0875985383755;3821.063839359319;3909.2181563687377;1009.5911155981839;1028.5165971993151;1030.7629245273629;1036.9170466362673;1054.6797046497736;822.3626689315709;839.8068444257855;898.6540182029835;904.8009437923646;965.4689920543673;5666.744996475169;5720.342160651495;5728.77084916607;6212.502999760099;6227.346128656516;882.2104216726123;884.920357167858;903.2367649336301;919.4713040002025;960.1790469148777;3882.825272862728;4051.716379853441;4155.16896620671;4197.580241975778;4255.170241802881;10996;11407;11436.370999595103;11441.656750297505;11450.484728187252;10991.120710343153;11231.719207019727;11236.775264494665;11271.09831213501;11283.605073822377;7978.720744773905;8289.626966786509;8326.084130745614;8360.247577718035;8413.915860841313;5805.187273781589;5989.221401217988;5996.820095397145;6039.396060394101;6047.425494578184;9946.204303655835;10042.397456152654;10043.397396156253;10176.084152426318;10247.897521024694;9930.106290433896;10032.799344012932;10052.94973525157;10112.696619101438;10221.74445638865;6631;6833.145856767904;7375.299346562068;7779.338756205786;7939.047314322087;8321.83356332882;8722.171393717586;8724.214820666171;8729.083446238054;8733.868991964999;7686.500377475446;7945.920540794518;7955.443118981616;8037.156098609562;8156.225158609923;7582.128055273714;7600.2779735925;7750.651220694969;7773.961130194313;7913.841723165619;6831.0436538883605;6881.174259088942;6924.861502770017;6969.198542167513;7048.612326322102;5171.120909445479;5294.179402192666;5300.946990530046;5382.542483888913;5510.669359838423;5160.612954028538;5263;5267.762950667153;5279.9472005280995;5358.303420555303 10:50:00 INFO - PROCESS | 12990 | |4;prototype.html;330.43825496655694;332.55769826131245;341.2288228603356;343.4059077795414;346.0673484958039;5446.128619420893;5467.972660136698;5543.77824887004;5581.665100093992;5606.411326810688;5363.490468405495;5487.945120548793;5511.807086751965;5516;5529.861753456165;4306.483222013363;4310.482742070956;4316.503602085753;4333.306670932651;4336.6747493938;4210.242156411845;4299.656027517791;4300.69895107341;4312.504062032859;4327.7186982846015;4264.701470897038;4272.594103560157;4288.592583704543;4300.913981720364;4313.633341166004;4217.704760666755;4277.593628605277;4286.914261714748;4302.978485107586;4339.329358197086;3684.5313639861356;3835.5972622874756;3839.9232015359817;3847.1920896611746;3847.365184744514;5344.518993290622;5354.544863686591;5374.2476053352175;5405.486478784548;5448.4279150689;4898.70184401134;4900.607951363882;4925.507449255082;4931.112399768041;4947.971331754;5512.717457103982;5709.800156994527;5724.055530837407;5725;5737.454941780566;4085.6721565491334;4092.5702801205744;4108.465899433085;4128.60778226068;4161.771102589357;5878.882422351572;5908.261467316585;5962.672053037081;5978.2228310319815;6002.609830361012;4160.604742549453;4230.048239146167;4249.936250956238;4278.914421711548;4283.293256612624;4222.936655950163;4297.376880352332;4321.913561728811;4324.789059063404;4334.501532323823;4915.361003069578;4925.236588328815;4936.925946110811;4942.827001055018;4943.530364615356;5629.605927585029;5768.798092066758;5810.651360918274;5819.679917604572;5829.621074630136;1480.3042569992087;1503.443725821453;1506.006036016224;1507.766296224087;1510.3882927414415;931.5947562810064;975.7999610079917;981.3915372468972;981.964027950519;982.8722266105503;4849.369581954324;4865.513448655106;4880.463149053601;4901.656884018156;4931.802727890916;5190.6107041972;5210.843674689765;5227.790888364499;5232.2413250078525;5233.267342572043;4665.486796452456;4854.368932038812;4867.9269810952865;4913.70517768935;4924.72913989734;2817.873195706198;2822.407294468144;2827.9960613982153;2859.7283258090447;2877.3813630069635;5300.761465734051;5316.574674026068;5325.733713314319;5370.650907690988;5394.62237643369;5105.412877519058;5159.535641792181;5243.4232234454175;5304.946950530445;5333.546648534841;5232.843014709565;5273.2617433559335;5275.261463395128;5311.415744268127;5313.495217954288;5122.718250496258;5150.793968241228;5158.535731784157;5176.974115129551;5193.480651934928;4756.643251756063;4993.277319324827;5066.721330326867;5087.262346959744;5117.718525481134;5243.8164664236565;5251.317328747391;5302.734863256745;5351.732413379394;5355.866103347447;3878.2825177342283;3977.542582602922;4102.835886564504;4120.21715873983;4169;5840.2991641003355;5852.619579727304;5857.384974577608;5880.176775251382;5915.940840591539;5627.690477023803;5709.25779648643;5714.971425142848;5732.856678583069;5736.741846616996;5666.433356664301;5672.7730890763905;5704.401037891128;5704.942950570441;5705.429457054262;5701;5717.885642287214;5739.167820665896;5749.885002299847;5795.536357091339;5544.528715059265;5697.4931030346515;5762.827115186551;5795.913061304;5822.592418530662;5657.878295639135;5681.295611316671;5710.200571919851;5720.17057526648;5727.885442291047 10:50:00 INFO - PROCESS | 12990 | |5;yui.html;725.902003229564;745.5750222373246;770.0412985832639;773.5474747272847;806;14742;15263.38946442141;15297.464588739396;15413.075215487064;15503.767443488357;13929.582112536615;13979.720405591883;14009.579712608638;14012.719745605082;14059.086159399632;794.574902427203;801.4950581133907;802.626778547975;803.5660743198665;805.19078326282;795.6141271483326;800.7837883771379;803.2289002557552;804.4007214625112;805.1586092533316;843.9534976628967;846.3905987688854;851.3274513134617;853.9103394143588;855.0380821575727;845.3870943565865;845.9830803383928;846.6317152038852;847.7456762971115;848.5502683577714;613.9807918854724;616.2081724983375;619.9690015499207;621.4189732600033;626.1203009771278;11742.706432339175;11777.057835373149;11778.234414763014;11780.410979451079;11805.10088313349;12088.214266072677;12171.391430428532;12409.75180496394;12433.813492797615;12494.437750301258;10555.630552930686;10673.679789606324;10919.235653504258;11029.117670586334;11135.610253641084;3678.8104089219332;3690.4464330350393;3706.7745699178154;3760.830762615689;3788.109794198361;60745.69627151836;63711.362886371004;63779.68110159419;64423.35576644267;66677.3332266676;9371.437713737061;9539.284553658503;9690.51547422626;9829.700610694576;9846.901530984598;18898.244070237037;19064.61870762577;19095;19145.617087658167;19153.138108785137;7894.921050789533;7920.168382319889;8035.0759662638375;8121.75634730959;8233.670653173926;4509.88725281864;4535.7732113394195;4707.576318131316;4719.292106184032;4821.5178482152205;3385.1029477188563;3580.5882323532605;3586.5158203642172;3593.2813437312643;3606.783592984429;590.9320428150818;591.7159763313548;592.5022980696236;601.8074216250845;615.3661728419735;628.8616504369031;655.9967200163968;715.1954051691847;720.3660778514874;744.8249661329584;9264;9270.953645231732;9325.766855828659;9729.221662267144;9761.853572196424;581.7614777941109;612.2713970375239;619.8563650065712;661.9205695316593;731.378328420838;4125.66994640428;4633.582977532038;4738.09976104546;4762.3808904842845;4766.523347665275;54735;54779.452205477435;55029.44970550323;55229.17156242659;79915.60042199868;77873.61063194647;78076.60961695269;78385;79595;79955;67437.6628116866;68596.31403685999;68721.31278687248;69844.6507767458;71927.64036179785;8808.955955220183;8916.86624700643;9186.127317904788;9248.583813728534;9460.526973651427;45176.77411612921;46494.30258546192;46713.53286467092;47190.29214561715;47241.76379118083;62859.6857015712;64362.67818660877;66591.66704166641;67034.32965670477;68121;10838.67483975482;10981.505832237408;11027.83458248143;11056.778864422828;11152.275102118336;11925;12135.878641213829;12179.695507612027;12426.378681066091;13037.15258508194;11539.942300288445;11677.824832627688;11783;11791.351475668578;12823.743525129632;12588.370581470706;12659.746805064031;12722;12826.743465130832;13152.605421837361;12777.680557985754;13127.277999710108;13265.955120942775;13514.459421623025;13520.526781562992;10251.641192558225;10693.839592406275;10867.836982445428;11140.275882067965;11602.593909213138;9999.30004899679;11092.722681933015;11214.644924565606;11221;11299.548018079513 10:50:00 INFO - PROCESS | 12990 | __end_tp_report 10:50:00 INFO - PROCESS | 12990 | __start_cc_report 10:50:00 INFO - PROCESS | 12990 | _x_x_mozilla_cycle_collect,327 10:50:00 INFO - PROCESS | 12990 | __end_cc_report 10:50:00 INFO - PROCESS | 12990 | __startTimestamp1477590600913__endTimestamp 10:50:00 INFO - PROCESS | 12990 | 10:50:00 INFO - PROCESS | 12990 | ------- Summary: start ------- 10:50:00 INFO - PROCESS | 12990 | Number of tests: 6 10:50:00 INFO - PROCESS | 12990 | 10:50:00 INFO - PROCESS | 12990 | [#0] dojo.html Cycles:165 Average:5391.93 Median:5605.19 stddev:615.82 (11.0%) stddev-sans-first:590.58 10:50:00 INFO - PROCESS | 12990 | Values: 3087.7 3094.0 3101.7 3118.3 3141.7 5280.9 5419.5 5449.7 5470.3 5500.3 5372.1 5372.1 5442.2 5522.8 5538.9 4841.6 4871.9 4955.3 4986.3 5009.9 4961.8 5029.8 5068.2 5086.9 5108.0 4786.9 4820.3 5025.9 5073.4 5081.5 4839.7 4903.4 4904.3 4938.8 4955.7 4821.5 4842.3 4853.8 4877.3 4930.5 5326.2 5381.9 5409.6 5411.4 5422.3 5665.6 5751.9 5768.7 5787.3 5863.3 5828.2 5838.7 5840.3 5842.3 5845.0 5416.9 5417.6 5425.3 5437.6 5450.7 5856.4 5912.3 5929.4 5938.4 5959.3 5657.1 5722.5 5728.1 5728.3 5778.2 5774.2 5813.2 5830.0 5830.1 5833.3 5631.3 5669.9 5739.9 5759.5 5760.5 5806.1 5808.8 5818.7 5844.9 5854.5 4361.1 4368.0 4413.4 4440.9 4460.2 3881.1 3899.7 3933.5 3978.8 4010.3 5525.9 5548.8 5569.0 5605.2 5626.9 5825.9 5866.7 5881.4 5891.1 5897.9 5323.9 5341.8 5514.4 5557.6 5564.3 5058.6 5085.3 5093.0 5138.9 5142.7 6000.8 6015.3 6020.0 6032.8 6033.7 5634.1 5636.2 5873.0 5885.6 5899.3 5917.8 5952.7 5981.5 5988.9 6069.7 5695.2 5731.4 5744.7 5745.9 5761.6 5697.4 5760.1 5806.9 5813.5 5821.2 5600.6 5609.6 5669.5 5703.2 5784.0 5663.4 5678.6 5679.8 5685.1 5697.9 5473.4 5534.6 5623.8 5668.8 5697.0 5584.9 5624.4 5659.9 5677.8 5748.4 5491.6 5542.2 5543.4 5548.2 5550.4 10:50:00 INFO - PROCESS | 12990 | 10:50:00 INFO - PROCESS | 12990 | [#1] ext.html Cycles:180 Average:56391.65 Median:40457.72 stddev:107329.58 (265.3%) stddev-sans-first:107548.85 10:50:00 INFO - PROCESS | 12990 | Values: 574.1 598.5 608.7 626.7 629.0 37079.0 40870.0 40932.0 40986.0 41043.8 41574.4 42232.2 42232.8 42240.8 42277.0 8665.6 8820.3 8833.8 8839.6 8855.4 8707.6 8812.1 8818.6 8821.7 8824.3 8827.9 8838.2 8884.4 8897.6 8963.5 8749.2 8799.1 8800.7 8809.7 8881.0 8648.7 8658.2 8678.9 8726.2 8741.0 33340.8 33526.2 33588.5 33631.2 33761.3 3368.5 3586.5 3680.1 3845.5 3989.8 31061.7 31478.7 31625.2 31625.8 31633.8 4212.5 4264.8 4306.9 4313.9 4386.4 255553.0 258882.0 328647.0 328796.0 329768.0 61622.7 61860.4 62095.7 62191.0 62622.0 65698.3 66438.0 66632.0 66814.3 66839.0 16159.5 16323.0 16349.1 16403.4 16413.7 12172.1 12188.5 12308.7 12316.1 12327.8 18625.5 19851.1 19882.7 19953.0 20032.0 7173.2 7543.4 7619.2 7706.5 7867.0 862.2 922.0 1031.6 1077.6 1086.5 31836.8 32157.5 32361.4 32554.8 32903.7 1060.0 1080.4 1082.9 1116.5 1135.7 16413.3 17120.2 17158.7 17181.7 17422.4 485096.0 490280.0 491992.0 492818.0 494548.0 56250.4 56454.0 56556.4 56704.7 56894.1 1313.2 1316.5 1337.9 1342.8 1358.4 30558.4 32442.0 33049.0 33562.8 33960.5 48414.5 49724.3 49753.8 49792.3 49804.0 397997.0 401774.0 402132.0 402335.0 403216.0 27097.9 27704.4 27813.6 27937.4 28077.9 47018.3 47081.5 47936.5 48178.3 48629.8 38984.4 39022.0 39789.6 40879.8 41986.0 38977.4 40119.8 40453.6 40461.8 40534.8 39697.6 40559.8 40640.0 40795.8 44029.6 32815.8 36447.3 36608.0 37099.3 37536.4 27750.4 28258.4 28450.6 28623.3 28844.4 10:50:00 INFO - PROCESS | 12990 | 10:50:00 INFO - PROCESS | 12990 | [#2] jquery.html Cycles:180 Average:28378.64 Median:2630.22 stddev:78971.32 (3002.5%) stddev-sans-first:79164.85 10:50:00 INFO - PROCESS | 12990 | Values: 370.9 384.5 384.9 392.9 417.5 14306.1 17681.8 18076.5 19021.5 19074.4 18073.7 18433.0 18711.4 18947.0 19142.0 5646.7 5704.9 5840.0 5840.6 5885.3 5807.5 5909.8 5911.0 5911.3 5920.9 5576.1 5725.5 5738.3 5744.7 5747.1 5589.6 5736.9 5762.7 5773.7 5790.9 5083.5 5122.5 5143.6 5146.4 5146.6 22074.8 22545.0 22816.0 22837.8 22918.4 2183.7 2343.1 2493.7 2588.6 2671.8 10244.8 10395.0 10431.8 10654.2 10786.9 1876.9 1965.0 1975.7 1983.1 1987.2 70535.0 76942.6 78903.6 80785.2 81352.6 10649.3 10832.4 11029.9 11110.6 11200.5 12076.3 14547.3 15261.7 15313.7 15384.8 7268.1 7275.4 7561.6 7596.0 7710.8 7114.4 7286.8 7374.9 7414.3 7583.4 3725.2 3893.9 4013.8 4066.2 4125.2 1934.7 1973.6 2017.8 2036.8 2037.8 929.0 950.9 975.8 996.9 1034.9 19506.2 19592.0 19760.3 19928.2 20056.0 949.9 976.4 986.2 989.1 1021.3 10465.4 10495.6 10936.5 11079.7 11083.3 469991.0 471722.0 474196.0 485011.0 492652.4 89944.0 90781.1 91290.0 92253.0 92397.0 1026.7 1106.8 1136.8 1138.0 1141.2 17732.5 17769.6 18508.7 18525.9 18814.3 37923.0 39857.6 40090.6 40158.6 40888.0 55484.7 57949.4 58795.7 60182.7 61090.7 7170.2 7487.4 8274.7 8374.4 8558.2 12107.6 12849.6 12886.0 12940.5 13286.4 11013.9 11506.3 11615.7 11692.6 11835.5 11151.6 11283.6 11359.4 11879.3 12034.6 11387.3 11669.8 11706.0 11894.5 12430.9 7343.7 7570.8 7604.6 7699.6 7722.4 10806.3 11151.1 11563.2 11657.9 12033.7 10:50:00 INFO - PROCESS | 12990 | 10:50:00 INFO - PROCESS | 12990 | [#3] mootools.html Cycles:180 Average:5832.55 Median:4979.02 stddev:3374.51 (67.8%) stddev-sans-first:3368.07 10:50:00 INFO - PROCESS | 12990 | Values: 1472.5 1503.1 1674.4 1770.2 1802.5 7642.1 8032.0 8527.6 9106.9 9186.3 8488.5 8844.5 8848.8 9045.0 9077.3 2333.5 2349.7 2357.4 2360.2 2362.0 2299.0 2340.4 2353.0 2354.0 2373.7 2264.8 2315.3 2320.3 2322.3 2341.1 2261.5 2270.7 2281.5 2292.3 2324.2 2264.4 2279.3 2280.6 2294.9 2310.6 8811.0 8922.9 8927.6 9016.0 9079.6 5195.1 5296.7 5341.7 5351.5 5354.2 3139.8 3155.3 3378.2 3390.6 3394.8 1035.5 1045.9 1056.0 1067.8 1068.5 12559.7 12582.4 12660.9 12697.4 12699.2 4470.8 4577.3 4647.2 4689.7 4715.5 10517.7 10526.0 10552.4 10564.4 10620.6 5317.3 5340.6 5348.0 5356.8 5363.1 4829.2 4897.0 4933.9 5024.1 5055.4 3486.9 3541.3 3724.1 3821.1 3909.2 1009.6 1028.5 1030.8 1036.9 1054.7 822.4 839.8 898.7 904.8 965.5 5666.7 5720.3 5728.8 6212.5 6227.3 882.2 884.9 903.2 919.5 960.2 3882.8 4051.7 4155.2 4197.6 4255.2 10996.0 11407.0 11436.4 11441.7 11450.5 10991.1 11231.7 11236.8 11271.1 11283.6 7978.7 8289.6 8326.1 8360.2 8413.9 5805.2 5989.2 5996.8 6039.4 6047.4 9946.2 10042.4 10043.4 10176.1 10247.9 9930.1 10032.8 10052.9 10112.7 10221.7 6631.0 6833.1 7375.3 7779.3 7939.0 8321.8 8722.2 8724.2 8729.1 8733.9 7686.5 7945.9 7955.4 8037.2 8156.2 7582.1 7600.3 7750.7 7774.0 7913.8 6831.0 6881.2 6924.9 6969.2 7048.6 5171.1 5294.2 5300.9 5382.5 5510.7 5160.6 5263.0 5267.8 5279.9 5358.3 10:50:00 INFO - PROCESS | 12990 | 10:50:00 INFO - PROCESS | 12990 | [#4] prototype.html Cycles:180 Average:4658.33 Median:5183.79 stddev:1329.51 (25.6%) stddev-sans-first:1292.95 10:50:00 INFO - PROCESS | 12990 | Values: 330.4 332.6 341.2 343.4 346.1 5446.1 5468.0 5543.8 5581.7 5606.4 5363.5 5487.9 5511.8 5516.0 5529.9 4306.5 4310.5 4316.5 4333.3 4336.7 4210.2 4299.7 4300.7 4312.5 4327.7 4264.7 4272.6 4288.6 4300.9 4313.6 4217.7 4277.6 4286.9 4303.0 4339.3 3684.5 3835.6 3839.9 3847.2 3847.4 5344.5 5354.5 5374.2 5405.5 5448.4 4898.7 4900.6 4925.5 4931.1 4948.0 5512.7 5709.8 5724.1 5725.0 5737.5 4085.7 4092.6 4108.5 4128.6 4161.8 5878.9 5908.3 5962.7 5978.2 6002.6 4160.6 4230.0 4249.9 4278.9 4283.3 4222.9 4297.4 4321.9 4324.8 4334.5 4915.4 4925.2 4936.9 4942.8 4943.5 5629.6 5768.8 5810.7 5819.7 5829.6 1480.3 1503.4 1506.0 1507.8 1510.4 931.6 975.8 981.4 982.0 982.9 4849.4 4865.5 4880.5 4901.7 4931.8 5190.6 5210.8 5227.8 5232.2 5233.3 4665.5 4854.4 4867.9 4913.7 4924.7 2817.9 2822.4 2828.0 2859.7 2877.4 5300.8 5316.6 5325.7 5370.7 5394.6 5105.4 5159.5 5243.4 5304.9 5333.5 5232.8 5273.3 5275.3 5311.4 5313.5 5122.7 5150.8 5158.5 5177.0 5193.5 4756.6 4993.3 5066.7 5087.3 5117.7 5243.8 5251.3 5302.7 5351.7 5355.9 3878.3 3977.5 4102.8 4120.2 4169.0 5840.3 5852.6 5857.4 5880.2 5915.9 5627.7 5709.3 5715.0 5732.9 5736.7 5666.4 5672.8 5704.4 5704.9 5705.4 5701.0 5717.9 5739.2 5749.9 5795.5 5544.5 5697.5 5762.8 5795.9 5822.6 5657.9 5681.3 5710.2 5720.2 5727.9 10:50:00 INFO - PROCESS | 12990 | 10:50:00 INFO - PROCESS | 12990 | [#5] yui.html Cycles:180 Average:16948.56 Median:54904.45 stddev:22139.75 (40.3%) stddev-sans-first:22168.34 10:50:00 INFO - PROCESS | 12990 | Values: 725.9 745.6 770.0 773.5 806.0 14742.0 15263.4 15297.5 15413.1 15503.8 13929.6 13979.7 14009.6 14012.7 14059.1 794.6 801.5 802.6 803.6 805.2 795.6 800.8 803.2 804.4 805.2 844.0 846.4 851.3 853.9 855.0 845.4 846.0 846.6 847.7 848.6 614.0 616.2 620.0 621.4 626.1 11742.7 11777.1 11778.2 11780.4 11805.1 12088.2 12171.4 12409.8 12433.8 12494.4 10555.6 10673.7 10919.2 11029.1 11135.6 3678.8 3690.4 3706.8 3760.8 3788.1 60745.7 63711.4 63779.7 64423.4 66677.3 9371.4 9539.3 9690.5 9829.7 9846.9 18898.2 19064.6 19095.0 19145.6 19153.1 7894.9 7920.2 8035.1 8121.8 8233.7 4509.9 4535.8 4707.6 4719.3 4821.5 3385.1 3580.6 3586.5 3593.3 3606.8 590.9 591.7 592.5 601.8 615.4 628.9 656.0 715.2 720.4 744.8 9264.0 9271.0 9325.8 9729.2 9761.9 581.8 612.3 619.9 661.9 731.4 4125.7 4633.6 4738.1 4762.4 4766.5 54735.0 54779.5 55029.4 55229.2 79915.6 77873.6 78076.6 78385.0 79595.0 79955.0 67437.7 68596.3 68721.3 69844.7 71927.6 8809.0 8916.9 9186.1 9248.6 9460.5 45176.8 46494.3 46713.5 47190.3 47241.8 62859.7 64362.7 66591.7 67034.3 68121.0 10838.7 10981.5 11027.8 11056.8 11152.3 11925.0 12135.9 12179.7 12426.4 13037.2 11539.9 11677.8 11783.0 11791.4 12823.7 12588.4 12659.7 12722.0 12826.7 13152.6 12777.7 13127.3 13266.0 13514.5 13520.5 10251.6 10693.8 10867.8 11140.3 11602.6 9999.3 11092.7 11214.6 11221.0 11299.5 10:50:00 INFO - PROCESS | 12990 | -------- Summary: end -------- 10:50:00 INFO - PROCESS | 12990 | 10:50:01 INFO - TEST-INFO | 12990: exit 0 10:50:01 INFO - TEST-OK | dromaeo_css | took 1115020ms 10:50:01 INFO - TEST-START | kraken 10:50:01 INFO - operating with platform_type : linux_ 10:50:01 INFO - Initialising browser for kraken test... 10:50:01 INFO - TEST-INFO | started process 13348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIW9f2k/profile http://localhost:53792/getInfo.html) 10:50:06 INFO - PROCESS | 13348 | __metrics Screen width/height:1600/1200 10:50:06 INFO - PROCESS | 13348 | colorDepth:24 10:50:06 INFO - PROCESS | 13348 | Browser inner width/height: 1024/697 10:50:06 INFO - PROCESS | 13348 | __metrics 10:50:06 ERROR - PROCESS | 13348 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 10:50:07 INFO - TEST-INFO | 13348: exit 0 10:50:07 INFO - Browser initialized. 10:50:07 INFO - Running cycle 1/1 for kraken test... 10:50:07 INFO - TEST-INFO | started process 13472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIW9f2k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:19 INFO - PROCESS | 13472 | RSS: Main: 181882880 10:50:19 INFO - PROCESS | 13472 | 10:50:22 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53792/tests/kraken/driver.html?testName=audio-beat-detection) 10:50:23 INFO - PROCESS | 13472 | RSS: Main: 195674112 10:50:23 INFO - PROCESS | 13472 | 10:50:26 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53792/tests/kraken/driver.html?testName=audio-dft) 10:50:26 INFO - PROCESS | 13472 | RSS: Main: 194121728 10:50:26 INFO - PROCESS | 13472 | 10:50:29 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53792/tests/kraken/driver.html?testName=audio-fft) 10:50:30 INFO - PROCESS | 13472 | RSS: Main: 190468096 10:50:30 INFO - PROCESS | 13472 | 10:50:32 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53792/tests/kraken/driver.html?testName=audio-oscillator) 10:50:33 INFO - PROCESS | 13472 | RSS: Main: 190926848 10:50:33 INFO - PROCESS | 13472 | 10:50:35 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53792/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:50:35 INFO - PROCESS | 13472 | RSS: Main: 191488000 10:50:35 INFO - PROCESS | 13472 | 10:50:39 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53792/tests/kraken/driver.html?testName=imaging-darkroom) 10:50:39 INFO - PROCESS | 13472 | RSS: Main: 192073728 10:50:39 INFO - PROCESS | 13472 | 10:50:43 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53792/tests/kraken/driver.html?testName=imaging-desaturate) 10:50:43 INFO - PROCESS | 13472 | RSS: Main: 192073728 10:50:43 INFO - PROCESS | 13472 | 10:50:46 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53792/tests/kraken/driver.html?testName=json-parse-financial) 10:50:47 INFO - PROCESS | 13472 | RSS: Main: 192188416 10:50:47 INFO - PROCESS | 13472 | 10:50:48 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53792/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:50:49 INFO - PROCESS | 13472 | RSS: Main: 192061440 10:50:49 INFO - PROCESS | 13472 | 10:50:51 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53792/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:50:51 INFO - PROCESS | 13472 | RSS: Main: 191815680 10:50:51 INFO - PROCESS | 13472 | 10:50:53 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53792/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:50:54 INFO - PROCESS | 13472 | RSS: Main: 192245760 10:50:54 INFO - PROCESS | 13472 | 10:50:57 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:50:57 INFO - PROCESS | 13472 | RSS: Main: 192049152 10:50:57 INFO - PROCESS | 13472 | 10:51:00 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:51:01 INFO - PROCESS | 13472 | RSS: Main: 193105920 10:51:01 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | Cycle 1(1): loaded http://localhost:53792/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53792/tests/kraken/driver.html?testName=ai-astar) 10:51:03 INFO - PROCESS | 13472 | RSS: Main: 193998848 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | __start_tp_report 10:51:03 INFO - PROCESS | 13472 | _x_x_mozilla_page_load 10:51:03 INFO - PROCESS | 13472 | _x_x_mozilla_page_load_details 10:51:03 INFO - PROCESS | 13472 | |i|pagename|runs| 10:51:03 INFO - PROCESS | 13472 | |0;ai-astar;105;113;112;111;112;111;111;111;112;111 10:51:03 INFO - PROCESS | 13472 | |1;audio-beat-detection;153;127;125;171;127;123;123;124;151;132 10:51:03 INFO - PROCESS | 13472 | |2;audio-dft;168;165;165;175;164;165;161;170;163;162 10:51:03 INFO - PROCESS | 13472 | |3;audio-fft;76;76;77;109;76;76;75;77;97;76 10:51:03 INFO - PROCESS | 13472 | |4;audio-oscillator;82;82;119;91;82;82;105;83;83;107 10:51:03 INFO - PROCESS | 13472 | |5;imaging-gaussian-blur;118;117;118;119;118;118;118;118;117;117 10:51:03 INFO - PROCESS | 13472 | |6;imaging-darkroom;147;149;147;148;147;148;146;148;147;147 10:51:03 INFO - PROCESS | 13472 | |7;imaging-desaturate;84;86;86;85;85;87;85;85;85;84 10:51:03 INFO - PROCESS | 13472 | |8;json-parse-financial;55;54;57;55;57;55;57;57;56;57 10:51:03 INFO - PROCESS | 13472 | |9;json-stringify-tinderbox;62;62;61;62;62;61;61;61;63;62 10:51:03 INFO - PROCESS | 13472 | |10;stanford-crypto-aes;83;82;87;86;82;82;81;86;81;81 10:51:03 INFO - PROCESS | 13472 | |11;stanford-crypto-ccm;141;137;135;142;138;137;136;138;170;135 10:51:03 INFO - PROCESS | 13472 | |12;stanford-crypto-pbkdf2;176;168;168;175;171;173;167;168;166;172 10:51:03 INFO - PROCESS | 13472 | |13;stanford-crypto-sha256-iterative;66;65;66;66;73;65;66;73;68;66 10:51:03 INFO - PROCESS | 13472 | __end_tp_report 10:51:03 INFO - PROCESS | 13472 | __start_cc_report 10:51:03 INFO - PROCESS | 13472 | _x_x_mozilla_cycle_collect,803 10:51:03 INFO - PROCESS | 13472 | __end_cc_report 10:51:03 INFO - PROCESS | 13472 | __startTimestamp1477590663381__endTimestamp 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | ------- Summary: start ------- 10:51:03 INFO - PROCESS | 13472 | Number of tests: 14 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:2.18 (2.0%) stddev-sans-first:0.73 10:51:03 INFO - PROCESS | 13472 | Values: 105.0 113.0 112.0 111.0 112.0 111.0 111.0 111.0 112.0 111.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:129.50 stddev:16.73 (12.9%) stddev-sans-first:16.52 10:51:03 INFO - PROCESS | 13472 | Values: 153.0 127.0 125.0 171.0 127.0 123.0 123.0 124.0 151.0 132.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.00 stddev:4.18 (2.5%) stddev-sans-first:4.36 10:51:03 INFO - PROCESS | 13472 | Values: 168.0 165.0 165.0 175.0 164.0 165.0 161.0 170.0 163.0 162.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:11.69 (15.4%) stddev-sans-first:12.23 10:51:03 INFO - PROCESS | 13472 | Values: 76.0 76.0 77.0 109.0 76.0 76.0 75.0 77.0 97.0 76.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:82.00 stddev:13.68 (16.7%) stddev-sans-first:14.06 10:51:03 INFO - PROCESS | 13472 | Values: 82.0 82.0 119.0 91.0 82.0 82.0 105.0 83.0 83.0 107.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:51:03 INFO - PROCESS | 13472 | Values: 118.0 117.0 118.0 119.0 118.0 118.0 118.0 118.0 117.0 117.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 10:51:03 INFO - PROCESS | 13472 | Values: 147.0 149.0 147.0 148.0 147.0 148.0 146.0 148.0 147.0 147.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 10:51:03 INFO - PROCESS | 13472 | Values: 84.0 86.0 86.0 85.0 85.0 87.0 85.0 85.0 85.0 84.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:1.15 (2.0%) stddev-sans-first:1.17 10:51:03 INFO - PROCESS | 13472 | Values: 55.0 54.0 57.0 55.0 57.0 55.0 57.0 57.0 56.0 57.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 10:51:03 INFO - PROCESS | 13472 | Values: 62.0 62.0 61.0 62.0 62.0 61.0 61.0 61.0 63.0 62.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.50 stddev:2.33 (2.8%) stddev-sans-first:2.47 10:51:03 INFO - PROCESS | 13472 | Values: 83.0 82.0 87.0 86.0 82.0 82.0 81.0 86.0 81.0 81.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:138.00 stddev:10.48 (7.6%) stddev-sans-first:11.12 10:51:03 INFO - PROCESS | 13472 | Values: 141.0 137.0 135.0 142.0 138.0 137.0 136.0 138.0 170.0 135.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.50 stddev:3.50 (2.0%) stddev-sans-first:3.07 10:51:03 INFO - PROCESS | 13472 | Values: 176.0 168.0 168.0 175.0 171.0 173.0 167.0 168.0 166.0 172.0 10:51:03 INFO - PROCESS | 13472 | 10:51:03 INFO - PROCESS | 13472 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:66.00 stddev:3.06 (4.6%) stddev-sans-first:3.21 10:51:03 INFO - PROCESS | 13472 | Values: 66.0 65.0 66.0 66.0 73.0 65.0 66.0 73.0 68.0 66.0 10:51:03 INFO - PROCESS | 13472 | -------- Summary: end -------- 10:51:03 INFO - PROCESS | 13472 | 10:51:04 INFO - TEST-INFO | 13472: exit 0 10:51:04 INFO - TEST-OK | kraken | took 62699ms 10:51:04 INFO - SUITE-END | took 1177s 10:51:05 INFO - Completed test suite (00:19:38) 10:51:05 INFO - javascript benchmark 10:51:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7106.937899356054, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3087.7066678665524, 3094.0, 3101.6743241959593, 3118.251619611291, 3141.670124636913, 5280.9207861882105, 5419.539339156171, 5449.673019618821, 5470.288862447881, 5500.326391899509, 5372.113601255788, 5372.140457526796, 5442.210879422481, 5522.751476183571, 5538.9169162462495, 4841.588464980481, 4871.878203044926, 4955.281484184791, 4986.276989836471, 5009.899802003958, 4961.751912404366, 5029.798808047692, 5068.239764035387, 5086.898262034757, 5107.974460127694, 4786.904261914742, 4820.276958456225, 5025.899482010376, 5073.441921388644, 5081.491850814926, 4839.685420447659, 4903.362562866804, 4904.337914381548, 4938.827141050082, 4955.653104282702, 4821.493743156953, 4842.322074909515, 4853.830115945925, 4877.34155888954, 4930.531599498042, 5326.174442961347, 5381.892362152735, 5409.5672346212605, 5411.404745477994, 5422.267993820823, 5665.603407761459, 5751.884962300773, 5768.711564421762, 5787.33445653751, 5863.2670916135485, 5828.1549175369755, 5838.678872662002, 5840.269966254218, 5842.269716285465, 5845.0, 5416.891662166813, 5417.59368047398, 5425.348958124971, 5437.592180586472, 5450.672959622435, 5856.443637854397, 5912.3496415394275, 5929.407059294036, 5938.435848594377, 5959.344472108065, 5657.094864821609, 5722.484976352065, 5728.112142617901, 5728.341240757283, 5778.16216648592, 5774.191613174159, 5813.157092221689, 5830.0, 5830.067189249699, 5833.270841144857, 5631.267935168484, 5669.943300566942, 5739.885202295931, 5759.510441612426, 5760.481556659921, 5806.129080637938, 5808.79669211584, 5818.709064546756, 5844.912326315109, 5854.531637468992, 4361.06237159006, 4368.0, 4413.404190434315, 4440.933385999213, 4460.1525710114975, 3881.107345310594, 3899.66852817508, 3933.527976642821, 3978.840846366171, 4010.318245898204, 5525.889482210333, 5548.750306236229, 5568.9721551392795, 5605.187247849039, 5626.943730562723, 5825.941740582624, 5866.73599688015, 5881.3530511643685, 5891.057430811135, 5897.911531327033, 5323.893522129536, 5341.81303654378, 5514.448555144453, 5557.638753481092, 5564.304461942257, 5058.570021548209, 5085.3134826797905, 5093.032323858455, 5138.922916156261, 5142.665726727751, 6000.849978750566, 6015.3383127855905, 6019.969900150471, 6032.788852390146, 6033.728482218398, 5634.070378387521, 5636.210930469655, 5873.0, 5885.588008839341, 5899.321578018583, 5917.763289468373, 5952.732127054206, 5981.461668449686, 5988.910166347421, 6069.696515174312, 5695.202671626059, 5731.426857314235, 5744.712764361681, 5745.9425405745405, 5761.56788240892, 5697.401772813795, 5760.1359796029255, 5806.883862322815, 5813.476787089182, 5821.155932389865, 5600.551955843604, 5609.607327487037, 5669.518090962314, 5703.230063941315, 5784.016717158009, 5663.433656634304, 5678.574106942078, 5679.77280908759, 5685.090385538294, 5697.857553561194, 5473.370562385217, 5534.640248383842, 5623.803166889139, 5668.773249069991, 5696.971515142398, 5584.916226256691, 5624.381318055092, 5659.886802263849, 5677.77288908439, 5748.367679555162, 5491.615586908878, 5542.168674698827, 5543.445655434424, 5548.195511650869, 5550.417206193291], "value": 5349.827788022034, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.1416582209596, 598.4643743849255, 608.7139044649014, 626.7399029402798, 628.9559331509695, 37079.0, 40870.0, 40932.0, 40986.0, 41043.79478102605, 41574.37638435426, 42232.15535689292, 42232.78883605578, 42240.788796056055, 42277.0, 8665.61350183969, 8820.33847461443, 8833.779155521099, 8839.602217900177, 8855.380123391333, 8707.608157632922, 8812.074732153127, 8818.603162857655, 8821.691240806573, 8824.294056475499, 8827.867581986275, 8838.248748856355, 8884.378093533454, 8897.555122243863, 8963.462192268453, 8749.212570868653, 8799.076097009818, 8800.679898015285, 8809.735707928772, 8880.955595222014, 8648.697295594688, 8658.220760131555, 8678.86981695275, 8726.171013753683, 8740.956295218546, 33340.83329583361, 33526.1618459538, 33588.49617255743, 33631.15922101967, 33761.32477350439, 3368.511565822942, 3586.4799604057525, 3680.0615842959874, 3845.5000849889334, 3989.8204580793936, 31061.689383106106, 31478.685213148034, 31625.20936976571, 31625.8418707905, 31633.84183079093, 4212.515560710527, 4264.808083636244, 4306.935395969063, 4313.870583882489, 4386.429764130675, 255553.0, 258882.0, 328647.0, 328796.0, 329767.9999999976, 61622.69188654028, 61860.38139618546, 62095.68952155301, 62191.0, 62622.0, 65698.34301657017, 66438.00342994859, 66632.0, 66814.33185668178, 66839.0, 16159.515214543582, 16323.0, 16349.100799456144, 16403.42588009414, 16413.67172656564, 12172.14794964344, 12188.451519681636, 12308.692282693004, 12316.137870349168, 12327.815082773766, 18625.541125540967, 19851.106700198525, 19882.707624004393, 19953.0, 20032.0, 7173.175084865203, 7543.396528277724, 7619.238076192337, 7706.499077559941, 7866.960665196638, 862.185234952976, 921.995390023059, 1031.6234574380446, 1077.5851297250615, 1086.4567716141928, 31836.824410396966, 32157.51763723546, 32361.35277294441, 32554.83722581372, 32903.67096329054, 1059.9629012984508, 1080.400377790334, 1082.8917108289108, 1116.5198964445367, 1135.7217481717032, 16413.343466261216, 17120.229589668244, 17158.742618860728, 17181.65636687284, 17422.390216342366, 485096.0, 490280.0, 491992.0, 492818.0, 494548.0, 56250.43749562534, 56454.0, 56556.43443565594, 56704.71647641818, 56894.14658780122, 1313.1530163044783, 1316.493150137204, 1337.9264140472173, 1342.7515909556764, 1358.4498278197345, 30558.388832223674, 32442.0, 33049.0, 33562.83218583989, 33960.490592640635, 48414.51585484241, 49724.254136187265, 49753.751231243616, 49792.25311620256, 49804.0, 397997.0, 401774.0, 402132.0, 402335.0, 403216.0, 27097.864510677322, 27704.445911082068, 27813.582796257666, 27937.44125117527, 28077.859610701817, 47018.29472557983, 47081.52918470772, 47936.5206347932, 48178.27732584084, 48629.75685121552, 38984.41523377208, 39022.0, 39789.60210397859, 40879.795601021804, 41986.0, 38977.41533876937, 40119.799401002805, 40453.63709032821, 40461.79769101136, 40534.797326013184, 39697.603023969394, 40559.78320650385, 40640.0, 40795.796021019705, 44029.55970440255, 32815.835920820246, 36447.27105457929, 36608.0, 37099.25801484009, 37536.436953445176, 27750.44499110047, 28258.434831302846, 28450.57324140098, 28623.284417889718, 28844.42311153807], "value": 19753.816590405073, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.91283548366147, 384.4982298100978, 384.8670284416735, 392.87428023032635, 417.4864916153132, 14306.14163150209, 17681.823181768177, 18076.4577062688, 19021.524461888443, 19074.42776716699, 18073.7288940666, 18432.95428451622, 18711.438656840284, 18947.0, 19142.0, 5646.745896434671, 5704.914426283609, 5840.0, 5840.561957853157, 5885.293764748236, 5807.506361959238, 5909.822705318826, 5911.0, 5911.290645122592, 5920.88158236835, 5576.1356989666665, 5725.4847063764255, 5738.31140263169, 5744.6840423776675, 5747.109198074284, 5589.580781441367, 5736.942630573703, 5762.654240745548, 5773.740181691834, 5790.942090579082, 5083.491650834924, 5122.5133612307145, 5143.639945203838, 5146.433892271847, 5146.639735218536, 22074.779252207434, 22545.0, 22816.0, 22837.77162228373, 22918.427039323982, 2183.661532462471, 2343.1447521654645, 2493.7007559093026, 2588.5987671910884, 2671.839689618629, 10244.795104097951, 10395.0, 10431.843522347172, 10654.200934929833, 10786.946065269623, 1876.9155388007573, 1964.99017504913, 1975.654260504406, 1983.1274239334646, 1987.1554589299635, 70535.0, 76942.6152869232, 78903.60548197222, 80785.19214807835, 81352.59323703403, 10649.254552181428, 10832.404217768099, 11029.889701103048, 11110.555577776799, 11200.54392928914, 12076.275423474444, 14547.3453694584, 15261.694766104616, 15313.693726125637, 15384.769228461582, 7268.127824660969, 7275.381592564586, 7561.621918904033, 7596.0, 7710.7686769397005, 7114.359707626339, 7286.781396558112, 7374.889376659355, 7414.295641914009, 7583.355414789694, 3725.161838586296, 3893.8637147699696, 4013.8394464221687, 4066.2477441672795, 4125.154343359664, 1934.7484826972404, 1973.615145046702, 2017.767956685, 2036.8166864982222, 2037.8267847232855, 928.9814203716023, 950.9001554836781, 975.7902051059057, 996.9152622027063, 1034.891336409666, 19506.219751210076, 19592.0, 19760.308389206308, 19928.20287188496, 20056.0, 949.8575213717997, 976.414151509103, 986.2356673577891, 989.0603926270072, 1021.269792098653, 10465.37207767521, 10495.580176792995, 10936.507857146447, 11079.72300692473, 11083.334999899871, 469991.0, 471722.0, 474196.0, 485011.0, 492652.3673816295, 89944.0, 90781.09218907858, 91290.0, 92253.0, 92397.0, 1026.7022563456514, 1106.7509810292781, 1136.7953768321781, 1138.0269869261826, 1141.19545720267, 17732.468025959242, 17769.55576110556, 18508.722369164203, 18525.90737046306, 18814.341498047503, 37923.0, 39857.60142398539, 40090.599094008685, 40158.59841401548, 40888.0, 55484.72257638686, 57949.420505796086, 58795.70602146962, 60182.69908650429, 61090.69454652698, 7170.175429825428, 7487.363574096045, 8274.710385136492, 8374.413791034569, 8558.186972237627, 12107.636770896886, 12849.614511564669, 12886.0, 12940.482380704667, 13286.402111904794, 11013.852298801658, 11506.252093613888, 11615.709607259887, 11692.590759323382, 11835.52657893709, 11151.553937842395, 11283.605073822377, 11359.375234362189, 11879.346635935106, 12034.63896083119, 11387.316760994367, 11669.76660466769, 11706.0, 11894.464749086139, 12430.937845310715, 7343.669534871051, 7570.772876813704, 7604.581748003913, 7699.615019249127, 7722.420818438752, 10806.335780402196, 11151.10791136691, 11563.190576659554, 11657.88342116568, 12033.699157521132], "value": 9045.91994602298, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.5287907869483, 1503.1281856523215, 1674.3888480704538, 1770.238797317153, 1802.5043113143884, 7642.121156067054, 8031.9598402007905, 8527.616257268422, 9106.863397049041, 9186.26509879209, 8488.53313067781, 8844.513551754651, 8848.823023539526, 9045.005049444573, 9077.319201059914, 2333.4516388648653, 2349.6710460535455, 2357.3752955466816, 2360.1739391213023, 2362.0, 2298.977010229901, 2340.426595484109, 2353.0470159585393, 2353.964690529635, 2373.667686523888, 2264.7657026920288, 2315.2822624986225, 2320.3155069254526, 2322.3149170994598, 2341.086976079322, 2261.457250259926, 2270.7048083749173, 2281.4752606900424, 2292.266474728088, 2324.2097686786574, 2264.4112530742127, 2279.2592407467473, 2280.623697089978, 2294.850834695756, 2310.607196776552, 8811.0, 8922.86615700765, 8927.642894284221, 9016.0, 9079.636814527412, 5195.116830138885, 5296.735163241822, 5341.706206158659, 5351.518363347279, 5354.170103633904, 3139.827309497977, 3155.2900597365638, 3378.1554611347165, 3390.593128824557, 3394.7963122212745, 1035.4770840725384, 1045.9406236757454, 1055.9915280906716, 1067.7917806027829, 1068.5458680060942, 12559.686007849785, 12582.43379047945, 12660.873391266061, 12697.365131743469, 12699.238045717195, 4470.798814053375, 4577.29051996941, 4647.18674232008, 4689.718616882929, 4715.528447155326, 10517.737056573647, 10526.0, 10552.419616921143, 10564.366138031743, 10620.575176992988, 5317.335333083364, 5340.626156169109, 5347.983883062206, 5356.812511562077, 5363.061464243741, 4829.203181475017, 4897.045076210176, 4933.925991110136, 5024.120778863684, 5055.368078990126, 3486.91282717929, 3541.309444658267, 3724.0875985383755, 3821.063839359319, 3909.2181563687377, 1009.5911155981839, 1028.5165971993151, 1030.7629245273629, 1036.9170466362673, 1054.6797046497736, 822.3626689315709, 839.8068444257855, 898.6540182029835, 904.8009437923646, 965.4689920543673, 5666.744996475169, 5720.342160651495, 5728.77084916607, 6212.502999760099, 6227.346128656516, 882.2104216726123, 884.920357167858, 903.2367649336301, 919.4713040002025, 960.1790469148777, 3882.825272862728, 4051.716379853441, 4155.16896620671, 4197.580241975778, 4255.170241802881, 10996.0, 11407.0, 11436.370999595103, 11441.656750297505, 11450.484728187252, 10991.120710343153, 11231.719207019727, 11236.775264494665, 11271.09831213501, 11283.605073822377, 7978.720744773905, 8289.626966786509, 8326.084130745614, 8360.247577718035, 8413.915860841313, 5805.187273781589, 5989.221401217988, 5996.820095397145, 6039.396060394101, 6047.425494578184, 9946.204303655835, 10042.397456152654, 10043.397396156253, 10176.084152426318, 10247.897521024694, 9930.106290433896, 10032.799344012932, 10052.94973525157, 10112.696619101438, 10221.74445638865, 6631.0, 6833.145856767904, 7375.299346562068, 7779.338756205786, 7939.047314322087, 8321.83356332882, 8722.171393717586, 8724.214820666171, 8729.083446238054, 8733.868991964999, 7686.500377475446, 7945.920540794518, 7955.443118981616, 8037.156098609562, 8156.225158609923, 7582.128055273714, 7600.2779735925, 7750.651220694969, 7773.961130194313, 7913.841723165619, 6831.0436538883605, 6881.174259088942, 6924.861502770017, 6969.198542167513, 7048.612326322102, 5171.120909445479, 5294.179402192666, 5300.946990530046, 5382.542483888913, 5510.669359838423, 5160.612954028538, 5263.0, 5267.762950667153, 5279.9472005280995, 5358.303420555303], "value": 4613.447541260365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.43825496655694, 332.55769826131245, 341.2288228603356, 343.4059077795414, 346.0673484958039, 5446.128619420893, 5467.972660136698, 5543.77824887004, 5581.665100093992, 5606.411326810688, 5363.490468405495, 5487.945120548793, 5511.807086751965, 5516.0, 5529.861753456165, 4306.483222013363, 4310.482742070956, 4316.503602085753, 4333.306670932651, 4336.6747493938, 4210.242156411845, 4299.656027517791, 4300.69895107341, 4312.504062032859, 4327.7186982846015, 4264.701470897038, 4272.594103560157, 4288.592583704543, 4300.913981720364, 4313.633341166004, 4217.704760666755, 4277.593628605277, 4286.914261714748, 4302.978485107586, 4339.329358197086, 3684.5313639861356, 3835.5972622874756, 3839.9232015359817, 3847.1920896611746, 3847.365184744514, 5344.518993290622, 5354.544863686591, 5374.2476053352175, 5405.486478784548, 5448.4279150689, 4898.70184401134, 4900.607951363882, 4925.507449255082, 4931.112399768041, 4947.971331754, 5512.717457103982, 5709.800156994527, 5724.055530837407, 5725.0, 5737.454941780566, 4085.6721565491334, 4092.5702801205744, 4108.465899433085, 4128.60778226068, 4161.771102589357, 5878.882422351572, 5908.261467316585, 5962.672053037081, 5978.2228310319815, 6002.609830361012, 4160.604742549453, 4230.048239146167, 4249.936250956238, 4278.914421711548, 4283.293256612624, 4222.936655950163, 4297.376880352332, 4321.913561728811, 4324.789059063404, 4334.501532323823, 4915.361003069578, 4925.236588328815, 4936.925946110811, 4942.827001055018, 4943.530364615356, 5629.605927585029, 5768.798092066758, 5810.651360918274, 5819.679917604572, 5829.621074630136, 1480.3042569992087, 1503.443725821453, 1506.006036016224, 1507.766296224087, 1510.3882927414415, 931.5947562810064, 975.7999610079917, 981.3915372468972, 981.964027950519, 982.8722266105503, 4849.369581954324, 4865.513448655106, 4880.463149053601, 4901.656884018156, 4931.802727890916, 5190.6107041972, 5210.843674689765, 5227.790888364499, 5232.2413250078525, 5233.267342572043, 4665.486796452456, 4854.368932038812, 4867.9269810952865, 4913.70517768935, 4924.72913989734, 2817.873195706198, 2822.407294468144, 2827.9960613982153, 2859.7283258090447, 2877.3813630069635, 5300.761465734051, 5316.574674026068, 5325.733713314319, 5370.650907690988, 5394.62237643369, 5105.412877519058, 5159.535641792181, 5243.4232234454175, 5304.946950530445, 5333.546648534841, 5232.843014709565, 5273.2617433559335, 5275.261463395128, 5311.415744268127, 5313.495217954288, 5122.718250496258, 5150.793968241228, 5158.535731784157, 5176.974115129551, 5193.480651934928, 4756.643251756063, 4993.277319324827, 5066.721330326867, 5087.262346959744, 5117.718525481134, 5243.8164664236565, 5251.317328747391, 5302.734863256745, 5351.732413379394, 5355.866103347447, 3878.2825177342283, 3977.542582602922, 4102.835886564504, 4120.21715873983, 4169.0, 5840.2991641003355, 5852.619579727304, 5857.384974577608, 5880.176775251382, 5915.940840591539, 5627.690477023803, 5709.25779648643, 5714.971425142848, 5732.856678583069, 5736.741846616996, 5666.433356664301, 5672.7730890763905, 5704.401037891128, 5704.942950570441, 5705.429457054262, 5701.0, 5717.885642287214, 5739.167820665896, 5749.885002299847, 5795.536357091339, 5544.528715059265, 5697.4931030346515, 5762.827115186551, 5795.913061304, 5822.592418530662, 5657.878295639135, 5681.295611316671, 5710.200571919851, 5720.17057526648, 5727.885442291047], "value": 4239.0959262218375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.902003229564, 745.5750222373246, 770.0412985832639, 773.5474747272847, 806.0, 14742.0, 15263.38946442141, 15297.464588739396, 15413.075215487064, 15503.767443488357, 13929.582112536615, 13979.720405591883, 14009.579712608638, 14012.719745605082, 14059.086159399632, 794.574902427203, 801.4950581133907, 802.626778547975, 803.5660743198665, 805.19078326282, 795.6141271483326, 800.7837883771379, 803.2289002557552, 804.4007214625112, 805.1586092533316, 843.9534976628967, 846.3905987688854, 851.3274513134617, 853.9103394143588, 855.0380821575727, 845.3870943565865, 845.9830803383928, 846.6317152038852, 847.7456762971115, 848.5502683577714, 613.9807918854724, 616.2081724983375, 619.9690015499207, 621.4189732600033, 626.1203009771278, 11742.706432339175, 11777.057835373149, 11778.234414763014, 11780.410979451079, 11805.10088313349, 12088.214266072677, 12171.391430428532, 12409.75180496394, 12433.813492797615, 12494.437750301258, 10555.630552930686, 10673.679789606324, 10919.235653504258, 11029.117670586334, 11135.610253641084, 3678.8104089219332, 3690.4464330350393, 3706.7745699178154, 3760.830762615689, 3788.109794198361, 60745.69627151836, 63711.362886371004, 63779.68110159419, 64423.35576644267, 66677.3332266676, 9371.437713737061, 9539.284553658503, 9690.51547422626, 9829.700610694576, 9846.901530984598, 18898.244070237037, 19064.61870762577, 19095.0, 19145.617087658167, 19153.138108785137, 7894.921050789533, 7920.168382319889, 8035.0759662638375, 8121.75634730959, 8233.670653173926, 4509.88725281864, 4535.7732113394195, 4707.576318131316, 4719.292106184032, 4821.5178482152205, 3385.1029477188563, 3580.5882323532605, 3586.5158203642172, 3593.2813437312643, 3606.783592984429, 590.9320428150818, 591.7159763313548, 592.5022980696236, 601.8074216250845, 615.3661728419735, 628.8616504369031, 655.9967200163968, 715.1954051691847, 720.3660778514874, 744.8249661329584, 9264.0, 9270.953645231732, 9325.766855828659, 9729.221662267144, 9761.853572196424, 581.7614777941109, 612.2713970375239, 619.8563650065712, 661.9205695316593, 731.378328420838, 4125.66994640428, 4633.582977532038, 4738.09976104546, 4762.3808904842845, 4766.523347665275, 54735.0, 54779.452205477435, 55029.44970550323, 55229.17156242659, 79915.60042199868, 77873.61063194647, 78076.60961695269, 78385.0, 79595.0, 79955.0, 67437.6628116866, 68596.31403685999, 68721.31278687248, 69844.6507767458, 71927.64036179785, 8808.955955220183, 8916.86624700643, 9186.127317904788, 9248.583813728534, 9460.526973651427, 45176.77411612921, 46494.30258546192, 46713.53286467092, 47190.29214561715, 47241.76379118083, 62859.6857015712, 64362.67818660877, 66591.66704166641, 67034.32965670477, 68121.0, 10838.67483975482, 10981.505832237408, 11027.83458248143, 11056.778864422828, 11152.275102118336, 11925.0, 12135.878641213829, 12179.695507612027, 12426.378681066091, 13037.15258508194, 11539.942300288445, 11677.824832627688, 11783.0, 11791.351475668578, 12823.743525129632, 12588.370581470706, 12659.746805064031, 12722.0, 12826.743465130832, 13152.605421837361, 12777.680557985754, 13127.277999710108, 13265.955120942775, 13514.459421623025, 13520.526781562992, 10251.641192558225, 10693.839592406275, 10867.836982445428, 11140.275882067965, 11602.593909213138, 9999.30004899679, 11092.722681933015, 11214.644924565606, 11221.0, 11299.548018079513], "value": 6891.418359730483, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 112.0, 111.0, 112.0, 111.0, 111.0, 111.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 125.0, 171.0, 127.0, 123.0, 123.0, 124.0, 151.0, 132.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 165.0, 175.0, 164.0, 165.0, 161.0, 170.0, 163.0, 162.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 109.0, 76.0, 76.0, 75.0, 77.0, 97.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 119.0, 91.0, 82.0, 82.0, 105.0, 83.0, 83.0, 107.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 148.0, 147.0, 148.0, 146.0, 148.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 85.0, 85.0, 87.0, 85.0, 85.0, 85.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 57.0, 55.0, 57.0, 55.0, 57.0, 57.0, 56.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 63.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 87.0, 86.0, 82.0, 82.0, 81.0, 86.0, 81.0, 81.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 135.0, 142.0, 138.0, 137.0, 136.0, 138.0, 170.0, 135.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 168.0, 168.0, 175.0, 171.0, 173.0, 167.0, 168.0, 166.0, 172.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 73.0, 65.0, 66.0, 73.0, 68.0, 66.0], "value": 67.4, "unit": "score"}]}]} 10:51:05 INFO - Return code: 0 10:51:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:51:05 ERROR - # TBPL SUCCESS # 10:51:05 INFO - Running post-action listener: _resource_record_post_action 10:51:05 INFO - [mozharness: 2016-10-27 17:51:05.198571Z] Finished run-tests step (success) 10:51:05 INFO - Running post-run listener: _resource_record_post_run 10:51:05 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391778304; Read time: 16; Write time: 274716 10:51:05 INFO - TinderboxPrint: CPU usage
13.5% 10:51:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:51:05 INFO - TinderboxPrint: I/O write bytes / time
391,778,304 / 274,716 10:51:05 INFO - TinderboxPrint: CPU idle
8,241.6 (86.5%) 10:51:05 INFO - TinderboxPrint: CPU user
1,226.0 (12.9%) 10:51:05 INFO - TinderboxPrint: Swap in / out
0 / 0 10:51:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103456768; Read time: 0; Write time: 101796 10:51:05 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288321536; Read time: 0; Write time: 172920 10:51:05 INFO - Running post-run listener: _upload_blobber_files 10:51:05 INFO - Blob upload gear active. 10:51:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:51:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:51:05 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'] 10:51:05 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 10:51:06 INFO - (blobuploader) - INFO - Open directory for files ... 10:51:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:51:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:51:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:07 INFO - (blobuploader) - INFO - Done attempting. 10:51:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:51:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:51:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:10 INFO - (blobuploader) - INFO - Done attempting. 10:51:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:51:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:51:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:10 INFO - (blobuploader) - INFO - Done attempting. 10:51:10 INFO - (blobuploader) - INFO - Iteration through files over. 10:51:10 INFO - Return code: 0 10:51:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:51:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:51:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd63bc21ffedd1cef90f857685d9da5ec6ef7d634fa789a3259208d9e1608fff6ad296b7824a6113302ee45fa7f67d197ae8f0b6adc6a52036b1bc5f215b0f10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7423afbf47f7f16a9d317f683e06417a30da383680785bdb31282d1a24264ea1326c86be9d7bbb207a5daaa3dc6cb98c145709cbce0a380f88cf1630ed15a63c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe818775bc33dff19f376150432ed9698f72c65754698ab3cd6c4cb054c21a22d9831bb8104a2d49159cff6d025ab18a0dad9309532a29f69f85ebb4533450d"} 10:51:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:51:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:51:10 INFO - Contents: 10:51:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd63bc21ffedd1cef90f857685d9da5ec6ef7d634fa789a3259208d9e1608fff6ad296b7824a6113302ee45fa7f67d197ae8f0b6adc6a52036b1bc5f215b0f10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7423afbf47f7f16a9d317f683e06417a30da383680785bdb31282d1a24264ea1326c86be9d7bbb207a5daaa3dc6cb98c145709cbce0a380f88cf1630ed15a63c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe818775bc33dff19f376150432ed9698f72c65754698ab3cd6c4cb054c21a22d9831bb8104a2d49159cff6d025ab18a0dad9309532a29f69f85ebb4533450d"} 10:51:10 INFO - Running post-run listener: copy_logs_to_upload_dir 10:51:10 INFO - Copying logs to upload dir... 10:51:10 INFO - mkdir: /builds/slave/test/build/upload/logs 10:51:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.873041 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-27 10:51:10.126232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 10:51:10.129689) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504 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/cd63bc21ffedd1cef90f857685d9da5ec6ef7d634fa789a3259208d9e1608fff6ad296b7824a6113302ee45fa7f67d197ae8f0b6adc6a52036b1bc5f215b0f10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7423afbf47f7f16a9d317f683e06417a30da383680785bdb31282d1a24264ea1326c86be9d7bbb207a5daaa3dc6cb98c145709cbce0a380f88cf1630ed15a63c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe818775bc33dff19f376150432ed9698f72c65754698ab3cd6c4cb054c21a22d9831bb8104a2d49159cff6d025ab18a0dad9309532a29f69f85ebb4533450d"} build_url:https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/a9M8gO22SSSedf8pBku6Ww/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd63bc21ffedd1cef90f857685d9da5ec6ef7d634fa789a3259208d9e1608fff6ad296b7824a6113302ee45fa7f67d197ae8f0b6adc6a52036b1bc5f215b0f10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7423afbf47f7f16a9d317f683e06417a30da383680785bdb31282d1a24264ea1326c86be9d7bbb207a5daaa3dc6cb98c145709cbce0a380f88cf1630ed15a63c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abe818775bc33dff19f376150432ed9698f72c65754698ab3cd6c4cb054c21a22d9831bb8104a2d49159cff6d025ab18a0dad9309532a29f69f85ebb4533450d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 10:51:10.154911) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:51:10.155203) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477589429.478119-96384504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 10:51:10.240244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 10:51:10.240568) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 10:51:10.240852) ========= ========= Total master_lag: 0.17 =========