builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1476527415.19 results: success (0) buildid: 20161015020935 builduid: 4d78f8bbb5ce420994b1c7aecc00f08f revision: 2a1297e90c5981dea1449019480328aafff0cbd5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:15.187984) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:15.188421) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:15.188740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:15.204422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:15.204907) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-15 03:30:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-10-15 03:30:17 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107951 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:15.328461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:15.328791) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021668 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:15.394130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-15 03:30:15.394470) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a1297e90c5981dea1449019480328aafff0cbd5 --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 2a1297e90c5981dea1449019480328aafff0cbd5 --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=a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-15 03:30:17,298 truncating revision to first 12 chars 2016-10-15 03:30:17,298 Setting DEBUG logging. 2016-10-15 03:30:17,299 attempt 1/10 2016-10-15 03:30:17,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a1297e90c59?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-15 03:30:18,020 unpacking tar archive at: mozilla-central-2a1297e90c59/testing/mozharness/ program finished with exit code 0 elapsedTime=1.122729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-15 03:30:16.531210) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:16.531563) ========= script_repo_revision: 2a1297e90c5981dea1449019480328aafff0cbd5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:16.532023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:16.532322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-15 03:30:16.541598) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-15 03:30:16.541957) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:18 INFO - MultiFileLogger online at 20161015 03:30:18 in /builds/slave/test 03:30:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:30:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:18 INFO - {'append_to_log': False, 03:30:18 INFO - 'base_work_dir': '/builds/slave/test', 03:30:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:30:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:18 INFO - 'branch': 'Firefox-Non-PGO', 03:30:18 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:18 INFO - 'config_files': ('talos/linux_config.py',), 03:30:18 INFO - 'default_actions': ('clobber', 03:30:18 INFO - 'read-buildbot-config', 03:30:18 INFO - 'download-and-extract', 03:30:18 INFO - 'populate-webroot', 03:30:18 INFO - 'create-virtualenv', 03:30:18 INFO - 'install', 03:30:18 INFO - 'run-tests'), 03:30:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:18 INFO - 'download_minidump_stackwalk': True, 03:30:18 INFO - 'download_symbols': 'ondemand', 03:30:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:18 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:18 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:18 INFO - 'installer_path': 'installer.exe', 03:30:18 INFO - 'log_level': 'info', 03:30:18 INFO - 'log_name': 'talos', 03:30:18 INFO - 'log_to_console': True, 03:30:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:18 INFO - 'opt_config_files': (), 03:30:18 INFO - 'pip_index': False, 03:30:18 INFO - 'sps_profile': False, 03:30:18 INFO - 'sps_profile_interval': 0, 03:30:18 INFO - 'suite': 'dromaeojs', 03:30:18 INFO - 'system_bits': '32', 03:30:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:18 INFO - 'title': 'talos-linux64-ix-064', 03:30:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:18 INFO - 'use_talos_json': True, 03:30:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:18 INFO - 'work_dir': 'build'} 03:30:18 INFO - [mozharness: 2016-10-15 10:30:18.542494Z] Running clobber step. 03:30:18 INFO - Running pre-action listener: _resource_record_pre_action 03:30:18 INFO - Running main action method: clobber 03:30:18 INFO - rmtree: /builds/slave/test/build 03:30:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:19 INFO - Running post-action listener: _resource_record_post_action 03:30:19 INFO - [mozharness: 2016-10-15 10:30:19.004957Z] Finished clobber step (success) 03:30:19 INFO - [mozharness: 2016-10-15 10:30:19.005057Z] Running read-buildbot-config step. 03:30:19 INFO - Running pre-action listener: _resource_record_pre_action 03:30:19 INFO - Running main action method: read_buildbot_config 03:30:19 INFO - Using buildbot properties: 03:30:19 INFO - { 03:30:19 INFO - "project": "", 03:30:19 INFO - "product": "firefox", 03:30:19 INFO - "script_repo_revision": "production", 03:30:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:30:19 INFO - "repository": "", 03:30:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:30:19 INFO - "buildid": "20161015020935", 03:30:19 INFO - "pgo_build": "False", 03:30:19 INFO - "basedir": "/builds/slave/test", 03:30:19 INFO - "buildnumber": 680, 03:30:19 INFO - "slavename": "talos-linux64-ix-064", 03:30:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:30:19 INFO - "platform": "ubuntu64_hw", 03:30:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:30:19 INFO - "branch": "mozilla-central", 03:30:19 INFO - "repo_path": "mozilla-central", 03:30:19 INFO - "revision": "2a1297e90c5981dea1449019480328aafff0cbd5", 03:30:19 INFO - "stage_platform": "linux64", 03:30:19 INFO - "builduid": "4d78f8bbb5ce420994b1c7aecc00f08f", 03:30:19 INFO - "slavebuilddir": "test" 03:30:19 INFO - } 03:30:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:30:19 INFO - Running post-action listener: _resource_record_post_action 03:30:19 INFO - [mozharness: 2016-10-15 10:30:19.007495Z] Finished read-buildbot-config step (success) 03:30:19 INFO - [mozharness: 2016-10-15 10:30:19.007582Z] Running download-and-extract step. 03:30:19 INFO - Running pre-action listener: _resource_record_pre_action 03:30:19 INFO - Running main action method: download_and_extract 03:30:19 INFO - mkdir: /builds/slave/test/build/tests 03:30:19 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')]} 03:30:19 INFO - trying https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:30:19 INFO - Downloading https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/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 03:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/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 03:30:19 INFO - Downloaded 1361 bytes. 03:30:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:30:19 INFO - Using the following test package requirements: 03:30:19 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:19 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:19 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:30:19 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:19 INFO - u'jsshell-linux-x86_64.zip'], 03:30:19 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:19 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:19 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:30:19 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:30:19 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:19 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:30:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:19 INFO - Fetch https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:30:20 INFO - Http code: 200 03:30:20 INFO - via: 1.1 6eaa7f856e226a0db7cef6201d3b8393.cloudfront.net (CloudFront) 03:30:20 INFO - x-amz-cf-id: feFvsDM4Zcx9Y1Oc3UYoJ8U4WXsKtco6IjsYStEA66StliOUrOctoQ== 03:30:20 INFO - x-amz-version-id: j0LAj0NAj1Dizf6hcM.Ud6DtHctwYxSw 03:30:20 INFO - Expected file size: 20553650 03:30:20 INFO - Obtained file size: 20553650 03:30:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:30:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:30:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:24 INFO - Fetch https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:30:24 INFO - Http code: 200 03:30:24 INFO - via: 1.1 ca024aca72de992a25bcd7fdcfe84b67.cloudfront.net (CloudFront) 03:30:24 INFO - x-amz-cf-id: zh2xsmJOUYzWo8UPd0sbLzlF1qCTdWglFT8NaqWsTipojiiMAAB59Q== 03:30:24 INFO - x-amz-version-id: j0LAj0NAj1Dizf6hcM.Ud6DtHctwYxSw 03:30:25 INFO - Expected file size: 20553650 03:30:25 INFO - Obtained file size: 20553650 03:30:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:30:29 INFO - Fetch https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:30:30 INFO - Http code: 200 03:30:30 INFO - via: 1.1 7db492e48a5d55351dcb787a8a14e113.cloudfront.net (CloudFront) 03:30:30 INFO - x-amz-cf-id: JRPXh8cl1RK6Kxd486J9VPX5jUIg4sfY-7JEWXTStOPJ9vpm46NDjQ== 03:30:30 INFO - x-amz-version-id: vbSMAVeep4YW4XS1O0p8Yp2Tz2V6oBpT 03:30:30 INFO - Expected file size: 14409028 03:30:30 INFO - Obtained file size: 14409028 03:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:31 INFO - trying https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:30:31 INFO - Downloading https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/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 03:30:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/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 03:30:33 INFO - Downloaded 55779549 bytes. 03:30:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:30:33 INFO - mkdir: /builds/slave/test/properties 03:30:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:33 INFO - Contents: 03:30:33 INFO - build_url:https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:30:34 INFO - Running post-action listener: _resource_record_post_action 03:30:34 INFO - Running post-action listener: set_extra_try_arguments 03:30:34 INFO - [mozharness: 2016-10-15 10:30:34.002951Z] Finished download-and-extract step (success) 03:30:34 INFO - [mozharness: 2016-10-15 10:30:34.003185Z] Running populate-webroot step. 03:30:34 INFO - Running pre-action listener: _resource_record_pre_action 03:30:34 INFO - Running main action method: populate_webroot 03:30:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:34 INFO - '--tppagecycles', 03:30:34 INFO - '7'], 03:30:34 INFO - 'tests': ['tsvgm']}}, 03:30:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:34 INFO - 'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:34 INFO - 'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['damp', 'tps']}, 03:30:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:34 INFO - 'tests': ['damp', 'tps']}, 03:30:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['dromaeo_dom']}, 03:30:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['basic_compositor_video']}, 03:30:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:30:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['a11yr', 03:30:34 INFO - 'ts_paint', 03:30:34 INFO - 'tpaint', 03:30:34 INFO - 'sessionrestore', 03:30:34 INFO - 'sessionrestore_no_auto_restore', 03:30:34 INFO - 'tabpaint']}, 03:30:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:34 INFO - 'ts_paint', 03:30:34 INFO - 'tpaint', 03:30:34 INFO - 'sessionrestore', 03:30:34 INFO - 'sessionrestore_no_auto_restore', 03:30:34 INFO - 'tabpaint']}, 03:30:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:30:34 INFO - 'ts_paint', 03:30:34 INFO - 'tpaint', 03:30:34 INFO - 'sessionrestore', 03:30:34 INFO - 'sessionrestore_no_auto_restore', 03:30:34 INFO - 'tabpaint']}, 03:30:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:30:34 INFO - 'ts_paint', 03:30:34 INFO - 'tpaint', 03:30:34 INFO - 'sessionrestore', 03:30:34 INFO - 'sessionrestore_no_auto_restore', 03:30:34 INFO - 'tabpaint']}, 03:30:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['a11yr', 03:30:34 INFO - 'ts_paint', 03:30:34 INFO - 'tpaint', 03:30:34 INFO - 'sessionrestore', 03:30:34 INFO - 'sessionrestore_no_auto_restore', 03:30:34 INFO - 'tabpaint']}, 03:30:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['a11yr', 03:30:34 INFO - 'ts_paint', 03:30:34 INFO - 'tpaint', 03:30:34 INFO - 'sessionrestore', 03:30:34 INFO - 'sessionrestore_no_auto_restore', 03:30:34 INFO - 'tabpaint']}, 03:30:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['tsvgx', 03:30:34 INFO - 'tsvgr_opacity', 03:30:34 INFO - 'tart', 03:30:34 INFO - 'tscrollx', 03:30:34 INFO - 'cart']}, 03:30:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:34 INFO - 'tsvgr_opacity', 03:30:34 INFO - 'tart', 03:30:34 INFO - 'tscrollx', 03:30:34 INFO - 'cart']}, 03:30:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:34 INFO - 'talos_options': ['--disable-e10s'], 03:30:34 INFO - 'tests': ['tp5o']}, 03:30:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:34 INFO - 'tests': ['tp5o']}, 03:30:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:34 INFO - 'talos_options': ['--disable-e10s', 03:30:34 INFO - '--xperf_path', 03:30:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:34 INFO - 'tests': ['tp5n']}, 03:30:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:34 INFO - 'talos_options': ['--xperf_path', 03:30:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:34 INFO - 'tests': ['tp5n']}}, 03:30:34 INFO - 'talos.zip': {'path': '', 03:30:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:34 INFO - Running post-action listener: _resource_record_post_action 03:30:34 INFO - [mozharness: 2016-10-15 10:30:34.018848Z] Finished populate-webroot step (success) 03:30:34 INFO - [mozharness: 2016-10-15 10:30:34.018955Z] Running create-virtualenv step. 03:30:34 INFO - Running pre-action listener: _resource_record_pre_action 03:30:34 INFO - Running main action method: create_virtualenv 03:30:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:34 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 03:30:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:34 INFO - Using real prefix '/usr' 03:30:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:34 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:36 INFO - Installing pip.................done. 03:30:36 INFO - Return code: 0 03:30:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:30:36 INFO - Reading from file tmpfile_stdout 03:30:36 INFO - Output received: 03:30:36 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) 03:30:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef39fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', '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 03:30:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:30:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:30:36 INFO - Using env: {'DISPLAY': ':0', 03:30:36 INFO - 'HOME': '/home/cltbld', 03:30:36 INFO - 'LANG': 'en_US.UTF-8', 03:30:36 INFO - 'LANGUAGE': 'en_US:en', 03:30:36 INFO - 'LOGNAME': 'cltbld', 03:30:36 INFO - 'MAIL': '/var/mail/cltbld', 03:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:36 INFO - 'MOZ_NO_REMOTE': '1', 03:30:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:36 INFO - 'NO_EM_RESTART': '1', 03:30:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:36 INFO - 'PWD': '/builds/slave/test', 03:30:36 INFO - 'SHELL': '/bin/bash', 03:30:36 INFO - 'SHLVL': '1', 03:30:36 INFO - 'TERM': 'linux', 03:30:36 INFO - 'TMOUT': '86400', 03:30:36 INFO - 'USER': 'cltbld', 03:30:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:36 INFO - '_': '/tools/buildbot/bin/python'} 03:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:37 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 03:30:37 INFO - Cleaning up... 03:30:37 INFO - Return code: 0 03:30:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', '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 0x7fef39fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', '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 03:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:30: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 psutil>=3.1.1 03:30:37 INFO - Using env: {'DISPLAY': ':0', 03:30:37 INFO - 'HOME': '/home/cltbld', 03:30:37 INFO - 'LANG': 'en_US.UTF-8', 03:30:37 INFO - 'LANGUAGE': 'en_US:en', 03:30:37 INFO - 'LOGNAME': 'cltbld', 03:30:37 INFO - 'MAIL': '/var/mail/cltbld', 03:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:37 INFO - 'MOZ_NO_REMOTE': '1', 03:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:37 INFO - 'NO_EM_RESTART': '1', 03:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:37 INFO - 'PWD': '/builds/slave/test', 03:30:37 INFO - 'SHELL': '/bin/bash', 03:30:37 INFO - 'SHLVL': '1', 03:30:37 INFO - 'TERM': 'linux', 03:30:37 INFO - 'TMOUT': '86400', 03:30:37 INFO - 'USER': 'cltbld', 03:30:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:37 INFO - '_': '/tools/buildbot/bin/python'} 03:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:37 INFO - Downloading/unpacking psutil>=3.1.1 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:39 INFO - Installing collected packages: psutil 03:30:39 INFO - Running setup.py install for psutil 03:30:39 INFO - building 'psutil._psutil_linux' extension 03:30:39 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 03:30:39 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 03:30:39 INFO - building 'psutil._psutil_posix' extension 03:30:39 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 03:30:39 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 03:30:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:39 INFO - Successfully installed psutil 03:30:39 INFO - Cleaning up... 03:30:39 INFO - Return code: 0 03:30:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef39fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', '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 03:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:30:39 INFO - Using env: {'DISPLAY': ':0', 03:30:39 INFO - 'HOME': '/home/cltbld', 03:30:39 INFO - 'LANG': 'en_US.UTF-8', 03:30:39 INFO - 'LANGUAGE': 'en_US:en', 03:30:39 INFO - 'LOGNAME': 'cltbld', 03:30:39 INFO - 'MAIL': '/var/mail/cltbld', 03:30:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:39 INFO - 'MOZ_NO_REMOTE': '1', 03:30:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:39 INFO - 'NO_EM_RESTART': '1', 03:30:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:39 INFO - 'PWD': '/builds/slave/test', 03:30:39 INFO - 'SHELL': '/bin/bash', 03:30:39 INFO - 'SHLVL': '1', 03:30:39 INFO - 'TERM': 'linux', 03:30:39 INFO - 'TMOUT': '86400', 03:30:39 INFO - 'USER': 'cltbld', 03:30:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:30:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:39 INFO - '_': '/tools/buildbot/bin/python'} 03:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:30:42 INFO - Installing collected packages: mozsystemmonitor 03:30:42 INFO - Running setup.py install for mozsystemmonitor 03:30:42 INFO - Successfully installed mozsystemmonitor 03:30:42 INFO - Cleaning up... 03:30:42 INFO - Return code: 0 03:30:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:42 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 0x7fef39fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', '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 03:30:42 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 03:30:42 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 03:30:42 INFO - Using env: {'DISPLAY': ':0', 03:30:42 INFO - 'HOME': '/home/cltbld', 03:30:42 INFO - 'LANG': 'en_US.UTF-8', 03:30:42 INFO - 'LANGUAGE': 'en_US:en', 03:30:42 INFO - 'LOGNAME': 'cltbld', 03:30:42 INFO - 'MAIL': '/var/mail/cltbld', 03:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:42 INFO - 'MOZ_NO_REMOTE': '1', 03:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:42 INFO - 'NO_EM_RESTART': '1', 03:30:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:42 INFO - 'PWD': '/builds/slave/test', 03:30:42 INFO - 'SHELL': '/bin/bash', 03:30:42 INFO - 'SHLVL': '1', 03:30:42 INFO - 'TERM': 'linux', 03:30:42 INFO - 'TMOUT': '86400', 03:30:42 INFO - 'USER': 'cltbld', 03:30:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:42 INFO - '_': '/tools/buildbot/bin/python'} 03:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:42 INFO - Downloading/unpacking jsonschema==2.5.1 03:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:30:44 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 03:30:44 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 03:30:44 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 03:30:44 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 03:30:44 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 03:30:44 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 03:30:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:44 INFO - warning: no files found matching '*.txt' 03:30:44 INFO - no previously-included directories found matching 'build' 03:30:44 INFO - no previously-included directories found matching 'dist' 03:30:44 INFO - no previously-included directories found matching '.git*' 03:30:44 INFO - Installing collected packages: jsonschema, functools32 03:30:44 INFO - Running setup.py install for functools32 03:30:44 INFO - warning: no files found matching '*.txt' 03:30:44 INFO - no previously-included directories found matching 'build' 03:30:44 INFO - no previously-included directories found matching 'dist' 03:30:44 INFO - no previously-included directories found matching '.git*' 03:30:44 INFO - Successfully installed jsonschema functools32 03:30:44 INFO - Cleaning up... 03:30:44 INFO - Return code: 0 03:30:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:44 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 0x7fef39fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', '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 03:30:44 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 03:30:44 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 03:30:44 INFO - Using env: {'DISPLAY': ':0', 03:30:44 INFO - 'HOME': '/home/cltbld', 03:30:44 INFO - 'LANG': 'en_US.UTF-8', 03:30:44 INFO - 'LANGUAGE': 'en_US:en', 03:30:44 INFO - 'LOGNAME': 'cltbld', 03:30:44 INFO - 'MAIL': '/var/mail/cltbld', 03:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:44 INFO - 'MOZ_NO_REMOTE': '1', 03:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:44 INFO - 'NO_EM_RESTART': '1', 03:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:44 INFO - 'PWD': '/builds/slave/test', 03:30:44 INFO - 'SHELL': '/bin/bash', 03:30:44 INFO - 'SHLVL': '1', 03:30:44 INFO - 'TERM': 'linux', 03:30:44 INFO - 'TMOUT': '86400', 03:30:44 INFO - 'USER': 'cltbld', 03:30:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:44 INFO - '_': '/tools/buildbot/bin/python'} 03:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:30:44 INFO - Cleaning up... 03:30:45 INFO - Return code: 0 03:30:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:45 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 0x7fef39fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', '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 03:30:45 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 03:30:45 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 03:30:45 INFO - Using env: {'DISPLAY': ':0', 03:30:45 INFO - 'HOME': '/home/cltbld', 03:30:45 INFO - 'LANG': 'en_US.UTF-8', 03:30:45 INFO - 'LANGUAGE': 'en_US:en', 03:30:45 INFO - 'LOGNAME': 'cltbld', 03:30:45 INFO - 'MAIL': '/var/mail/cltbld', 03:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:45 INFO - 'MOZ_NO_REMOTE': '1', 03:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:45 INFO - 'NO_EM_RESTART': '1', 03:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:45 INFO - 'PWD': '/builds/slave/test', 03:30:45 INFO - 'SHELL': '/bin/bash', 03:30:45 INFO - 'SHLVL': '1', 03:30:45 INFO - 'TERM': 'linux', 03:30:45 INFO - 'TMOUT': '86400', 03:30:45 INFO - 'USER': 'cltbld', 03:30:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:45 INFO - '_': '/tools/buildbot/bin/python'} 03:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:47 INFO - Downloading docopt-0.6.1.tar.gz 03:30:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:47 INFO - Running setup.py install for blobuploader 03:30:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:48 INFO - Running setup.py install for requests 03:30:48 INFO - Running setup.py install for docopt 03:30:48 INFO - Successfully installed blobuploader requests docopt 03:30:48 INFO - Cleaning up... 03:30:48 INFO - Return code: 0 03:30:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:48 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 0x7fef39fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', '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 03:30:48 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 03:30:48 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 03:30:48 INFO - Using env: {'DISPLAY': ':0', 03:30:48 INFO - 'HOME': '/home/cltbld', 03:30:48 INFO - 'LANG': 'en_US.UTF-8', 03:30:48 INFO - 'LANGUAGE': 'en_US:en', 03:30:48 INFO - 'LOGNAME': 'cltbld', 03:30:48 INFO - 'MAIL': '/var/mail/cltbld', 03:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:48 INFO - 'MOZ_NO_REMOTE': '1', 03:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:48 INFO - 'NO_EM_RESTART': '1', 03:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:48 INFO - 'PWD': '/builds/slave/test', 03:30:48 INFO - 'SHELL': '/bin/bash', 03:30:48 INFO - 'SHLVL': '1', 03:30:48 INFO - 'TERM': 'linux', 03:30:48 INFO - 'TMOUT': '86400', 03:30:48 INFO - 'USER': 'cltbld', 03:30:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:48 INFO - '_': '/tools/buildbot/bin/python'} 03:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:48 INFO - Running setup.py (path:/tmp/pip-9CqhBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:48 INFO - Running setup.py (path:/tmp/pip-GdyNrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:48 INFO - Running setup.py (path:/tmp/pip-rhtYJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:48 INFO - Running setup.py (path:/tmp/pip-3XL_Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:49 INFO - Running setup.py (path:/tmp/pip-9hS46H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:49 INFO - Running setup.py (path:/tmp/pip-E4Ly3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:49 INFO - Running setup.py (path:/tmp/pip-g8qSMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:49 INFO - Running setup.py (path:/tmp/pip-3bCWsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:49 INFO - Running setup.py (path:/tmp/pip-s5JNO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:49 INFO - Running setup.py (path:/tmp/pip-nivIxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:49 INFO - Running setup.py (path:/tmp/pip-oRjlhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:49 INFO - Running setup.py (path:/tmp/pip-sVyDxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:49 INFO - Running setup.py (path:/tmp/pip-nN4FUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:49 INFO - Running setup.py (path:/tmp/pip-96OFcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:49 INFO - Running setup.py (path:/tmp/pip-tbCMSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:49 INFO - Running setup.py (path:/tmp/pip-uXneJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:49 INFO - Running setup.py (path:/tmp/pip-yNJ_Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:50 INFO - Running setup.py install for manifestparser 03:30:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:50 INFO - Running setup.py install for mozcrash 03:30:50 INFO - Running setup.py install for mozdebug 03:30:50 INFO - Running setup.py install for mozdevice 03:30:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:50 INFO - Running setup.py install for mozfile 03:30:50 INFO - Running setup.py install for mozhttpd 03:30:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:50 INFO - Running setup.py install for mozinfo 03:30:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:50 INFO - Running setup.py install for mozInstall 03:30:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:50 INFO - Running setup.py install for mozleak 03:30:50 INFO - Running setup.py install for mozlog 03:30:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:51 INFO - Running setup.py install for moznetwork 03:30:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:51 INFO - Running setup.py install for mozprocess 03:30:51 INFO - Running setup.py install for mozprofile 03:30:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:51 INFO - Running setup.py install for mozrunner 03:30:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:51 INFO - Running setup.py install for mozscreenshot 03:30:51 INFO - Running setup.py install for moztest 03:30:51 INFO - Running setup.py install for mozversion 03:30:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:51 INFO - Cleaning up... 03:30:51 INFO - Return code: 0 03:30:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:51 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')]} 03:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:51 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')]} 03:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:51 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 0x7fef39fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', '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 03:30:51 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 03:30:51 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 03:30:51 INFO - Using env: {'DISPLAY': ':0', 03:30:51 INFO - 'HOME': '/home/cltbld', 03:30:51 INFO - 'LANG': 'en_US.UTF-8', 03:30:51 INFO - 'LANGUAGE': 'en_US:en', 03:30:51 INFO - 'LOGNAME': 'cltbld', 03:30:51 INFO - 'MAIL': '/var/mail/cltbld', 03:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:51 INFO - 'MOZ_NO_REMOTE': '1', 03:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:51 INFO - 'NO_EM_RESTART': '1', 03:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:51 INFO - 'PWD': '/builds/slave/test', 03:30:51 INFO - 'SHELL': '/bin/bash', 03:30:51 INFO - 'SHLVL': '1', 03:30:51 INFO - 'TERM': 'linux', 03:30:51 INFO - 'TMOUT': '86400', 03:30:51 INFO - 'USER': 'cltbld', 03:30:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:51 INFO - '_': '/tools/buildbot/bin/python'} 03:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:52 INFO - Running setup.py (path:/tmp/pip-zyabIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:52 INFO - Running setup.py (path:/tmp/pip-SW7XYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:52 INFO - Running setup.py (path:/tmp/pip-RwkTIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:52 INFO - Running setup.py (path:/tmp/pip-JqXJcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:52 INFO - Running setup.py (path:/tmp/pip-CMAkS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:52 INFO - Running setup.py (path:/tmp/pip-q2N9Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:52 INFO - Running setup.py (path:/tmp/pip-FlRSiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:52 INFO - Running setup.py (path:/tmp/pip-ZTE6JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:52 INFO - Running setup.py (path:/tmp/pip-gZiE9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:52 INFO - Running setup.py (path:/tmp/pip-YsYGjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:52 INFO - Running setup.py (path:/tmp/pip-oFxhgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:52 INFO - Running setup.py (path:/tmp/pip-Nbv0iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:52 INFO - Running setup.py (path:/tmp/pip-uNuu9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:52 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)) 03:30:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:52 INFO - Running setup.py (path:/tmp/pip-RWzSfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:53 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)) 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:53 INFO - Running setup.py (path:/tmp/pip-EXxr77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:53 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)) 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:53 INFO - Running setup.py (path:/tmp/pip-LmMnwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:53 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)) 03:30:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:53 INFO - Running setup.py (path:/tmp/pip-IJwpxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:53 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)) 03:30:53 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)) 03:30:53 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)) 03:30:53 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)) 03:30:53 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)) 03:30:53 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)) 03:30:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:55 INFO - Downloading blessings-1.6.tar.gz 03:30:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:55 INFO - Installing collected packages: blessings 03:30:55 INFO - Running setup.py install for blessings 03:30:55 INFO - Successfully installed blessings 03:30:55 INFO - Cleaning up... 03:30:55 INFO - Return code: 0 03:30:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:55 INFO - Reading from file tmpfile_stdout 03:30:55 INFO - Current package versions: 03:30:55 INFO - argparse == 1.2.1 03:30:55 INFO - blessings == 1.6 03:30:55 INFO - blobuploader == 1.2.4 03:30:55 INFO - docopt == 0.6.1 03:30:55 INFO - functools32 == 3.2.3-2 03:30:55 INFO - jsonschema == 2.5.1 03:30:55 INFO - manifestparser == 1.1 03:30:55 INFO - mozInstall == 1.12 03:30:55 INFO - mozcrash == 0.17 03:30:55 INFO - mozdebug == 0.1 03:30:55 INFO - mozdevice == 0.48 03:30:55 INFO - mozfile == 1.2 03:30:55 INFO - mozhttpd == 0.7 03:30:55 INFO - mozinfo == 0.9 03:30:55 INFO - mozleak == 0.1 03:30:55 INFO - mozlog == 3.4 03:30:55 INFO - moznetwork == 0.27 03:30:55 INFO - mozprocess == 0.23 03:30:55 INFO - mozprofile == 0.28 03:30:55 INFO - mozrunner == 6.12 03:30:55 INFO - mozscreenshot == 0.1 03:30:55 INFO - mozsystemmonitor == 0.3 03:30:55 INFO - moztest == 0.7 03:30:55 INFO - mozversion == 1.4 03:30:55 INFO - psutil == 3.1.1 03:30:55 INFO - requests == 1.2.3 03:30:55 INFO - wsgiref == 0.1.2 03:30:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 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 0x7fef39fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', '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 03:30:55 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 03:30:55 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 03:30:55 INFO - Using env: {'DISPLAY': ':0', 03:30:55 INFO - 'HOME': '/home/cltbld', 03:30:55 INFO - 'LANG': 'en_US.UTF-8', 03:30:55 INFO - 'LANGUAGE': 'en_US:en', 03:30:55 INFO - 'LOGNAME': 'cltbld', 03:30:55 INFO - 'MAIL': '/var/mail/cltbld', 03:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:55 INFO - 'MOZ_NO_REMOTE': '1', 03:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:55 INFO - 'NO_EM_RESTART': '1', 03:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:55 INFO - 'PWD': '/builds/slave/test', 03:30:55 INFO - 'SHELL': '/bin/bash', 03:30:55 INFO - 'SHLVL': '1', 03:30:55 INFO - 'TERM': 'linux', 03:30:55 INFO - 'TMOUT': '86400', 03:30:55 INFO - 'USER': 'cltbld', 03:30:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:55 INFO - '_': '/tools/buildbot/bin/python'} 03:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 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)) 03:30:55 INFO - Cleaning up... 03:30:55 INFO - Return code: 0 03:30:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef39fdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', '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 03:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:30:55 INFO - Using env: {'DISPLAY': ':0', 03:30:55 INFO - 'HOME': '/home/cltbld', 03:30:55 INFO - 'LANG': 'en_US.UTF-8', 03:30:55 INFO - 'LANGUAGE': 'en_US:en', 03:30:55 INFO - 'LOGNAME': 'cltbld', 03:30:55 INFO - 'MAIL': '/var/mail/cltbld', 03:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:55 INFO - 'MOZ_NO_REMOTE': '1', 03:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:55 INFO - 'NO_EM_RESTART': '1', 03:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:55 INFO - 'PWD': '/builds/slave/test', 03:30:55 INFO - 'SHELL': '/bin/bash', 03:30:55 INFO - 'SHLVL': '1', 03:30:55 INFO - 'TERM': 'linux', 03:30:55 INFO - 'TMOUT': '86400', 03:30:55 INFO - 'USER': 'cltbld', 03:30:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:55 INFO - '_': '/tools/buildbot/bin/python'} 03:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:56 INFO - Cleaning up... 03:30:56 INFO - Return code: 0 03:30:56 INFO - Running post-action listener: _resource_record_post_action 03:30:56 INFO - Running post-action listener: _start_resource_monitoring 03:30:56 INFO - Starting resource monitoring. 03:30:56 INFO - [mozharness: 2016-10-15 10:30:56.155428Z] Finished create-virtualenv step (success) 03:30:56 INFO - [mozharness: 2016-10-15 10:30:56.155883Z] Running install step. 03:30:56 INFO - Running pre-action listener: _resource_record_pre_action 03:30:56 INFO - Running main action method: install 03:30:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:56 INFO - Reading from file tmpfile_stdout 03:30:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:56 INFO - Reading from file tmpfile_stdout 03:30:56 INFO - Output received: 03:30:56 INFO - Usage: mozinstall [options] installer 03:30:56 INFO - Options: 03:30:56 INFO - -h, --help show this help message and exit 03:30:56 INFO - -d DEST, --destination=DEST 03:30:56 INFO - Directory to install application into. [default: 03:30:56 INFO - "/builds/slave/test"] 03:30:56 INFO - --app=APP Application being installed. [default: firefox] 03:30:56 INFO - mkdir: /builds/slave/test/build/application 03:30:56 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'] 03:30:56 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 03:31:12 INFO - Reading from file tmpfile_stdout 03:31:12 INFO - Output received: 03:31:12 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:12 INFO - Running post-action listener: _resource_record_post_action 03:31:12 INFO - [mozharness: 2016-10-15 10:31:12.834129Z] Finished install step (success) 03:31:12 INFO - [mozharness: 2016-10-15 10:31:12.834373Z] Running run-tests step. 03:31:12 INFO - Running pre-action listener: _resource_record_pre_action 03:31:12 INFO - Running main action method: run_tests 03:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:12 INFO - Python 2.7.3 03:31:12 INFO - Return code: 0 03:31:12 INFO - grabbing minidump binary from tooltool 03:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ba5f60>, '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 0x1ba6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ba71d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:31:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:31:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:31:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:12 INFO - Return code: 0 03:31:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 03:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 03:31:12 INFO - Using env: {'DISPLAY': ':0', 03:31:12 INFO - 'HOME': '/home/cltbld', 03:31:12 INFO - 'LANG': 'en_US.UTF-8', 03:31:12 INFO - 'LANGUAGE': 'en_US:en', 03:31:12 INFO - 'LOGNAME': 'cltbld', 03:31:12 INFO - 'MAIL': '/var/mail/cltbld', 03:31:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:12 INFO - 'MOZ_NO_REMOTE': '1', 03:31:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:12 INFO - 'NO_EM_RESTART': '1', 03:31:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:12 INFO - 'PWD': '/builds/slave/test', 03:31:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:12 INFO - 'SHELL': '/bin/bash', 03:31:12 INFO - 'SHLVL': '1', 03:31:12 INFO - 'TERM': 'linux', 03:31:12 INFO - 'TMOUT': '86400', 03:31:12 INFO - 'USER': 'cltbld', 03:31:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093', 03:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:12 INFO - '_': '/tools/buildbot/bin/python'} 03:31:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 03:31:13 INFO - mozversion application_buildid: 20161015020935 03:31:13 INFO - mozversion application_changeset: 2a1297e90c5981dea1449019480328aafff0cbd5 03:31:13 INFO - mozversion application_display_name: Nightly 03:31:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:13 INFO - mozversion application_name: Firefox 03:31:13 INFO - mozversion application_remotingname: firefox 03:31:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:31:13 INFO - mozversion application_vendor: Mozilla 03:31:13 INFO - mozversion application_version: 52.0a1 03:31:13 INFO - mozversion platform_buildid: 20161015020935 03:31:13 INFO - mozversion platform_changeset: 2a1297e90c5981dea1449019480328aafff0cbd5 03:31:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:31:13 INFO - mozversion platform_version: 52.0a1 03:31:13 INFO - using testdate: 1476527473 03:31:13 INFO - actual date: 1476527473 03:31:13 INFO - starting webserver on 'localhost:46093' 03:31:13 INFO - SUITE-START | Running 2 tests 03:31:13 INFO - TEST-START | dromaeo_css 03:31:13 INFO - operating with platform_type : linux_ 03:31:13 INFO - Initialising browser for dromaeo_css test... 03:31:13 INFO - TEST-INFO | started process 11313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX_OhYi/profile http://localhost:46093/getInfo.html) 03:31:17 INFO - PROCESS | 11313 | __metrics Screen width/height:1600/1200 03:31:17 INFO - PROCESS | 11313 | colorDepth:24 03:31:17 INFO - PROCESS | 11313 | Browser inner width/height: 1024/697 03:31:17 INFO - PROCESS | 11313 | __metrics 03:31:18 INFO - PROCESS | 11313 | 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" 03:31:18 INFO - PROCESS | 11313 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:18 INFO - PROCESS | 11313 | console.error: PushService: 03:31:18 INFO - PROCESS | 11313 | stateChangeProcessEnqueue: Error transitioning state 03:31:18 INFO - PROCESS | 11313 | UnknownError 03:31:19 INFO - TEST-INFO | 11313: exit 0 03:31:19 INFO - Browser initialized. 03:31:19 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:19 INFO - TEST-INFO | started process 11397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX_OhYi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:32 INFO - PROCESS | 11397 | RSS: Main: 173973504 03:31:32 INFO - PROCESS | 11397 | 03:32:23 INFO - PROCESS | 11397 | 1476527543655 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] 03:34:38 INFO - PROCESS | 11397 | Cycle 1(1): loaded http://localhost:46093/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46093/tests/dromaeo/cssquery-ext.html) 03:34:39 INFO - PROCESS | 11397 | RSS: Main: 303947776 03:34:39 INFO - PROCESS | 11397 | 03:37:42 INFO - PROCESS | 11397 | Cycle 1(1): loaded http://localhost:46093/tests/dromaeo/cssquery-ext.html (next: http://localhost:46093/tests/dromaeo/cssquery-jquery.html) 03:37:42 INFO - PROCESS | 11397 | RSS: Main: 282927104 03:37:42 INFO - PROCESS | 11397 | 03:40:44 INFO - PROCESS | 11397 | Cycle 1(1): loaded http://localhost:46093/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46093/tests/dromaeo/cssquery-mootools.html) 03:40:45 INFO - PROCESS | 11397 | RSS: Main: 244891648 03:40:45 INFO - PROCESS | 11397 | 03:43:47 INFO - PROCESS | 11397 | Cycle 1(1): loaded http://localhost:46093/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46093/tests/dromaeo/cssquery-prototype.html) 03:43:48 INFO - PROCESS | 11397 | RSS: Main: 235806720 03:43:48 INFO - PROCESS | 11397 | 03:46:51 INFO - PROCESS | 11397 | Cycle 1(1): loaded http://localhost:46093/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46093/tests/dromaeo/cssquery-yui.html) 03:46:52 INFO - PROCESS | 11397 | RSS: Main: 221257728 03:46:52 INFO - PROCESS | 11397 | 03:49:55 INFO - PROCESS | 11397 | Cycle 1(1): loaded http://localhost:46093/tests/dromaeo/cssquery-yui.html (next: http://localhost:46093/tests/dromaeo/cssquery-dojo.html) 03:49:55 INFO - PROCESS | 11397 | RSS: Main: 299667456 03:49:55 INFO - PROCESS | 11397 | 03:49:55 INFO - PROCESS | 11397 | __start_tp_report 03:49:55 INFO - PROCESS | 11397 | _x_x_mozilla_page_load 03:49:55 INFO - PROCESS | 11397 | _x_x_mozilla_page_load_details 03:49:55 INFO - PROCESS | 11397 | |i|pagename|runs| 03:49:55 INFO - PROCESS | 11397 | |0;dojo.html;2590.7927365810738;2620.3973086190176;2624.186502184323;2656.123479251847;2663.3075400395905;4528.04910968697;4552.931706024412;4664.300354946756;4703.200455922492;4726.952730472699;4591.77041147943;4601.079784043188;4614.584687378136;4627.167109920213;4636.559526844952;4234.957650423495;4257;4267.829286828523;4286.935695964563;4338.327559228309;4286.592773686495;4309.547497512763;4321.675874309423;4322.546132656057;4324.805383757723;4319.892002699926;4322.567743225683;4325.82696692132;4360.324149756777;4378.6934914555995;4383.9342409863875;4385.627221686161;4406.609416877567;4411.801468933873;4442.378067070613;4186.162767446523;4223.13425747721;4265.658747300208;4286.39990401344;4330.285502892019;4685.906281874378;4701.717896926195;4713.222318317474;4754.334393184957;4760.904781904343;5018.046571151506;5042.974785126087;5061.063703214881;5067.594592432597;5125.641205115643;4931.26031095335;4990.226514890198;4992.975035124838;5049.873753156164;5062.417821950486;4732.952670473252;4749.786259618326;4771.260454629538;4772.809087636525;4796.496367881322;5195.532402083755;5203.245529398216;5204.21936709489;5213.2701421800975;5262.158054711228;4815.470298267188;4980.800767969241;4992.350994370709;4992.675476094042;4993.226049962262;4934.383202099738;4984.925226121611;5014.89970200594;5030.3963524377305;5040.1179793535985;5003.849884503471;5010.148274793221;5012.473690262543;5056.469070747592;5064.873378165502;4960.950390496121;4996.050750357421;5015.3229314042865;5019.347484826949;5070.188769796889;4201.264778663783;4244.3633454982;4244.957550424518;4283.935740963888;4321.351797230441;3766.246750649826;3772.75477093988;3786.280606684776;3803.5245594300713;3811.8475260989803;4304.354346847936;4332.436783218224;4334.479862416467;4336.674749393808;4337.7180483268485;4985.700857948535;4996.450390457119;4997.450280469146;4997.700137991732;4998.90002199954;4290.0776333087915;4323.329883868006;4327.697061205686;4330.025744207591;4333.826646934151;4551.40831691878;4586.4496260448295;4616.192166370872;4629.675922685447;4633.698809577367;4778.450478195052;4780.354652122058;4783.210770222874;4821.108095002436;4842.539958703988;5058.089543882136;5058.772355244097;5061.468545802785;5067.974660126676;5107.080725469451;4652.976735116303;4703.200455922433;4703.788329525111;4772.260299653559;4836.032793441396;4807.158747219292;4859.878503037452;4870.464248932685;4875.561199492063;4946.530079642428;4947;4950.4059512858685;4953;4957.157283261926;5013.047520971004;4754.595859351855;4821.927671084866;4822.300766388784;4823.294285261986;4881.9023619528125;4820.566149046603;4857.659963802641;4861.076395484846;4904.117258893433;4906.092372911023;4825.95174048255;4830.686005409637;4834.782434790513;4850.272459131159;4890.266460031024;4919.557239848431;4923.310736496822;4925.064237794808;4926.039422312615;4980.252962055721;4716.551927566876;4765.7140571565815;4768.356271903387;4815.542523460265;4837.951620483891 03:49:55 INFO - PROCESS | 11397 | |1;ext.html;550.2241839007;558.7848678258872;565.5334349161942;566.6628356128105;569.2116418760019;27791;28619.284517887038;41871.16257674849;43472.565274347326;43508.34737478932;40127.79936100323;40608.59391406085;40650.39024414636;40702.59297407025;40763.79618101913;7633.5801530915915;7733.497322674037;7736.690532378698;7748.8837667434755;7794.064712234512;7414.998975138341;7491.700331986741;7507.099148102208;7507.361874240696;7508.774736757906;7519.473636845396;7551.886721699179;7566.810829729273;7572.167061623217;7584.886226706604;7465.589392583406;7475.289847464509;7502.62486875654;7509.324160825552;7511.661975211156;7547.283008114276;7603.163651998276;7662.118856331537;7663.961680191564;7665.655045522909;37796.62203377958;38182.618173818184;38214;38219;38221.23557528834;2992.9102126936227;2998.5202367621296;3020.6073210482496;3021.9093427197217;3027.712367325101;27650.585241221397;28023.439531209464;28481.57277640837;28702.138935831957;29866.70133298661;3332.516785066176;3401.9489707654157;3402.9829850850588;3432.8626854925774;3499.7550171488006;194474;196481;250686;251410;251488;55262.72368638131;55891.72054139703;55908.72045639746;55943.16085258724;55959;32966.83516582402;33566.3286734264;33601.83199083989;35835.10412239715;58815.70592147012;13662.316884155753;13725.45098196081;13733.313334333243;13741.931290343484;13747.106438081693;9849.21206303494;9908.108270255567;9938.850917236246;9944.35361701487;9947;18793.90603046976;18883.52791180204;18888;18908.43274701761;18913.7162942556;6923.723051077901;7024.508284420143;7157.069580954442;7173.964130179315;7414.851702965911;778.7507997440878;800.7837883771466;869.8434281829205;875.7110153649407;947.966821161256;24777;27074.593881091798;27689;27850.303742406602;28026.579601305995;922.8292765838341;939.8355287824741;942.9434233945985;1005.582683186484;1025.4565080507193;13816;14356.569302920929;14558.272086395638;14728.263586820616;14967.326470308863;350945;355140;355624;355646;356168;49228.75385623049;49875.25187122196;49888;49907.500924991014;49933.50066499361;1125.3585456289836;1139.2765593847967;1164.1152723929874;1178.7583545373177;1183.2427246562206;26026.739732602433;26648.60027099556;26823.597646034934;27232.319192020357;27308.590371144845;41974.37038444487;42694.57305426906;42704.35943460913;42717;42782.78608606937;333354;333615;335529;335852;336040;24598.877005614857;25085.749142508343;25170.24489265325;25438;25464.618030729183;41133;41761.164776703685;42157.57842421537;42624.786876065424;42934.57065429306;35241.295174096886;35590.8220458896;36519.63480365162;37285.440718389786;37476.43785343276;35259;35673.643263567035;35678;35704.64295357013;35788.10529736777;34911.47632785561;35347.46978795269;35504.82247588746;35881;36219.818900905324;30081;32872.34255314832;32875.67124328726;32944.1763955903;33017.17457063593;24259;25193.244202673948;25233.621495677948;25493;25648.487030259665 03:49:55 INFO - PROCESS | 11397 | |2;jquery.html;326.4939344016776;343.6477610449291;344.6088689337601;346.791924845093;374;12112.27326360419;13271.20372777634;15568.14375209363;15971.600709982256;16931.915340423282;14658.560243192695;14709.92645036776;14934.626634334147;15001.549953501386;15187.620309492268;4921.729304888238;5139.768710408022;5150.227465880111;5153.330067091291;5154.69071855688;4265.637420819234;5995.550333724967;6049.637021778685;6129.570930034899;6130.938690613104;5716.514096301819;5977.701114944257;6084.482818960394;6091.939080609203;6092.086187071953;5816.738246778905;5834.970825145847;5846.532277417797;5847.064469684851;5858.589898707092;4908.386451693538;5047.318611987372;5064.620153488466;5110.591152707774;5156.3296771419855;16289.185540722916;16357.345706171738;16370.263338149813;18125.36561220351;19872.90063549673;1797.3978717129778;2370.454795397051;2376.6553849691873;2431.7932975697086;2501.6122501012374;12770.48918043277;12774.808377874338;12922.87077129226;13279;13477.506661267696;1704.2671651189983;1718.7421886716968;1769.9115044247865;1791.3282519055354;1819.7543331650322;68098.65950670265;68920.31079689189;68932.31067689309;69472.3052769471;70120;7848.803779905548;8501.61742721579;8583.270422014073;8818.95590522056;8819.603117859711;11615.6515304541;11747.649020362596;11790.349351090854;11805;11822.52709891612;6440.452561532228;6629.1382120325015;6672.632110417353;6792.8301792454595;6812.591244525344;6589.242237142694;6621.139251897319;6686.7993960181275;6783.118194634666;6838.965805170942;3490.616032236452;3534.7879127252445;3538.239278555123;3559.911002224965;3606.441001644749;1720.956976075583;1734.9306027759;1761.0314327120034;1770.1857145713116;1800.8379245867934;638.6327861479667;781.9022622172229;808.3694718119876;808.8099296665279;827.71443851871;15540.84459155394;15944.202789860461;16390.918045409697;16769.90995585283;16881.662366752596;827.4414770030326;833.1751565949667;844.7972486603171;870.5299138465284;880.6257340630207;8766.430182038275;9321.533923303808;10132.392056476636;10164.796704065877;10434.739131521621;372135;375558;378671;382971;383725;73350.63324683449;75468.62265688636;76221.3290139381;76974;78051.60974195093;902.3818684201212;908.8182363527321;932.7201839448275;937.5921474158763;940.9623615055322;15141.924290378478;15229.466968656045;15700.214989250264;16118.435854745028;16164;35365.81098307837;37047.44428833516;37565.81217093897;37884.24231515409;38396;48205.420485053866;48512;48513.757431212616;48545.75727121342;48877.511224888716;7068.540544864567;7179.892301615376;7385.9261407387385;7463.872796253042;7620.276073772982;7945.562994035384;9397;10470.476476176313;10781.137508999105;10824;6721.764738234138;6799.218089919723;6800.625965571941;8879.845620069349;9334.113259240361;6582.341765823571;6921.2732663069655;6951.548149370275;7193.136823581203;7452.664630091767;6878.759243426456;7000.719971201095;7017.649117544204;7044.15470143586;7158.248383919822;10674.839877402;10746.946265268623;11211.943940280247;11313.886861131283;11469.426528673699;9555.569999349907;9778.364406313567;9801.558929848032;10114.089731924161;10402.531886064993 03:49:55 INFO - PROCESS | 11397 | |3;mootools.html;1339.437436276764;1399.1605036977815;1428.9214093224875;1623.4155703946585;1664.7419649954247;7263.201047884735;7826.1391246962785;7826.491278066922;7832.96083519583;7840.137584865674;6519.739210431589;6719.260881303053;7180.281971802817;7446.404287656988;7556.773296801091;2112.260708751936;2138.272987184357;2140.935771926837;2141.7429908411013;2157.9426081220245;2080.251109600543;2105.8525903186705;2142.9035693393835;2143.47484866208;2146.1415433826437;2077.1587507059667;2094.214669498938;2103.905324260404;2106.5049713317358;2128.8084072433476;2040.1125510402949;2046.4474591860114;2047.3653167518116;2047.5904819036252;2048.92828750993;2030.8883011434366;2038.775734669185;2051.169276443028;2057.845661575373;2059.835213182942;7567.091948966159;7572.810679732996;7639.121501027397;7676.11724651661;7676.232376762335;4236.597523235288;4334.761588112652;4344.304911214191;4344.695871289011;4348;2750.339918419585;2825.2371859597997;2862.3130448692373;2866.054202113298;2876.7698584113223;864.6109250837086;907.4373888189299;911.5214512380986;913;913.6756451459703;9908.455034973074;9960.90039099607;9964.451955142464;9991.75020624483;9994.300398972075;3871.4773505576386;3950.585188555218;4104.199681062164;4118.4440100586635;4127.380892866034;8416.53709045996;8423.241908228289;8440;8444.071152173256;8499.830003399897;4389.034412429261;4391.8682439526865;4393.29707246839;4394.231009573376;4395.604395604411;3485.3552092862396;3632.6912212461707;3839.884803455901;3934.6655534279334;3990.4213888985932;3402.608699999532;3454.4990976308295;3542.8582856685957;3570.3751843427817;3579;1087.363892123101;1101.3446999035561;1119.3004372267333;1127.0532752487786;1130.6834086455806;814.8777683347545;819.7499762572472;822.6627082895984;827.2141465607576;828.8147948433798;4946.455889852114;4956.306117143603;4992.775325110379;5050.242463630411;5086.694798312114;403.1453318963757;822.8066404394963;873.9126087391337;927.6660402255183;961.0629636104882;3323.933521329608;3412.675795799395;3439.3465241604517;3460.8788692395647;3482.3209474152295;8622.698205562776;8970.955145224232;9005.05446928063;9013.459192448474;9014.504202268807;8986.236169925498;8987.685431009882;8990.415622984485;8993.955030224806;9001.954990225138;6790.151231096113;6844.828879277959;6981.755638552626;7143.4999550031;7163.820904477429;4749.192637251606;4902.965269413154;4931.852044438672;4952.1581331173065;5063.898722025465;8393.916060839314;8452.873206901779;8457.238848503419;8497.022842372959;8563.357748169037;8073.6770529178175;8382.49705017701;8396.370272229486;8562.143785621389;8664.523451210243;5796.391378905323;5958.821235362946;6553.5084868634085;6710.261871194262;6719.596824190368;6871.801023672377;7104.786856394317;7166.498345115792;7324.670389832577;7325.230850760593;6330.8100756977365;6339.444824367561;6402.839929001626;6470.708818103102;6546.509011824037;6419.807405777834;6446.290908000023;6494.155759751202;6504.642244676588;6507.642079685474;5517.944820551904;5613.803516876889;5627.268455100811;5628.296462942132;5635.6618602883955;4044.1911617675996;4106.486689163855;4122.42286079943;4205.810738516835;4438.1567502174485;4111.773852438145;4171.520275168395;4189.120284740238;4206.516250631216;4249.235137675249 03:49:55 INFO - PROCESS | 11397 | |4;prototype.html;270.6076189525189;276.74677669932015;278.1197509881226;282.2956722976175;286.6273844002796;4554.726716397018;4745.928811067833;4789.760511974396;4817.349657796192;4828.7585620719;4590.540945905408;4677.549959512554;4680.4149481314835;4716.36329095572;4768.21324481461;3737.1591391936868;3760.247950409915;3770.660640542351;3771.5097037385103;3779.3197224499577;3582.283543291352;3769.7549659272195;3774.7168962327796;3777.112378591029;3781.5273090863643;3439.1917899293644;3705.925881482369;3733.383991641376;3747.812609369534;3748.550173979126;3731.7201209909094;3734.8319325630414;3740.345439548068;3751.4747935289083;3756.887293381203;3305.9669403305898;3311.586051743532;3311.850966706504;3320.5019247113128;3329.667033296675;4595.8740108673255;4662.184117779409;4663.160631086403;4725.834595789131;4729.881752956169;4237.258479766028;4240.194363071007;4251.256030194703;4301.483821941356;4303.462067241595;4965.751712414401;5001.524855138756;5016.347874776292;5027.4469808321055;5058.064258112261;3443.707284880788;3580.7672501287593;3599.1182160370613;3619.8914032579064;3636.7636103653444;5174.395937259424;5194.97402512985;5205.817796377147;5207.843764687065;5208.151106357226;3654;3661.853525858989;3664.9816750916075;3705.203381273039;3705.8517659293325;3758.4550240215017;3758.774473531597;3776.962230377716;3779.903827889936;3787.8106094695154;4167.291560434734;4211.768352740567;4272.615464608138;4295.312749960054;4297.538836795505;4967.428745694219;4989.426215985136;4991.675541089818;5005.549500544968;5009.44896061433;1222.8226907098422;1263.1789336931067;1272.8727127287198;1297.3902265934996;1305.11252348404;842.4456877061812;882.8587426011936;895.1719659315238;898.9056149104381;906.5133181582211;4408.7575183365225;4413.845515406945;4414.911701765946;4436.401085853433;4447.264932066756;5145.434002259748;5159.819406320761;5168.664036837594;5191.454897235812;5194.246834209019;4296.6347860432215;4371.191329604034;4390.463337831733;4410.558944105564;4440.4005459263235;2709.794141606966;2717.144099608617;2735.822171558882;2739.9999000364724;2745.5058089543672;4828.396450443694;4832.540908613676;4865.391826021747;4880.341153944243;4881.559939817762;5056.721880296619;5152.845414637567;5168.328117344721;5203.869903252449;5234.194202999959;4783.425988881357;4795.496472870368;4817.735024573612;4870.610351171968;4872.342233798534;4946.727929963887;5060.924086138784;5075.7969681212335;5076.923846142385;5142.6914385137015;4994.900101998012;5002.949970500248;5038.748062596929;5041.697498150123;5045.747712614281;4849.248366503198;4850.1997170467885;4851.326292429107;4852.80588776445;4897.461279259207;3713.442983552489;3721.6650501455;3737.7852198035202;3749.4000959846294;3749.7937613431523;5036.974815126047;5117.61617878668;5125.641205115606;5127.41034781005;5151.948480515147;4968.8757781055765;4977.576905963034;4982.277569752293;4983.27742477346;4995.475475075064;4982.6512144149565;4985.476524964972;4990.5508504234795;5007.097303024827;5015.974920125522;4734;4739.459675605511;4876.4392094909535;4970.502949705001;4979;4884.755762211804;5060.443351231288;5061.822836200715;5063.924041139312;5072.442031376472;4944.294218494613;4968.677035992649;4968.7081358846235;4974.502549744997;4994.500549944976 03:49:55 INFO - PROCESS | 11397 | |5;yui.html;554.1161846854267;612.5314134686965;613.6594190224425;613.9048447490637;620.9658468784215;12573.434195461203;12780.297083660394;13235.933820330885;13458.663533411669;13531.12047716899;13042.282674452901;13168.802467962989;13245.139065960706;13252.867471325284;13254.668633284173;751.0574229342168;766.7086507127311;766.8696321625337;767.3055884424605;768.227930929418;619.683961179797;630.4263120560291;636.5130675033603;638.6264035539192;773.2731232641328;661.1339145719099;782.8943092682472;791.1534657916033;809.28378385129;813.2680587471264;800.6197056398222;800.6637212370819;802.2298593350362;802.3260461212581;802.6147449224346;589.3634874335708;590.6721769417971;591.5918016568554;591.6864062047122;592.120700759372;9984.80030399388;10217.744556386075;11582.305061696325;11952.342621155833;11999.580014699532;12428.37858107091;12668.2399056056;13314.933425332909;13468.39392227352;13620.18278903269;10121.291509594332;10205.183585313158;10251.384916904935;10344.482775861252;10606.310589811637;3284.556584861037;3341.61571419285;3354.815485148316;3355.9161020974425;3400.0989737719524;61403.38596614066;61878.69060654713;62289.377106228814;62385.68807155981;62439.37560624426;10181.643642472478;10255;10295.569679919457;10430.53062612169;10436.42599657011;20077.29729459491;20185.49536261576;20278.391648250577;20283.290084846958;20332.288369907277;6554.672266386661;6559.737610495622;6673.132492775908;6694.933050669529;6738.494612904052;3249.8862539810993;3250.5286733423995;3277.8033318001;3333.333333333343;3340.549025881475;2871.899483518067;3033.4843076676575;3048.3750831079574;3055.450018996602;3055.8930437434583;500.47450177313675;500.57201093065635;506.5668853130594;508.5905845794171;512.0552580488992;560.778492495462;585.1537016902176;589.8348462430527;597.223609307898;603.8399824046631;7797.220277972271;8134.715284965117;8283.792905177419;8323.417360784686;8449.070602233749;474.0660898030874;499.3757802746567;545.9408747030748;573.9368669446358;632.1024145713099;3762.680172185395;3808.333541630204;3850.1914597934187;3954.703397245218;4001.47980762499;55135;55325.72337138288;56672.14991775127;71978.64010680017;75688;71876.64061679762;72842.63578682073;74358;74751.62624186845;76467.61766191245;40886.79556602198;52514.21228681573;54681;67972;69857.3014269861;7987.64055617487;8304.003519577689;8384.245417912418;8414.705485307984;8420.663173472993;38357.232855343296;40784.79607602062;41993.58006419897;42713.359299611155;43265.56734432741;51673.73365242352;62099.169091400814;62206;63093.68453157888;63448;11257.549698012315;11485.540578376771;11510.136739744385;11568.826467602825;11625.36060516646;11996.280223186637;12329.630111096682;12849.807252891027;13033.15284506504;13753.174809511462;11162;11636.476358563716;11690.339852755329;11755.118366122404;12239.69400764988;10691.25161238737;11301.660950171508;11750.118741094622;11972.64082077539;12210;11390.145739069438;11561.083839201056;11880.524779008743;11882.10884183707;11936;9595.184409325286;9905.455199964072;10115.280065080844;10326.225533085199;10345.482725863827;9443.952780236055;9827.4103553787;9923.35498192644;9985.201183905125;10077.19382449417 03:49:55 INFO - PROCESS | 11397 | __end_tp_report 03:49:55 INFO - PROCESS | 11397 | __start_cc_report 03:49:55 INFO - PROCESS | 11397 | _x_x_mozilla_cycle_collect,1338 03:49:55 INFO - PROCESS | 11397 | __end_cc_report 03:49:55 INFO - PROCESS | 11397 | __startTimestamp1476528595423__endTimestamp 03:49:55 INFO - PROCESS | 11397 | 03:49:55 INFO - PROCESS | 11397 | ------- Summary: start ------- 03:49:55 INFO - PROCESS | 11397 | Number of tests: 6 03:49:55 INFO - PROCESS | 11397 | 03:49:55 INFO - PROCESS | 11397 | [#0] dojo.html Cycles:165 Average:4643.53 Median:4778.45 stddev:481.49 (10.1%) stddev-sans-first:455.24 03:49:55 INFO - PROCESS | 11397 | Values: 2590.8 2620.4 2624.2 2656.1 2663.3 4528.0 4552.9 4664.3 4703.2 4727.0 4591.8 4601.1 4614.6 4627.2 4636.6 4235.0 4257.0 4267.8 4286.9 4338.3 4286.6 4309.5 4321.7 4322.5 4324.8 4319.9 4322.6 4325.8 4360.3 4378.7 4383.9 4385.6 4406.6 4411.8 4442.4 4186.2 4223.1 4265.7 4286.4 4330.3 4685.9 4701.7 4713.2 4754.3 4760.9 5018.0 5043.0 5061.1 5067.6 5125.6 4931.3 4990.2 4993.0 5049.9 5062.4 4733.0 4749.8 4771.3 4772.8 4796.5 5195.5 5203.2 5204.2 5213.3 5262.2 4815.5 4980.8 4992.4 4992.7 4993.2 4934.4 4984.9 5014.9 5030.4 5040.1 5003.8 5010.1 5012.5 5056.5 5064.9 4961.0 4996.1 5015.3 5019.3 5070.2 4201.3 4244.4 4245.0 4283.9 4321.4 3766.2 3772.8 3786.3 3803.5 3811.8 4304.4 4332.4 4334.5 4336.7 4337.7 4985.7 4996.5 4997.5 4997.7 4998.9 4290.1 4323.3 4327.7 4330.0 4333.8 4551.4 4586.4 4616.2 4629.7 4633.7 4778.5 4780.4 4783.2 4821.1 4842.5 5058.1 5058.8 5061.5 5068.0 5107.1 4653.0 4703.2 4703.8 4772.3 4836.0 4807.2 4859.9 4870.5 4875.6 4946.5 4947.0 4950.4 4953.0 4957.2 5013.0 4754.6 4821.9 4822.3 4823.3 4881.9 4820.6 4857.7 4861.1 4904.1 4906.1 4826.0 4830.7 4834.8 4850.3 4890.3 4919.6 4923.3 4925.1 4926.0 4980.3 4716.6 4765.7 4768.4 4815.5 4838.0 03:49:55 INFO - PROCESS | 11397 | 03:49:55 INFO - PROCESS | 11397 | [#1] ext.html Cycles:180 Average:45782.97 Median:35746.37 stddev:81984.72 (229.4%) stddev-sans-first:82144.37 03:49:55 INFO - PROCESS | 11397 | Values: 550.2 558.8 565.5 566.7 569.2 27791.0 28619.3 41871.2 43472.6 43508.3 40127.8 40608.6 40650.4 40702.6 40763.8 7633.6 7733.5 7736.7 7748.9 7794.1 7415.0 7491.7 7507.1 7507.4 7508.8 7519.5 7551.9 7566.8 7572.2 7584.9 7465.6 7475.3 7502.6 7509.3 7511.7 7547.3 7603.2 7662.1 7664.0 7665.7 37796.6 38182.6 38214.0 38219.0 38221.2 2992.9 2998.5 3020.6 3021.9 3027.7 27650.6 28023.4 28481.6 28702.1 29866.7 3332.5 3401.9 3403.0 3432.9 3499.8 194474.0 196481.0 250686.0 251410.0 251488.0 55262.7 55891.7 55908.7 55943.2 55959.0 32966.8 33566.3 33601.8 35835.1 58815.7 13662.3 13725.5 13733.3 13741.9 13747.1 9849.2 9908.1 9938.9 9944.4 9947.0 18793.9 18883.5 18888.0 18908.4 18913.7 6923.7 7024.5 7157.1 7174.0 7414.9 778.8 800.8 869.8 875.7 948.0 24777.0 27074.6 27689.0 27850.3 28026.6 922.8 939.8 942.9 1005.6 1025.5 13816.0 14356.6 14558.3 14728.3 14967.3 350945.0 355140.0 355624.0 355646.0 356168.0 49228.8 49875.3 49888.0 49907.5 49933.5 1125.4 1139.3 1164.1 1178.8 1183.2 26026.7 26648.6 26823.6 27232.3 27308.6 41974.4 42694.6 42704.4 42717.0 42782.8 333354.0 333615.0 335529.0 335852.0 336040.0 24598.9 25085.7 25170.2 25438.0 25464.6 41133.0 41761.2 42157.6 42624.8 42934.6 35241.3 35590.8 36519.6 37285.4 37476.4 35259.0 35673.6 35678.0 35704.6 35788.1 34911.5 35347.5 35504.8 35881.0 36219.8 30081.0 32872.3 32875.7 32944.2 33017.2 24259.0 25193.2 25233.6 25493.0 25648.5 03:49:55 INFO - PROCESS | 11397 | 03:49:55 INFO - PROCESS | 11397 | [#2] jquery.html Cycles:180 Average:23471.44 Median:4984.52 stddev:62618.88 (1256.3%) stddev-sans-first:62770.43 03:49:55 INFO - PROCESS | 11397 | Values: 326.5 343.6 344.6 346.8 374.0 12112.3 13271.2 15568.1 15971.6 16931.9 14658.6 14709.9 14934.6 15001.5 15187.6 4921.7 5139.8 5150.2 5153.3 5154.7 4265.6 5995.6 6049.6 6129.6 6130.9 5716.5 5977.7 6084.5 6091.9 6092.1 5816.7 5835.0 5846.5 5847.1 5858.6 4908.4 5047.3 5064.6 5110.6 5156.3 16289.2 16357.3 16370.3 18125.4 19872.9 1797.4 2370.5 2376.7 2431.8 2501.6 12770.5 12774.8 12922.9 13279.0 13477.5 1704.3 1718.7 1769.9 1791.3 1819.8 68098.7 68920.3 68932.3 69472.3 70120.0 7848.8 8501.6 8583.3 8819.0 8819.6 11615.7 11747.6 11790.3 11805.0 11822.5 6440.5 6629.1 6672.6 6792.8 6812.6 6589.2 6621.1 6686.8 6783.1 6839.0 3490.6 3534.8 3538.2 3559.9 3606.4 1721.0 1734.9 1761.0 1770.2 1800.8 638.6 781.9 808.4 808.8 827.7 15540.8 15944.2 16390.9 16769.9 16881.7 827.4 833.2 844.8 870.5 880.6 8766.4 9321.5 10132.4 10164.8 10434.7 372135.0 375558.0 378671.0 382971.0 383725.0 73350.6 75468.6 76221.3 76974.0 78051.6 902.4 908.8 932.7 937.6 941.0 15141.9 15229.5 15700.2 16118.4 16164.0 35365.8 37047.4 37565.8 37884.2 38396.0 48205.4 48512.0 48513.8 48545.8 48877.5 7068.5 7179.9 7385.9 7463.9 7620.3 7945.6 9397.0 10470.5 10781.1 10824.0 6721.8 6799.2 6800.6 8879.8 9334.1 6582.3 6921.3 6951.5 7193.1 7452.7 6878.8 7000.7 7017.6 7044.2 7158.2 10674.8 10746.9 11211.9 11313.9 11469.4 9555.6 9778.4 9801.6 10114.1 10402.5 03:49:55 INFO - PROCESS | 11397 | 03:49:55 INFO - PROCESS | 11397 | [#3] mootools.html Cycles:180 Average:4855.75 Median:5302.32 stddev:2698.46 (50.9%) stddev-sans-first:2693.09 03:49:55 INFO - PROCESS | 11397 | Values: 1339.4 1399.2 1428.9 1623.4 1664.7 7263.2 7826.1 7826.5 7833.0 7840.1 6519.7 6719.3 7180.3 7446.4 7556.8 2112.3 2138.3 2140.9 2141.7 2157.9 2080.3 2105.9 2142.9 2143.5 2146.1 2077.2 2094.2 2103.9 2106.5 2128.8 2040.1 2046.4 2047.4 2047.6 2048.9 2030.9 2038.8 2051.2 2057.8 2059.8 7567.1 7572.8 7639.1 7676.1 7676.2 4236.6 4334.8 4344.3 4344.7 4348.0 2750.3 2825.2 2862.3 2866.1 2876.8 864.6 907.4 911.5 913.0 913.7 9908.5 9960.9 9964.5 9991.8 9994.3 3871.5 3950.6 4104.2 4118.4 4127.4 8416.5 8423.2 8440.0 8444.1 8499.8 4389.0 4391.9 4393.3 4394.2 4395.6 3485.4 3632.7 3839.9 3934.7 3990.4 3402.6 3454.5 3542.9 3570.4 3579.0 1087.4 1101.3 1119.3 1127.1 1130.7 814.9 819.7 822.7 827.2 828.8 4946.5 4956.3 4992.8 5050.2 5086.7 403.1 822.8 873.9 927.7 961.1 3323.9 3412.7 3439.3 3460.9 3482.3 8622.7 8971.0 9005.1 9013.5 9014.5 8986.2 8987.7 8990.4 8994.0 9002.0 6790.2 6844.8 6981.8 7143.5 7163.8 4749.2 4903.0 4931.9 4952.2 5063.9 8393.9 8452.9 8457.2 8497.0 8563.4 8073.7 8382.5 8396.4 8562.1 8664.5 5796.4 5958.8 6553.5 6710.3 6719.6 6871.8 7104.8 7166.5 7324.7 7325.2 6330.8 6339.4 6402.8 6470.7 6546.5 6419.8 6446.3 6494.2 6504.6 6507.6 5517.9 5613.8 5627.3 5628.3 5635.7 4044.2 4106.5 4122.4 4205.8 4438.2 4111.8 4171.5 4189.1 4206.5 4249.2 03:49:55 INFO - PROCESS | 11397 | 03:49:55 INFO - PROCESS | 11397 | [#4] prototype.html Cycles:180 Average:4158.68 Median:4736.73 stddev:1197.47 (25.3%) stddev-sans-first:1164.73 03:49:55 INFO - PROCESS | 11397 | Values: 270.6 276.7 278.1 282.3 286.6 4554.7 4745.9 4789.8 4817.3 4828.8 4590.5 4677.5 4680.4 4716.4 4768.2 3737.2 3760.2 3770.7 3771.5 3779.3 3582.3 3769.8 3774.7 3777.1 3781.5 3439.2 3705.9 3733.4 3747.8 3748.6 3731.7 3734.8 3740.3 3751.5 3756.9 3306.0 3311.6 3311.9 3320.5 3329.7 4595.9 4662.2 4663.2 4725.8 4729.9 4237.3 4240.2 4251.3 4301.5 4303.5 4965.8 5001.5 5016.3 5027.4 5058.1 3443.7 3580.8 3599.1 3619.9 3636.8 5174.4 5195.0 5205.8 5207.8 5208.2 3654.0 3661.9 3665.0 3705.2 3705.9 3758.5 3758.8 3777.0 3779.9 3787.8 4167.3 4211.8 4272.6 4295.3 4297.5 4967.4 4989.4 4991.7 5005.5 5009.4 1222.8 1263.2 1272.9 1297.4 1305.1 842.4 882.9 895.2 898.9 906.5 4408.8 4413.8 4414.9 4436.4 4447.3 5145.4 5159.8 5168.7 5191.5 5194.2 4296.6 4371.2 4390.5 4410.6 4440.4 2709.8 2717.1 2735.8 2740.0 2745.5 4828.4 4832.5 4865.4 4880.3 4881.6 5056.7 5152.8 5168.3 5203.9 5234.2 4783.4 4795.5 4817.7 4870.6 4872.3 4946.7 5060.9 5075.8 5076.9 5142.7 4994.9 5002.9 5038.7 5041.7 5045.7 4849.2 4850.2 4851.3 4852.8 4897.5 3713.4 3721.7 3737.8 3749.4 3749.8 5037.0 5117.6 5125.6 5127.4 5151.9 4968.9 4977.6 4982.3 4983.3 4995.5 4982.7 4985.5 4990.6 5007.1 5016.0 4734.0 4739.5 4876.4 4970.5 4979.0 4884.8 5060.4 5061.8 5063.9 5072.4 4944.3 4968.7 4968.7 4974.5 4994.5 03:49:55 INFO - PROCESS | 11397 | 03:49:55 INFO - PROCESS | 11397 | [#5] yui.html Cycles:180 Average:15870.08 Median:499.93 stddev:20808.44 (4162.3%) stddev-sans-first:20835.03 03:49:55 INFO - PROCESS | 11397 | Values: 554.1 612.5 613.7 613.9 621.0 12573.4 12780.3 13235.9 13458.7 13531.1 13042.3 13168.8 13245.1 13252.9 13254.7 751.1 766.7 766.9 767.3 768.2 619.7 630.4 636.5 638.6 773.3 661.1 782.9 791.2 809.3 813.3 800.6 800.7 802.2 802.3 802.6 589.4 590.7 591.6 591.7 592.1 9984.8 10217.7 11582.3 11952.3 11999.6 12428.4 12668.2 13314.9 13468.4 13620.2 10121.3 10205.2 10251.4 10344.5 10606.3 3284.6 3341.6 3354.8 3355.9 3400.1 61403.4 61878.7 62289.4 62385.7 62439.4 10181.6 10255.0 10295.6 10430.5 10436.4 20077.3 20185.5 20278.4 20283.3 20332.3 6554.7 6559.7 6673.1 6694.9 6738.5 3249.9 3250.5 3277.8 3333.3 3340.5 2871.9 3033.5 3048.4 3055.5 3055.9 500.5 500.6 506.6 508.6 512.1 560.8 585.2 589.8 597.2 603.8 7797.2 8134.7 8283.8 8323.4 8449.1 474.1 499.4 545.9 573.9 632.1 3762.7 3808.3 3850.2 3954.7 4001.5 55135.0 55325.7 56672.1 71978.6 75688.0 71876.6 72842.6 74358.0 74751.6 76467.6 40886.8 52514.2 54681.0 67972.0 69857.3 7987.6 8304.0 8384.2 8414.7 8420.7 38357.2 40784.8 41993.6 42713.4 43265.6 51673.7 62099.2 62206.0 63093.7 63448.0 11257.5 11485.5 11510.1 11568.8 11625.4 11996.3 12329.6 12849.8 13033.2 13753.2 11162.0 11636.5 11690.3 11755.1 12239.7 10691.3 11301.7 11750.1 11972.6 12210.0 11390.1 11561.1 11880.5 11882.1 11936.0 9595.2 9905.5 10115.3 10326.2 10345.5 9444.0 9827.4 9923.4 9985.2 10077.2 03:49:55 INFO - PROCESS | 11397 | -------- Summary: end -------- 03:49:55 INFO - PROCESS | 11397 | 03:49:56 INFO - TEST-INFO | 11397: exit 0 03:49:56 INFO - TEST-OK | dromaeo_css | took 1123225ms 03:49:56 INFO - TEST-START | kraken 03:49:56 INFO - operating with platform_type : linux_ 03:49:56 INFO - Initialising browser for kraken test... 03:49:56 INFO - TEST-INFO | started process 11706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpojJVXM/profile http://localhost:46093/getInfo.html) 03:50:00 INFO - PROCESS | 11706 | __metrics Screen width/height:1600/1200 03:50:00 INFO - PROCESS | 11706 | colorDepth:24 03:50:00 INFO - PROCESS | 11706 | Browser inner width/height: 1024/697 03:50:00 INFO - PROCESS | 11706 | __metrics 03:50:01 INFO - PROCESS | 11706 | 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" 03:50:01 INFO - PROCESS | 11706 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:50:02 INFO - PROCESS | 11706 | console.error: PushService: 03:50:02 INFO - PROCESS | 11706 | stateChangeProcessEnqueue: Error transitioning state 03:50:02 INFO - PROCESS | 11706 | UnknownError 03:50:03 INFO - TEST-INFO | 11706: exit 0 03:50:03 INFO - Browser initialized. 03:50:03 INFO - Running cycle 1/1 for kraken test... 03:50:03 INFO - TEST-INFO | started process 11785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpojJVXM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:15 INFO - PROCESS | 11785 | RSS: Main: 174055424 03:50:15 INFO - PROCESS | 11785 | 03:50:18 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46093/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:19 INFO - PROCESS | 11785 | RSS: Main: 230821888 03:50:19 INFO - PROCESS | 11785 | 03:50:21 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46093/tests/kraken/driver.html?testName=audio-dft) 03:50:22 INFO - PROCESS | 11785 | RSS: Main: 217620480 03:50:22 INFO - PROCESS | 11785 | 03:50:25 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46093/tests/kraken/driver.html?testName=audio-fft) 03:50:26 INFO - PROCESS | 11785 | RSS: Main: 299302912 03:50:26 INFO - PROCESS | 11785 | 03:50:28 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46093/tests/kraken/driver.html?testName=audio-oscillator) 03:50:29 INFO - PROCESS | 11785 | RSS: Main: 210427904 03:50:29 INFO - PROCESS | 11785 | 03:50:31 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46093/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:31 INFO - PROCESS | 11785 | RSS: Main: 213110784 03:50:31 INFO - PROCESS | 11785 | 03:50:35 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46093/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:35 INFO - PROCESS | 11785 | RSS: Main: 249192448 03:50:35 INFO - PROCESS | 11785 | 03:50:39 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46093/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:39 INFO - PROCESS | 11785 | RSS: Main: 247857152 03:50:39 INFO - PROCESS | 11785 | 03:50:42 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46093/tests/kraken/driver.html?testName=json-parse-financial) 03:50:43 INFO - PROCESS | 11785 | RSS: Main: 248487936 03:50:43 INFO - PROCESS | 11785 | 03:50:44 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46093/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:45 INFO - PROCESS | 11785 | RSS: Main: 210464768 03:50:45 INFO - PROCESS | 11785 | 03:50:47 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46093/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:48 INFO - PROCESS | 11785 | RSS: Main: 217894912 03:50:48 INFO - PROCESS | 11785 | 03:50:50 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46093/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:50 INFO - PROCESS | 11785 | RSS: Main: 226578432 03:50:50 INFO - PROCESS | 11785 | 03:50:53 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:54 INFO - PROCESS | 11785 | RSS: Main: 235556864 03:50:54 INFO - PROCESS | 11785 | 03:50:57 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:58 INFO - PROCESS | 11785 | RSS: Main: 232304640 03:50:58 INFO - PROCESS | 11785 | 03:50:59 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46093/tests/kraken/driver.html?testName=ai-astar) 03:51:00 INFO - PROCESS | 11785 | RSS: Main: 282308608 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | __start_tp_report 03:51:00 INFO - PROCESS | 11785 | _x_x_mozilla_page_load 03:51:00 INFO - PROCESS | 11785 | _x_x_mozilla_page_load_details 03:51:00 INFO - PROCESS | 11785 | |i|pagename|runs| 03:51:00 INFO - PROCESS | 11785 | |0;ai-astar;107;114;114;115;115;116;114;114;115;115 03:51:00 INFO - PROCESS | 11785 | |1;audio-beat-detection;155;126;127;170;128;134;129;131;159;129 03:51:00 INFO - PROCESS | 11785 | |2;audio-dft;162;159;161;163;161;162;161;163;161;160 03:51:00 INFO - PROCESS | 11785 | |3;audio-fft;77;77;78;116;77;77;77;76;101;76 03:51:00 INFO - PROCESS | 11785 | |4;audio-oscillator;83;84;111;84;85;85;107;84;85;120 03:51:00 INFO - PROCESS | 11785 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;117;117;117 03:51:00 INFO - PROCESS | 11785 | |6;imaging-darkroom;148;147;147;148;148;147;148;149;149;147 03:51:00 INFO - PROCESS | 11785 | |7;imaging-desaturate;85;84;84;85;84;84;84;84;84;84 03:51:00 INFO - PROCESS | 11785 | |8;json-parse-financial;65;64;64;64;63;64;64;66;63;65 03:51:00 INFO - PROCESS | 11785 | |9;json-stringify-tinderbox;68;68;68;68;68;67;68;68;69;69 03:51:00 INFO - PROCESS | 11785 | |10;stanford-crypto-aes;85;91;84;91;94;84;94;83;85;84 03:51:00 INFO - PROCESS | 11785 | |11;stanford-crypto-ccm;153;144;143;141;148;142;140;150;188;143 03:51:00 INFO - PROCESS | 11785 | |12;stanford-crypto-pbkdf2;179;177;180;179;177;174;176;176;175;183 03:51:00 INFO - PROCESS | 11785 | |13;stanford-crypto-sha256-iterative;75;74;73;71;69;70;69;67;68;68 03:51:00 INFO - PROCESS | 11785 | __end_tp_report 03:51:00 INFO - PROCESS | 11785 | __start_cc_report 03:51:00 INFO - PROCESS | 11785 | _x_x_mozilla_cycle_collect,1987 03:51:00 INFO - PROCESS | 11785 | __end_cc_report 03:51:00 INFO - PROCESS | 11785 | __startTimestamp1476528660219__endTimestamp 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | ------- Summary: start ------- 03:51:00 INFO - PROCESS | 11785 | Number of tests: 14 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.00 stddev:2.51 (2.2%) stddev-sans-first:0.71 03:51:00 INFO - PROCESS | 11785 | Values: 107.0 114.0 114.0 115.0 115.0 116.0 114.0 114.0 115.0 115.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:132.50 stddev:16.12 (12.2%) stddev-sans-first:16.00 03:51:00 INFO - PROCESS | 11785 | Values: 155.0 126.0 127.0 170.0 128.0 134.0 129.0 131.0 159.0 129.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 03:51:00 INFO - PROCESS | 11785 | Values: 162.0 159.0 161.0 163.0 161.0 162.0 161.0 163.0 161.0 160.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:13.81 (17.9%) stddev-sans-first:14.46 03:51:00 INFO - PROCESS | 11785 | Values: 77.0 77.0 78.0 116.0 77.0 77.0 77.0 76.0 101.0 76.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:84.00 stddev:14.08 (16.8%) stddev-sans-first:14.48 03:51:00 INFO - PROCESS | 11785 | Values: 83.0 84.0 111.0 84.0 85.0 85.0 107.0 84.0 85.0 120.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:51:00 INFO - PROCESS | 11785 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:51:00 INFO - PROCESS | 11785 | Values: 148.0 147.0 147.0 148.0 148.0 147.0 148.0 149.0 149.0 147.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 03:51:00 INFO - PROCESS | 11785 | Values: 85.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 03:51:00 INFO - PROCESS | 11785 | Values: 65.0 64.0 64.0 64.0 63.0 64.0 64.0 66.0 63.0 65.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 03:51:00 INFO - PROCESS | 11785 | Values: 68.0 68.0 68.0 68.0 68.0 67.0 68.0 68.0 69.0 69.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.00 stddev:4.45 (5.1%) stddev-sans-first:4.63 03:51:00 INFO - PROCESS | 11785 | Values: 85.0 91.0 84.0 91.0 94.0 84.0 94.0 83.0 85.0 84.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:146.00 stddev:14.26 (9.8%) stddev-sans-first:15.06 03:51:00 INFO - PROCESS | 11785 | Values: 153.0 144.0 143.0 141.0 148.0 142.0 140.0 150.0 188.0 143.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:178.00 stddev:2.67 (1.5%) stddev-sans-first:2.79 03:51:00 INFO - PROCESS | 11785 | Values: 179.0 177.0 180.0 179.0 177.0 174.0 176.0 176.0 175.0 183.0 03:51:00 INFO - PROCESS | 11785 | 03:51:00 INFO - PROCESS | 11785 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:2.76 (3.9%) stddev-sans-first:2.37 03:51:00 INFO - PROCESS | 11785 | Values: 75.0 74.0 73.0 71.0 69.0 70.0 69.0 67.0 68.0 68.0 03:51:00 INFO - PROCESS | 11785 | -------- Summary: end -------- 03:51:00 INFO - PROCESS | 11785 | 03:51:01 INFO - TEST-INFO | 11785: exit 0 03:51:01 INFO - TEST-OK | kraken | took 65270ms 03:51:01 INFO - SUITE-END | took 1188s 03:51:01 INFO - Completed test suite (00:19:48) 03:51:01 INFO - javascript benchmark 03:51:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.7927365810738, 2620.3973086190176, 2624.186502184323, 2656.123479251847, 2663.3075400395905, 4528.04910968697, 4552.931706024412, 4664.300354946756, 4703.200455922492, 4726.952730472699, 4591.77041147943, 4601.079784043188, 4614.584687378136, 4627.167109920213, 4636.559526844952, 4234.957650423495, 4257.0, 4267.829286828523, 4286.935695964563, 4338.327559228309, 4286.592773686495, 4309.547497512763, 4321.675874309423, 4322.546132656057, 4324.805383757723, 4319.892002699926, 4322.567743225683, 4325.82696692132, 4360.324149756777, 4378.6934914555995, 4383.9342409863875, 4385.627221686161, 4406.609416877567, 4411.801468933873, 4442.378067070613, 4186.162767446523, 4223.13425747721, 4265.658747300208, 4286.39990401344, 4330.285502892019, 4685.906281874378, 4701.717896926195, 4713.222318317474, 4754.334393184957, 4760.904781904343, 5018.046571151506, 5042.974785126087, 5061.063703214881, 5067.594592432597, 5125.641205115643, 4931.26031095335, 4990.226514890198, 4992.975035124838, 5049.873753156164, 5062.417821950486, 4732.952670473252, 4749.786259618326, 4771.260454629538, 4772.809087636525, 4796.496367881322, 5195.532402083755, 5203.245529398216, 5204.21936709489, 5213.2701421800975, 5262.158054711228, 4815.470298267188, 4980.800767969241, 4992.350994370709, 4992.675476094042, 4993.226049962262, 4934.383202099738, 4984.925226121611, 5014.89970200594, 5030.3963524377305, 5040.1179793535985, 5003.849884503471, 5010.148274793221, 5012.473690262543, 5056.469070747592, 5064.873378165502, 4960.950390496121, 4996.050750357421, 5015.3229314042865, 5019.347484826949, 5070.188769796889, 4201.264778663783, 4244.3633454982, 4244.957550424518, 4283.935740963888, 4321.351797230441, 3766.246750649826, 3772.75477093988, 3786.280606684776, 3803.5245594300713, 3811.8475260989803, 4304.354346847936, 4332.436783218224, 4334.479862416467, 4336.674749393808, 4337.7180483268485, 4985.700857948535, 4996.450390457119, 4997.450280469146, 4997.700137991732, 4998.90002199954, 4290.0776333087915, 4323.329883868006, 4327.697061205686, 4330.025744207591, 4333.826646934151, 4551.40831691878, 4586.4496260448295, 4616.192166370872, 4629.675922685447, 4633.698809577367, 4778.450478195052, 4780.354652122058, 4783.210770222874, 4821.108095002436, 4842.539958703988, 5058.089543882136, 5058.772355244097, 5061.468545802785, 5067.974660126676, 5107.080725469451, 4652.976735116303, 4703.200455922433, 4703.788329525111, 4772.260299653559, 4836.032793441396, 4807.158747219292, 4859.878503037452, 4870.464248932685, 4875.561199492063, 4946.530079642428, 4947.0, 4950.4059512858685, 4953.0, 4957.157283261926, 5013.047520971004, 4754.595859351855, 4821.927671084866, 4822.300766388784, 4823.294285261986, 4881.9023619528125, 4820.566149046603, 4857.659963802641, 4861.076395484846, 4904.117258893433, 4906.092372911023, 4825.95174048255, 4830.686005409637, 4834.782434790513, 4850.272459131159, 4890.266460031024, 4919.557239848431, 4923.310736496822, 4925.064237794808, 4926.039422312615, 4980.252962055721, 4716.551927566876, 4765.7140571565815, 4768.356271903387, 4815.542523460265, 4837.951620483891], "value": 4613.046503471293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.2241839007, 558.7848678258872, 565.5334349161942, 566.6628356128105, 569.2116418760019, 27791.0, 28619.284517887038, 41871.16257674849, 43472.565274347326, 43508.34737478932, 40127.79936100323, 40608.59391406085, 40650.39024414636, 40702.59297407025, 40763.79618101913, 7633.5801530915915, 7733.497322674037, 7736.690532378698, 7748.8837667434755, 7794.064712234512, 7414.998975138341, 7491.700331986741, 7507.099148102208, 7507.361874240696, 7508.774736757906, 7519.473636845396, 7551.886721699179, 7566.810829729273, 7572.167061623217, 7584.886226706604, 7465.589392583406, 7475.289847464509, 7502.62486875654, 7509.324160825552, 7511.661975211156, 7547.283008114276, 7603.163651998276, 7662.118856331537, 7663.961680191564, 7665.655045522909, 37796.62203377958, 38182.618173818184, 38214.0, 38219.0, 38221.23557528834, 2992.9102126936227, 2998.5202367621296, 3020.6073210482496, 3021.9093427197217, 3027.712367325101, 27650.585241221397, 28023.439531209464, 28481.57277640837, 28702.138935831957, 29866.70133298661, 3332.516785066176, 3401.9489707654157, 3402.9829850850588, 3432.8626854925774, 3499.7550171488006, 194474.0, 196481.0, 250686.0, 251410.0, 251488.0, 55262.72368638131, 55891.72054139703, 55908.72045639746, 55943.16085258724, 55959.0, 32966.83516582402, 33566.3286734264, 33601.83199083989, 35835.10412239715, 58815.70592147012, 13662.316884155753, 13725.45098196081, 13733.313334333243, 13741.931290343484, 13747.106438081693, 9849.21206303494, 9908.108270255567, 9938.850917236246, 9944.35361701487, 9947.0, 18793.90603046976, 18883.52791180204, 18888.0, 18908.43274701761, 18913.7162942556, 6923.723051077901, 7024.508284420143, 7157.069580954442, 7173.964130179315, 7414.851702965911, 778.7507997440878, 800.7837883771466, 869.8434281829205, 875.7110153649407, 947.966821161256, 24777.0, 27074.593881091798, 27689.0, 27850.303742406602, 28026.579601305995, 922.8292765838341, 939.8355287824741, 942.9434233945985, 1005.582683186484, 1025.4565080507193, 13816.0, 14356.569302920929, 14558.272086395638, 14728.263586820616, 14967.326470308863, 350945.0, 355140.0, 355624.0, 355646.0, 356168.0, 49228.75385623049, 49875.25187122196, 49888.0, 49907.500924991014, 49933.50066499361, 1125.3585456289836, 1139.2765593847967, 1164.1152723929874, 1178.7583545373177, 1183.2427246562206, 26026.739732602433, 26648.60027099556, 26823.597646034934, 27232.319192020357, 27308.590371144845, 41974.37038444487, 42694.57305426906, 42704.35943460913, 42717.0, 42782.78608606937, 333354.0, 333615.0, 335529.0, 335852.0, 336040.0, 24598.877005614857, 25085.749142508343, 25170.24489265325, 25438.0, 25464.618030729183, 41133.0, 41761.164776703685, 42157.57842421537, 42624.786876065424, 42934.57065429306, 35241.295174096886, 35590.8220458896, 36519.63480365162, 37285.440718389786, 37476.43785343276, 35259.0, 35673.643263567035, 35678.0, 35704.64295357013, 35788.10529736777, 34911.47632785561, 35347.46978795269, 35504.82247588746, 35881.0, 36219.818900905324, 30081.0, 32872.34255314832, 32875.67124328726, 32944.1763955903, 33017.17457063593, 24259.0, 25193.244202673948, 25233.621495677948, 25493.0, 25648.487030259665], "value": 17047.70559752719, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.4939344016776, 343.6477610449291, 344.6088689337601, 346.791924845093, 374.0, 12112.27326360419, 13271.20372777634, 15568.14375209363, 15971.600709982256, 16931.915340423282, 14658.560243192695, 14709.92645036776, 14934.626634334147, 15001.549953501386, 15187.620309492268, 4921.729304888238, 5139.768710408022, 5150.227465880111, 5153.330067091291, 5154.69071855688, 4265.637420819234, 5995.550333724967, 6049.637021778685, 6129.570930034899, 6130.938690613104, 5716.514096301819, 5977.701114944257, 6084.482818960394, 6091.939080609203, 6092.086187071953, 5816.738246778905, 5834.970825145847, 5846.532277417797, 5847.064469684851, 5858.589898707092, 4908.386451693538, 5047.318611987372, 5064.620153488466, 5110.591152707774, 5156.3296771419855, 16289.185540722916, 16357.345706171738, 16370.263338149813, 18125.36561220351, 19872.90063549673, 1797.3978717129778, 2370.454795397051, 2376.6553849691873, 2431.7932975697086, 2501.6122501012374, 12770.48918043277, 12774.808377874338, 12922.87077129226, 13279.0, 13477.506661267696, 1704.2671651189983, 1718.7421886716968, 1769.9115044247865, 1791.3282519055354, 1819.7543331650322, 68098.65950670265, 68920.31079689189, 68932.31067689309, 69472.3052769471, 70120.0, 7848.803779905548, 8501.61742721579, 8583.270422014073, 8818.95590522056, 8819.603117859711, 11615.6515304541, 11747.649020362596, 11790.349351090854, 11805.0, 11822.52709891612, 6440.452561532228, 6629.1382120325015, 6672.632110417353, 6792.8301792454595, 6812.591244525344, 6589.242237142694, 6621.139251897319, 6686.7993960181275, 6783.118194634666, 6838.965805170942, 3490.616032236452, 3534.7879127252445, 3538.239278555123, 3559.911002224965, 3606.441001644749, 1720.956976075583, 1734.9306027759, 1761.0314327120034, 1770.1857145713116, 1800.8379245867934, 638.6327861479667, 781.9022622172229, 808.3694718119876, 808.8099296665279, 827.71443851871, 15540.84459155394, 15944.202789860461, 16390.918045409697, 16769.90995585283, 16881.662366752596, 827.4414770030326, 833.1751565949667, 844.7972486603171, 870.5299138465284, 880.6257340630207, 8766.430182038275, 9321.533923303808, 10132.392056476636, 10164.796704065877, 10434.739131521621, 372135.0, 375558.0, 378671.0, 382971.0, 383725.0, 73350.63324683449, 75468.62265688636, 76221.3290139381, 76974.0, 78051.60974195093, 902.3818684201212, 908.8182363527321, 932.7201839448275, 937.5921474158763, 940.9623615055322, 15141.924290378478, 15229.466968656045, 15700.214989250264, 16118.435854745028, 16164.0, 35365.81098307837, 37047.44428833516, 37565.81217093897, 37884.24231515409, 38396.0, 48205.420485053866, 48512.0, 48513.757431212616, 48545.75727121342, 48877.511224888716, 7068.540544864567, 7179.892301615376, 7385.9261407387385, 7463.872796253042, 7620.276073772982, 7945.562994035384, 9397.0, 10470.476476176313, 10781.137508999105, 10824.0, 6721.764738234138, 6799.218089919723, 6800.625965571941, 8879.845620069349, 9334.113259240361, 6582.341765823571, 6921.2732663069655, 6951.548149370275, 7193.136823581203, 7452.664630091767, 6878.759243426456, 7000.719971201095, 7017.649117544204, 7044.15470143586, 7158.248383919822, 10674.839877402, 10746.946265268623, 11211.943940280247, 11313.886861131283, 11469.426528673699, 9555.569999349907, 9778.364406313567, 9801.558929848032, 10114.089731924161, 10402.531886064993], "value": 7855.371294639273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.437436276764, 1399.1605036977815, 1428.9214093224875, 1623.4155703946585, 1664.7419649954247, 7263.201047884735, 7826.1391246962785, 7826.491278066922, 7832.96083519583, 7840.137584865674, 6519.739210431589, 6719.260881303053, 7180.281971802817, 7446.404287656988, 7556.773296801091, 2112.260708751936, 2138.272987184357, 2140.935771926837, 2141.7429908411013, 2157.9426081220245, 2080.251109600543, 2105.8525903186705, 2142.9035693393835, 2143.47484866208, 2146.1415433826437, 2077.1587507059667, 2094.214669498938, 2103.905324260404, 2106.5049713317358, 2128.8084072433476, 2040.1125510402949, 2046.4474591860114, 2047.3653167518116, 2047.5904819036252, 2048.92828750993, 2030.8883011434366, 2038.775734669185, 2051.169276443028, 2057.845661575373, 2059.835213182942, 7567.091948966159, 7572.810679732996, 7639.121501027397, 7676.11724651661, 7676.232376762335, 4236.597523235288, 4334.761588112652, 4344.304911214191, 4344.695871289011, 4348.0, 2750.339918419585, 2825.2371859597997, 2862.3130448692373, 2866.054202113298, 2876.7698584113223, 864.6109250837086, 907.4373888189299, 911.5214512380986, 913.0, 913.6756451459703, 9908.455034973074, 9960.90039099607, 9964.451955142464, 9991.75020624483, 9994.300398972075, 3871.4773505576386, 3950.585188555218, 4104.199681062164, 4118.4440100586635, 4127.380892866034, 8416.53709045996, 8423.241908228289, 8440.0, 8444.071152173256, 8499.830003399897, 4389.034412429261, 4391.8682439526865, 4393.29707246839, 4394.231009573376, 4395.604395604411, 3485.3552092862396, 3632.6912212461707, 3839.884803455901, 3934.6655534279334, 3990.4213888985932, 3402.608699999532, 3454.4990976308295, 3542.8582856685957, 3570.3751843427817, 3579.0, 1087.363892123101, 1101.3446999035561, 1119.3004372267333, 1127.0532752487786, 1130.6834086455806, 814.8777683347545, 819.7499762572472, 822.6627082895984, 827.2141465607576, 828.8147948433798, 4946.455889852114, 4956.306117143603, 4992.775325110379, 5050.242463630411, 5086.694798312114, 403.1453318963757, 822.8066404394963, 873.9126087391337, 927.6660402255183, 961.0629636104882, 3323.933521329608, 3412.675795799395, 3439.3465241604517, 3460.8788692395647, 3482.3209474152295, 8622.698205562776, 8970.955145224232, 9005.05446928063, 9013.459192448474, 9014.504202268807, 8986.236169925498, 8987.685431009882, 8990.415622984485, 8993.955030224806, 9001.954990225138, 6790.151231096113, 6844.828879277959, 6981.755638552626, 7143.4999550031, 7163.820904477429, 4749.192637251606, 4902.965269413154, 4931.852044438672, 4952.1581331173065, 5063.898722025465, 8393.916060839314, 8452.873206901779, 8457.238848503419, 8497.022842372959, 8563.357748169037, 8073.6770529178175, 8382.49705017701, 8396.370272229486, 8562.143785621389, 8664.523451210243, 5796.391378905323, 5958.821235362946, 6553.5084868634085, 6710.261871194262, 6719.596824190368, 6871.801023672377, 7104.786856394317, 7166.498345115792, 7324.670389832577, 7325.230850760593, 6330.8100756977365, 6339.444824367561, 6402.839929001626, 6470.708818103102, 6546.509011824037, 6419.807405777834, 6446.290908000023, 6494.155759751202, 6504.642244676588, 6507.642079685474, 5517.944820551904, 5613.803516876889, 5627.268455100811, 5628.296462942132, 5635.6618602883955, 4044.1911617675996, 4106.486689163855, 4122.42286079943, 4205.810738516835, 4438.1567502174485, 4111.773852438145, 4171.520275168395, 4189.120284740238, 4206.516250631216, 4249.235137675249], "value": 3929.4259621931997, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.6076189525189, 276.74677669932015, 278.1197509881226, 282.2956722976175, 286.6273844002796, 4554.726716397018, 4745.928811067833, 4789.760511974396, 4817.349657796192, 4828.7585620719, 4590.540945905408, 4677.549959512554, 4680.4149481314835, 4716.36329095572, 4768.21324481461, 3737.1591391936868, 3760.247950409915, 3770.660640542351, 3771.5097037385103, 3779.3197224499577, 3582.283543291352, 3769.7549659272195, 3774.7168962327796, 3777.112378591029, 3781.5273090863643, 3439.1917899293644, 3705.925881482369, 3733.383991641376, 3747.812609369534, 3748.550173979126, 3731.7201209909094, 3734.8319325630414, 3740.345439548068, 3751.4747935289083, 3756.887293381203, 3305.9669403305898, 3311.586051743532, 3311.850966706504, 3320.5019247113128, 3329.667033296675, 4595.8740108673255, 4662.184117779409, 4663.160631086403, 4725.834595789131, 4729.881752956169, 4237.258479766028, 4240.194363071007, 4251.256030194703, 4301.483821941356, 4303.462067241595, 4965.751712414401, 5001.524855138756, 5016.347874776292, 5027.4469808321055, 5058.064258112261, 3443.707284880788, 3580.7672501287593, 3599.1182160370613, 3619.8914032579064, 3636.7636103653444, 5174.395937259424, 5194.97402512985, 5205.817796377147, 5207.843764687065, 5208.151106357226, 3654.0, 3661.853525858989, 3664.9816750916075, 3705.203381273039, 3705.8517659293325, 3758.4550240215017, 3758.774473531597, 3776.962230377716, 3779.903827889936, 3787.8106094695154, 4167.291560434734, 4211.768352740567, 4272.615464608138, 4295.312749960054, 4297.538836795505, 4967.428745694219, 4989.426215985136, 4991.675541089818, 5005.549500544968, 5009.44896061433, 1222.8226907098422, 1263.1789336931067, 1272.8727127287198, 1297.3902265934996, 1305.11252348404, 842.4456877061812, 882.8587426011936, 895.1719659315238, 898.9056149104381, 906.5133181582211, 4408.7575183365225, 4413.845515406945, 4414.911701765946, 4436.401085853433, 4447.264932066756, 5145.434002259748, 5159.819406320761, 5168.664036837594, 5191.454897235812, 5194.246834209019, 4296.6347860432215, 4371.191329604034, 4390.463337831733, 4410.558944105564, 4440.4005459263235, 2709.794141606966, 2717.144099608617, 2735.822171558882, 2739.9999000364724, 2745.5058089543672, 4828.396450443694, 4832.540908613676, 4865.391826021747, 4880.341153944243, 4881.559939817762, 5056.721880296619, 5152.845414637567, 5168.328117344721, 5203.869903252449, 5234.194202999959, 4783.425988881357, 4795.496472870368, 4817.735024573612, 4870.610351171968, 4872.342233798534, 4946.727929963887, 5060.924086138784, 5075.7969681212335, 5076.923846142385, 5142.6914385137015, 4994.900101998012, 5002.949970500248, 5038.748062596929, 5041.697498150123, 5045.747712614281, 4849.248366503198, 4850.1997170467885, 4851.326292429107, 4852.80588776445, 4897.461279259207, 3713.442983552489, 3721.6650501455, 3737.7852198035202, 3749.4000959846294, 3749.7937613431523, 5036.974815126047, 5117.61617878668, 5125.641205115606, 5127.41034781005, 5151.948480515147, 4968.8757781055765, 4977.576905963034, 4982.277569752293, 4983.27742477346, 4995.475475075064, 4982.6512144149565, 4985.476524964972, 4990.5508504234795, 5007.097303024827, 5015.974920125522, 4734.0, 4739.459675605511, 4876.4392094909535, 4970.502949705001, 4979.0, 4884.755762211804, 5060.443351231288, 5061.822836200715, 5063.924041139312, 5072.442031376472, 4944.294218494613, 4968.677035992649, 4968.7081358846235, 4974.502549744997, 4994.500549944976], "value": 3774.018109672767, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.1161846854267, 612.5314134686965, 613.6594190224425, 613.9048447490637, 620.9658468784215, 12573.434195461203, 12780.297083660394, 13235.933820330885, 13458.663533411669, 13531.12047716899, 13042.282674452901, 13168.802467962989, 13245.139065960706, 13252.867471325284, 13254.668633284173, 751.0574229342168, 766.7086507127311, 766.8696321625337, 767.3055884424605, 768.227930929418, 619.683961179797, 630.4263120560291, 636.5130675033603, 638.6264035539192, 773.2731232641328, 661.1339145719099, 782.8943092682472, 791.1534657916033, 809.28378385129, 813.2680587471264, 800.6197056398222, 800.6637212370819, 802.2298593350362, 802.3260461212581, 802.6147449224346, 589.3634874335708, 590.6721769417971, 591.5918016568554, 591.6864062047122, 592.120700759372, 9984.80030399388, 10217.744556386075, 11582.305061696325, 11952.342621155833, 11999.580014699532, 12428.37858107091, 12668.2399056056, 13314.933425332909, 13468.39392227352, 13620.18278903269, 10121.291509594332, 10205.183585313158, 10251.384916904935, 10344.482775861252, 10606.310589811637, 3284.556584861037, 3341.61571419285, 3354.815485148316, 3355.9161020974425, 3400.0989737719524, 61403.38596614066, 61878.69060654713, 62289.377106228814, 62385.68807155981, 62439.37560624426, 10181.643642472478, 10255.0, 10295.569679919457, 10430.53062612169, 10436.42599657011, 20077.29729459491, 20185.49536261576, 20278.391648250577, 20283.290084846958, 20332.288369907277, 6554.672266386661, 6559.737610495622, 6673.132492775908, 6694.933050669529, 6738.494612904052, 3249.8862539810993, 3250.5286733423995, 3277.8033318001, 3333.333333333343, 3340.549025881475, 2871.899483518067, 3033.4843076676575, 3048.3750831079574, 3055.450018996602, 3055.8930437434583, 500.47450177313675, 500.57201093065635, 506.5668853130594, 508.5905845794171, 512.0552580488992, 560.778492495462, 585.1537016902176, 589.8348462430527, 597.223609307898, 603.8399824046631, 7797.220277972271, 8134.715284965117, 8283.792905177419, 8323.417360784686, 8449.070602233749, 474.0660898030874, 499.3757802746567, 545.9408747030748, 573.9368669446358, 632.1024145713099, 3762.680172185395, 3808.333541630204, 3850.1914597934187, 3954.703397245218, 4001.47980762499, 55135.0, 55325.72337138288, 56672.14991775127, 71978.64010680017, 75688.0, 71876.64061679762, 72842.63578682073, 74358.0, 74751.62624186845, 76467.61766191245, 40886.79556602198, 52514.21228681573, 54681.0, 67972.0, 69857.3014269861, 7987.64055617487, 8304.003519577689, 8384.245417912418, 8414.705485307984, 8420.663173472993, 38357.232855343296, 40784.79607602062, 41993.58006419897, 42713.359299611155, 43265.56734432741, 51673.73365242352, 62099.169091400814, 62206.0, 63093.68453157888, 63448.0, 11257.549698012315, 11485.540578376771, 11510.136739744385, 11568.826467602825, 11625.36060516646, 11996.280223186637, 12329.630111096682, 12849.807252891027, 13033.15284506504, 13753.174809511462, 11162.0, 11636.476358563716, 11690.339852755329, 11755.118366122404, 12239.69400764988, 10691.25161238737, 11301.660950171508, 11750.118741094622, 11972.64082077539, 12210.0, 11390.145739069438, 11561.083839201056, 11880.524779008743, 11882.10884183707, 11936.0, 9595.184409325286, 9905.455199964072, 10115.280065080844, 10326.225533085199, 10345.482725863827, 9443.952780236055, 9827.4103553787, 9923.35498192644, 9985.201183905125, 10077.19382449417], "value": 6286.345500439617, "unit": "score"}], "name": "dromaeo_css", "value": 6214.416371218553, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 114.0, 115.0, 115.0, 116.0, 114.0, 114.0, 115.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 127.0, 170.0, 128.0, 134.0, 129.0, 131.0, 159.0, 129.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 161.0, 163.0, 161.0, 162.0, 161.0, 163.0, 161.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 116.0, 77.0, 77.0, 77.0, 76.0, 101.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 111.0, 84.0, 85.0, 85.0, 107.0, 84.0, 85.0, 120.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 149.0, 149.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 66.0, 63.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 84.0, 91.0, 94.0, 84.0, 94.0, 83.0, 85.0, 84.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 144.0, 143.0, 141.0, 148.0, 142.0, 140.0, 150.0, 188.0, 143.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 180.0, 179.0, 177.0, 174.0, 176.0, 176.0, 175.0, 183.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 71.0, 69.0, 70.0, 69.0, 67.0, 68.0, 68.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1556.2, "alertThreshold": 2.0}]} 03:51:01 INFO - Return code: 0 03:51:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:02 INFO - # TBPL SUCCESS # 03:51:02 INFO - Running post-action listener: _resource_record_post_action 03:51:02 INFO - [mozharness: 2016-10-15 10:51:02.032120Z] Finished run-tests step (success) 03:51:02 INFO - Running post-run listener: _resource_record_post_run 03:51:02 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 400982016; Read time: 0; Write time: 359512 03:51:02 INFO - TinderboxPrint: CPU usage
13.0% 03:51:02 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:51:02 INFO - TinderboxPrint: I/O write bytes / time
400,982,016 / 359,512 03:51:02 INFO - TinderboxPrint: CPU idle
8,359.7 (86.9%) 03:51:02 INFO - TinderboxPrint: CPU user
1,203.5 (12.5%) 03:51:02 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99442688; Read time: 0; Write time: 111976 03:51:02 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 289411072; Read time: 0; Write time: 244652 03:51:02 INFO - Running post-run listener: _upload_blobber_files 03:51:02 INFO - Blob upload gear active. 03:51:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:02 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 03:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:03 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:04 INFO - (blobuploader) - INFO - Done attempting. 03:51:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:07 INFO - (blobuploader) - INFO - Done attempting. 03:51:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:07 INFO - (blobuploader) - INFO - Done attempting. 03:51:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:07 INFO - Return code: 0 03:51:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2127387bc887ecbd0dfeca785619fe0f8d54dec9443b0b036b0715596977ca3dc394dccc0a9624a6be1a96df06504060e4722e4b161aa3b25f2a906ad3833cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d18a55182027c1c672ecf5aef5ae89c87493be1c221ccf146c50644803fb79dfc25becae023968b9e2ec9356ce53640b943b5a49bc8f457a578fbb71d94e9973", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c28fd08bdaee5414e9fe890dd54727a347f048dafedcba8b6e358d195246e70e38876b127dd6fb4e6e654f81f535bc0935ac37c92cebb06880c4ed9961cd3782"} 03:51:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:07 INFO - Contents: 03:51:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2127387bc887ecbd0dfeca785619fe0f8d54dec9443b0b036b0715596977ca3dc394dccc0a9624a6be1a96df06504060e4722e4b161aa3b25f2a906ad3833cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d18a55182027c1c672ecf5aef5ae89c87493be1c221ccf146c50644803fb79dfc25becae023968b9e2ec9356ce53640b943b5a49bc8f457a578fbb71d94e9973", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c28fd08bdaee5414e9fe890dd54727a347f048dafedcba8b6e358d195246e70e38876b127dd6fb4e6e654f81f535bc0935ac37c92cebb06880c4ed9961cd3782"} 03:51:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:07 INFO - Copying logs to upload dir... 03:51:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.509135 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-15 03:51:06.042654) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 03:51:06.046096) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2127387bc887ecbd0dfeca785619fe0f8d54dec9443b0b036b0715596977ca3dc394dccc0a9624a6be1a96df06504060e4722e4b161aa3b25f2a906ad3833cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d18a55182027c1c672ecf5aef5ae89c87493be1c221ccf146c50644803fb79dfc25becae023968b9e2ec9356ce53640b943b5a49bc8f457a578fbb71d94e9973", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c28fd08bdaee5414e9fe890dd54727a347f048dafedcba8b6e358d195246e70e38876b127dd6fb4e6e654f81f535bc0935ac37c92cebb06880c4ed9961cd3782"} build_url:https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/QVnKuBnQRfqNfkgqeF7yCw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f2127387bc887ecbd0dfeca785619fe0f8d54dec9443b0b036b0715596977ca3dc394dccc0a9624a6be1a96df06504060e4722e4b161aa3b25f2a906ad3833cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d18a55182027c1c672ecf5aef5ae89c87493be1c221ccf146c50644803fb79dfc25becae023968b9e2ec9356ce53640b943b5a49bc8f457a578fbb71d94e9973", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c28fd08bdaee5414e9fe890dd54727a347f048dafedcba8b6e358d195246e70e38876b127dd6fb4e6e654f81f535bc0935ac37c92cebb06880c4ed9961cd3782"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-15 03:51:06.072382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:51:06.072726) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476517760.89667-129457093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-15 03:51:06.154563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 03:51:06.154881) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-15 03:51:06.155171) ========= ========= Total master_lag: 0.16 =========