builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1478629751.44 results: success (0) buildid: 20161108073206 builduid: 427aa894efce4b62a6ee9b255ba6b949 revision: aea5b4c3d165dcde027b3b6551b146a56748e9be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:11.442604) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:11.443095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:11.443449) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:11.459125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:11.459822) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-08 10:29:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-11-08 10:29:11 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106215 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:11.580273) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:11.580600) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020588 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:11.629987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:11.630360) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aea5b4c3d165dcde027b3b6551b146a56748e9be --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 aea5b4c3d165dcde027b3b6551b146a56748e9be --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=9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-08 10:29:11,811 truncating revision to first 12 chars 2016-11-08 10:29:11,812 Setting DEBUG logging. 2016-11-08 10:29:11,812 attempt 1/10 2016-11-08 10:29:11,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aea5b4c3d165?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 10:29:12,110 unpacking tar archive at: mozilla-central-aea5b4c3d165/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609940 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:12.254107) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:12.254593) ========= script_repo_revision: aea5b4c3d165dcde027b3b6551b146a56748e9be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:12.255185) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:12.255626) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 10:29:12.266376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-08 10:29:12.266789) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:29:12 INFO - MultiFileLogger online at 20161108 10:29:12 in /builds/slave/test 10:29:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:29:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:29:12 INFO - {'append_to_log': False, 10:29:12 INFO - 'base_work_dir': '/builds/slave/test', 10:29:12 INFO - 'blob_upload_branch': 'Firefox', 10:29:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:29:12 INFO - 'branch': 'Firefox', 10:29:12 INFO - 'buildbot_json_path': 'buildprops.json', 10:29:12 INFO - 'config_files': ('talos/linux_config.py',), 10:29:12 INFO - 'default_actions': ('clobber', 10:29:12 INFO - 'read-buildbot-config', 10:29:12 INFO - 'download-and-extract', 10:29:12 INFO - 'populate-webroot', 10:29:12 INFO - 'create-virtualenv', 10:29:12 INFO - 'install', 10:29:12 INFO - 'run-tests'), 10:29:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:29:12 INFO - 'download_minidump_stackwalk': True, 10:29:12 INFO - 'download_symbols': 'ondemand', 10:29:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:29:12 INFO - 'tooltool.py': '/tools/tooltool.py', 10:29:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:29:12 INFO - '/tools/misc-python/virtualenv.py')}, 10:29:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:29:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:29:12 INFO - 'installer_path': 'installer.exe', 10:29:12 INFO - 'log_level': 'info', 10:29:12 INFO - 'log_name': 'talos', 10:29:12 INFO - 'log_to_console': True, 10:29:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:29:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:29:12 INFO - 'opt_config_files': (), 10:29:12 INFO - 'pip_index': False, 10:29:12 INFO - 'sps_profile': False, 10:29:12 INFO - 'sps_profile_interval': 0, 10:29:12 INFO - 'suite': 'dromaeojs', 10:29:12 INFO - 'system_bits': '32', 10:29:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:29:12 INFO - 'title': 'talos-linux64-ix-040', 10:29:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:29:12 INFO - 'use_talos_json': True, 10:29:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:29:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:29:12 INFO - 'work_dir': 'build'} 10:29:12 INFO - [mozharness: 2016-11-08 18:29:12.548360Z] Running clobber step. 10:29:12 INFO - Running pre-action listener: _resource_record_pre_action 10:29:12 INFO - Running main action method: clobber 10:29:12 INFO - rmtree: /builds/slave/test/build 10:29:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:29:13 INFO - Running post-action listener: _resource_record_post_action 10:29:13 INFO - [mozharness: 2016-11-08 18:29:13.004933Z] Finished clobber step (success) 10:29:13 INFO - [mozharness: 2016-11-08 18:29:13.005034Z] Running read-buildbot-config step. 10:29:13 INFO - Running pre-action listener: _resource_record_pre_action 10:29:13 INFO - Running main action method: read_buildbot_config 10:29:13 INFO - Using buildbot properties: 10:29:13 INFO - { 10:29:13 INFO - "project": "", 10:29:13 INFO - "product": "firefox", 10:29:13 INFO - "script_repo_revision": "production", 10:29:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:29:13 INFO - "repository": "", 10:29:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:29:13 INFO - "buildid": "20161108073206", 10:29:13 INFO - "pgo_build": "True", 10:29:13 INFO - "basedir": "/builds/slave/test", 10:29:13 INFO - "buildnumber": 75, 10:29:13 INFO - "slavename": "talos-linux64-ix-040", 10:29:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:29:13 INFO - "platform": "ubuntu64_hw", 10:29:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:29:13 INFO - "branch": "mozilla-central", 10:29:13 INFO - "repo_path": "mozilla-central", 10:29:13 INFO - "revision": "aea5b4c3d165dcde027b3b6551b146a56748e9be", 10:29:13 INFO - "stage_platform": "linux64-pgo", 10:29:13 INFO - "builduid": "427aa894efce4b62a6ee9b255ba6b949", 10:29:13 INFO - "slavebuilddir": "test" 10:29:13 INFO - } 10:29:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:29:13 INFO - Running post-action listener: _resource_record_post_action 10:29:13 INFO - [mozharness: 2016-11-08 18:29:13.007477Z] Finished read-buildbot-config step (success) 10:29:13 INFO - [mozharness: 2016-11-08 18:29:13.007566Z] Running download-and-extract step. 10:29:13 INFO - Running pre-action listener: _resource_record_pre_action 10:29:13 INFO - Running main action method: download_and_extract 10:29:13 INFO - mkdir: /builds/slave/test/build/tests 10:29:13 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:29:13 INFO - trying https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:29:13 INFO - Downloading https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/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:29:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/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:29:13 INFO - Downloaded 1361 bytes. 10:29:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:29:13 INFO - Using the following test package requirements: 10:29:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:29:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:29:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:29:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:29:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:29:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:29:13 INFO - u'jsshell-linux-x86_64.zip'], 10:29:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:29:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:29:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:29:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:29:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:29:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:29:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:29:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:29:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:29:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:29:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:29:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:29:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:29:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:29:13 INFO - Fetch https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:29:14 INFO - Http code: 200 10:29:14 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 10:29:14 INFO - x-amz-cf-id: SHsA-wPBKpSlt6yf75nSPNqqtqwICXQpXb-HXk4PoBZl6zcKN-uEFA== 10:29:14 INFO - x-amz-version-id: m3pRSk4tp8KR1apaF0izsK..RINJryap 10:29:14 INFO - Expected file size: 21923166 10:29:14 INFO - Obtained file size: 21923166 10:29:18 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:29:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:29:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:29:18 INFO - Fetch https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:29:19 INFO - Http code: 200 10:29:19 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 10:29:19 INFO - x-amz-cf-id: SG6015vHkFHXKLdLR5uXgyqR6GcOs2H5QTfEkuCddppN5qKCBsWxiA== 10:29:19 INFO - x-amz-version-id: m3pRSk4tp8KR1apaF0izsK..RINJryap 10:29:19 INFO - Expected file size: 21923166 10:29:19 INFO - Obtained file size: 21923166 10:29:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:29:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:29:23 INFO - Fetch https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:29:24 INFO - Http code: 200 10:29:24 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 10:29:24 INFO - x-amz-cf-id: GJdf3v4FKjXM_ZWizWkbeZDEKbrv7gUS-nud1OonQVTZQXZDRHDosA== 10:29:24 INFO - x-amz-version-id: HnxARfcIOTxWDYJLX6cO07H_TtnJSFIH 10:29:24 INFO - Expected file size: 14409038 10:29:24 INFO - Obtained file size: 14409038 10:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:24 INFO - trying https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:29:24 INFO - Downloading https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/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:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/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:29:26 INFO - Downloaded 59656570 bytes. 10:29:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:29:26 INFO - mkdir: /builds/slave/test/properties 10:29:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:29:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:29:26 INFO - Contents: 10:29:26 INFO - build_url:https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:29:26 INFO - Running post-action listener: _resource_record_post_action 10:29:26 INFO - Running post-action listener: set_extra_try_arguments 10:29:26 INFO - [mozharness: 2016-11-08 18:29:26.757038Z] Finished download-and-extract step (success) 10:29:26 INFO - [mozharness: 2016-11-08 18:29:26.757396Z] Running populate-webroot step. 10:29:26 INFO - Running pre-action listener: _resource_record_pre_action 10:29:26 INFO - Running main action method: populate_webroot 10:29:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:29:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:29:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:29:26 INFO - '--tppagecycles', 10:29:26 INFO - '7'], 10:29:26 INFO - 'tests': ['tsvgm']}}, 10:29:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:29:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:29:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:29:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:29:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:26 INFO - 'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:29:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:26 INFO - 'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['damp', 'tps']}, 10:29:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:26 INFO - 'tests': ['damp', 'tps']}, 10:29:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['dromaeo_dom']}, 10:29:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:29:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['basic_compositor_video']}, 10:29:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:29:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['a11yr', 10:29:26 INFO - 'ts_paint', 10:29:26 INFO - 'tpaint', 10:29:26 INFO - 'sessionrestore', 10:29:26 INFO - 'sessionrestore_no_auto_restore', 10:29:26 INFO - 'tabpaint']}, 10:29:26 INFO - 'other-e10s': {'tests': ['a11yr', 10:29:26 INFO - 'ts_paint', 10:29:26 INFO - 'tpaint', 10:29:26 INFO - 'sessionrestore', 10:29:26 INFO - 'sessionrestore_no_auto_restore', 10:29:26 INFO - 'tabpaint']}, 10:29:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:29:26 INFO - 'ts_paint', 10:29:26 INFO - 'tpaint', 10:29:26 INFO - 'sessionrestore', 10:29:26 INFO - 'sessionrestore_no_auto_restore', 10:29:26 INFO - 'tabpaint']}, 10:29:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:29:26 INFO - 'ts_paint', 10:29:26 INFO - 'tpaint', 10:29:26 INFO - 'sessionrestore', 10:29:26 INFO - 'sessionrestore_no_auto_restore', 10:29:26 INFO - 'tabpaint']}, 10:29:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['a11yr', 10:29:26 INFO - 'ts_paint', 10:29:26 INFO - 'tpaint', 10:29:26 INFO - 'sessionrestore', 10:29:26 INFO - 'sessionrestore_no_auto_restore', 10:29:26 INFO - 'tabpaint']}, 10:29:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['a11yr', 10:29:26 INFO - 'ts_paint', 10:29:26 INFO - 'tpaint', 10:29:26 INFO - 'sessionrestore', 10:29:26 INFO - 'sessionrestore_no_auto_restore', 10:29:26 INFO - 'tabpaint']}, 10:29:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['tsvgx', 10:29:26 INFO - 'tsvgr_opacity', 10:29:26 INFO - 'tart', 10:29:26 INFO - 'tscrollx', 10:29:26 INFO - 'cart']}, 10:29:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:29:26 INFO - 'tsvgr_opacity', 10:29:26 INFO - 'tart', 10:29:26 INFO - 'tscrollx', 10:29:26 INFO - 'cart']}, 10:29:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:26 INFO - 'talos_options': ['--disable-e10s'], 10:29:26 INFO - 'tests': ['tp5o']}, 10:29:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:26 INFO - 'tests': ['tp5o']}, 10:29:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:26 INFO - 'talos_options': ['--disable-e10s', 10:29:26 INFO - '--xperf_path', 10:29:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:26 INFO - 'tests': ['tp5n']}, 10:29:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:29:26 INFO - 'talos_options': ['--xperf_path', 10:29:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:29:26 INFO - 'tests': ['tp5n']}}, 10:29:26 INFO - 'talos.zip': {'path': '', 10:29:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:29:26 INFO - Running post-action listener: _resource_record_post_action 10:29:26 INFO - [mozharness: 2016-11-08 18:29:26.777198Z] Finished populate-webroot step (success) 10:29:26 INFO - [mozharness: 2016-11-08 18:29:26.777290Z] Running create-virtualenv step. 10:29:26 INFO - Running pre-action listener: _resource_record_pre_action 10:29:26 INFO - Running main action method: create_virtualenv 10:29:26 INFO - Creating virtualenv /builds/slave/test/build/venv 10:29:26 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:29:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:29:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:29:26 INFO - Using real prefix '/usr' 10:29:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:29:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:29:29 INFO - Installing pip.................done. 10:29:29 INFO - Return code: 0 10:29:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:29:29 INFO - Reading from file tmpfile_stdout 10:29:29 INFO - Output received: 10:29:29 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:29:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:29:29 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:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:29 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:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:29 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 0x7f7b2c8f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', '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:29:29 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:29:29 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:29:29 INFO - Using env: {'DISPLAY': ':0', 10:29:29 INFO - 'HOME': '/home/cltbld', 10:29:29 INFO - 'LANG': 'en_US.UTF-8', 10:29:29 INFO - 'LANGUAGE': 'en_US:en', 10:29:29 INFO - 'LOGNAME': 'cltbld', 10:29:29 INFO - 'MAIL': '/var/mail/cltbld', 10:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:29 INFO - 'MOZ_NO_REMOTE': '1', 10:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:29 INFO - 'NO_EM_RESTART': '1', 10:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:29 INFO - 'PWD': '/builds/slave/test', 10:29:29 INFO - 'SHELL': '/bin/bash', 10:29:29 INFO - 'SHLVL': '1', 10:29:29 INFO - 'TERM': 'linux', 10:29:29 INFO - 'TMOUT': '86400', 10:29:29 INFO - 'USER': 'cltbld', 10:29:29 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:29 INFO - '_': '/tools/buildbot/bin/python'} 10:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:29 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:29:29 INFO - Cleaning up... 10:29:29 INFO - Return code: 0 10:29:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:29:29 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:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:29 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:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:29 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 0x7f7b2c8f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', '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:29:29 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:29:29 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:29:29 INFO - Using env: {'DISPLAY': ':0', 10:29:29 INFO - 'HOME': '/home/cltbld', 10:29:29 INFO - 'LANG': 'en_US.UTF-8', 10:29:29 INFO - 'LANGUAGE': 'en_US:en', 10:29:29 INFO - 'LOGNAME': 'cltbld', 10:29:29 INFO - 'MAIL': '/var/mail/cltbld', 10:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:29 INFO - 'MOZ_NO_REMOTE': '1', 10:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:29 INFO - 'NO_EM_RESTART': '1', 10:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:29 INFO - 'PWD': '/builds/slave/test', 10:29:29 INFO - 'SHELL': '/bin/bash', 10:29:29 INFO - 'SHLVL': '1', 10:29:29 INFO - 'TERM': 'linux', 10:29:29 INFO - 'TMOUT': '86400', 10:29:29 INFO - 'USER': 'cltbld', 10:29:29 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:29 INFO - '_': '/tools/buildbot/bin/python'} 10:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:30 INFO - Downloading/unpacking psutil>=3.1.1 10:29:30 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:29:30 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:29:30 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:29:30 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:29:30 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:29:30 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:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:29:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:29:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:32 INFO - Installing collected packages: psutil 10:29:32 INFO - Running setup.py install for psutil 10:29:32 INFO - building 'psutil._psutil_linux' extension 10:29:32 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:29:32 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:29:32 INFO - building 'psutil._psutil_posix' extension 10:29:32 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:29:32 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:29:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:29:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:29:32 INFO - Successfully installed psutil 10:29:32 INFO - Cleaning up... 10:29:32 INFO - Return code: 0 10:29:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:32 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 0x7f7b2c8f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', '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:29:32 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:29:32 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:29:32 INFO - Using env: {'DISPLAY': ':0', 10:29:32 INFO - 'HOME': '/home/cltbld', 10:29:32 INFO - 'LANG': 'en_US.UTF-8', 10:29:32 INFO - 'LANGUAGE': 'en_US:en', 10:29:32 INFO - 'LOGNAME': 'cltbld', 10:29:32 INFO - 'MAIL': '/var/mail/cltbld', 10:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:32 INFO - 'MOZ_NO_REMOTE': '1', 10:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:32 INFO - 'NO_EM_RESTART': '1', 10:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:32 INFO - 'PWD': '/builds/slave/test', 10:29:32 INFO - 'SHELL': '/bin/bash', 10:29:32 INFO - 'SHLVL': '1', 10:29:32 INFO - 'TERM': 'linux', 10:29:32 INFO - 'TMOUT': '86400', 10:29:32 INFO - 'USER': 'cltbld', 10:29:32 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:32 INFO - '_': '/tools/buildbot/bin/python'} 10:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:29:32 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:29:32 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:29:32 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:29:32 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:29:32 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:29:32 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:29:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:29:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:29:34 INFO - Installing collected packages: mozsystemmonitor 10:29:34 INFO - Running setup.py install for mozsystemmonitor 10:29:34 INFO - Successfully installed mozsystemmonitor 10:29:34 INFO - Cleaning up... 10:29:34 INFO - Return code: 0 10:29:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b2c8f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', '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:29:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:29:34 INFO - Using env: {'DISPLAY': ':0', 10:29:34 INFO - 'HOME': '/home/cltbld', 10:29:34 INFO - 'LANG': 'en_US.UTF-8', 10:29:34 INFO - 'LANGUAGE': 'en_US:en', 10:29:34 INFO - 'LOGNAME': 'cltbld', 10:29:34 INFO - 'MAIL': '/var/mail/cltbld', 10:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:34 INFO - 'MOZ_NO_REMOTE': '1', 10:29:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:34 INFO - 'NO_EM_RESTART': '1', 10:29:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:34 INFO - 'PWD': '/builds/slave/test', 10:29:34 INFO - 'SHELL': '/bin/bash', 10:29:34 INFO - 'SHLVL': '1', 10:29:34 INFO - 'TERM': 'linux', 10:29:34 INFO - 'TMOUT': '86400', 10:29:34 INFO - 'USER': 'cltbld', 10:29:34 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:34 INFO - '_': '/tools/buildbot/bin/python'} 10:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:35 INFO - Downloading/unpacking jsonschema==2.5.1 10:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:29:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:37 INFO - Downloading functools32-3.2.3-2.tar.gz 10:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:29:37 INFO - warning: no files found matching '*.txt' 10:29:37 INFO - no previously-included directories found matching 'build' 10:29:37 INFO - no previously-included directories found matching 'dist' 10:29:37 INFO - no previously-included directories found matching '.git*' 10:29:37 INFO - Installing collected packages: jsonschema, functools32 10:29:37 INFO - Running setup.py install for functools32 10:29:37 INFO - warning: no files found matching '*.txt' 10:29:37 INFO - no previously-included directories found matching 'build' 10:29:37 INFO - no previously-included directories found matching 'dist' 10:29:37 INFO - no previously-included directories found matching '.git*' 10:29:37 INFO - Successfully installed jsonschema functools32 10:29:37 INFO - Cleaning up... 10:29:37 INFO - Return code: 0 10:29:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:37 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 0x7f7b2c8f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', '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:29:37 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:29:37 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:29:37 INFO - Using env: {'DISPLAY': ':0', 10:29:37 INFO - 'HOME': '/home/cltbld', 10:29:37 INFO - 'LANG': 'en_US.UTF-8', 10:29:37 INFO - 'LANGUAGE': 'en_US:en', 10:29:37 INFO - 'LOGNAME': 'cltbld', 10:29:37 INFO - 'MAIL': '/var/mail/cltbld', 10:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:37 INFO - 'MOZ_NO_REMOTE': '1', 10:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:37 INFO - 'NO_EM_RESTART': '1', 10:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:37 INFO - 'PWD': '/builds/slave/test', 10:29:37 INFO - 'SHELL': '/bin/bash', 10:29:37 INFO - 'SHLVL': '1', 10:29:37 INFO - 'TERM': 'linux', 10:29:37 INFO - 'TMOUT': '86400', 10:29:37 INFO - 'USER': 'cltbld', 10:29:37 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:37 INFO - '_': '/tools/buildbot/bin/python'} 10:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:29:37 INFO - Cleaning up... 10:29:37 INFO - Return code: 0 10:29:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:37 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 0x7f7b2c8f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', '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:29:37 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:29:37 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:29:37 INFO - Using env: {'DISPLAY': ':0', 10:29:37 INFO - 'HOME': '/home/cltbld', 10:29:37 INFO - 'LANG': 'en_US.UTF-8', 10:29:37 INFO - 'LANGUAGE': 'en_US:en', 10:29:37 INFO - 'LOGNAME': 'cltbld', 10:29:37 INFO - 'MAIL': '/var/mail/cltbld', 10:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:37 INFO - 'MOZ_NO_REMOTE': '1', 10:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:37 INFO - 'NO_EM_RESTART': '1', 10:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:37 INFO - 'PWD': '/builds/slave/test', 10:29:37 INFO - 'SHELL': '/bin/bash', 10:29:37 INFO - 'SHLVL': '1', 10:29:37 INFO - 'TERM': 'linux', 10:29:37 INFO - 'TMOUT': '86400', 10:29:37 INFO - 'USER': 'cltbld', 10:29:37 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:37 INFO - '_': '/tools/buildbot/bin/python'} 10:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:38 INFO - Downloading/unpacking blobuploader==1.2.4 10:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:39 INFO - Downloading blobuploader-1.2.4.tar.gz 10:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:29:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:29:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:40 INFO - Downloading docopt-0.6.1.tar.gz 10:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:29:40 INFO - Installing collected packages: blobuploader, requests, docopt 10:29:40 INFO - Running setup.py install for blobuploader 10:29:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:29:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:29:40 INFO - Running setup.py install for requests 10:29:41 INFO - Running setup.py install for docopt 10:29:41 INFO - Successfully installed blobuploader requests docopt 10:29:41 INFO - Cleaning up... 10:29:41 INFO - Return code: 0 10:29:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:41 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:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:41 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:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:41 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 0x7f7b2c8f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', '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:29:41 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:29:41 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:29:41 INFO - Using env: {'DISPLAY': ':0', 10:29:41 INFO - 'HOME': '/home/cltbld', 10:29:41 INFO - 'LANG': 'en_US.UTF-8', 10:29:41 INFO - 'LANGUAGE': 'en_US:en', 10:29:41 INFO - 'LOGNAME': 'cltbld', 10:29:41 INFO - 'MAIL': '/var/mail/cltbld', 10:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:41 INFO - 'MOZ_NO_REMOTE': '1', 10:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:41 INFO - 'NO_EM_RESTART': '1', 10:29:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:41 INFO - 'PWD': '/builds/slave/test', 10:29:41 INFO - 'SHELL': '/bin/bash', 10:29:41 INFO - 'SHLVL': '1', 10:29:41 INFO - 'TERM': 'linux', 10:29:41 INFO - 'TMOUT': '86400', 10:29:41 INFO - 'USER': 'cltbld', 10:29:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:41 INFO - '_': '/tools/buildbot/bin/python'} 10:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:41 INFO - Running setup.py (path:/tmp/pip-g8od7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:41 INFO - Running setup.py (path:/tmp/pip-4pU4K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:41 INFO - Running setup.py (path:/tmp/pip-lDjZnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:41 INFO - Running setup.py (path:/tmp/pip-Chsjjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:41 INFO - Running setup.py (path:/tmp/pip-MfpKI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:41 INFO - Running setup.py (path:/tmp/pip-yJO45C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:42 INFO - Running setup.py (path:/tmp/pip-gXvT1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:42 INFO - Running setup.py (path:/tmp/pip-naE_iD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:42 INFO - Running setup.py (path:/tmp/pip-KFsF_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:42 INFO - Running setup.py (path:/tmp/pip-sBwkka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:42 INFO - Running setup.py (path:/tmp/pip-_Cs20q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:42 INFO - Running setup.py (path:/tmp/pip-GufGrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:42 INFO - Running setup.py (path:/tmp/pip-JmxpEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:42 INFO - Running setup.py (path:/tmp/pip-en6y91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:42 INFO - Running setup.py (path:/tmp/pip-V7jjGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:42 INFO - Running setup.py (path:/tmp/pip-u_OyrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:42 INFO - Running setup.py (path:/tmp/pip-UGEY1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:29:42 INFO - Running setup.py install for manifestparser 10:29:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:29:42 INFO - Running setup.py install for mozcrash 10:29:43 INFO - Running setup.py install for mozdebug 10:29:43 INFO - Running setup.py install for mozdevice 10:29:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Running setup.py install for mozfile 10:29:43 INFO - Running setup.py install for mozhttpd 10:29:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Running setup.py install for mozinfo 10:29:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Running setup.py install for mozInstall 10:29:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Running setup.py install for mozleak 10:29:43 INFO - Running setup.py install for mozlog 10:29:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Running setup.py install for moznetwork 10:29:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:29:43 INFO - Running setup.py install for mozprocess 10:29:44 INFO - Running setup.py install for mozprofile 10:29:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:29:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:29:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:29:44 INFO - Running setup.py install for mozrunner 10:29:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:29:44 INFO - Running setup.py install for mozscreenshot 10:29:44 INFO - Running setup.py install for moztest 10:29:44 INFO - Running setup.py install for mozversion 10:29:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:29:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:29:44 INFO - Cleaning up... 10:29:44 INFO - Return code: 0 10:29:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:44 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 0x7f7b2c8f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', '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:29:44 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:29:44 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:29:44 INFO - Using env: {'DISPLAY': ':0', 10:29:44 INFO - 'HOME': '/home/cltbld', 10:29:44 INFO - 'LANG': 'en_US.UTF-8', 10:29:44 INFO - 'LANGUAGE': 'en_US:en', 10:29:44 INFO - 'LOGNAME': 'cltbld', 10:29:44 INFO - 'MAIL': '/var/mail/cltbld', 10:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:44 INFO - 'MOZ_NO_REMOTE': '1', 10:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:44 INFO - 'NO_EM_RESTART': '1', 10:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:44 INFO - 'PWD': '/builds/slave/test', 10:29:44 INFO - 'SHELL': '/bin/bash', 10:29:44 INFO - 'SHLVL': '1', 10:29:44 INFO - 'TERM': 'linux', 10:29:44 INFO - 'TMOUT': '86400', 10:29:44 INFO - 'USER': 'cltbld', 10:29:44 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:44 INFO - '_': '/tools/buildbot/bin/python'} 10:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:29:44 INFO - Running setup.py (path:/tmp/pip-okRafL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:29:44 INFO - Running setup.py (path:/tmp/pip-VeaEZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:29:44 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:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:29:44 INFO - Running setup.py (path:/tmp/pip-XjyBI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:29:45 INFO - Running setup.py (path:/tmp/pip-07U5fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:29:45 INFO - Running setup.py (path:/tmp/pip-FlUW5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:29:45 INFO - Running setup.py (path:/tmp/pip-QLw9sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:29:45 INFO - Running setup.py (path:/tmp/pip-GlQ35K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:29:45 INFO - Running setup.py (path:/tmp/pip-D7qnFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:29:45 INFO - Running setup.py (path:/tmp/pip-YrV6rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:29:45 INFO - Running setup.py (path:/tmp/pip-wmfGVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:29:45 INFO - Running setup.py (path:/tmp/pip-h_P1LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:29:45 INFO - Running setup.py (path:/tmp/pip-rPXS83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:29:45 INFO - Running setup.py (path:/tmp/pip-1zbBfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:29:45 INFO - Running setup.py (path:/tmp/pip-3V2urC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:29:45 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:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:45 INFO - Running setup.py (path:/tmp/pip-_xTEeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:29:45 INFO - Running setup.py (path:/tmp/pip-bxD9z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:29:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:29:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:29:45 INFO - Running setup.py (path:/tmp/pip-fwd7Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:29:46 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:29:46 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:29:46 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:29:46 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:29:46 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:29:46 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:29:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:47 INFO - Downloading blessings-1.6.tar.gz 10:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:29:48 INFO - Installing collected packages: blessings 10:29:48 INFO - Running setup.py install for blessings 10:29:48 INFO - Successfully installed blessings 10:29:48 INFO - Cleaning up... 10:29:48 INFO - Return code: 0 10:29:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:48 INFO - Reading from file tmpfile_stdout 10:29:48 INFO - Current package versions: 10:29:48 INFO - argparse == 1.2.1 10:29:48 INFO - blessings == 1.6 10:29:48 INFO - blobuploader == 1.2.4 10:29:48 INFO - docopt == 0.6.1 10:29:48 INFO - functools32 == 3.2.3-2 10:29:48 INFO - jsonschema == 2.5.1 10:29:48 INFO - manifestparser == 1.1 10:29:48 INFO - mozInstall == 1.12 10:29:48 INFO - mozcrash == 0.17 10:29:48 INFO - mozdebug == 0.1 10:29:48 INFO - mozdevice == 0.48 10:29:48 INFO - mozfile == 1.2 10:29:48 INFO - mozhttpd == 0.7 10:29:48 INFO - mozinfo == 0.9 10:29:48 INFO - mozleak == 0.1 10:29:48 INFO - mozlog == 3.4 10:29:48 INFO - moznetwork == 0.27 10:29:48 INFO - mozprocess == 0.23 10:29:48 INFO - mozprofile == 0.28 10:29:48 INFO - mozrunner == 6.12 10:29:48 INFO - mozscreenshot == 0.1 10:29:48 INFO - mozsystemmonitor == 0.3 10:29:48 INFO - moztest == 0.7 10:29:48 INFO - mozversion == 1.4 10:29:48 INFO - psutil == 3.1.1 10:29:48 INFO - requests == 1.2.3 10:29:48 INFO - wsgiref == 0.1.2 10:29:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:48 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 0x7f7b2c8f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', '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:29:48 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:29:48 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:29:48 INFO - Using env: {'DISPLAY': ':0', 10:29:48 INFO - 'HOME': '/home/cltbld', 10:29:48 INFO - 'LANG': 'en_US.UTF-8', 10:29:48 INFO - 'LANGUAGE': 'en_US:en', 10:29:48 INFO - 'LOGNAME': 'cltbld', 10:29:48 INFO - 'MAIL': '/var/mail/cltbld', 10:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:48 INFO - 'MOZ_NO_REMOTE': '1', 10:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:48 INFO - 'NO_EM_RESTART': '1', 10:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:48 INFO - 'PWD': '/builds/slave/test', 10:29:48 INFO - 'SHELL': '/bin/bash', 10:29:48 INFO - 'SHLVL': '1', 10:29:48 INFO - 'TERM': 'linux', 10:29:48 INFO - 'TMOUT': '86400', 10:29:48 INFO - 'USER': 'cltbld', 10:29:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:48 INFO - '_': '/tools/buildbot/bin/python'} 10:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:48 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:29:48 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:29:48 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:29:48 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:29:48 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:29:48 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:29:48 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:29:48 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:29:48 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:29:48 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:29:48 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:29:48 INFO - Cleaning up... 10:29:48 INFO - Return code: 0 10:29:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b2c8f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11bc790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', '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:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:29:48 INFO - Using env: {'DISPLAY': ':0', 10:29:48 INFO - 'HOME': '/home/cltbld', 10:29:48 INFO - 'LANG': 'en_US.UTF-8', 10:29:48 INFO - 'LANGUAGE': 'en_US:en', 10:29:48 INFO - 'LOGNAME': 'cltbld', 10:29:48 INFO - 'MAIL': '/var/mail/cltbld', 10:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:48 INFO - 'MOZ_NO_REMOTE': '1', 10:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:48 INFO - 'NO_EM_RESTART': '1', 10:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:48 INFO - 'PWD': '/builds/slave/test', 10:29:48 INFO - 'SHELL': '/bin/bash', 10:29:48 INFO - 'SHLVL': '1', 10:29:48 INFO - 'TERM': 'linux', 10:29:48 INFO - 'TMOUT': '86400', 10:29:48 INFO - 'USER': 'cltbld', 10:29:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:48 INFO - '_': '/tools/buildbot/bin/python'} 10:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:29:48 INFO - Cleaning up... 10:29:48 INFO - Return code: 0 10:29:48 INFO - Running post-action listener: _resource_record_post_action 10:29:48 INFO - Running post-action listener: _start_resource_monitoring 10:29:48 INFO - Starting resource monitoring. 10:29:48 INFO - [mozharness: 2016-11-08 18:29:48.937983Z] Finished create-virtualenv step (success) 10:29:48 INFO - [mozharness: 2016-11-08 18:29:48.938498Z] Running install step. 10:29:48 INFO - Running pre-action listener: _resource_record_pre_action 10:29:48 INFO - Running main action method: install 10:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:49 INFO - Reading from file tmpfile_stdout 10:29:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:29:49 INFO - Reading from file tmpfile_stdout 10:29:49 INFO - Output received: 10:29:49 INFO - Usage: mozinstall [options] installer 10:29:49 INFO - Options: 10:29:49 INFO - -h, --help show this help message and exit 10:29:49 INFO - -d DEST, --destination=DEST 10:29:49 INFO - Directory to install application into. [default: 10:29:49 INFO - "/builds/slave/test"] 10:29:49 INFO - --app=APP Application being installed. [default: firefox] 10:29:49 INFO - mkdir: /builds/slave/test/build/application 10:29:49 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:29:49 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:30:06 INFO - Reading from file tmpfile_stdout 10:30:06 INFO - Output received: 10:30:06 INFO - /builds/slave/test/build/application/firefox/firefox 10:30:06 INFO - Running post-action listener: _resource_record_post_action 10:30:06 INFO - [mozharness: 2016-11-08 18:30:06.175828Z] Finished install step (success) 10:30:06 INFO - [mozharness: 2016-11-08 18:30:06.176070Z] Running run-tests step. 10:30:06 INFO - Running pre-action listener: _resource_record_pre_action 10:30:06 INFO - Running main action method: run_tests 10:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:30:06 INFO - Python 2.7.3 10:30:06 INFO - Return code: 0 10:30:06 INFO - grabbing minidump binary from tooltool 10:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b9930>, '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 0x11ba830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bacc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:30:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:30:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:30:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:30:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:30:06 INFO - Return code: 0 10:30:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:30:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:30:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:30:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:30:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:30:06 INFO - Using env: {'DISPLAY': ':0', 10:30:06 INFO - 'HOME': '/home/cltbld', 10:30:06 INFO - 'LANG': 'en_US.UTF-8', 10:30:06 INFO - 'LANGUAGE': 'en_US:en', 10:30:06 INFO - 'LOGNAME': 'cltbld', 10:30:06 INFO - 'MAIL': '/var/mail/cltbld', 10:30:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:30:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:30:06 INFO - 'MOZ_NO_REMOTE': '1', 10:30:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:30:06 INFO - 'NO_EM_RESTART': '1', 10:30:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:30:06 INFO - 'PWD': '/builds/slave/test', 10:30:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:30:06 INFO - 'SHELL': '/bin/bash', 10:30:06 INFO - 'SHLVL': '1', 10:30:06 INFO - 'TERM': 'linux', 10:30:06 INFO - 'TMOUT': '86400', 10:30:06 INFO - 'USER': 'cltbld', 10:30:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382', 10:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:30:06 INFO - '_': '/tools/buildbot/bin/python'} 10:30:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:30:06 INFO - mozversion application_buildid: 20161108073206 10:30:06 INFO - mozversion application_changeset: aea5b4c3d165dcde027b3b6551b146a56748e9be 10:30:06 INFO - mozversion application_display_name: Nightly 10:30:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:30:06 INFO - mozversion application_name: Firefox 10:30:06 INFO - mozversion application_remotingname: firefox 10:30:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:30:06 INFO - mozversion application_vendor: Mozilla 10:30:06 INFO - mozversion application_version: 52.0a1 10:30:06 INFO - mozversion platform_buildid: 20161108073206 10:30:06 INFO - mozversion platform_changeset: aea5b4c3d165dcde027b3b6551b146a56748e9be 10:30:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:30:06 INFO - mozversion platform_version: 52.0a1 10:30:06 INFO - using testdate: 1478629806 10:30:06 INFO - actual date: 1478629806 10:30:06 INFO - starting webserver on 'localhost:44661' 10:30:06 INFO - SUITE-START | Running 2 tests 10:30:06 INFO - TEST-START | dromaeo_css 10:30:06 INFO - operating with platform_type : linux_ 10:30:06 INFO - Initialising browser for dromaeo_css test... 10:30:06 INFO - TEST-INFO | started process 1070 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyVyyLG/profile http://localhost:44661/getInfo.html) 10:30:10 INFO - PROCESS | 1070 | __metrics Screen width/height:1600/1200 10:30:10 INFO - PROCESS | 1070 | colorDepth:24 10:30:10 INFO - PROCESS | 1070 | Browser inner width/height: 1024/697 10:30:10 INFO - PROCESS | 1070 | __metrics 10:30:10 INFO - PROCESS | 1070 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:30:10 INFO - PROCESS | 1070 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:30:11 INFO - PROCESS | 1070 | console.error: PushService: 10:30:11 INFO - PROCESS | 1070 | stateChangeProcessEnqueue: Error transitioning state 10:30:11 INFO - PROCESS | 1070 | UnknownError 10:30:12 INFO - TEST-INFO | 1070: exit 0 10:30:12 INFO - Browser initialized. 10:30:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:30:12 INFO - TEST-INFO | started process 1220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyVyyLG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:24 INFO - PROCESS | 1220 | RSS: Main: 173047808 10:30:24 INFO - PROCESS | 1220 | 10:31:15 INFO - PROCESS | 1220 | 1478629875629 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:33:26 INFO - PROCESS | 1220 | Cycle 1(1): loaded http://localhost:44661/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44661/tests/dromaeo/cssquery-ext.html) 10:33:28 INFO - PROCESS | 1220 | RSS: Main: 360591360 10:33:28 INFO - PROCESS | 1220 | 10:36:31 INFO - PROCESS | 1220 | Cycle 1(1): loaded http://localhost:44661/tests/dromaeo/cssquery-ext.html (next: http://localhost:44661/tests/dromaeo/cssquery-jquery.html) 10:36:32 INFO - PROCESS | 1220 | RSS: Main: 275578880 10:36:32 INFO - PROCESS | 1220 | 10:39:34 INFO - PROCESS | 1220 | Cycle 1(1): loaded http://localhost:44661/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44661/tests/dromaeo/cssquery-mootools.html) 10:39:34 INFO - PROCESS | 1220 | RSS: Main: 216190976 10:39:34 INFO - PROCESS | 1220 | 10:42:36 INFO - PROCESS | 1220 | Cycle 1(1): loaded http://localhost:44661/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44661/tests/dromaeo/cssquery-prototype.html) 10:42:37 INFO - PROCESS | 1220 | RSS: Main: 254812160 10:42:37 INFO - PROCESS | 1220 | 10:45:40 INFO - PROCESS | 1220 | Cycle 1(1): loaded http://localhost:44661/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44661/tests/dromaeo/cssquery-yui.html) 10:45:40 INFO - PROCESS | 1220 | RSS: Main: 218636288 10:45:40 INFO - PROCESS | 1220 | 10:48:44 INFO - PROCESS | 1220 | Cycle 1(1): loaded http://localhost:44661/tests/dromaeo/cssquery-yui.html (next: http://localhost:44661/tests/dromaeo/cssquery-dojo.html) 10:48:44 INFO - PROCESS | 1220 | RSS: Main: 301338624 10:48:44 INFO - PROCESS | 1220 | 10:48:44 INFO - PROCESS | 1220 | __start_tp_report 10:48:44 INFO - PROCESS | 1220 | _x_x_mozilla_page_load 10:48:44 INFO - PROCESS | 1220 | _x_x_mozilla_page_load_details 10:48:44 INFO - PROCESS | 1220 | |i|pagename|runs| 10:48:44 INFO - PROCESS | 1220 | |0;dojo.html;3086.274725439522;3110.782245242834;3137.231378312313;3147.228928912417;3151.0704342219055;5308.70802105884;5388.137897936331;5441.993231252216;5492.670439773611;5533.418991005947;5397.136458166694;5403.081476149055;5411.83764487065;5413.945860541394;5416.756245968931;4867.245576935581;4887.975560122212;4904;4936.679115857458;4937.308776771255;4978.327925730035;5056.140456122468;5058.822941197059;5060.0132974070075;5061.139606266925;4899.6815207011605;4979.45226025137;5001.324821149153;5003.04942061009;5044.142495775709;5017.422996355393;5046.419661738892;5067.189249720064;5074.82238121664;5123.615728820316;4819.710817350935;4864.902701945941;4880.072786170652;4963.230699241623;4969.925451118236;5436.456354364532;5440.4287549807495;5451.291332126798;5453.15476101205;5556.972215138939;5828.825135245949;5865.120231965197;5867.442592953663;5870.6477611343025;5870.911936320916;5731.942680573183;5834.445727655866;5864.824055278305;5917.230760001173;5924.911126333109;5496.972515137439;5551.278333816578;5557.527610153183;5603.46767057133;5608.69152196625;6027.547933904974;6031.939680603138;6041.124037014608;6041.486473649789;6043.09353596964;5617.297837770278;5656.8020119295625;5796.21751063601;5798.797042103506;5803.47768700819;5747.798827041033;5767.740451679684;5799.623024503394;5828.358880523139;5879.52963762898;5749.252597162425;5752.712364381764;5809.448102430262;5811.854703632443;5873.2658417697785;5693.202951586781;5827.5920685552455;5830.53355731549;5831;5831.358550559435;4425.889352766207;4445.955540444555;4469.351943968171;4481.708688935274;4483.058557702919;4006.7595944242858;4018.819153138116;4029.0531725044593;4048.7570745755347;4049.149678567475;5615.0454422748235;5616.522595579339;5621.128725047624;5621.494065534122;5672.97163514188;5762.625429347079;5810.709464526757;5835;5879.412058794172;5906.645601263938;5624.268845050117;5626.212330273765;5630.746616402272;5648.548116150698;5665.631733937364;5058.4435712071645;5083.644144909895;5093.465186155475;5097.949020509747;5145.22821576759;5954.404559544011;5969.403059694169;6039.879202416015;6079.088136779607;6129.570930034854;5801.941980580309;5850.385709500441;5858.765649374148;5883.117532370179;5895.380984996514;6037.969810150921;6040.335563088145;6050.364711705208;6051.183090282755;6053.0617754246405;5563.082091454865;5612.074007788669;5709.543236540983;5710.600257982068;5712.971435142797;5712.285964254468;5752.884942301214;5755.7409916553015;5788.942110578841;5840.707964601838;5614;5628.099504079328;5672.829815105553;5681.460261275172;5694;5598;5679.460451257124;5689.971550142222;5692.459216374438;5693.743781529758;5605.775768969195;5666.376698563237;5689.2319536862;5693.5445164387575;5700.116481945305;5646;5726.169705392612;5734.655920644775;5736.483716465538;5764.884702305846;5471.562275017909;5503.449655034465;5509.779608815603;5657.632253903483;5668.404817494104 10:48:44 INFO - PROCESS | 1220 | |1;ext.html;538.7579807120807;594.088074805174;608.4645511949484;627.8273474794431;636.1729751323279;31544.52683209751;40806;41272.793636031856;41458.58541414585;41510.58489415105;42352.57647423525;42692.35961460573;42774.786126069324;42825.57174428255;42848.14303713924;7712.267334603232;7908.960455197716;8541.4448060876;8682.175193356621;8686.695965641204;9963.202943764481;10232.693019209435;10233.079022887938;10527.473626318653;10535.26253162279;10404.323718958243;10466.58133674656;10472.58109675616;10497.632582859602;10499.370037797757;10269.537870795832;10270.486475676187;10278.588856445733;10324.070833624972;10325.225608079425;10184.38893666375;10249.07758301749;10254.487275636264;10255.948720256425;10256.282060255711;37893.62106378929;37989.62010379889;38244;38251.42622860659;38416.23167536633;3342.5821772278464;3355.748318876094;3444.9827750861336;3560.608333083359;3565.9108522286892;30543.847280763675;30689.846550767328;30724.463776811295;30863.845680771454;30997.22506937322;3982.542007669097;4098.610631989956;4109.3425051991535;4153.771542565158;4263.59495847894;241147;241402;242074;243652;311693.44153279316;55087.72456137774;55920;55997;56016.71991640097;56048.719756400955;58718.706406467696;58805.70597146987;58891.28869690414;58929;58931;14961;15030.398784048515;15041.924790375979;15042.774358384633;15048;11777.293362398283;12137.393130343447;12646.430910609044;12671.746565068646;12712.42794074269;16194.190290485429;16479.258433370527;16612.667746645;16822.831771682373;16905.408310709066;5910.408959104141;5985.834590371924;6066.464418138896;6107.572469927151;6142.232220972379;911.4303560274828;986.3884391677062;999.1956475037664;1001.2640709078821;1020.6580795433613;30338.848305758773;30407.543886841715;30527.69472305293;30891.38217235643;31068.223294417367;1037.678319720889;1080.7676349584876;1090.6564432203988;1098.9230753847314;1162.0993729859258;15891.046537207805;16229.107399092927;16289.429869954494;16296.34814607426;16490.505284841474;451792;453238;453484;454019;455181;54757.72621136948;54887;54951;54996.45003549913;55086.72456637691;1209.6008317255285;1259.8551166615773;1274.1972557288848;1337.7926421404698;1348.164138234301;27958.580621291105;30970.84514577413;31178.688213118487;33127.83436082804;33532.32935341231;52717.47282527279;53319.73340133274;53381.46618533765;53458.198127027346;53539.73230133824;425024;425821;427646;429142;430756;34238.31523369469;35225.471617925235;38857.417138743505;39139;39716.60283397244;41982.37026444667;44090.779546102065;44198.337024944005;48870.51129488659;49130;38240;38545.6145438542;39113.80443097766;39178.4123238146;40361.39457908193;38611.227775444895;38822.80588597039;39232.607673922896;39368.21263574655;40890.38664420095;38656.6134338653;38757.6124238754;38940.41589376218;39831.601683982786;39987;32062.83968580142;34684;34723;35550;35756;26690;27025.1892443227;27131.42574012139;27311;27435 10:48:44 INFO - PROCESS | 1220 | |2;jquery.html;384.778752217475;393.15667892370885;395.6933376633109;396.41726661807144;418.63787823532635;14376.281185940714;16631.750523742154;17929.820701792978;19561.90219048906;19576.11907464164;14909.32908019139;16755;17950.56395488361;18217.36239231627;18356.17397217125;4714.976425117869;4995.825146119886;5003.724795136266;5014.548690617844;5018;4995.400551933773;5027.949720502785;5028.547430731233;5037.773300201499;5039.697618142924;4818.518148185171;4967.826126085588;4985.775640096204;4994.225894986283;5002.59979201663;4987.551120399164;5017.974910125426;5031.496850314939;5031.823886163985;5033.471485494026;4843.806247750086;5106.591472682177;5144.356955380577;5210.244514545369;5221.2951251580935;11988.64034078979;12198.573049943298;12222.144449888512;20849.791502084936;22406.215782447536;2174.3911704722705;2223.188536184281;2239.1715065425733;2252.245497758253;2345.953080938372;8918.063603321623;9009.864852027225;9060.909390906072;9254.722358329194;9538.284628652878;1703.9062851543283;1756.8331008554167;1807.3945228348518;1818.209079050604;1828.1316374722035;74588;76577;77639.6118019412;78558.6072069636;78923.60538197329;10348.586056557653;10366.740831479123;10518.211134164816;10779.730506737238;10785.56857725698;14618.926905365404;14644.707105857824;14665.486707965383;14671.486497972519;14725.631859203606;7147.2852714728115;7554.093508778982;7573.2048134945035;7814;8077;7029.22678505364;7542.698292068366;7578.848423031509;7715.614219289126;7716.537007779439;4400.845970391021;4450.376947227391;4473.731576105444;4508.534726213994;4525.502194758574;1729.4725108841671;1780.4658602419222;1812.4019073705645;1838.0534024977148;1883.7739471263535;854.3293514591016;924.5377311344328;955.9330846840794;994.557421947241;1012.7265638277623;17714.468565943043;18583.72124418135;18771.812281877006;18949;19225.03874806254;926.9397489163183;962.4399098398367;963.2534785541261;984.1487113646788;1009.2128140050772;9663.516824158763;10139.138173255209;10310.473933886246;10353.61866770632;10428.37429754202;441355;444929;451084;452195;452280;86778;87056;87643.56178219196;87707;90653.09346906446;1015.9695209143738;1044.1959691037857;1068.326954018963;1071.6249312740479;1073.7047311989108;15643.921780391025;15690.843091569395;16170.434034808724;16289.266982985557;16711.164441778106;41020.589794101674;41738.37392439055;41886.16227675368;41886.581134188265;42591.14817703567;47060.29409558791;52204;52623;54979;55108.44891551194;5687.43125687428;7339.458713670189;7557.962210188914;7755.6509957053195;8184.54984975832;10604.734881628021;12932.676683082998;13156.342182891009;13165.802512962506;13668.65828354299;11389.715257118638;11414.771704566028;11476;11539.249948753304;11681.532738690697;11267.380294083903;11387.658370248906;11429.371384573928;11500.769984600094;11548;11057.281276716987;11090.500927458123;11460.541578336773;11532.94233528827;12045.939770301093;7412.1846596875375;7662.463627546018;7716.652750626347;7891;7917.089534703583;10553.472326383804;11099.056580190774;11104.833427498432;11516.366599836754;11639.301641901513 10:48:44 INFO - PROCESS | 1220 | |3;mootools.html;1442.1635451438167;1471.4334981032302;1603.9759403608948;1699.898006119632;1755.9648807023868;7489.812754681136;7729.61351932404;7997.120316765158;8551.74344769658;8556.91443085569;7741.458097933147;7986.321162701177;7999.640016199271;8170.060443049051;8184;2272.000319859265;2299.7815207555254;2300.309907027893;2301.838871279011;2314.456102815837;2009.487580666928;2072.367927782026;2273.7044184256106;2323.848949818265;2345.7654234576576;2260.389694782408;2325.500017496238;2334.6264597664376;2343.988280058606;2345.4019225097577;2339.801116905065;2342.227065068523;2359.1978727232654;2363.0902102690416;2365.7752513511273;2247.179779380531;2248.460369511322;2266.7506574276817;2273.2157405695007;2299.8045166160896;8550.273226775731;8600.5699715014;8658.826823463496;8665.43674661145;8675.609597568124;5186.7925282988635;5327.627066105374;5330.493603107699;5331;5336;3326.6839650233433;3336.1317662109295;3362.3611513812543;3407.2333724911946;3409.590849098099;1072.1208608940672;1077.7736675298197;1102.211918478284;1103.3545375955075;1125.2292179856825;11690.298582085103;11710.824337634942;11722.765544689144;11741.119416043832;11765.11761617882;4409.559044095565;4559.088182363541;4620.699654522446;4653.95346046542;4802.375691160127;10030.498475076218;10057.346272492265;10062.144717699077;10066.144377727975;10072.899271007343;5304.9734751326;5308.283381743415;5308.46915308466;5309.3894202166475;5313.415524292324;4628;4797.328374027639;4835.371401717754;4849.927251091236;4860.4896485869185;3846.8845934621445;3938.074552480165;3950.170464202492;4018.9799051005143;4154.335306350969;1161.361251311775;1194.952201911931;1239.6157191270736;1311.5344052861287;1322.4247452358254;881.6605606841284;950.1923365139576;958.7794807194244;961.5721004153085;977.731123940922;5663.263775709213;5801.6519008859605;5819.359870414251;5867.677277749679;6069.302030266487;879.4064006795516;896.1083721696954;901.378049146087;964.5563041001078;972.5884407418567;4010.979945100256;4195.601417865298;4205;4232.809523571446;4377.124575084996;10305.175585953106;10668.359898406121;10670.30643008202;10670.57317707283;10671.679849604525;9391.295652826066;9573.760655983517;10647.787044259227;10663.786724265472;10669.83995240072;7570.848583028309;7746.147923728386;7748.22517748232;7752.224777522202;7753.883691744629;5670.149477578396;5671.631343962629;5746.683932383592;5836.620619659709;5908.675022873783;9284.210842078499;9377.484238366955;9381.85927211106;9467.289953253396;9474.099960503741;9487.72294649293;9899.307048506535;9965.302428829913;9968.850467242852;9969.601215951281;7598.924010759822;7726.768196953875;7761.185075566984;7765;7771.961140194263;7827.882581761392;8163.79590510242;8177.550234736908;8241.752747417588;8254.092049874629;6006.699665016644;7446.367058800062;7479;7577.5453472791805;7829.647665855164;7343.963280183565;7402.259774022555;7424.888626670496;7477.140128885248;7483.625818709152;6556.147700798866;6696.7656132035145;6729.764458243938;6751.257361690308;6835.658217089225;5040.697558146523;5065.442801291929;5140.023395554833;5188.429272780067;5297.5232229099565;4941.805379636307;4991.850244492671;5042.520960508746;5158.38099428071;5218.66078704883 10:48:44 INFO - PROCESS | 1220 | |4;prototype.html;321.959755030621;324.48892993535185;332.08179384003233;334.26461784075025;336.13110110364704;5091.719955402451;5203.895922081556;5207.255569384256;5257.868553286165;5293.311869456975;5076.898462030757;5218.19118036704;5223.555997740187;5226.294450249225;5247.895042099156;4156.875293741193;4160.355144952538;4163.585120630028;4175.749455032693;4187.330027195657;3925.9018524536827;4122.340425531916;4172.853950111731;4185.727927684706;4186.597489840907;4086.509618845743;4099.405586190015;4109.849242212185;4114.753114813121;4118.361653943643;4057.1885622875247;4075.735077219971;4085.7140000199997;4090.650085471787;4120.196561670476;3633.8728144514816;3636.9816451393654;3650.945235821465;3661;3667.2665466906724;5099.15863882459;5114.514121158484;5121.334226550562;5124.769385377667;5146.275997540828;4639.304104384336;4651.976740116278;4660.813567457298;4681.321208424793;4711.95288047122;5504.055330398218;5507.201455788928;5509.146082357201;5513.889722205574;5577.581681373913;3772.8868133956025;3930.78380689062;3932.6460618544183;3932.744371615836;3936.311145549546;5644.322681278273;5667.433256674341;5687.43125687428;5702.116171993306;5735.913961290584;4037.6971727120585;4042.3936409538805;4048.8987775305854;4049.9595004049584;4061.472008638858;3909.237698648793;4001.659858912025;4011.4584531088512;4040.7573796542615;4088.9386659200136;4597.747123908217;4613.907721845611;4613.93079103807;4621.838235661736;4622.815087396534;5457.645253058538;5481.616286859961;5490.380337800359;5518;5571.749271282802;1273.6497463197695;1282.4870051979096;1298.7597294500547;1343.2142196814973;1357.927237482378;905.2441211588266;939.3706216834737;943.9474985391239;950.6625148072472;957.3920560444168;5200.375954885438;5203.2195170723935;5210.921836172461;5224.216367544898;5251.737413129405;5393.5954803389905;5431.51116399518;5434.809781657623;5438.700871452108;5455.427180146107;4936.2102063669645;5185.585153187736;5189.6886186828915;5201.297824793604;5206.557442617344;2835.4546772009303;2853.885844566194;2862.012605651047;2871.6697579778593;2873.5976963225166;5531.225628412026;5549.472800083986;5597.860053498695;5621.550275977912;5714.257146570919;5194.662346947436;5491.890162196733;5498.45015498455;5505.834824955257;5516.5521549031855;5600.915986260128;5611.9438805612235;5621.4378562144275;5630.38187242934;5632.971835140798;5288.338957630296;5312.36251649789;5377.623566350318;5420.376656684532;5472.179173124063;5308.434011966557;5406.080966235828;5408.64783804049;5414.889947560662;5416.9729151353995;5514.779408823602;5519.2824932758485;5557.221988921635;5567.4432556744005;5622.746976385991;3804.2962052019357;3878.9526827755785;3951.8934698284525;3955.861544845917;3960.168364643342;5395.13677811564;5670.8015219467125;5671.298610416941;5678.290213723285;5679.9148012779015;5430.484104010113;5456.863578410572;5522.337319521523;5553.305836770403;5571.9721401392735;5492.780288788404;5530.557555395479;5568.777248909998;5586.413426590149;5601.439856014366;5383;5492.011437941209;5535.7785688572;5560.416156303691;5566.165075238747;5602.067286786052;5609.326880774333;5646.971765141148;5648.237487939075;5652.265205523256;5529.474699903502;5535.197396377584;5542.75057622416;5549.944500555104;5576.944230557642 10:48:44 INFO - PROCESS | 1220 | |5;yui.html;682.7610336382266;711.530389942638;737.5611511150867;773.7794728502378;797.0674311056064;13556.661083472905;14041.017128800975;14295.714085718306;14431.783523247133;14814.333354999024;12834.80747788784;13074.084814063019;13181.143225690348;13189.736205275889;13227.801582976263;770.4298818874034;792.7383963292128;792.8889955406248;793.7499687598388;794.5232860283842;660.7753363856287;676.9966150169267;770.437580566187;792.1484404265437;795.7652492514723;825.6490991328691;828.5857071464268;828.6436832162168;829.5396055189367;829.8049958259804;824.8927639406899;825.5253229393123;825.8885050518163;826.7147833997261;828.2793969246763;505.6713136461293;519.5428023339475;520.731823111098;521.2259794205602;589.7552515705977;12911.225326480348;13497.190168589817;13506.93246533761;13511.594652160451;13515.526956556572;12050.216735912138;12350.5059797608;12462.189957652723;12561.811572826415;12732.681682957907;11764.764704705944;11815.645530634094;11985.880141198564;12192.634220973385;12252.509899604005;4077.2864748668862;4104.445899803518;4159.209750147463;4236.68224883135;4337.0458499130145;64778;65126.348736512504;65212;65896.67051664759;67650.66174669095;10343.935610319015;10354.948225258826;10424.895751042544;10581.788364232827;10755.78488430227;18799.718004229948;18816.52958676044;18975.71536426955;18978.81021189798;19097.618047639247;6991.650417479207;7110.288971102848;7116.288371162842;7190.316919892602;7269.927986093867;4147.357159640261;4164.68764842638;4237.724547904438;4273.786310684453;4358.847440339573;3358.429067058606;3443.362977849106;3446.8621255150015;3446.879359222415;3448.2758620689433;589.5548860610212;599.5713065158345;608.9512838972871;609.9939000610026;634.9428551430301;536.5948708724887;590.0912594604347;594.913737508059;611.9541034422436;636.0409937392911;7977.441579089524;8432.831343373098;8696;8781.648734050694;8833.911660883308;539.7490167072331;564.8644325361965;592.5230189697335;595.624756403463;636.5448704176536;3944.723869329119;4180.770057646859;4199.139176468817;4242.893927651771;4289.196900543488;84409.57795210984;84997.15002849893;85951.57024214964;87678.56160719156;91343.54328228449;74060;75407;76578.61710691522;77812.61093694609;78620;54758;56251.15623265654;57111.714441427524;62019.37980620136;69474;8112.797180070545;8227.547484888388;8756.192127899141;8902.70283710853;8999.730008099768;44121.55878441175;44137.33793993029;45455.772721136185;45777;46026;54165.18752218641;56906;61284;61855;63282.36717632765;11411.771764564828;11546.364949927834;11594.942025290156;12171.939140304241;12302.507899684271;12325.260484370609;12355.135140540076;12456.501739930301;13228.47086116583;13348.065635405817;12456.875431245933;12513.624591262276;12521.060920430822;13228.47086116583;13399.665008374868;11750.973927183557;12303.93848030754;12306.87693123093;12370.651215392558;12580.748385032432;11513.251638643462;12497.25016499013;12759.170653907466;12995.350232488148;13272.070955033056;10309.278350515691;10555.472226388496;10566.630167944086;10875.836862447228;10976.396298203676;10320.845187322046;10724;10777.353358798497;10973.670789876316;11017 10:48:44 INFO - PROCESS | 1220 | __end_tp_report 10:48:44 INFO - PROCESS | 1220 | __start_cc_report 10:48:44 INFO - PROCESS | 1220 | _x_x_mozilla_cycle_collect,1879 10:48:44 INFO - PROCESS | 1220 | __end_cc_report 10:48:44 INFO - PROCESS | 1220 | __startTimestamp1478630924275__endTimestamp 10:48:44 INFO - PROCESS | 1220 | 10:48:44 INFO - PROCESS | 1220 | ------- Summary: start ------- 10:48:44 INFO - PROCESS | 1220 | Number of tests: 6 10:48:44 INFO - PROCESS | 1220 | 10:48:44 INFO - PROCESS | 1220 | [#0] dojo.html Cycles:165 Average:5428.56 Median:5646.00 stddev:612.32 (10.8%) stddev-sans-first:585.98 10:48:44 INFO - PROCESS | 1220 | Values: 3086.3 3110.8 3137.2 3147.2 3151.1 5308.7 5388.1 5442.0 5492.7 5533.4 5397.1 5403.1 5411.8 5413.9 5416.8 4867.2 4888.0 4904.0 4936.7 4937.3 4978.3 5056.1 5058.8 5060.0 5061.1 4899.7 4979.5 5001.3 5003.0 5044.1 5017.4 5046.4 5067.2 5074.8 5123.6 4819.7 4864.9 4880.1 4963.2 4969.9 5436.5 5440.4 5451.3 5453.2 5557.0 5828.8 5865.1 5867.4 5870.6 5870.9 5731.9 5834.4 5864.8 5917.2 5924.9 5497.0 5551.3 5557.5 5603.5 5608.7 6027.5 6031.9 6041.1 6041.5 6043.1 5617.3 5656.8 5796.2 5798.8 5803.5 5747.8 5767.7 5799.6 5828.4 5879.5 5749.3 5752.7 5809.4 5811.9 5873.3 5693.2 5827.6 5830.5 5831.0 5831.4 4425.9 4446.0 4469.4 4481.7 4483.1 4006.8 4018.8 4029.1 4048.8 4049.1 5615.0 5616.5 5621.1 5621.5 5673.0 5762.6 5810.7 5835.0 5879.4 5906.6 5624.3 5626.2 5630.7 5648.5 5665.6 5058.4 5083.6 5093.5 5097.9 5145.2 5954.4 5969.4 6039.9 6079.1 6129.6 5801.9 5850.4 5858.8 5883.1 5895.4 6038.0 6040.3 6050.4 6051.2 6053.1 5563.1 5612.1 5709.5 5710.6 5713.0 5712.3 5752.9 5755.7 5788.9 5840.7 5614.0 5628.1 5672.8 5681.5 5694.0 5598.0 5679.5 5690.0 5692.5 5693.7 5605.8 5666.4 5689.2 5693.5 5700.1 5646.0 5726.2 5734.7 5736.5 5764.9 5471.6 5503.4 5509.8 5657.6 5668.4 10:48:44 INFO - PROCESS | 1220 | 10:48:44 INFO - PROCESS | 1220 | [#1] ext.html Cycles:180 Average:54526.64 Median:38114.81 stddev:102969.10 (270.2%) stddev-sans-first:103178.17 10:48:44 INFO - PROCESS | 1220 | Values: 538.8 594.1 608.5 627.8 636.2 31544.5 40806.0 41272.8 41458.6 41510.6 42352.6 42692.4 42774.8 42825.6 42848.1 7712.3 7909.0 8541.4 8682.2 8686.7 9963.2 10232.7 10233.1 10527.5 10535.3 10404.3 10466.6 10472.6 10497.6 10499.4 10269.5 10270.5 10278.6 10324.1 10325.2 10184.4 10249.1 10254.5 10255.9 10256.3 37893.6 37989.6 38244.0 38251.4 38416.2 3342.6 3355.7 3445.0 3560.6 3565.9 30543.8 30689.8 30724.5 30863.8 30997.2 3982.5 4098.6 4109.3 4153.8 4263.6 241147.0 241402.0 242074.0 243652.0 311693.4 55087.7 55920.0 55997.0 56016.7 56048.7 58718.7 58805.7 58891.3 58929.0 58931.0 14961.0 15030.4 15041.9 15042.8 15048.0 11777.3 12137.4 12646.4 12671.7 12712.4 16194.2 16479.3 16612.7 16822.8 16905.4 5910.4 5985.8 6066.5 6107.6 6142.2 911.4 986.4 999.2 1001.3 1020.7 30338.8 30407.5 30527.7 30891.4 31068.2 1037.7 1080.8 1090.7 1098.9 1162.1 15891.0 16229.1 16289.4 16296.3 16490.5 451792.0 453238.0 453484.0 454019.0 455181.0 54757.7 54887.0 54951.0 54996.5 55086.7 1209.6 1259.9 1274.2 1337.8 1348.2 27958.6 30970.8 31178.7 33127.8 33532.3 52717.5 53319.7 53381.5 53458.2 53539.7 425024.0 425821.0 427646.0 429142.0 430756.0 34238.3 35225.5 38857.4 39139.0 39716.6 41982.4 44090.8 44198.3 48870.5 49130.0 38240.0 38545.6 39113.8 39178.4 40361.4 38611.2 38822.8 39232.6 39368.2 40890.4 38656.6 38757.6 38940.4 39831.6 39987.0 32062.8 34684.0 34723.0 35550.0 35756.0 26690.0 27025.2 27131.4 27311.0 27435.0 10:48:44 INFO - PROCESS | 1220 | 10:48:44 INFO - PROCESS | 1220 | [#2] jquery.html Cycles:180 Average:26807.55 Median:41379.48 stddev:74082.52 (179.0%) stddev-sans-first:74263.77 10:48:44 INFO - PROCESS | 1220 | Values: 384.8 393.2 395.7 396.4 418.6 14376.3 16631.8 17929.8 19561.9 19576.1 14909.3 16755.0 17950.6 18217.4 18356.2 4715.0 4995.8 5003.7 5014.5 5018.0 4995.4 5027.9 5028.5 5037.8 5039.7 4818.5 4967.8 4985.8 4994.2 5002.6 4987.6 5018.0 5031.5 5031.8 5033.5 4843.8 5106.6 5144.4 5210.2 5221.3 11988.6 12198.6 12222.1 20849.8 22406.2 2174.4 2223.2 2239.2 2252.2 2346.0 8918.1 9009.9 9060.9 9254.7 9538.3 1703.9 1756.8 1807.4 1818.2 1828.1 74588.0 76577.0 77639.6 78558.6 78923.6 10348.6 10366.7 10518.2 10779.7 10785.6 14618.9 14644.7 14665.5 14671.5 14725.6 7147.3 7554.1 7573.2 7814.0 8077.0 7029.2 7542.7 7578.8 7715.6 7716.5 4400.8 4450.4 4473.7 4508.5 4525.5 1729.5 1780.5 1812.4 1838.1 1883.8 854.3 924.5 955.9 994.6 1012.7 17714.5 18583.7 18771.8 18949.0 19225.0 926.9 962.4 963.3 984.1 1009.2 9663.5 10139.1 10310.5 10353.6 10428.4 441355.0 444929.0 451084.0 452195.0 452280.0 86778.0 87056.0 87643.6 87707.0 90653.1 1016.0 1044.2 1068.3 1071.6 1073.7 15643.9 15690.8 16170.4 16289.3 16711.2 41020.6 41738.4 41886.2 41886.6 42591.1 47060.3 52204.0 52623.0 54979.0 55108.4 5687.4 7339.5 7558.0 7755.7 8184.5 10604.7 12932.7 13156.3 13165.8 13668.7 11389.7 11414.8 11476.0 11539.2 11681.5 11267.4 11387.7 11429.4 11500.8 11548.0 11057.3 11090.5 11460.5 11532.9 12045.9 7412.2 7662.5 7716.7 7891.0 7917.1 10553.5 11099.1 11104.8 11516.4 11639.3 10:48:44 INFO - PROCESS | 1220 | 10:48:44 INFO - PROCESS | 1220 | [#3] mootools.html Cycles:180 Average:5615.71 Median:5187.61 stddev:3111.56 (60.0%) stddev-sans-first:3104.48 10:48:44 INFO - PROCESS | 1220 | Values: 1442.2 1471.4 1604.0 1699.9 1756.0 7489.8 7729.6 7997.1 8551.7 8556.9 7741.5 7986.3 7999.6 8170.1 8184.0 2272.0 2299.8 2300.3 2301.8 2314.5 2009.5 2072.4 2273.7 2323.8 2345.8 2260.4 2325.5 2334.6 2344.0 2345.4 2339.8 2342.2 2359.2 2363.1 2365.8 2247.2 2248.5 2266.8 2273.2 2299.8 8550.3 8600.6 8658.8 8665.4 8675.6 5186.8 5327.6 5330.5 5331.0 5336.0 3326.7 3336.1 3362.4 3407.2 3409.6 1072.1 1077.8 1102.2 1103.4 1125.2 11690.3 11710.8 11722.8 11741.1 11765.1 4409.6 4559.1 4620.7 4654.0 4802.4 10030.5 10057.3 10062.1 10066.1 10072.9 5305.0 5308.3 5308.5 5309.4 5313.4 4628.0 4797.3 4835.4 4849.9 4860.5 3846.9 3938.1 3950.2 4019.0 4154.3 1161.4 1195.0 1239.6 1311.5 1322.4 881.7 950.2 958.8 961.6 977.7 5663.3 5801.7 5819.4 5867.7 6069.3 879.4 896.1 901.4 964.6 972.6 4011.0 4195.6 4205.0 4232.8 4377.1 10305.2 10668.4 10670.3 10670.6 10671.7 9391.3 9573.8 10647.8 10663.8 10669.8 7570.8 7746.1 7748.2 7752.2 7753.9 5670.1 5671.6 5746.7 5836.6 5908.7 9284.2 9377.5 9381.9 9467.3 9474.1 9487.7 9899.3 9965.3 9968.9 9969.6 7598.9 7726.8 7761.2 7765.0 7772.0 7827.9 8163.8 8177.6 8241.8 8254.1 6006.7 7446.4 7479.0 7577.5 7829.6 7344.0 7402.3 7424.9 7477.1 7483.6 6556.1 6696.8 6729.8 6751.3 6835.7 5040.7 5065.4 5140.0 5188.4 5297.5 4941.8 4991.9 5042.5 5158.4 5218.7 10:48:44 INFO - PROCESS | 1220 | 10:48:44 INFO - PROCESS | 1220 | [#4] prototype.html Cycles:180 Average:4586.45 Median:5225.26 stddev:1344.31 (25.7%) stddev-sans-first:1309.42 10:48:44 INFO - PROCESS | 1220 | Values: 322.0 324.5 332.1 334.3 336.1 5091.7 5203.9 5207.3 5257.9 5293.3 5076.9 5218.2 5223.6 5226.3 5247.9 4156.9 4160.4 4163.6 4175.7 4187.3 3925.9 4122.3 4172.9 4185.7 4186.6 4086.5 4099.4 4109.8 4114.8 4118.4 4057.2 4075.7 4085.7 4090.7 4120.2 3633.9 3637.0 3650.9 3661.0 3667.3 5099.2 5114.5 5121.3 5124.8 5146.3 4639.3 4652.0 4660.8 4681.3 4712.0 5504.1 5507.2 5509.1 5513.9 5577.6 3772.9 3930.8 3932.6 3932.7 3936.3 5644.3 5667.4 5687.4 5702.1 5735.9 4037.7 4042.4 4048.9 4050.0 4061.5 3909.2 4001.7 4011.5 4040.8 4088.9 4597.7 4613.9 4613.9 4621.8 4622.8 5457.6 5481.6 5490.4 5518.0 5571.7 1273.6 1282.5 1298.8 1343.2 1357.9 905.2 939.4 943.9 950.7 957.4 5200.4 5203.2 5210.9 5224.2 5251.7 5393.6 5431.5 5434.8 5438.7 5455.4 4936.2 5185.6 5189.7 5201.3 5206.6 2835.5 2853.9 2862.0 2871.7 2873.6 5531.2 5549.5 5597.9 5621.6 5714.3 5194.7 5491.9 5498.5 5505.8 5516.6 5600.9 5611.9 5621.4 5630.4 5633.0 5288.3 5312.4 5377.6 5420.4 5472.2 5308.4 5406.1 5408.6 5414.9 5417.0 5514.8 5519.3 5557.2 5567.4 5622.7 3804.3 3879.0 3951.9 3955.9 3960.2 5395.1 5670.8 5671.3 5678.3 5679.9 5430.5 5456.9 5522.3 5553.3 5572.0 5492.8 5530.6 5568.8 5586.4 5601.4 5383.0 5492.0 5535.8 5560.4 5566.2 5602.1 5609.3 5647.0 5648.2 5652.3 5529.5 5535.2 5542.8 5549.9 5576.9 10:48:44 INFO - PROCESS | 1220 | 10:48:44 INFO - PROCESS | 1220 | [#5] yui.html Cycles:180 Average:17178.08 Median:44129.45 stddev:22980.99 (52.1%) stddev-sans-first:23012.07 10:48:44 INFO - PROCESS | 1220 | Values: 682.8 711.5 737.6 773.8 797.1 13556.7 14041.0 14295.7 14431.8 14814.3 12834.8 13074.1 13181.1 13189.7 13227.8 770.4 792.7 792.9 793.7 794.5 660.8 677.0 770.4 792.1 795.8 825.6 828.6 828.6 829.5 829.8 824.9 825.5 825.9 826.7 828.3 505.7 519.5 520.7 521.2 589.8 12911.2 13497.2 13506.9 13511.6 13515.5 12050.2 12350.5 12462.2 12561.8 12732.7 11764.8 11815.6 11985.9 12192.6 12252.5 4077.3 4104.4 4159.2 4236.7 4337.0 64778.0 65126.3 65212.0 65896.7 67650.7 10343.9 10354.9 10424.9 10581.8 10755.8 18799.7 18816.5 18975.7 18978.8 19097.6 6991.7 7110.3 7116.3 7190.3 7269.9 4147.4 4164.7 4237.7 4273.8 4358.8 3358.4 3443.4 3446.9 3446.9 3448.3 589.6 599.6 609.0 610.0 634.9 536.6 590.1 594.9 612.0 636.0 7977.4 8432.8 8696.0 8781.6 8833.9 539.7 564.9 592.5 595.6 636.5 3944.7 4180.8 4199.1 4242.9 4289.2 84409.6 84997.2 85951.6 87678.6 91343.5 74060.0 75407.0 76578.6 77812.6 78620.0 54758.0 56251.2 57111.7 62019.4 69474.0 8112.8 8227.5 8756.2 8902.7 8999.7 44121.6 44137.3 45455.8 45777.0 46026.0 54165.2 56906.0 61284.0 61855.0 63282.4 11411.8 11546.4 11594.9 12171.9 12302.5 12325.3 12355.1 12456.5 13228.5 13348.1 12456.9 12513.6 12521.1 13228.5 13399.7 11751.0 12303.9 12306.9 12370.7 12580.7 11513.3 12497.3 12759.2 12995.4 13272.1 10309.3 10555.5 10566.6 10875.8 10976.4 10320.8 10724.0 10777.4 10973.7 11017.0 10:48:44 INFO - PROCESS | 1220 | -------- Summary: end -------- 10:48:44 INFO - PROCESS | 1220 | 10:48:45 INFO - TEST-INFO | 1220: exit 0 10:48:45 INFO - TEST-OK | dromaeo_css | took 1118671ms 10:48:45 INFO - TEST-START | kraken 10:48:45 INFO - operating with platform_type : linux_ 10:48:45 INFO - Initialising browser for kraken test... 10:48:45 INFO - TEST-INFO | started process 1530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptehbbr/profile http://localhost:44661/getInfo.html) 10:48:49 INFO - PROCESS | 1530 | __metrics Screen width/height:1600/1200 10:48:49 INFO - PROCESS | 1530 | colorDepth:24 10:48:49 INFO - PROCESS | 1530 | Browser inner width/height: 1024/697 10:48:49 INFO - PROCESS | 1530 | __metrics 10:48:49 INFO - PROCESS | 1530 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:48:49 INFO - PROCESS | 1530 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:48:50 INFO - PROCESS | 1530 | console.error: PushService: 10:48:50 INFO - PROCESS | 1530 | stateChangeProcessEnqueue: Error transitioning state 10:48:50 INFO - PROCESS | 1530 | UnknownError 10:48:50 INFO - TEST-INFO | 1530: exit 0 10:48:50 INFO - Browser initialized. 10:48:50 INFO - Running cycle 1/1 for kraken test... 10:48:50 INFO - TEST-INFO | started process 1614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptehbbr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:49:03 INFO - PROCESS | 1614 | RSS: Main: 172589056 10:49:03 INFO - PROCESS | 1614 | 10:49:05 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44661/tests/kraken/driver.html?testName=audio-beat-detection) 10:49:06 INFO - PROCESS | 1614 | RSS: Main: 229150720 10:49:06 INFO - PROCESS | 1614 | 10:49:09 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44661/tests/kraken/driver.html?testName=audio-dft) 10:49:09 INFO - PROCESS | 1614 | RSS: Main: 216256512 10:49:09 INFO - PROCESS | 1614 | 10:49:12 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44661/tests/kraken/driver.html?testName=audio-fft) 10:49:13 INFO - PROCESS | 1614 | RSS: Main: 297472000 10:49:13 INFO - PROCESS | 1614 | 10:49:15 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44661/tests/kraken/driver.html?testName=audio-oscillator) 10:49:16 INFO - PROCESS | 1614 | RSS: Main: 207024128 10:49:16 INFO - PROCESS | 1614 | 10:49:18 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44661/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:49:18 INFO - PROCESS | 1614 | RSS: Main: 212090880 10:49:18 INFO - PROCESS | 1614 | 10:49:21 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44661/tests/kraken/driver.html?testName=imaging-darkroom) 10:49:22 INFO - PROCESS | 1614 | RSS: Main: 247910400 10:49:22 INFO - PROCESS | 1614 | 10:49:25 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44661/tests/kraken/driver.html?testName=imaging-desaturate) 10:49:26 INFO - PROCESS | 1614 | RSS: Main: 246554624 10:49:26 INFO - PROCESS | 1614 | 10:49:29 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44661/tests/kraken/driver.html?testName=json-parse-financial) 10:49:29 INFO - PROCESS | 1614 | RSS: Main: 246816768 10:49:29 INFO - PROCESS | 1614 | 10:49:31 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44661/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:49:31 INFO - PROCESS | 1614 | RSS: Main: 209035264 10:49:31 INFO - PROCESS | 1614 | 10:49:33 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44661/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:49:34 INFO - PROCESS | 1614 | RSS: Main: 216981504 10:49:34 INFO - PROCESS | 1614 | 10:49:36 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44661/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:49:36 INFO - PROCESS | 1614 | RSS: Main: 225054720 10:49:36 INFO - PROCESS | 1614 | 10:49:39 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:49:40 INFO - PROCESS | 1614 | RSS: Main: 233254912 10:49:40 INFO - PROCESS | 1614 | 10:49:43 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:49:43 INFO - PROCESS | 1614 | RSS: Main: 230764544 10:49:43 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | Cycle 1(1): loaded http://localhost:44661/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44661/tests/kraken/driver.html?testName=ai-astar) 10:49:45 INFO - PROCESS | 1614 | RSS: Main: 282046464 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | __start_tp_report 10:49:45 INFO - PROCESS | 1614 | _x_x_mozilla_page_load 10:49:45 INFO - PROCESS | 1614 | _x_x_mozilla_page_load_details 10:49:45 INFO - PROCESS | 1614 | |i|pagename|runs| 10:49:45 INFO - PROCESS | 1614 | |0;ai-astar;104;112;113;111;111;111;111;112;111;113 10:49:45 INFO - PROCESS | 1614 | |1;audio-beat-detection;154;122;123;151;130;125;124;122;153;122 10:49:45 INFO - PROCESS | 1614 | |2;audio-dft;160;162;161;163;160;161;162;162;162;161 10:49:45 INFO - PROCESS | 1614 | |3;audio-fft;76;75;76;117;76;75;75;85;96;75 10:49:45 INFO - PROCESS | 1614 | |4;audio-oscillator;82;82;111;83;84;83;112;82;82;116 10:49:45 INFO - PROCESS | 1614 | |5;imaging-gaussian-blur;117;116;117;117;117;117;118;116;117;117 10:49:45 INFO - PROCESS | 1614 | |6;imaging-darkroom;147;147;147;148;146;147;147;146;145;146 10:49:45 INFO - PROCESS | 1614 | |7;imaging-desaturate;85;85;85;86;85;86;85;85;85;85 10:49:45 INFO - PROCESS | 1614 | |8;json-parse-financial;57;59;52;51;54;55;53;55;53;54 10:49:45 INFO - PROCESS | 1614 | |9;json-stringify-tinderbox;63;64;62;62;62;62;62;62;63;63 10:49:45 INFO - PROCESS | 1614 | |10;stanford-crypto-aes;89;84;79;79;80;86;80;80;80;89 10:49:45 INFO - PROCESS | 1614 | |11;stanford-crypto-ccm;133;134;132;144;140;148;131;130;193;133 10:49:45 INFO - PROCESS | 1614 | |12;stanford-crypto-pbkdf2;172;167;171;172;173;165;170;170;168;167 10:49:45 INFO - PROCESS | 1614 | |13;stanford-crypto-sha256-iterative;67;66;66;69;64;65;64;65;70;62 10:49:45 INFO - PROCESS | 1614 | __end_tp_report 10:49:45 INFO - PROCESS | 1614 | __start_cc_report 10:49:45 INFO - PROCESS | 1614 | _x_x_mozilla_cycle_collect,1665 10:49:45 INFO - PROCESS | 1614 | __end_cc_report 10:49:45 INFO - PROCESS | 1614 | __startTimestamp1478630985571__endTimestamp 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | ------- Summary: start ------- 10:49:45 INFO - PROCESS | 1614 | Number of tests: 14 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:2.56 (2.3%) stddev-sans-first:0.87 10:49:45 INFO - PROCESS | 1614 | Values: 104.0 112.0 113.0 111.0 111.0 111.0 111.0 112.0 111.0 113.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:127.50 stddev:14.06 (11.0%) stddev-sans-first:12.61 10:49:45 INFO - PROCESS | 1614 | Values: 154.0 122.0 123.0 151.0 130.0 125.0 124.0 122.0 153.0 122.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 10:49:45 INFO - PROCESS | 1614 | Values: 160.0 162.0 161.0 163.0 160.0 161.0 162.0 162.0 162.0 161.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:13.87 (18.2%) stddev-sans-first:14.50 10:49:45 INFO - PROCESS | 1614 | Values: 76.0 75.0 76.0 117.0 76.0 75.0 75.0 85.0 96.0 75.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:82.00 stddev:14.77 (18.0%) stddev-sans-first:15.24 10:49:45 INFO - PROCESS | 1614 | Values: 82.0 82.0 111.0 83.0 84.0 83.0 112.0 82.0 82.0 116.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:49:45 INFO - PROCESS | 1614 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 10:49:45 INFO - PROCESS | 1614 | Values: 147.0 147.0 147.0 148.0 146.0 147.0 147.0 146.0 145.0 146.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 10:49:45 INFO - PROCESS | 1614 | Values: 85.0 85.0 85.0 86.0 85.0 86.0 85.0 85.0 85.0 85.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:2.36 (4.3%) stddev-sans-first:2.29 10:49:45 INFO - PROCESS | 1614 | Values: 57.0 59.0 52.0 51.0 54.0 55.0 53.0 55.0 53.0 54.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 10:49:45 INFO - PROCESS | 1614 | Values: 63.0 64.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 63.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:4.06 (5.0%) stddev-sans-first:3.59 10:49:45 INFO - PROCESS | 1614 | Values: 89.0 84.0 79.0 79.0 80.0 86.0 80.0 80.0 80.0 89.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:137.00 stddev:18.96 (13.8%) stddev-sans-first:19.84 10:49:45 INFO - PROCESS | 1614 | Values: 133.0 134.0 132.0 144.0 140.0 148.0 131.0 130.0 193.0 133.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.50 stddev:2.64 (1.5%) stddev-sans-first:2.64 10:49:45 INFO - PROCESS | 1614 | Values: 172.0 167.0 171.0 172.0 173.0 165.0 170.0 170.0 168.0 167.0 10:49:45 INFO - PROCESS | 1614 | 10:49:45 INFO - PROCESS | 1614 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:2.39 (3.6%) stddev-sans-first:2.50 10:49:45 INFO - PROCESS | 1614 | Values: 67.0 66.0 66.0 69.0 64.0 65.0 64.0 65.0 70.0 62.0 10:49:45 INFO - PROCESS | 1614 | -------- Summary: end -------- 10:49:45 INFO - PROCESS | 1614 | 10:49:46 INFO - TEST-INFO | 1614: exit 0 10:49:46 INFO - TEST-OK | kraken | took 61665ms 10:49:46 INFO - SUITE-END | took 1180s 10:49:47 INFO - Completed test suite (00:19:40) 10:49:47 INFO - javascript benchmark 10:49:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.274725439522, 3110.782245242834, 3137.231378312313, 3147.228928912417, 3151.0704342219055, 5308.70802105884, 5388.137897936331, 5441.993231252216, 5492.670439773611, 5533.418991005947, 5397.136458166694, 5403.081476149055, 5411.83764487065, 5413.945860541394, 5416.756245968931, 4867.245576935581, 4887.975560122212, 4904.0, 4936.679115857458, 4937.308776771255, 4978.327925730035, 5056.140456122468, 5058.822941197059, 5060.0132974070075, 5061.139606266925, 4899.6815207011605, 4979.45226025137, 5001.324821149153, 5003.04942061009, 5044.142495775709, 5017.422996355393, 5046.419661738892, 5067.189249720064, 5074.82238121664, 5123.615728820316, 4819.710817350935, 4864.902701945941, 4880.072786170652, 4963.230699241623, 4969.925451118236, 5436.456354364532, 5440.4287549807495, 5451.291332126798, 5453.15476101205, 5556.972215138939, 5828.825135245949, 5865.120231965197, 5867.442592953663, 5870.6477611343025, 5870.911936320916, 5731.942680573183, 5834.445727655866, 5864.824055278305, 5917.230760001173, 5924.911126333109, 5496.972515137439, 5551.278333816578, 5557.527610153183, 5603.46767057133, 5608.69152196625, 6027.547933904974, 6031.939680603138, 6041.124037014608, 6041.486473649789, 6043.09353596964, 5617.297837770278, 5656.8020119295625, 5796.21751063601, 5798.797042103506, 5803.47768700819, 5747.798827041033, 5767.740451679684, 5799.623024503394, 5828.358880523139, 5879.52963762898, 5749.252597162425, 5752.712364381764, 5809.448102430262, 5811.854703632443, 5873.2658417697785, 5693.202951586781, 5827.5920685552455, 5830.53355731549, 5831.0, 5831.358550559435, 4425.889352766207, 4445.955540444555, 4469.351943968171, 4481.708688935274, 4483.058557702919, 4006.7595944242858, 4018.819153138116, 4029.0531725044593, 4048.7570745755347, 4049.149678567475, 5615.0454422748235, 5616.522595579339, 5621.128725047624, 5621.494065534122, 5672.97163514188, 5762.625429347079, 5810.709464526757, 5835.0, 5879.412058794172, 5906.645601263938, 5624.268845050117, 5626.212330273765, 5630.746616402272, 5648.548116150698, 5665.631733937364, 5058.4435712071645, 5083.644144909895, 5093.465186155475, 5097.949020509747, 5145.22821576759, 5954.404559544011, 5969.403059694169, 6039.879202416015, 6079.088136779607, 6129.570930034854, 5801.941980580309, 5850.385709500441, 5858.765649374148, 5883.117532370179, 5895.380984996514, 6037.969810150921, 6040.335563088145, 6050.364711705208, 6051.183090282755, 6053.0617754246405, 5563.082091454865, 5612.074007788669, 5709.543236540983, 5710.600257982068, 5712.971435142797, 5712.285964254468, 5752.884942301214, 5755.7409916553015, 5788.942110578841, 5840.707964601838, 5614.0, 5628.099504079328, 5672.829815105553, 5681.460261275172, 5694.0, 5598.0, 5679.460451257124, 5689.971550142222, 5692.459216374438, 5693.743781529758, 5605.775768969195, 5666.376698563237, 5689.2319536862, 5693.5445164387575, 5700.116481945305, 5646.0, 5726.169705392612, 5734.655920644775, 5736.483716465538, 5764.884702305846, 5471.562275017909, 5503.449655034465, 5509.779608815603, 5657.632253903483, 5668.404817494104], "value": 5387.083193534329, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.7579807120807, 594.088074805174, 608.4645511949484, 627.8273474794431, 636.1729751323279, 31544.52683209751, 40806.0, 41272.793636031856, 41458.58541414585, 41510.58489415105, 42352.57647423525, 42692.35961460573, 42774.786126069324, 42825.57174428255, 42848.14303713924, 7712.267334603232, 7908.960455197716, 8541.4448060876, 8682.175193356621, 8686.695965641204, 9963.202943764481, 10232.693019209435, 10233.079022887938, 10527.473626318653, 10535.26253162279, 10404.323718958243, 10466.58133674656, 10472.58109675616, 10497.632582859602, 10499.370037797757, 10269.537870795832, 10270.486475676187, 10278.588856445733, 10324.070833624972, 10325.225608079425, 10184.38893666375, 10249.07758301749, 10254.487275636264, 10255.948720256425, 10256.282060255711, 37893.62106378929, 37989.62010379889, 38244.0, 38251.42622860659, 38416.23167536633, 3342.5821772278464, 3355.748318876094, 3444.9827750861336, 3560.608333083359, 3565.9108522286892, 30543.847280763675, 30689.846550767328, 30724.463776811295, 30863.845680771454, 30997.22506937322, 3982.542007669097, 4098.610631989956, 4109.3425051991535, 4153.771542565158, 4263.59495847894, 241147.0, 241402.0, 242074.0, 243652.0, 311693.44153279316, 55087.72456137774, 55920.0, 55997.0, 56016.71991640097, 56048.719756400955, 58718.706406467696, 58805.70597146987, 58891.28869690414, 58929.0, 58931.0, 14961.0, 15030.398784048515, 15041.924790375979, 15042.774358384633, 15048.0, 11777.293362398283, 12137.393130343447, 12646.430910609044, 12671.746565068646, 12712.42794074269, 16194.190290485429, 16479.258433370527, 16612.667746645, 16822.831771682373, 16905.408310709066, 5910.408959104141, 5985.834590371924, 6066.464418138896, 6107.572469927151, 6142.232220972379, 911.4303560274828, 986.3884391677062, 999.1956475037664, 1001.2640709078821, 1020.6580795433613, 30338.848305758773, 30407.543886841715, 30527.69472305293, 30891.38217235643, 31068.223294417367, 1037.678319720889, 1080.7676349584876, 1090.6564432203988, 1098.9230753847314, 1162.0993729859258, 15891.046537207805, 16229.107399092927, 16289.429869954494, 16296.34814607426, 16490.505284841474, 451792.0, 453238.0, 453484.0, 454019.0, 455181.0, 54757.72621136948, 54887.0, 54951.0, 54996.45003549913, 55086.72456637691, 1209.6008317255285, 1259.8551166615773, 1274.1972557288848, 1337.7926421404698, 1348.164138234301, 27958.580621291105, 30970.84514577413, 31178.688213118487, 33127.83436082804, 33532.32935341231, 52717.47282527279, 53319.73340133274, 53381.46618533765, 53458.198127027346, 53539.73230133824, 425024.0, 425821.0, 427646.0, 429142.0, 430756.0, 34238.31523369469, 35225.471617925235, 38857.417138743505, 39139.0, 39716.60283397244, 41982.37026444667, 44090.779546102065, 44198.337024944005, 48870.51129488659, 49130.0, 38240.0, 38545.6145438542, 39113.80443097766, 39178.4123238146, 40361.39457908193, 38611.227775444895, 38822.80588597039, 39232.607673922896, 39368.21263574655, 40890.38664420095, 38656.6134338653, 38757.6124238754, 38940.41589376218, 39831.601683982786, 39987.0, 32062.83968580142, 34684.0, 34723.0, 35550.0, 35756.0, 26690.0, 27025.1892443227, 27131.42574012139, 27311.0, 27435.0], "value": 19540.827374648463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.778752217475, 393.15667892370885, 395.6933376633109, 396.41726661807144, 418.63787823532635, 14376.281185940714, 16631.750523742154, 17929.820701792978, 19561.90219048906, 19576.11907464164, 14909.32908019139, 16755.0, 17950.56395488361, 18217.36239231627, 18356.17397217125, 4714.976425117869, 4995.825146119886, 5003.724795136266, 5014.548690617844, 5018.0, 4995.400551933773, 5027.949720502785, 5028.547430731233, 5037.773300201499, 5039.697618142924, 4818.518148185171, 4967.826126085588, 4985.775640096204, 4994.225894986283, 5002.59979201663, 4987.551120399164, 5017.974910125426, 5031.496850314939, 5031.823886163985, 5033.471485494026, 4843.806247750086, 5106.591472682177, 5144.356955380577, 5210.244514545369, 5221.2951251580935, 11988.64034078979, 12198.573049943298, 12222.144449888512, 20849.791502084936, 22406.215782447536, 2174.3911704722705, 2223.188536184281, 2239.1715065425733, 2252.245497758253, 2345.953080938372, 8918.063603321623, 9009.864852027225, 9060.909390906072, 9254.722358329194, 9538.284628652878, 1703.9062851543283, 1756.8331008554167, 1807.3945228348518, 1818.209079050604, 1828.1316374722035, 74588.0, 76577.0, 77639.6118019412, 78558.6072069636, 78923.60538197329, 10348.586056557653, 10366.740831479123, 10518.211134164816, 10779.730506737238, 10785.56857725698, 14618.926905365404, 14644.707105857824, 14665.486707965383, 14671.486497972519, 14725.631859203606, 7147.2852714728115, 7554.093508778982, 7573.2048134945035, 7814.0, 8077.0, 7029.22678505364, 7542.698292068366, 7578.848423031509, 7715.614219289126, 7716.537007779439, 4400.845970391021, 4450.376947227391, 4473.731576105444, 4508.534726213994, 4525.502194758574, 1729.4725108841671, 1780.4658602419222, 1812.4019073705645, 1838.0534024977148, 1883.7739471263535, 854.3293514591016, 924.5377311344328, 955.9330846840794, 994.557421947241, 1012.7265638277623, 17714.468565943043, 18583.72124418135, 18771.812281877006, 18949.0, 19225.03874806254, 926.9397489163183, 962.4399098398367, 963.2534785541261, 984.1487113646788, 1009.2128140050772, 9663.516824158763, 10139.138173255209, 10310.473933886246, 10353.61866770632, 10428.37429754202, 441355.0, 444929.0, 451084.0, 452195.0, 452280.0, 86778.0, 87056.0, 87643.56178219196, 87707.0, 90653.09346906446, 1015.9695209143738, 1044.1959691037857, 1068.326954018963, 1071.6249312740479, 1073.7047311989108, 15643.921780391025, 15690.843091569395, 16170.434034808724, 16289.266982985557, 16711.164441778106, 41020.589794101674, 41738.37392439055, 41886.16227675368, 41886.581134188265, 42591.14817703567, 47060.29409558791, 52204.0, 52623.0, 54979.0, 55108.44891551194, 5687.43125687428, 7339.458713670189, 7557.962210188914, 7755.6509957053195, 8184.54984975832, 10604.734881628021, 12932.676683082998, 13156.342182891009, 13165.802512962506, 13668.65828354299, 11389.715257118638, 11414.771704566028, 11476.0, 11539.249948753304, 11681.532738690697, 11267.380294083903, 11387.658370248906, 11429.371384573928, 11500.769984600094, 11548.0, 11057.281276716987, 11090.500927458123, 11460.541578336773, 11532.94233528827, 12045.939770301093, 7412.1846596875375, 7662.463627546018, 7716.652750626347, 7891.0, 7917.089534703583, 10553.472326383804, 11099.056580190774, 11104.833427498432, 11516.366599836754, 11639.301641901513], "value": 8568.391026515419, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.1635451438167, 1471.4334981032302, 1603.9759403608948, 1699.898006119632, 1755.9648807023868, 7489.812754681136, 7729.61351932404, 7997.120316765158, 8551.74344769658, 8556.91443085569, 7741.458097933147, 7986.321162701177, 7999.640016199271, 8170.060443049051, 8184.0, 2272.000319859265, 2299.7815207555254, 2300.309907027893, 2301.838871279011, 2314.456102815837, 2009.487580666928, 2072.367927782026, 2273.7044184256106, 2323.848949818265, 2345.7654234576576, 2260.389694782408, 2325.500017496238, 2334.6264597664376, 2343.988280058606, 2345.4019225097577, 2339.801116905065, 2342.227065068523, 2359.1978727232654, 2363.0902102690416, 2365.7752513511273, 2247.179779380531, 2248.460369511322, 2266.7506574276817, 2273.2157405695007, 2299.8045166160896, 8550.273226775731, 8600.5699715014, 8658.826823463496, 8665.43674661145, 8675.609597568124, 5186.7925282988635, 5327.627066105374, 5330.493603107699, 5331.0, 5336.0, 3326.6839650233433, 3336.1317662109295, 3362.3611513812543, 3407.2333724911946, 3409.590849098099, 1072.1208608940672, 1077.7736675298197, 1102.211918478284, 1103.3545375955075, 1125.2292179856825, 11690.298582085103, 11710.824337634942, 11722.765544689144, 11741.119416043832, 11765.11761617882, 4409.559044095565, 4559.088182363541, 4620.699654522446, 4653.95346046542, 4802.375691160127, 10030.498475076218, 10057.346272492265, 10062.144717699077, 10066.144377727975, 10072.899271007343, 5304.9734751326, 5308.283381743415, 5308.46915308466, 5309.3894202166475, 5313.415524292324, 4628.0, 4797.328374027639, 4835.371401717754, 4849.927251091236, 4860.4896485869185, 3846.8845934621445, 3938.074552480165, 3950.170464202492, 4018.9799051005143, 4154.335306350969, 1161.361251311775, 1194.952201911931, 1239.6157191270736, 1311.5344052861287, 1322.4247452358254, 881.6605606841284, 950.1923365139576, 958.7794807194244, 961.5721004153085, 977.731123940922, 5663.263775709213, 5801.6519008859605, 5819.359870414251, 5867.677277749679, 6069.302030266487, 879.4064006795516, 896.1083721696954, 901.378049146087, 964.5563041001078, 972.5884407418567, 4010.979945100256, 4195.601417865298, 4205.0, 4232.809523571446, 4377.124575084996, 10305.175585953106, 10668.359898406121, 10670.30643008202, 10670.57317707283, 10671.679849604525, 9391.295652826066, 9573.760655983517, 10647.787044259227, 10663.786724265472, 10669.83995240072, 7570.848583028309, 7746.147923728386, 7748.22517748232, 7752.224777522202, 7753.883691744629, 5670.149477578396, 5671.631343962629, 5746.683932383592, 5836.620619659709, 5908.675022873783, 9284.210842078499, 9377.484238366955, 9381.85927211106, 9467.289953253396, 9474.099960503741, 9487.72294649293, 9899.307048506535, 9965.302428829913, 9968.850467242852, 9969.601215951281, 7598.924010759822, 7726.768196953875, 7761.185075566984, 7765.0, 7771.961140194263, 7827.882581761392, 8163.79590510242, 8177.550234736908, 8241.752747417588, 8254.092049874629, 6006.699665016644, 7446.367058800062, 7479.0, 7577.5453472791805, 7829.647665855164, 7343.963280183565, 7402.259774022555, 7424.888626670496, 7477.140128885248, 7483.625818709152, 6556.147700798866, 6696.7656132035145, 6729.764458243938, 6751.257361690308, 6835.658217089225, 5040.697558146523, 5065.442801291929, 5140.023395554833, 5188.429272780067, 5297.5232229099565, 4941.805379636307, 4991.850244492671, 5042.520960508746, 5158.38099428071, 5218.66078704883], "value": 4533.118779029579, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.959755030621, 324.48892993535185, 332.08179384003233, 334.26461784075025, 336.13110110364704, 5091.719955402451, 5203.895922081556, 5207.255569384256, 5257.868553286165, 5293.311869456975, 5076.898462030757, 5218.19118036704, 5223.555997740187, 5226.294450249225, 5247.895042099156, 4156.875293741193, 4160.355144952538, 4163.585120630028, 4175.749455032693, 4187.330027195657, 3925.9018524536827, 4122.340425531916, 4172.853950111731, 4185.727927684706, 4186.597489840907, 4086.509618845743, 4099.405586190015, 4109.849242212185, 4114.753114813121, 4118.361653943643, 4057.1885622875247, 4075.735077219971, 4085.7140000199997, 4090.650085471787, 4120.196561670476, 3633.8728144514816, 3636.9816451393654, 3650.945235821465, 3661.0, 3667.2665466906724, 5099.15863882459, 5114.514121158484, 5121.334226550562, 5124.769385377667, 5146.275997540828, 4639.304104384336, 4651.976740116278, 4660.813567457298, 4681.321208424793, 4711.95288047122, 5504.055330398218, 5507.201455788928, 5509.146082357201, 5513.889722205574, 5577.581681373913, 3772.8868133956025, 3930.78380689062, 3932.6460618544183, 3932.744371615836, 3936.311145549546, 5644.322681278273, 5667.433256674341, 5687.43125687428, 5702.116171993306, 5735.913961290584, 4037.6971727120585, 4042.3936409538805, 4048.8987775305854, 4049.9595004049584, 4061.472008638858, 3909.237698648793, 4001.659858912025, 4011.4584531088512, 4040.7573796542615, 4088.9386659200136, 4597.747123908217, 4613.907721845611, 4613.93079103807, 4621.838235661736, 4622.815087396534, 5457.645253058538, 5481.616286859961, 5490.380337800359, 5518.0, 5571.749271282802, 1273.6497463197695, 1282.4870051979096, 1298.7597294500547, 1343.2142196814973, 1357.927237482378, 905.2441211588266, 939.3706216834737, 943.9474985391239, 950.6625148072472, 957.3920560444168, 5200.375954885438, 5203.2195170723935, 5210.921836172461, 5224.216367544898, 5251.737413129405, 5393.5954803389905, 5431.51116399518, 5434.809781657623, 5438.700871452108, 5455.427180146107, 4936.2102063669645, 5185.585153187736, 5189.6886186828915, 5201.297824793604, 5206.557442617344, 2835.4546772009303, 2853.885844566194, 2862.012605651047, 2871.6697579778593, 2873.5976963225166, 5531.225628412026, 5549.472800083986, 5597.860053498695, 5621.550275977912, 5714.257146570919, 5194.662346947436, 5491.890162196733, 5498.45015498455, 5505.834824955257, 5516.5521549031855, 5600.915986260128, 5611.9438805612235, 5621.4378562144275, 5630.38187242934, 5632.971835140798, 5288.338957630296, 5312.36251649789, 5377.623566350318, 5420.376656684532, 5472.179173124063, 5308.434011966557, 5406.080966235828, 5408.64783804049, 5414.889947560662, 5416.9729151353995, 5514.779408823602, 5519.2824932758485, 5557.221988921635, 5567.4432556744005, 5622.746976385991, 3804.2962052019357, 3878.9526827755785, 3951.8934698284525, 3955.861544845917, 3960.168364643342, 5395.13677811564, 5670.8015219467125, 5671.298610416941, 5678.290213723285, 5679.9148012779015, 5430.484104010113, 5456.863578410572, 5522.337319521523, 5553.305836770403, 5571.9721401392735, 5492.780288788404, 5530.557555395479, 5568.777248909998, 5586.413426590149, 5601.439856014366, 5383.0, 5492.011437941209, 5535.7785688572, 5560.416156303691, 5566.165075238747, 5602.067286786052, 5609.326880774333, 5646.971765141148, 5648.237487939075, 5652.265205523256, 5529.474699903502, 5535.197396377584, 5542.75057622416, 5549.944500555104, 5576.944230557642], "value": 4155.469779862695, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.7610336382266, 711.530389942638, 737.5611511150867, 773.7794728502378, 797.0674311056064, 13556.661083472905, 14041.017128800975, 14295.714085718306, 14431.783523247133, 14814.333354999024, 12834.80747788784, 13074.084814063019, 13181.143225690348, 13189.736205275889, 13227.801582976263, 770.4298818874034, 792.7383963292128, 792.8889955406248, 793.7499687598388, 794.5232860283842, 660.7753363856287, 676.9966150169267, 770.437580566187, 792.1484404265437, 795.7652492514723, 825.6490991328691, 828.5857071464268, 828.6436832162168, 829.5396055189367, 829.8049958259804, 824.8927639406899, 825.5253229393123, 825.8885050518163, 826.7147833997261, 828.2793969246763, 505.6713136461293, 519.5428023339475, 520.731823111098, 521.2259794205602, 589.7552515705977, 12911.225326480348, 13497.190168589817, 13506.93246533761, 13511.594652160451, 13515.526956556572, 12050.216735912138, 12350.5059797608, 12462.189957652723, 12561.811572826415, 12732.681682957907, 11764.764704705944, 11815.645530634094, 11985.880141198564, 12192.634220973385, 12252.509899604005, 4077.2864748668862, 4104.445899803518, 4159.209750147463, 4236.68224883135, 4337.0458499130145, 64778.0, 65126.348736512504, 65212.0, 65896.67051664759, 67650.66174669095, 10343.935610319015, 10354.948225258826, 10424.895751042544, 10581.788364232827, 10755.78488430227, 18799.718004229948, 18816.52958676044, 18975.71536426955, 18978.81021189798, 19097.618047639247, 6991.650417479207, 7110.288971102848, 7116.288371162842, 7190.316919892602, 7269.927986093867, 4147.357159640261, 4164.68764842638, 4237.724547904438, 4273.786310684453, 4358.847440339573, 3358.429067058606, 3443.362977849106, 3446.8621255150015, 3446.879359222415, 3448.2758620689433, 589.5548860610212, 599.5713065158345, 608.9512838972871, 609.9939000610026, 634.9428551430301, 536.5948708724887, 590.0912594604347, 594.913737508059, 611.9541034422436, 636.0409937392911, 7977.441579089524, 8432.831343373098, 8696.0, 8781.648734050694, 8833.911660883308, 539.7490167072331, 564.8644325361965, 592.5230189697335, 595.624756403463, 636.5448704176536, 3944.723869329119, 4180.770057646859, 4199.139176468817, 4242.893927651771, 4289.196900543488, 84409.57795210984, 84997.15002849893, 85951.57024214964, 87678.56160719156, 91343.54328228449, 74060.0, 75407.0, 76578.61710691522, 77812.61093694609, 78620.0, 54758.0, 56251.15623265654, 57111.714441427524, 62019.37980620136, 69474.0, 8112.797180070545, 8227.547484888388, 8756.192127899141, 8902.70283710853, 8999.730008099768, 44121.55878441175, 44137.33793993029, 45455.772721136185, 45777.0, 46026.0, 54165.18752218641, 56906.0, 61284.0, 61855.0, 63282.36717632765, 11411.771764564828, 11546.364949927834, 11594.942025290156, 12171.939140304241, 12302.507899684271, 12325.260484370609, 12355.135140540076, 12456.501739930301, 13228.47086116583, 13348.065635405817, 12456.875431245933, 12513.624591262276, 12521.060920430822, 13228.47086116583, 13399.665008374868, 11750.973927183557, 12303.93848030754, 12306.87693123093, 12370.651215392558, 12580.748385032432, 11513.251638643462, 12497.25016499013, 12759.170653907466, 12995.350232488148, 13272.070955033056, 10309.278350515691, 10555.472226388496, 10566.630167944086, 10875.836862447228, 10976.396298203676, 10320.845187322046, 10724.0, 10777.353358798497, 10973.670789876316, 11017.0], "value": 6769.440512009639, "unit": "score"}], "name": "dromaeo_css", "value": 6973.782117836535, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 111.0, 111.0, 111.0, 111.0, 112.0, 111.0, 113.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 123.0, 151.0, 130.0, 125.0, 124.0, 122.0, 153.0, 122.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 163.0, 160.0, 161.0, 162.0, 162.0, 162.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 117.0, 76.0, 75.0, 75.0, 85.0, 96.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 111.0, 83.0, 84.0, 83.0, 112.0, 82.0, 82.0, 116.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 145.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 52.0, 51.0, 54.0, 55.0, 53.0, 55.0, 53.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 79.0, 79.0, 80.0, 86.0, 80.0, 80.0, 80.0, 89.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 134.0, 132.0, 144.0, 140.0, 148.0, 131.0, 130.0, 193.0, 133.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 171.0, 172.0, 173.0, 165.0, 170.0, 170.0, 168.0, 167.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 69.0, 64.0, 65.0, 64.0, 65.0, 70.0, 62.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1504.3999999999999, "alertThreshold": 2.0}]} 10:49:47 INFO - Return code: 0 10:49:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:49:47 INFO - # TBPL SUCCESS # 10:49:47 INFO - Running post-action listener: _resource_record_post_action 10:49:47 INFO - [mozharness: 2016-11-08 18:49:47.375561Z] Finished run-tests step (success) 10:49:47 INFO - Running post-run listener: _resource_record_post_run 10:49:47 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403529728; Read time: 12; Write time: 265752 10:49:47 INFO - TinderboxPrint: CPU usage
13.1% 10:49:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:49:47 INFO - TinderboxPrint: I/O write bytes / time
403,529,728 / 265,752 10:49:47 INFO - TinderboxPrint: CPU idle
8,304.4 (86.9%) 10:49:47 INFO - TinderboxPrint: CPU user
1,203.8 (12.6%) 10:49:47 INFO - TinderboxPrint: Swap in / out
0 / 0 10:49:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114323456; Read time: 0; Write time: 69064 10:49:47 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287940608; Read time: 0; Write time: 196660 10:49:48 INFO - Running post-run listener: _upload_blobber_files 10:49:48 INFO - Blob upload gear active. 10:49:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:49:48 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:49:48 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:49:48 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:49:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:49:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:49:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:49:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:51 INFO - (blobuploader) - INFO - Done attempting. 10:49:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:49:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:49:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:52 INFO - (blobuploader) - INFO - Done attempting. 10:49:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:49:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:49:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:53 INFO - (blobuploader) - INFO - Done attempting. 10:49:53 INFO - (blobuploader) - INFO - Iteration through files over. 10:49:53 INFO - Return code: 0 10:49:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:49:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:49:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/237244d44d96097f7b0c2effe12e26e0b6c736c7f7d24994f061e64a3a5594f3f52386c94ea4a16ea8010634bb9cca95ff098fe065937a4a44b8ad227d188e8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e07fb8f731b1f32d06cb4c6089dfefd8b940b073cfa9fd238480518b37ffdc01e5d3e622187bd209ed5b84f2e8de4143270aa8f0e2727df0a613e6aabcc5fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cca0cc785ba515c173a04dfcf3975376c3bb5bc97df1db27d1be286db3dce24ca0416d0f7276440fe95e757f0c30ae42018e532690ee0ac1780cc13befb82f6"} 10:49:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:49:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:49:53 INFO - Contents: 10:49:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/237244d44d96097f7b0c2effe12e26e0b6c736c7f7d24994f061e64a3a5594f3f52386c94ea4a16ea8010634bb9cca95ff098fe065937a4a44b8ad227d188e8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e07fb8f731b1f32d06cb4c6089dfefd8b940b073cfa9fd238480518b37ffdc01e5d3e622187bd209ed5b84f2e8de4143270aa8f0e2727df0a613e6aabcc5fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cca0cc785ba515c173a04dfcf3975376c3bb5bc97df1db27d1be286db3dce24ca0416d0f7276440fe95e757f0c30ae42018e532690ee0ac1780cc13befb82f6"} 10:49:53 INFO - Running post-run listener: copy_logs_to_upload_dir 10:49:53 INFO - Copying logs to upload dir... 10:49:53 INFO - mkdir: /builds/slave/test/build/upload/logs 10:49:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.074314 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-08 10:49:53.353970) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:53.357625) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/237244d44d96097f7b0c2effe12e26e0b6c736c7f7d24994f061e64a3a5594f3f52386c94ea4a16ea8010634bb9cca95ff098fe065937a4a44b8ad227d188e8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e07fb8f731b1f32d06cb4c6089dfefd8b940b073cfa9fd238480518b37ffdc01e5d3e622187bd209ed5b84f2e8de4143270aa8f0e2727df0a613e6aabcc5fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cca0cc785ba515c173a04dfcf3975376c3bb5bc97df1db27d1be286db3dce24ca0416d0f7276440fe95e757f0c30ae42018e532690ee0ac1780cc13befb82f6"} build_url:https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/DfvllYcCSIKKtI4jSkA81g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/237244d44d96097f7b0c2effe12e26e0b6c736c7f7d24994f061e64a3a5594f3f52386c94ea4a16ea8010634bb9cca95ff098fe065937a4a44b8ad227d188e8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93e07fb8f731b1f32d06cb4c6089dfefd8b940b073cfa9fd238480518b37ffdc01e5d3e622187bd209ed5b84f2e8de4143270aa8f0e2727df0a613e6aabcc5fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5cca0cc785ba515c173a04dfcf3975376c3bb5bc97df1db27d1be286db3dce24ca0416d0f7276440fe95e757f0c30ae42018e532690ee0ac1780cc13befb82f6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:53.383264) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:53.383598) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1478627903.345301-515316382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 10:49:53.469327) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 10:49:53.469682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 10:49:53.470039) ========= ========= Total master_lag: 0.17 =========