builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1476981632.54 results: success (0) buildid: 20161020074850 builduid: 53e31627a5e14ebaad912fd7148a032d revision: 3f0aeafe59c40c5e92ba9636fa718cf26088e127 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:32.537427) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:32.537909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:32.538221) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:32.552849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:32.553160) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 09:40:32-- 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% 11.7M=0.001s 2016-10-20 09:40:33 (11.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.222660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:32.791959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:32.792810) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019143 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:32.843489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:32.843992) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3f0aeafe59c40c5e92ba9636fa718cf26088e127 --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 3f0aeafe59c40c5e92ba9636fa718cf26088e127 --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=6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 09:40:33,180 truncating revision to first 12 chars 2016-10-20 09:40:33,180 Setting DEBUG logging. 2016-10-20 09:40:33,180 attempt 1/10 2016-10-20 09:40:33,180 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3f0aeafe59c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 09:40:33,809 unpacking tar archive at: mozilla-central-3f0aeafe59c4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:33.792945) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:33.793324) ========= script_repo_revision: 3f0aeafe59c40c5e92ba9636fa718cf26088e127 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:33.793782) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:33.794085) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 09:40:33.803291) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-20 09:40:33.803606) ========= /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=6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:40:34 INFO - MultiFileLogger online at 20161020 09:40:34 in /builds/slave/test 09:40:34 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 09:40:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:40:34 INFO - {'append_to_log': False, 09:40:34 INFO - 'base_work_dir': '/builds/slave/test', 09:40:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:40:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:40:34 INFO - 'branch': 'Firefox-Non-PGO', 09:40:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:40:34 INFO - 'config_files': ('talos/linux_config.py',), 09:40:34 INFO - 'default_actions': ('clobber', 09:40:34 INFO - 'read-buildbot-config', 09:40:34 INFO - 'download-and-extract', 09:40:34 INFO - 'populate-webroot', 09:40:34 INFO - 'create-virtualenv', 09:40:34 INFO - 'install', 09:40:34 INFO - 'run-tests'), 09:40:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:40:34 INFO - 'download_minidump_stackwalk': True, 09:40:34 INFO - 'download_symbols': 'ondemand', 09:40:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:40:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:40:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:40:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:40:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:40:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:40:34 INFO - 'installer_path': 'installer.exe', 09:40:34 INFO - 'log_level': 'info', 09:40:34 INFO - 'log_name': 'talos', 09:40:34 INFO - 'log_to_console': True, 09:40:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:40:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:40:34 INFO - 'opt_config_files': (), 09:40:34 INFO - 'pip_index': False, 09:40:34 INFO - 'sps_profile': False, 09:40:34 INFO - 'sps_profile_interval': 0, 09:40:34 INFO - 'suite': 'dromaeojs', 09:40:34 INFO - 'system_bits': '32', 09:40:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:40:34 INFO - 'title': 'talos-linux64-ix-023', 09:40:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:40:34 INFO - 'use_talos_json': True, 09:40:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:40:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:40:34 INFO - 'work_dir': 'build'} 09:40:34 INFO - [mozharness: 2016-10-20 16:40:34.241069Z] Running clobber step. 09:40:34 INFO - Running pre-action listener: _resource_record_pre_action 09:40:34 INFO - Running main action method: clobber 09:40:34 INFO - rmtree: /builds/slave/test/build 09:40:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:40:34 INFO - Running post-action listener: _resource_record_post_action 09:40:34 INFO - [mozharness: 2016-10-20 16:40:34.693903Z] Finished clobber step (success) 09:40:34 INFO - [mozharness: 2016-10-20 16:40:34.694021Z] Running read-buildbot-config step. 09:40:34 INFO - Running pre-action listener: _resource_record_pre_action 09:40:34 INFO - Running main action method: read_buildbot_config 09:40:34 INFO - Using buildbot properties: 09:40:34 INFO - { 09:40:34 INFO - "project": "", 09:40:34 INFO - "product": "firefox", 09:40:34 INFO - "script_repo_revision": "production", 09:40:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:40:34 INFO - "repository": "", 09:40:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:40:34 INFO - "buildid": "20161020074850", 09:40:34 INFO - "pgo_build": "False", 09:40:34 INFO - "basedir": "/builds/slave/test", 09:40:34 INFO - "buildnumber": 688, 09:40:34 INFO - "slavename": "talos-linux64-ix-023", 09:40:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:40:34 INFO - "platform": "ubuntu64_hw", 09:40:34 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:40:34 INFO - "branch": "mozilla-central", 09:40:34 INFO - "repo_path": "mozilla-central", 09:40:34 INFO - "revision": "3f0aeafe59c40c5e92ba9636fa718cf26088e127", 09:40:34 INFO - "stage_platform": "linux64", 09:40:34 INFO - "builduid": "53e31627a5e14ebaad912fd7148a032d", 09:40:34 INFO - "slavebuilddir": "test" 09:40:34 INFO - } 09:40:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:40:34 INFO - Running post-action listener: _resource_record_post_action 09:40:34 INFO - [mozharness: 2016-10-20 16:40:34.696517Z] Finished read-buildbot-config step (success) 09:40:34 INFO - [mozharness: 2016-10-20 16:40:34.696605Z] Running download-and-extract step. 09:40:34 INFO - Running pre-action listener: _resource_record_pre_action 09:40:34 INFO - Running main action method: download_and_extract 09:40:34 INFO - mkdir: /builds/slave/test/build/tests 09:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:34 INFO - trying https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:40:34 INFO - Downloading https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/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 09:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/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 09:40:35 INFO - Downloaded 1361 bytes. 09:40:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:40:35 INFO - Using the following test package requirements: 09:40:35 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:40:35 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:40:35 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:40:35 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:35 INFO - u'jsshell-linux-x86_64.zip'], 09:40:35 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:40:35 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:40:35 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:40:35 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:40:35 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:40:35 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:35 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:40:35 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:40:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:40:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:40:35 INFO - Fetch https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:40:35 INFO - Http code: 200 09:40:35 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 09:40:35 INFO - x-amz-cf-id: GWp3u5o4D2OjK8WntoPvRWi39Y86Yc1EMQauEcNajx_KQZfKmlg0LA== 09:40:35 INFO - x-amz-version-id: JKRtF970tW8FOhEQQWqkzM.8RIUM0Lg3 09:40:36 INFO - Expected file size: 20549402 09:40:36 INFO - Obtained file size: 20549402 09:40:40 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 09:40:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:40:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:40:40 INFO - Fetch https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:40:40 INFO - Http code: 200 09:40:40 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 09:40:40 INFO - x-amz-cf-id: X8NNgQCTwEUgmovS3M-ddtIX_-guizOfZe9lImGxBmYgrDdxZC8zMQ== 09:40:40 INFO - x-amz-version-id: JKRtF970tW8FOhEQQWqkzM.8RIUM0Lg3 09:40:41 INFO - Expected file size: 20549402 09:40:41 INFO - Obtained file size: 20549402 09:40:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:40:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:40:45 INFO - Fetch https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:40:46 INFO - Http code: 200 09:40:46 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 09:40:46 INFO - x-amz-cf-id: gCY-zaYF8sJ7ecseIKhyh_3-dlNxkxKhGqQHclWCn9TWKPV58ifZQQ== 09:40:46 INFO - x-amz-version-id: YY3cEj720cPv9yRvfo0XXO_ww4E1q3lC 09:40:46 INFO - Expected file size: 14409028 09:40:46 INFO - Obtained file size: 14409028 09:40:46 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')]} 09:40:46 INFO - trying https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:40:46 INFO - Downloading https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/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 09:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/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 09:40:47 INFO - Downloaded 55526719 bytes. 09:40:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:40:47 INFO - mkdir: /builds/slave/test/properties 09:40:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:40:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:40:47 INFO - Contents: 09:40:47 INFO - build_url:https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:40:48 INFO - Running post-action listener: _resource_record_post_action 09:40:48 INFO - Running post-action listener: set_extra_try_arguments 09:40:48 INFO - [mozharness: 2016-10-20 16:40:48.384064Z] Finished download-and-extract step (success) 09:40:48 INFO - [mozharness: 2016-10-20 16:40:48.384361Z] Running populate-webroot step. 09:40:48 INFO - Running pre-action listener: _resource_record_pre_action 09:40:48 INFO - Running main action method: populate_webroot 09:40:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:40:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:40:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:40:48 INFO - '--tppagecycles', 09:40:48 INFO - '7'], 09:40:48 INFO - 'tests': ['tsvgm']}}, 09:40:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:40:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:40:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:40:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:40:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:48 INFO - 'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:48 INFO - 'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['damp', 'tps']}, 09:40:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:48 INFO - 'tests': ['damp', 'tps']}, 09:40:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['dromaeo_dom']}, 09:40:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:40:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['basic_compositor_video']}, 09:40:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:40:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['a11yr', 09:40:48 INFO - 'ts_paint', 09:40:48 INFO - 'tpaint', 09:40:48 INFO - 'sessionrestore', 09:40:48 INFO - 'sessionrestore_no_auto_restore', 09:40:48 INFO - 'tabpaint']}, 09:40:48 INFO - 'other-e10s': {'tests': ['a11yr', 09:40:48 INFO - 'ts_paint', 09:40:48 INFO - 'tpaint', 09:40:48 INFO - 'sessionrestore', 09:40:48 INFO - 'sessionrestore_no_auto_restore', 09:40:48 INFO - 'tabpaint']}, 09:40:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:40:48 INFO - 'ts_paint', 09:40:48 INFO - 'tpaint', 09:40:48 INFO - 'sessionrestore', 09:40:48 INFO - 'sessionrestore_no_auto_restore', 09:40:48 INFO - 'tabpaint']}, 09:40:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:40:48 INFO - 'ts_paint', 09:40:48 INFO - 'tpaint', 09:40:48 INFO - 'sessionrestore', 09:40:48 INFO - 'sessionrestore_no_auto_restore', 09:40:48 INFO - 'tabpaint']}, 09:40:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['a11yr', 09:40:48 INFO - 'ts_paint', 09:40:48 INFO - 'tpaint', 09:40:48 INFO - 'sessionrestore', 09:40:48 INFO - 'sessionrestore_no_auto_restore', 09:40:48 INFO - 'tabpaint']}, 09:40:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['a11yr', 09:40:48 INFO - 'ts_paint', 09:40:48 INFO - 'tpaint', 09:40:48 INFO - 'sessionrestore', 09:40:48 INFO - 'sessionrestore_no_auto_restore', 09:40:48 INFO - 'tabpaint']}, 09:40:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['tsvgx', 09:40:48 INFO - 'tsvgr_opacity', 09:40:48 INFO - 'tart', 09:40:48 INFO - 'tscrollx', 09:40:48 INFO - 'cart']}, 09:40:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:40:48 INFO - 'tsvgr_opacity', 09:40:48 INFO - 'tart', 09:40:48 INFO - 'tscrollx', 09:40:48 INFO - 'cart']}, 09:40:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:48 INFO - 'talos_options': ['--disable-e10s'], 09:40:48 INFO - 'tests': ['tp5o']}, 09:40:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:48 INFO - 'tests': ['tp5o']}, 09:40:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:48 INFO - 'talos_options': ['--disable-e10s', 09:40:48 INFO - '--xperf_path', 09:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:48 INFO - 'tests': ['tp5n']}, 09:40:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:48 INFO - 'talos_options': ['--xperf_path', 09:40:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:48 INFO - 'tests': ['tp5n']}}, 09:40:48 INFO - 'talos.zip': {'path': '', 09:40:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:40:48 INFO - Running post-action listener: _resource_record_post_action 09:40:48 INFO - [mozharness: 2016-10-20 16:40:48.407812Z] Finished populate-webroot step (success) 09:40:48 INFO - [mozharness: 2016-10-20 16:40:48.407904Z] Running create-virtualenv step. 09:40:48 INFO - Running pre-action listener: _resource_record_pre_action 09:40:48 INFO - Running main action method: create_virtualenv 09:40:48 INFO - Creating virtualenv /builds/slave/test/build/venv 09:40:48 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 09:40:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:40:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:40:48 INFO - Using real prefix '/usr' 09:40:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:40:49 INFO - Installing distribute.............................................................................................................................................................................................done. 09:40:50 INFO - Installing pip.................done. 09:40:50 INFO - Return code: 0 09:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:40:51 INFO - Reading from file tmpfile_stdout 09:40:51 INFO - Output received: 09:40:51 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) 09:40:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:40: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')]} 09:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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')]} 09:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:51 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 0x7ff1ed3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', '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 09:40:51 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 09:40:51 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 09:40:51 INFO - Using env: {'DISPLAY': ':0', 09:40:51 INFO - 'HOME': '/home/cltbld', 09:40:51 INFO - 'LANG': 'en_US.UTF-8', 09:40:51 INFO - 'LANGUAGE': 'en_US:en', 09:40:51 INFO - 'LOGNAME': 'cltbld', 09:40:51 INFO - 'MAIL': '/var/mail/cltbld', 09:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:51 INFO - 'MOZ_NO_REMOTE': '1', 09:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:51 INFO - 'NO_EM_RESTART': '1', 09:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:51 INFO - 'PWD': '/builds/slave/test', 09:40:51 INFO - 'SHELL': '/bin/bash', 09:40:51 INFO - 'SHLVL': '1', 09:40:51 INFO - 'TERM': 'linux', 09:40:51 INFO - 'TMOUT': '86400', 09:40:51 INFO - 'USER': 'cltbld', 09:40:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:51 INFO - '_': '/tools/buildbot/bin/python'} 09:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:51 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 09:40:51 INFO - Cleaning up... 09:40:51 INFO - Return code: 0 09:40:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:40: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')]} 09:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40: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')]} 09:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:51 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 0x7ff1ed3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', '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 09:40:51 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 09:40:51 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 09:40:51 INFO - Using env: {'DISPLAY': ':0', 09:40:51 INFO - 'HOME': '/home/cltbld', 09:40:51 INFO - 'LANG': 'en_US.UTF-8', 09:40:51 INFO - 'LANGUAGE': 'en_US:en', 09:40:51 INFO - 'LOGNAME': 'cltbld', 09:40:51 INFO - 'MAIL': '/var/mail/cltbld', 09:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:51 INFO - 'MOZ_NO_REMOTE': '1', 09:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:51 INFO - 'NO_EM_RESTART': '1', 09:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:51 INFO - 'PWD': '/builds/slave/test', 09:40:51 INFO - 'SHELL': '/bin/bash', 09:40:51 INFO - 'SHLVL': '1', 09:40:51 INFO - 'TERM': 'linux', 09:40:51 INFO - 'TMOUT': '86400', 09:40:51 INFO - 'USER': 'cltbld', 09:40:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:51 INFO - '_': '/tools/buildbot/bin/python'} 09:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:51 INFO - Downloading/unpacking psutil>=3.1.1 09:40:51 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 09:40:51 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 09:40:51 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 09:40:51 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 09:40:51 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 09:40:51 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 09:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:53 INFO - Installing collected packages: psutil 09:40:53 INFO - Running setup.py install for psutil 09:40:53 INFO - building 'psutil._psutil_linux' extension 09:40:53 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 09:40:53 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 09:40:53 INFO - building 'psutil._psutil_posix' extension 09:40:53 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 09:40:54 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 09:40:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:54 INFO - Successfully installed psutil 09:40:54 INFO - Cleaning up... 09:40:54 INFO - Return code: 0 09:40:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:40:54 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')]} 09:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:54 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')]} 09:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:54 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 0x7ff1ed3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', '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 09:40:54 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 09:40:54 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 09:40:54 INFO - Using env: {'DISPLAY': ':0', 09:40:54 INFO - 'HOME': '/home/cltbld', 09:40:54 INFO - 'LANG': 'en_US.UTF-8', 09:40:54 INFO - 'LANGUAGE': 'en_US:en', 09:40:54 INFO - 'LOGNAME': 'cltbld', 09:40:54 INFO - 'MAIL': '/var/mail/cltbld', 09:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:54 INFO - 'MOZ_NO_REMOTE': '1', 09:40:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:54 INFO - 'NO_EM_RESTART': '1', 09:40:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:54 INFO - 'PWD': '/builds/slave/test', 09:40:54 INFO - 'SHELL': '/bin/bash', 09:40:54 INFO - 'SHLVL': '1', 09:40:54 INFO - 'TERM': 'linux', 09:40:54 INFO - 'TMOUT': '86400', 09:40:54 INFO - 'USER': 'cltbld', 09:40:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:54 INFO - '_': '/tools/buildbot/bin/python'} 09:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:40:54 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 09:40:54 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 09:40:54 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 09:40:54 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 09:40:54 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 09:40:54 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 09:40:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:40:56 INFO - Installing collected packages: mozsystemmonitor 09:40:56 INFO - Running setup.py install for mozsystemmonitor 09:40:56 INFO - Successfully installed mozsystemmonitor 09:40:56 INFO - Cleaning up... 09:40:56 INFO - Return code: 0 09:40:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:40:56 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')]} 09:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:56 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')]} 09:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:56 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 0x7ff1ed3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', '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 09:40:56 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 09:40:56 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 09:40:56 INFO - Using env: {'DISPLAY': ':0', 09:40:56 INFO - 'HOME': '/home/cltbld', 09:40:56 INFO - 'LANG': 'en_US.UTF-8', 09:40:56 INFO - 'LANGUAGE': 'en_US:en', 09:40:56 INFO - 'LOGNAME': 'cltbld', 09:40:56 INFO - 'MAIL': '/var/mail/cltbld', 09:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:56 INFO - 'MOZ_NO_REMOTE': '1', 09:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:56 INFO - 'NO_EM_RESTART': '1', 09:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:56 INFO - 'PWD': '/builds/slave/test', 09:40:56 INFO - 'SHELL': '/bin/bash', 09:40:56 INFO - 'SHLVL': '1', 09:40:56 INFO - 'TERM': 'linux', 09:40:56 INFO - 'TMOUT': '86400', 09:40:56 INFO - 'USER': 'cltbld', 09:40:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:56 INFO - '_': '/tools/buildbot/bin/python'} 09:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:56 INFO - Downloading/unpacking jsonschema==2.5.1 09:40:56 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 09:40:56 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 09:40:56 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 09:40:56 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 09:40:56 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 09:40:56 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 09:40:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:40:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:40:58 INFO - warning: no files found matching '*.txt' 09:40:58 INFO - no previously-included directories found matching 'build' 09:40:58 INFO - no previously-included directories found matching 'dist' 09:40:58 INFO - no previously-included directories found matching '.git*' 09:40:58 INFO - Installing collected packages: jsonschema, functools32 09:40:59 INFO - Running setup.py install for functools32 09:40:59 INFO - warning: no files found matching '*.txt' 09:40:59 INFO - no previously-included directories found matching 'build' 09:40:59 INFO - no previously-included directories found matching 'dist' 09:40:59 INFO - no previously-included directories found matching '.git*' 09:40:59 INFO - Successfully installed jsonschema functools32 09:40:59 INFO - Cleaning up... 09:40:59 INFO - Return code: 0 09:40:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:40:59 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')]} 09:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:59 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')]} 09:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:59 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 0x7ff1ed3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', '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 09:40:59 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 09:40:59 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 09:40:59 INFO - Using env: {'DISPLAY': ':0', 09:40:59 INFO - 'HOME': '/home/cltbld', 09:40:59 INFO - 'LANG': 'en_US.UTF-8', 09:40:59 INFO - 'LANGUAGE': 'en_US:en', 09:40:59 INFO - 'LOGNAME': 'cltbld', 09:40:59 INFO - 'MAIL': '/var/mail/cltbld', 09:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:59 INFO - 'MOZ_NO_REMOTE': '1', 09:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:59 INFO - 'NO_EM_RESTART': '1', 09:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:59 INFO - 'PWD': '/builds/slave/test', 09:40:59 INFO - 'SHELL': '/bin/bash', 09:40:59 INFO - 'SHLVL': '1', 09:40:59 INFO - 'TERM': 'linux', 09:40:59 INFO - 'TMOUT': '86400', 09:40:59 INFO - 'USER': 'cltbld', 09:40:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:59 INFO - '_': '/tools/buildbot/bin/python'} 09:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:40:59 INFO - Cleaning up... 09:40:59 INFO - Return code: 0 09:40:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:40:59 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')]} 09:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:59 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')]} 09:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:59 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 0x7ff1ed3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', '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 09:40:59 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 09:40:59 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 09:40:59 INFO - Using env: {'DISPLAY': ':0', 09:40:59 INFO - 'HOME': '/home/cltbld', 09:40:59 INFO - 'LANG': 'en_US.UTF-8', 09:40:59 INFO - 'LANGUAGE': 'en_US:en', 09:40:59 INFO - 'LOGNAME': 'cltbld', 09:40:59 INFO - 'MAIL': '/var/mail/cltbld', 09:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:59 INFO - 'MOZ_NO_REMOTE': '1', 09:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:59 INFO - 'NO_EM_RESTART': '1', 09:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:59 INFO - 'PWD': '/builds/slave/test', 09:40:59 INFO - 'SHELL': '/bin/bash', 09:40:59 INFO - 'SHLVL': '1', 09:40:59 INFO - 'TERM': 'linux', 09:40:59 INFO - 'TMOUT': '86400', 09:40:59 INFO - 'USER': 'cltbld', 09:40:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:59 INFO - '_': '/tools/buildbot/bin/python'} 09:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:40:59 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 09:40:59 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 09:40:59 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 09:40:59 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 09:40:59 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 09:40:59 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 09:41:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:41:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:41:01 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 09:41:01 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 09:41:01 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 09:41:01 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 09:41:01 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 09:41:01 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 09:41:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:41:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:41:02 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 09:41:02 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 09:41:02 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 09:41:02 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 09:41:02 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 09:41:02 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 09:41:02 INFO - Downloading docopt-0.6.1.tar.gz 09:41:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:41:02 INFO - Installing collected packages: blobuploader, requests, docopt 09:41:02 INFO - Running setup.py install for blobuploader 09:41:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:41:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:41:02 INFO - Running setup.py install for requests 09:41:02 INFO - Running setup.py install for docopt 09:41:02 INFO - Successfully installed blobuploader requests docopt 09:41:02 INFO - Cleaning up... 09:41:02 INFO - Return code: 0 09:41:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41:02 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')]} 09:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:02 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')]} 09:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:02 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 0x7ff1ed3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', '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 09:41:02 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 09:41:02 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 09:41:02 INFO - Using env: {'DISPLAY': ':0', 09:41:02 INFO - 'HOME': '/home/cltbld', 09:41:02 INFO - 'LANG': 'en_US.UTF-8', 09:41:02 INFO - 'LANGUAGE': 'en_US:en', 09:41:02 INFO - 'LOGNAME': 'cltbld', 09:41:02 INFO - 'MAIL': '/var/mail/cltbld', 09:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:02 INFO - 'MOZ_NO_REMOTE': '1', 09:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:41:02 INFO - 'NO_EM_RESTART': '1', 09:41:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:02 INFO - 'PWD': '/builds/slave/test', 09:41:02 INFO - 'SHELL': '/bin/bash', 09:41:02 INFO - 'SHLVL': '1', 09:41:02 INFO - 'TERM': 'linux', 09:41:02 INFO - 'TMOUT': '86400', 09:41:02 INFO - 'USER': 'cltbld', 09:41:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:02 INFO - '_': '/tools/buildbot/bin/python'} 09:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:41:03 INFO - Running setup.py (path:/tmp/pip-Iz22ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:41:03 INFO - Running setup.py (path:/tmp/pip-F9pEoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:41:03 INFO - Running setup.py (path:/tmp/pip-wGXqij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:41:03 INFO - Running setup.py (path:/tmp/pip-w393jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:41:03 INFO - Running setup.py (path:/tmp/pip-xo6t4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:41:03 INFO - Running setup.py (path:/tmp/pip-jv_h47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:41:03 INFO - Running setup.py (path:/tmp/pip-npsNNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:41:03 INFO - Running setup.py (path:/tmp/pip-CnhoIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:41:03 INFO - Running setup.py (path:/tmp/pip-BN0sM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:41:03 INFO - Running setup.py (path:/tmp/pip-lX8vRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:41:03 INFO - Running setup.py (path:/tmp/pip-Rhuekk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:41:03 INFO - Running setup.py (path:/tmp/pip-kZ9dCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:41:04 INFO - Running setup.py (path:/tmp/pip-G390_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:41:04 INFO - Running setup.py (path:/tmp/pip-ImnfCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:04 INFO - Running setup.py (path:/tmp/pip-GKUv6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:41:04 INFO - Running setup.py (path:/tmp/pip-vqhNtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:41:04 INFO - Running setup.py (path:/tmp/pip-mtWXLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:41:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:41:04 INFO - Running setup.py install for manifestparser 09:41:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Running setup.py install for mozcrash 09:41:04 INFO - Running setup.py install for mozdebug 09:41:04 INFO - Running setup.py install for mozdevice 09:41:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Running setup.py install for mozfile 09:41:04 INFO - Running setup.py install for mozhttpd 09:41:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:41:04 INFO - Running setup.py install for mozinfo 09:41:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Running setup.py install for mozInstall 09:41:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Running setup.py install for mozleak 09:41:05 INFO - Running setup.py install for mozlog 09:41:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Running setup.py install for moznetwork 09:41:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Running setup.py install for mozprocess 09:41:05 INFO - Running setup.py install for mozprofile 09:41:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Running setup.py install for mozrunner 09:41:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:41:05 INFO - Running setup.py install for mozscreenshot 09:41:05 INFO - Running setup.py install for moztest 09:41:06 INFO - Running setup.py install for mozversion 09:41:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:41:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:41:06 INFO - Cleaning up... 09:41:06 INFO - Return code: 0 09:41:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:06 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 0x7ff1ed3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', '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 09:41:06 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 09:41:06 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 09:41:06 INFO - Using env: {'DISPLAY': ':0', 09:41:06 INFO - 'HOME': '/home/cltbld', 09:41:06 INFO - 'LANG': 'en_US.UTF-8', 09:41:06 INFO - 'LANGUAGE': 'en_US:en', 09:41:06 INFO - 'LOGNAME': 'cltbld', 09:41:06 INFO - 'MAIL': '/var/mail/cltbld', 09:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:06 INFO - 'MOZ_NO_REMOTE': '1', 09:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:41:06 INFO - 'NO_EM_RESTART': '1', 09:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:06 INFO - 'PWD': '/builds/slave/test', 09:41:06 INFO - 'SHELL': '/bin/bash', 09:41:06 INFO - 'SHLVL': '1', 09:41:06 INFO - 'TERM': 'linux', 09:41:06 INFO - 'TMOUT': '86400', 09:41:06 INFO - 'USER': 'cltbld', 09:41:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:06 INFO - '_': '/tools/buildbot/bin/python'} 09:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:41:06 INFO - Running setup.py (path:/tmp/pip-g96diW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:41:06 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)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:41:06 INFO - Running setup.py (path:/tmp/pip-bgFBAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:41:06 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)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:41:06 INFO - Running setup.py (path:/tmp/pip-LMEgDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:41:06 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)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:41:06 INFO - Running setup.py (path:/tmp/pip-_xxcAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:41:06 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)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:41:06 INFO - Running setup.py (path:/tmp/pip-SiVasV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:41:06 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)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:41:06 INFO - Running setup.py (path:/tmp/pip-kVutuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:41:06 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)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:41:06 INFO - Running setup.py (path:/tmp/pip-BWBFyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:41:06 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)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:41:06 INFO - Running setup.py (path:/tmp/pip-CN8bPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:41:06 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)) 09:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:41:06 INFO - Running setup.py (path:/tmp/pip-cBuDLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:41:07 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)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:41:07 INFO - Running setup.py (path:/tmp/pip-NQarGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:41:07 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)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:41:07 INFO - Running setup.py (path:/tmp/pip-7TsChD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:41:07 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)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:41:07 INFO - Running setup.py (path:/tmp/pip-vkqNz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:41:07 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)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:41:07 INFO - Running setup.py (path:/tmp/pip-Kh2lGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:41:07 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)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:41:07 INFO - Running setup.py (path:/tmp/pip-BMXbdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:41:07 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)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:07 INFO - Running setup.py (path:/tmp/pip-4vxJXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:41:07 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)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:41:07 INFO - Running setup.py (path:/tmp/pip-Gb88Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:41:07 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)) 09:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:41:07 INFO - Running setup.py (path:/tmp/pip-2NWZn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:41:07 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)) 09:41:07 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)) 09:41:07 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)) 09:41:07 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)) 09:41:07 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)) 09:41:07 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)) 09:41:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:41:07 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 09:41:07 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 09:41:07 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 09:41:07 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 09:41:07 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 09:41:07 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 09:41:09 INFO - Downloading blessings-1.6.tar.gz 09:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:41:09 INFO - Installing collected packages: blessings 09:41:09 INFO - Running setup.py install for blessings 09:41:09 INFO - Successfully installed blessings 09:41:09 INFO - Cleaning up... 09:41:09 INFO - Return code: 0 09:41:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:41:10 INFO - Reading from file tmpfile_stdout 09:41:10 INFO - Current package versions: 09:41:10 INFO - argparse == 1.2.1 09:41:10 INFO - blessings == 1.6 09:41:10 INFO - blobuploader == 1.2.4 09:41:10 INFO - docopt == 0.6.1 09:41:10 INFO - functools32 == 3.2.3-2 09:41:10 INFO - jsonschema == 2.5.1 09:41:10 INFO - manifestparser == 1.1 09:41:10 INFO - mozInstall == 1.12 09:41:10 INFO - mozcrash == 0.17 09:41:10 INFO - mozdebug == 0.1 09:41:10 INFO - mozdevice == 0.48 09:41:10 INFO - mozfile == 1.2 09:41:10 INFO - mozhttpd == 0.7 09:41:10 INFO - mozinfo == 0.9 09:41:10 INFO - mozleak == 0.1 09:41:10 INFO - mozlog == 3.4 09:41:10 INFO - moznetwork == 0.27 09:41:10 INFO - mozprocess == 0.23 09:41:10 INFO - mozprofile == 0.28 09:41:10 INFO - mozrunner == 6.12 09:41:10 INFO - mozscreenshot == 0.1 09:41:10 INFO - mozsystemmonitor == 0.3 09:41:10 INFO - moztest == 0.7 09:41:10 INFO - mozversion == 1.4 09:41:10 INFO - psutil == 3.1.1 09:41:10 INFO - requests == 1.2.3 09:41:10 INFO - wsgiref == 0.1.2 09:41:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:10 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 0x7ff1ed3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', '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 09:41:10 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 09:41:10 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 09:41:10 INFO - Using env: {'DISPLAY': ':0', 09:41:10 INFO - 'HOME': '/home/cltbld', 09:41:10 INFO - 'LANG': 'en_US.UTF-8', 09:41:10 INFO - 'LANGUAGE': 'en_US:en', 09:41:10 INFO - 'LOGNAME': 'cltbld', 09:41:10 INFO - 'MAIL': '/var/mail/cltbld', 09:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:10 INFO - 'MOZ_NO_REMOTE': '1', 09:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:41:10 INFO - 'NO_EM_RESTART': '1', 09:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:10 INFO - 'PWD': '/builds/slave/test', 09:41:10 INFO - 'SHELL': '/bin/bash', 09:41:10 INFO - 'SHLVL': '1', 09:41:10 INFO - 'TERM': 'linux', 09:41:10 INFO - 'TMOUT': '86400', 09:41:10 INFO - 'USER': 'cltbld', 09:41:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:10 INFO - '_': '/tools/buildbot/bin/python'} 09:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 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)) 09:41:10 INFO - Cleaning up... 09:41:10 INFO - Return code: 0 09:41:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:41:10 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 0x7ff1ed3e8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aaeca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', '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 09:41:10 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 09:41:10 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 09:41:10 INFO - Using env: {'DISPLAY': ':0', 09:41:10 INFO - 'HOME': '/home/cltbld', 09:41:10 INFO - 'LANG': 'en_US.UTF-8', 09:41:10 INFO - 'LANGUAGE': 'en_US:en', 09:41:10 INFO - 'LOGNAME': 'cltbld', 09:41:10 INFO - 'MAIL': '/var/mail/cltbld', 09:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:10 INFO - 'MOZ_NO_REMOTE': '1', 09:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:41:10 INFO - 'NO_EM_RESTART': '1', 09:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:10 INFO - 'PWD': '/builds/slave/test', 09:41:10 INFO - 'SHELL': '/bin/bash', 09:41:10 INFO - 'SHLVL': '1', 09:41:10 INFO - 'TERM': 'linux', 09:41:10 INFO - 'TMOUT': '86400', 09:41:10 INFO - 'USER': 'cltbld', 09:41:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:10 INFO - '_': '/tools/buildbot/bin/python'} 09:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:41:10 INFO - Cleaning up... 09:41:10 INFO - Return code: 0 09:41:10 INFO - Running post-action listener: _resource_record_post_action 09:41:10 INFO - Running post-action listener: _start_resource_monitoring 09:41:10 INFO - Starting resource monitoring. 09:41:10 INFO - [mozharness: 2016-10-20 16:41:10.521966Z] Finished create-virtualenv step (success) 09:41:10 INFO - [mozharness: 2016-10-20 16:41:10.522527Z] Running install step. 09:41:10 INFO - Running pre-action listener: _resource_record_pre_action 09:41:10 INFO - Running main action method: install 09:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:41:10 INFO - Reading from file tmpfile_stdout 09:41:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:41:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:41:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:41:10 INFO - Reading from file tmpfile_stdout 09:41:10 INFO - Output received: 09:41:10 INFO - Usage: mozinstall [options] installer 09:41:10 INFO - Options: 09:41:10 INFO - -h, --help show this help message and exit 09:41:10 INFO - -d DEST, --destination=DEST 09:41:10 INFO - Directory to install application into. [default: 09:41:10 INFO - "/builds/slave/test"] 09:41:10 INFO - --app=APP Application being installed. [default: firefox] 09:41:10 INFO - mkdir: /builds/slave/test/build/application 09:41:10 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'] 09:41:10 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 09:41:26 INFO - Reading from file tmpfile_stdout 09:41:26 INFO - Output received: 09:41:26 INFO - /builds/slave/test/build/application/firefox/firefox 09:41:26 INFO - Running post-action listener: _resource_record_post_action 09:41:26 INFO - [mozharness: 2016-10-20 16:41:26.839210Z] Finished install step (success) 09:41:26 INFO - [mozharness: 2016-10-20 16:41:26.839453Z] Running run-tests step. 09:41:26 INFO - Running pre-action listener: _resource_record_pre_action 09:41:26 INFO - Running main action method: run_tests 09:41:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:41:26 INFO - Python 2.7.3 09:41:26 INFO - Return code: 0 09:41:26 INFO - grabbing minidump binary from tooltool 09:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:41:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aabf60>, '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 0x2aacd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aad1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:41:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:41:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:41:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:41:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:41:26 INFO - Return code: 0 09:41:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:41:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:41:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:41:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:41:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:41:26 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/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 09:41:26 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/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 09:41:26 INFO - Using env: {'DISPLAY': ':0', 09:41:26 INFO - 'HOME': '/home/cltbld', 09:41:26 INFO - 'LANG': 'en_US.UTF-8', 09:41:26 INFO - 'LANGUAGE': 'en_US:en', 09:41:26 INFO - 'LOGNAME': 'cltbld', 09:41:26 INFO - 'MAIL': '/var/mail/cltbld', 09:41:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:41:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:41:26 INFO - 'MOZ_NO_REMOTE': '1', 09:41:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:41:26 INFO - 'NO_EM_RESTART': '1', 09:41:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:41:26 INFO - 'PWD': '/builds/slave/test', 09:41:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:41:26 INFO - 'SHELL': '/bin/bash', 09:41:26 INFO - 'SHLVL': '1', 09:41:26 INFO - 'TERM': 'linux', 09:41:26 INFO - 'TMOUT': '86400', 09:41:26 INFO - 'USER': 'cltbld', 09:41:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627', 09:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:41:26 INFO - '_': '/tools/buildbot/bin/python'} 09:41:26 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/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 09:41:27 INFO - mozversion application_buildid: 20161020074850 09:41:27 INFO - mozversion application_changeset: 3f0aeafe59c40c5e92ba9636fa718cf26088e127 09:41:27 INFO - mozversion application_display_name: Nightly 09:41:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:41:27 INFO - mozversion application_name: Firefox 09:41:27 INFO - mozversion application_remotingname: firefox 09:41:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:41:27 INFO - mozversion application_vendor: Mozilla 09:41:27 INFO - mozversion application_version: 52.0a1 09:41:27 INFO - mozversion platform_buildid: 20161020074850 09:41:27 INFO - mozversion platform_changeset: 3f0aeafe59c40c5e92ba9636fa718cf26088e127 09:41:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:41:27 INFO - mozversion platform_version: 52.0a1 09:41:27 INFO - using testdate: 1476981687 09:41:27 INFO - actual date: 1476981687 09:41:27 INFO - starting webserver on 'localhost:57190' 09:41:27 INFO - SUITE-START | Running 2 tests 09:41:27 INFO - TEST-START | dromaeo_css 09:41:27 INFO - operating with platform_type : linux_ 09:41:27 INFO - Initialising browser for dromaeo_css test... 09:41:27 INFO - TEST-INFO | started process 13957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRfRveO/profile http://localhost:57190/getInfo.html) 09:41:31 INFO - PROCESS | 13957 | __metrics Screen width/height:1600/1200 09:41:31 INFO - PROCESS | 13957 | colorDepth:24 09:41:31 INFO - PROCESS | 13957 | Browser inner width/height: 1024/697 09:41:31 INFO - PROCESS | 13957 | __metrics 09:41:31 INFO - PROCESS | 13957 | 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" 09:41:31 INFO - PROCESS | 13957 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:41:32 INFO - PROCESS | 13957 | console.error: PushService: 09:41:32 INFO - PROCESS | 13957 | stateChangeProcessEnqueue: Error transitioning state 09:41:32 INFO - PROCESS | 13957 | UnknownError 09:41:33 INFO - TEST-INFO | 13957: exit 0 09:41:33 INFO - Browser initialized. 09:41:33 INFO - Running cycle 1/1 for dromaeo_css test... 09:41:33 INFO - TEST-INFO | started process 14041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRfRveO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:45 INFO - PROCESS | 14041 | RSS: Main: 173035520 09:41:45 INFO - PROCESS | 14041 | 09:42:36 INFO - PROCESS | 14041 | 1476981756964 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] 09:44:50 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57190/tests/dromaeo/cssquery-ext.html) 09:44:52 INFO - PROCESS | 14041 | RSS: Main: 374231040 09:44:52 INFO - PROCESS | 14041 | 09:47:55 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-ext.html (next: http://localhost:57190/tests/dromaeo/cssquery-jquery.html) 09:47:55 INFO - PROCESS | 14041 | RSS: Main: 279314432 09:47:55 INFO - PROCESS | 14041 | 09:50:57 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57190/tests/dromaeo/cssquery-mootools.html) 09:50:58 INFO - PROCESS | 14041 | RSS: Main: 241119232 09:50:58 INFO - PROCESS | 14041 | 09:54:00 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57190/tests/dromaeo/cssquery-prototype.html) 09:54:01 INFO - PROCESS | 14041 | RSS: Main: 220172288 09:54:01 INFO - PROCESS | 14041 | 09:57:04 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57190/tests/dromaeo/cssquery-yui.html) 09:57:05 INFO - PROCESS | 14041 | RSS: Main: 223838208 09:57:05 INFO - PROCESS | 14041 | 10:00:08 INFO - PROCESS | 14041 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-yui.html (next: http://localhost:57190/tests/dromaeo/cssquery-dojo.html) 10:00:08 INFO - PROCESS | 14041 | RSS: Main: 312803328 10:00:08 INFO - PROCESS | 14041 | 10:00:08 INFO - PROCESS | 14041 | __start_tp_report 10:00:08 INFO - PROCESS | 14041 | _x_x_mozilla_page_load 10:00:08 INFO - PROCESS | 14041 | _x_x_mozilla_page_load_details 10:00:08 INFO - PROCESS | 14041 | |i|pagename|runs| 10:00:08 INFO - PROCESS | 14041 | |0;dojo.html;2558.923232303031;2573.1122762646905;2593.494268617619;2614.8692565371725;2615.79073674106;4496.055828276066;4611.884702882421;4657.930131048032;4675.625949924002;4695.8356457524;4645.88385290367;4655.022445286494;4659.464161621406;4665.696729712567;4666.206744853374;4212.578742125794;4248.787560621972;4250.57494250574;4293.570642935697;4326.870193894172;4321.9783901080455;4330.718503297291;4334.77359574414;4341.6092551670345;4353.216421044211;4261.872143835674;4268.103698223377;4291.699581029329;4314.37441570972;4346.5436129206455;4345.239583072981;4348.108637729258;4349.26062569364;4376.234159022159;4379.627731642799;4201.579842015804;4232.640225580829;4253.553376895412;4259.233337999159;4267.359896015591;4664.416947881515;4675.135100006476;4679.064187162581;4690.835820746258;4759.428868535763;4988.326575912241;5035.043341765053;5049.873753156164;5053.646244762868;5093.388793344785;4814.879628009293;4854.830080947185;4855.68438051529;5098.852758129391;5121.692698438068;4547.727136371828;4576.26779715244;4583.541645835457;4589.472210695746;4636.652251081183;5049;5053.0399224147295;5058.570021548209;5069.188929771219;5069.467705890902;4914.361133052752;4943.678660887031;4954.554090131834;5007;5009.423916249605;4960.851174464772;5013.924791128136;5017.272495488134;5073.061483625467;5085.898282034413;4963.106640804617;4986.401631804207;5014.2979982802435;5071.746412679351;5071.797128114834;4792.784324705397;4836.250381190921;4850.223964165716;4934.802607895644;4948.925766113512;4277.615014648696;4320.200762858818;4320.395144679747;4324.416203812508;4380.69335146543;3736.551613806361;3744.8314825832904;3745.5318085239346;3790.3556395412847;3792.924141517154;4143.02638879863;4349.151915376535;4350.869473915787;4351.825926962886;4409.228385032607;4930.630202734737;4988.55103040728;4997.775100120503;4998.125328067574;4999.625028122905;4311.33174357975;4320.416743739618;4321.243782338078;4322.092360604245;4327.0480494291205;4065.3698676705158;4537.954620453753;4547.454305483363;4587;4629.398178236875;4745.217039188633;4746.098241334135;4760.78576464053;4792.736399497921;4810.759462026955;5013.097642424399;5015.322931404214;5037.420696619935;5041.218611115283;5085.77114029877;4584.908301833878;4622.930656040229;4623.468301145412;4675.181843177498;4689.601383882272;4832.057748738962;4870.707757534559;4871.805127794849;4876.366072410564;4880.219164933594;4934.259861020875;4945.4312754033745;4945.975270123627;4949.183384741621;4950.430700469492;4806;4816.157172494729;4816.397950256218;4817.012512434872;4819.036192761532;4796.37647105874;4804.711717296974;4806.903861922672;4808.06242782654;4808.6153107752;4761.857144285677;4838.491958344323;4887.462379138363;4907.5828554571835;4967.478414766398;4987.501249874984;4988.8752781180765;4995.275685025578;5042.495750425075;5055.368078990126;4870.805167793249;4881.145799485147;4883.413990321184;4939.950600493949;4941.160002799605 10:00:08 INFO - PROCESS | 14041 | |1;ext.html;555.4501043966474;555.7193617223302;572.6020415811013;578.9983328841105;585.7130006296916;25472.74527254727;37665;38719.612803871954;38791.22417551647;42252;39514.8024259879;39863.80068099655;39893.8005309973;39902.20195596086;39907.40138897912;7759.456838021327;7898.60506974649;7903.209679032108;7903.525788452683;7904.446688731791;7775.961120194391;7868.2918537331625;7870.724524641639;7871.960640196791;7872.488288261274;7832.882506762403;7901.328387087105;7902.288794008538;7913.881291780628;7919.8416031679335;7860.371170306362;7883.36933045355;7899.328557072656;7907.920920790776;7910.644021019068;7718.151003389623;7770.728024519115;7774.300312971804;7774.572398518079;7776.183500732398;37669.43495847564;37964;38042.80978595117;38100;38110.80944595259;2721.249175453626;2945.175350901751;2950.867210975511;3020.894268700607;3191.888283910052;28143.155705328874;28206.717932820615;28609.99865004715;29349.706502935125;29740.405191896258;3496.5629296337956;3547.396942519778;3566.251087271676;3572.3212589607892;3632.5822530409077;243781;244108;244375;245498;245720;49567.76080598014;49785.75107124441;49907.50092499029;49937;49986;31296.687033129834;31716.841415792773;32146.517802232986;34143.65856341405;52317;12946.352682365845;13063.281519516519;13086.803697944539;13095.345232738326;13102.672433189247;9343.299252556086;9358.812823743487;9386.530673466299;9437.433753974783;9456.8581471278;17223.449889510004;17432;17435.215415306342;17458.214380352914;17476.650466990588;6835.872081106661;6907.378335949788;6927.93072069283;7166.355028047396;7187.820304492325;766.5975362934392;783.3615603283306;931.7810314576069;977.237754551451;1020.6529779874878;26186.607200892002;27352.726472735416;27775.861120694266;28030.43939121247;28073;700.5691499727631;874.3966663002635;879.1516186879564;879.2482427524375;898.4339865884582;14093.577192684235;14782.09217468569;14960;14988.250587470582;14995.475158369405;347534;348641;349033;350165;350938;45578;45997.310040349425;46060.3090953636;46100;46183;977.7604486900755;1049.8425236214782;1123.4719681749564;1147.1224513247373;1149.9712507187387;25132.62301065522;28479.145625631263;28632.856835715687;30183.69816301809;30421.239469013453;44768.55231447644;45241.09517809691;45312.32031519596;45360;45371.77314113409;315095;317350;317462;317771;317822;24097.879510602335;25000.624990625518;25025.374365641004;25065.87467062726;25066.74933250717;39534.20931581295;39626;39738.40392394174;39997;40858.38712419375;34607.480887787206;34707.82646086854;34751.65248347585;34836.82581587076;34891.82554087213;34043.82978085094;34071.65928340784;34280.82859585686;35011.82494087513;35402.11494712653;29168.27079323034;29300.41399171962;32967.83516082404;34368.65631343654;34718;29065.564016540193;31499.527507086954;31821;31848.203794905312;32381.676183238807;24225.63661545043;24287.149949751674;24552.508949821262;24880.12919547807;24900.62649060229 10:00:08 INFO - PROCESS | 14041 | |2;jquery.html;336.6604468402296;354.3533052179771;361.4036839215295;367.8712450642275;384.2526286373004;12414.255144691313;13303.20180789152;13408.530701425452;16847.157642117876;16877.746833797504;12534.874651253485;12764.744705105892;14872.24863400269;14906.850931490682;14940.327685254162;4946.975265123679;5162.819301324435;5167.844964651066;5190.4809519047985;5193.065248255312;3584.1039740064984;3804.5814960354337;5828.650280983134;6098.14625952367;6162.106494558287;5849.941500585003;6114.724837382329;6115.143879856823;6123.663198524079;6124.050772130305;6017.578769486137;6096.329403765582;6101.2983506896835;6102.359252278491;6108.267007959073;5176.689398636094;5314.92027619586;5330.067238233332;5380.381256155553;5389.568834493231;20290.391288261377;20382.796172038237;20387.796122038737;20504.38486845397;20526.178952841867;1799.1723807048772;1801.4505575799376;1818.9181486833124;1842.5577861313188;1868.7383766272733;12381.319027453486;13247.337633118306;13523.39144738489;13638.113522620997;13755.518556850462;1654.7848779658689;1676.5054308978881;1723.1125970125395;1732.3070771691425;1774.3434929076195;66967;67133.32866671319;67511;67627;69227;9306.767330816783;9506.429614223169;9517.191038761783;9596.136347728738;9687.32188746781;13001.674958125934;13041.217526948414;13054.34728263583;13124.212547247196;13125.671858203621;6602.537822352485;6690.832729181712;6862.705901167467;6879.484038697117;6882.105326307648;6260.46786023184;6325.272593651789;6407.359264073555;6457;6524.151860258231;5890.676012819336;6108.602940808833;6169.413905678954;6178.845528861724;6333.113364129025;1685.2500637216567;1722.336900293371;1740.6518696260798;1745.2408202431982;1783.9821601784076;840.5083026429485;847.525385783963;887.964481420736;900.1988230474883;922.3405265235255;16701;16726.6654666906;17357.913210433868;17414;17872.55318617045;850.6809946270149;850.7107583421666;851.0638297872415;863;922.9307801914749;9373.578188981512;10072.59709611622;10127.493625318704;10176.333967962775;10262.640807571699;328654;335043;336848;337014;337156;65173;65582.01626975599;65656.67171664111;67625.3237467619;68639.65680171567;923.9399439036441;927.2628260532892;929.7210836748948;934.3039435620507;955.044955044955;15089.849101508844;15333.310001049756;15467.381304747683;15830.28763705659;16080.758788617946;34625;34644;35385.46921796124;35721.82139089288;36074.4588831173;42788.358174628025;45455.54544454513;45811;45826.77086614545;46065;7136.85726285461;7463.776086717407;7650.655720492702;7783.104942931635;7890.921090789018;11553.364564949008;11639.6508104757;11739.47172377228;11983.940080299542;12072.698182545506;9161.633534658538;9813.411195328303;9922.503874806374;10626.096781773636;10801.081908037904;9812.705618831447;9917.900820991697;9950.950245249018;10017.39895606266;10021.5490302938;8960.163166550972;9972.451515166735;10125.544350504098;10479.161667066464;10646.73383165427;7651.464397492122;7741;7767.92232077672;7817.960910195413;7871.48835325702;8495.405321627426;10072.093511583993;10232.64185753495;10375.325603836029;10673.46632668379 10:00:08 INFO - PROCESS | 14041 | |3;mootools.html;1172.9824052639217;1355.5391167003218;1372.2795532345517;1449.420231907237;1700.4303558307975;6542.803715888525;7349.338559529641;7641.08307003159;7647.158812530617;7875.92124078759;7790.727324543642;7857.1357150713375;7859.882101768478;7860.724874629374;7863.56750378729;2129.925452609155;2153.1710291537715;2156.223759446598;2158.147531724968;2161.5676864627058;2127.7872212778752;2150.419386765572;2157;2158.730158730151;2174.0325555127974;2076.4289820299464;2095.434232757155;2102.5899949509853;2114.0909408954144;2121.4802373418456;2019.1822311963679;2020.777714451409;2020.959580808383;2037.6128535578341;2039.1129858511595;1964.0768838645813;2064.1021155797125;2066.214838361413;2071.6271071207175;2071.927482538104;7666.501677390952;7697.615119244016;7754.069511658637;7760.301572858413;7762.029746281715;4106.322456794625;4236.957630423687;4240.724352917051;4295.699301048928;4309.913801723979;2880.9711902880913;3046.558249053875;3091.119031076155;3093.8453077346044;3103.3482968576627;891.6032365597312;897.3135551303258;907.5099446298991;932.4079209701821;937.3438592984937;10653.147748180127;10771.299865508718;10774.19193560486;10811.837822432592;10818.837717434244;3828.8659896903473;4119.299719047769;4152.4601801765575;4219.599138081939;4220.910649228652;8441.607134822809;8445.1977062179;8446.66213351459;8453.619587118472;8458.87311690325;4482.260427029503;4501.729896206238;4508.098380323949;4508.932366014513;4513.142502924434;3575.8212089395424;3702;3848.826802793881;4168.520620128664;4168.624823765815;3305.4215512285255;3324.8337583120747;3412.9829350853583;3417.384870723244;3433.9484907726405;1050.7163065972145;1061.7717190804015;1071.3678929431674;1076.962306319275;1086.6794295682635;772.5094564951296;780.473180603102;795.1333046978821;796.7131832540281;811.9878201826978;4567.862964111082;4717.339572459859;4744.59670927975;4844.563989240914;5046.091703493406;812.4637739092288;828.5939889454245;859.5788063848669;887.4187407248263;918.2608000559613;3174.555562221291;3200.567923330321;3247.9837600812316;3253.7234335081785;3404.4042292598697;8984.46093234408;9326.487043212554;9327.300452466092;9377.29670274732;9377.624895004123;9339.626414943463;9420.95289523548;9424;9432.90567094334;9437.056294370508;6455.903161452582;6581.243157037002;6591.110200122922;6676.26561078281;6694.83262918431;4766.499517550746;4774.522547745198;4802.087603355351;4816.277558366133;4954.380702412199;8591.226789588967;8630.223279904838;8670.089640587648;8793.912060879566;8800.38397312182;8238.464499807493;8447.535385553607;8540.44487108336;8823.029466758522;8875.822483550422;5831.183634291117;6033.54748393881;6591.5056370773345;6754.696038678369;6782.660866956534;7009.579425234502;7355;7366.558006519626;7480.962595186989;7488.5506869588;6547.508936829661;6634.104395906684;6656.36764507371;6830.863382732218;6921.688524016331;6386.201724784402;6492.513061520499;6493.253275873335;6510.088587597835;6599.505037122139;5878.441548052928;5966.075258334965;5966.313873904556;5972.074328479092;5976.521878249642;4097.815598298143;4177.97911010443;4253.638440732572;4334.566543345641;4360.215161271001;4235.63997060241;4340.262155433521;4352.608265256142;4409.559044095693;4467.262901621196 10:00:08 INFO - PROCESS | 14041 | |4;prototype.html;295.3428621317569;296.1234745154343;304.7942638718864;308.6358097445014;310.04815217282936;4753.144434001878;4764.498638214939;4790.329353890458;4800.759962001899;4865.148598995175;4763.14263432582;4763.261694437368;4772.475027746945;4784.44978827435;4798.344571122966;3837.6929845612353;3847.6344747249104;3852.229554089179;3866.4007078902673;3874.302625527404;3724.385476396405;3807.9809600951958;3846.788426636534;3848.3073046851555;3851.4607954886337;3744.6255374462608;3751.5181503306176;3764.849406023756;3769.9434508482395;3769.9434508482395;3735.4210097434943;3755.868544600926;3758.455024021529;3765.1008723283057;3778.6019172905926;3141.15188898996;3222.9677703223138;3230.709236168733;3310.5034244863223;3357.8321083945707;4604.654650901196;4613.607843333287;4675.742834144121;4681.976590117028;4683.976580117078;4318.568143185687;4329.177456283296;4342.826286948518;4346.326319420463;4349.456317960255;4659.5573420525;4756.143894099061;4970.080535100982;5025.748712564357;5030.547250747413;3607.8376473058775;3612.349777040132;3614.1326081740194;3615.4757560153894;3623.691986181178;5245.220033382314;5245.763940622681;5262;5265;5274.156135018456;3416.419208734521;3598.568171819346;3619.7647152934974;3729.4965179700935;3738.700903927679;3647.635236476331;3650.525431693916;3662.285854258447;3664.688501477351;3681.134933290728;4194.895127621834;4232.788360581959;4237;4240.427542281815;4240.91518169641;4899.755012249373;4976.2038073908;4982.725950072709;4989.800407983713;5025.6482046256415;1257.6792917805901;1270.2378572856212;1276.789329760579;1286.7748144074749;1286.7941129419435;786.8544319300947;815.176671561727;829.5064436660177;835.5154010673795;837.7403005068327;3971.590085519657;3971.72197946141;3990.5610382857863;3990.6009399059863;4010.498687664042;4541.568550987651;4570.588647021784;4588.88527786808;4590.94408286096;4612.379282263407;3960.544537378181;3962.32640451124;3964.691651754914;3999.0202400411504;4024.2957482440456;2334.743178250391;2408.9764597737985;2424.8908799104083;2440.999190331991;2446.3272600035134;4648.163330600524;4714.22215334466;4806.855794326176;4827.372441582572;4889.682170658896;5287.656302340336;5299.198272587339;5310.8937821244135;5313.760880760375;5324.866878328073;4704.6236301096515;4906.705597664151;4920.72935988524;4951.282064100686;4954.727489988013;5111.3355263815465;5132.563732082815;5134.897302053863;5140.511651393112;5144.30551875492;5027.84916452507;5043.218301163325;5072.9746351268;5080.288759573737;5089.821856235014;4698.788554515123;4832.323474713613;4849.175640141114;4875.80496780139;4880.804767809248;3605.7836529808296;3619.9276014480088;3645.76302540334;3663.5603727551797;3668.8899333020054;5131.512506311894;5134.204198349262;5151;5209.661372010807;5246.790128394974;4807.18277892766;5055.483354993561;5074.238864170404;5081.314022606901;5098.617603679665;5032.220005899091;5038.193888977746;5047.167217409086;5047.498226932661;5060.240963855451;4976.900461990812;4994.80020799164;4996.3504744383;5044.722540260321;5055.140626093499;4960.950390496048;5052.791477411796;5098.898022039612;5118.641695081308;5127.512886275797;4923.138450771173;4930.161872481615;4933.58064564516;4934.654574179916;4937.777799998937 10:00:08 INFO - PROCESS | 14041 | |5;yui.html;604.6592576017503;659.3439527669967;662.6885363878978;703.9788806335812;723.3489859126788;12939.741205175902;14340;14356.497522586698;14357.856421435783;14412.927935360321;13336.466541338335;13377.799333010013;13429;13481.662958426019;13485.3257337133;594.925634295713;611.5994023914321;748.3825843678959;755.928186822251;768.0476209500235;755.9433042521805;767.6430459836175;768.6733138416179;768.7655265144128;768.9577073260969;829.3613917283687;831.2809419851845;831.3141658132035;831.3889291370867;831.5343407691712;633.8478765096366;649.7530938243484;650.151552224347;653.0335104045992;829.1873963515758;480.219643079995;590.2385922160408;596.7434003378589;607.5230943709167;608.3277977834473;12903.161294515827;12913.741725165444;12930.741385172338;12983.415746291439;13023.674408139777;12220.327881966488;12567.371631418393;12673.93663031688;12930.224186548743;13356.265405402699;11607.709807254887;11835.644930652094;11881;11923.523059077626;12484.937575312157;4006.759594424344;4041.5150181978056;4097.282975479279;4138.461999940018;4228.513720922103;61113.694431528005;61636.38363616351;62599.68700156516;63345.683271583344;63439;9855.507224638739;10163;10243.630684135587;10362.378257304586;10411.271211015308;18840.52898677544;19060;19065.714014289795;19114.13986370617;19125.13936872844;6557.573757705733;6576.473882089422;6620.801375958729;6678.799636010927;7032.824179395454;3624.7643903146213;3674.2829941687473;3714.9442758358105;3722;3766.642168993941;2737.904173353963;2832.178668186203;2833.546632538825;3125.4217969675683;3279;566.4194200943983;570.3213176320165;583.7606581301646;583.8423625621059;591.2432086928738;457.3848174205688;465.32810581758764;515.5746509129983;529.8251576979587;561.9129034999581;7971.108602483616;8971.551422428853;9102.681406150752;9132.863007054899;9195.218406435393;521.0386836287045;555.8610347413147;630.2437075509407;643.7585905285518;645.5932762359777;3880.2821478026653;4155.854545090907;4220.198162349144;4365.301551751768;4473.642108631302;72936.63531682413;76267;76339.61830190924;85603.15952607158;88721;73110;73583;77000.06498992666;78113;79583.60208198921;64313.35686643167;67578.66210668915;68849;70882.64558677276;70951;7830.491018083806;8128.309093727099;8225.917740822515;8247.463914845515;8314.470876867057;41567.58432415637;41954;42405.787971059945;42995;43818.780906095264;54213.45786542084;60034;60089.69955150371;62819.685901572026;63416;10682.786344272916;10786.191035672513;10807.783844323227;11233.438328083726;11319.830202547133;12513.624591262276;12690.746185076063;13263.734725305247;13705.383257753225;14142.080764750259;11457.65627031157;11646.88353116458;11861.703457413634;11909.642710718346;11928.76142477163;10462.424566648908;10996.890031099587;11149.10807135411;11339.829902551633;11367.602133925604;11610.88389116098;11848.644540663794;12556.497740090294;12819.294938778457;12972.870271297166;9801.803963920824;10084.14284785772;10184.643537476153;10197.9490102549;10249;8858.778530536789;8925.072663911347;8989.325800565115;9146.771330716785;10297.330673506198 10:00:08 INFO - PROCESS | 14041 | __end_tp_report 10:00:08 INFO - PROCESS | 14041 | __start_cc_report 10:00:08 INFO - PROCESS | 14041 | _x_x_mozilla_cycle_collect,2302 10:00:08 INFO - PROCESS | 14041 | __end_cc_report 10:00:08 INFO - PROCESS | 14041 | __startTimestamp1476982808355__endTimestamp 10:00:08 INFO - PROCESS | 14041 | 10:00:08 INFO - PROCESS | 14041 | ------- Summary: start ------- 10:00:08 INFO - PROCESS | 14041 | Number of tests: 6 10:00:08 INFO - PROCESS | 14041 | 10:00:08 INFO - PROCESS | 14041 | [#0] dojo.html Cycles:165 Average:4619.91 Median:4760.79 stddev:482.38 (10.1%) stddev-sans-first:455.96 10:00:08 INFO - PROCESS | 14041 | Values: 2558.9 2573.1 2593.5 2614.9 2615.8 4496.1 4611.9 4657.9 4675.6 4695.8 4645.9 4655.0 4659.5 4665.7 4666.2 4212.6 4248.8 4250.6 4293.6 4326.9 4322.0 4330.7 4334.8 4341.6 4353.2 4261.9 4268.1 4291.7 4314.4 4346.5 4345.2 4348.1 4349.3 4376.2 4379.6 4201.6 4232.6 4253.6 4259.2 4267.4 4664.4 4675.1 4679.1 4690.8 4759.4 4988.3 5035.0 5049.9 5053.6 5093.4 4814.9 4854.8 4855.7 5098.9 5121.7 4547.7 4576.3 4583.5 4589.5 4636.7 5049.0 5053.0 5058.6 5069.2 5069.5 4914.4 4943.7 4954.6 5007.0 5009.4 4960.9 5013.9 5017.3 5073.1 5085.9 4963.1 4986.4 5014.3 5071.7 5071.8 4792.8 4836.3 4850.2 4934.8 4948.9 4277.6 4320.2 4320.4 4324.4 4380.7 3736.6 3744.8 3745.5 3790.4 3792.9 4143.0 4349.2 4350.9 4351.8 4409.2 4930.6 4988.6 4997.8 4998.1 4999.6 4311.3 4320.4 4321.2 4322.1 4327.0 4065.4 4538.0 4547.5 4587.0 4629.4 4745.2 4746.1 4760.8 4792.7 4810.8 5013.1 5015.3 5037.4 5041.2 5085.8 4584.9 4622.9 4623.5 4675.2 4689.6 4832.1 4870.7 4871.8 4876.4 4880.2 4934.3 4945.4 4946.0 4949.2 4950.4 4806.0 4816.2 4816.4 4817.0 4819.0 4796.4 4804.7 4806.9 4808.1 4808.6 4761.9 4838.5 4887.5 4907.6 4967.5 4987.5 4988.9 4995.3 5042.5 5055.4 4870.8 4881.1 4883.4 4940.0 4941.2 10:00:08 INFO - PROCESS | 14041 | 10:00:08 INFO - PROCESS | 14041 | [#1] ext.html Cycles:180 Average:45016.86 Median:19474.76 stddev:80621.69 (414.0%) stddev-sans-first:80778.74 10:00:08 INFO - PROCESS | 14041 | Values: 555.5 555.7 572.6 579.0 585.7 25472.7 37665.0 38719.6 38791.2 42252.0 39514.8 39863.8 39893.8 39902.2 39907.4 7759.5 7898.6 7903.2 7903.5 7904.4 7776.0 7868.3 7870.7 7872.0 7872.5 7832.9 7901.3 7902.3 7913.9 7919.8 7860.4 7883.4 7899.3 7907.9 7910.6 7718.2 7770.7 7774.3 7774.6 7776.2 37669.4 37964.0 38042.8 38100.0 38110.8 2721.2 2945.2 2950.9 3020.9 3191.9 28143.2 28206.7 28610.0 29349.7 29740.4 3496.6 3547.4 3566.3 3572.3 3632.6 243781.0 244108.0 244375.0 245498.0 245720.0 49567.8 49785.8 49907.5 49937.0 49986.0 31296.7 31716.8 32146.5 34143.7 52317.0 12946.4 13063.3 13086.8 13095.3 13102.7 9343.3 9358.8 9386.5 9437.4 9456.9 17223.4 17432.0 17435.2 17458.2 17476.7 6835.9 6907.4 6927.9 7166.4 7187.8 766.6 783.4 931.8 977.2 1020.7 26186.6 27352.7 27775.9 28030.4 28073.0 700.6 874.4 879.2 879.2 898.4 14093.6 14782.1 14960.0 14988.3 14995.5 347534.0 348641.0 349033.0 350165.0 350938.0 45578.0 45997.3 46060.3 46100.0 46183.0 977.8 1049.8 1123.5 1147.1 1150.0 25132.6 28479.1 28632.9 30183.7 30421.2 44768.6 45241.1 45312.3 45360.0 45371.8 315095.0 317350.0 317462.0 317771.0 317822.0 24097.9 25000.6 25025.4 25065.9 25066.7 39534.2 39626.0 39738.4 39997.0 40858.4 34607.5 34707.8 34751.7 34836.8 34891.8 34043.8 34071.7 34280.8 35011.8 35402.1 29168.3 29300.4 32967.8 34368.7 34718.0 29065.6 31499.5 31821.0 31848.2 32381.7 24225.6 24287.1 24552.5 24880.1 24900.6 10:00:08 INFO - PROCESS | 14041 | 10:00:08 INFO - PROCESS | 14041 | [#2] jquery.html Cycles:180 Average:22217.16 Median:45945.89 stddev:55327.28 (120.4%) stddev-sans-first:55458.10 10:00:08 INFO - PROCESS | 14041 | Values: 336.7 354.4 361.4 367.9 384.3 12414.3 13303.2 13408.5 16847.2 16877.7 12534.9 12764.7 14872.2 14906.9 14940.3 4947.0 5162.8 5167.8 5190.5 5193.1 3584.1 3804.6 5828.7 6098.1 6162.1 5849.9 6114.7 6115.1 6123.7 6124.1 6017.6 6096.3 6101.3 6102.4 6108.3 5176.7 5314.9 5330.1 5380.4 5389.6 20290.4 20382.8 20387.8 20504.4 20526.2 1799.2 1801.5 1818.9 1842.6 1868.7 12381.3 13247.3 13523.4 13638.1 13755.5 1654.8 1676.5 1723.1 1732.3 1774.3 66967.0 67133.3 67511.0 67627.0 69227.0 9306.8 9506.4 9517.2 9596.1 9687.3 13001.7 13041.2 13054.3 13124.2 13125.7 6602.5 6690.8 6862.7 6879.5 6882.1 6260.5 6325.3 6407.4 6457.0 6524.2 5890.7 6108.6 6169.4 6178.8 6333.1 1685.3 1722.3 1740.7 1745.2 1784.0 840.5 847.5 888.0 900.2 922.3 16701.0 16726.7 17357.9 17414.0 17872.6 850.7 850.7 851.1 863.0 922.9 9373.6 10072.6 10127.5 10176.3 10262.6 328654.0 335043.0 336848.0 337014.0 337156.0 65173.0 65582.0 65656.7 67625.3 68639.7 923.9 927.3 929.7 934.3 955.0 15089.8 15333.3 15467.4 15830.3 16080.8 34625.0 34644.0 35385.5 35721.8 36074.5 42788.4 45455.5 45811.0 45826.8 46065.0 7136.9 7463.8 7650.7 7783.1 7890.9 11553.4 11639.7 11739.5 11983.9 12072.7 9161.6 9813.4 9922.5 10626.1 10801.1 9812.7 9917.9 9951.0 10017.4 10021.5 8960.2 9972.5 10125.5 10479.2 10646.7 7651.5 7741.0 7767.9 7818.0 7871.5 8495.4 10072.1 10232.6 10375.3 10673.5 10:00:08 INFO - PROCESS | 14041 | 10:00:08 INFO - PROCESS | 14041 | [#3] mootools.html Cycles:180 Average:4939.96 Median:4809.18 stddev:2811.08 (58.5%) stddev-sans-first:2804.71 10:00:08 INFO - PROCESS | 14041 | Values: 1173.0 1355.5 1372.3 1449.4 1700.4 6542.8 7349.3 7641.1 7647.2 7875.9 7790.7 7857.1 7859.9 7860.7 7863.6 2129.9 2153.2 2156.2 2158.1 2161.6 2127.8 2150.4 2157.0 2158.7 2174.0 2076.4 2095.4 2102.6 2114.1 2121.5 2019.2 2020.8 2021.0 2037.6 2039.1 1964.1 2064.1 2066.2 2071.6 2071.9 7666.5 7697.6 7754.1 7760.3 7762.0 4106.3 4237.0 4240.7 4295.7 4309.9 2881.0 3046.6 3091.1 3093.8 3103.3 891.6 897.3 907.5 932.4 937.3 10653.1 10771.3 10774.2 10811.8 10818.8 3828.9 4119.3 4152.5 4219.6 4220.9 8441.6 8445.2 8446.7 8453.6 8458.9 4482.3 4501.7 4508.1 4508.9 4513.1 3575.8 3702.0 3848.8 4168.5 4168.6 3305.4 3324.8 3413.0 3417.4 3433.9 1050.7 1061.8 1071.4 1077.0 1086.7 772.5 780.5 795.1 796.7 812.0 4567.9 4717.3 4744.6 4844.6 5046.1 812.5 828.6 859.6 887.4 918.3 3174.6 3200.6 3248.0 3253.7 3404.4 8984.5 9326.5 9327.3 9377.3 9377.6 9339.6 9421.0 9424.0 9432.9 9437.1 6455.9 6581.2 6591.1 6676.3 6694.8 4766.5 4774.5 4802.1 4816.3 4954.4 8591.2 8630.2 8670.1 8793.9 8800.4 8238.5 8447.5 8540.4 8823.0 8875.8 5831.2 6033.5 6591.5 6754.7 6782.7 7009.6 7355.0 7366.6 7481.0 7488.6 6547.5 6634.1 6656.4 6830.9 6921.7 6386.2 6492.5 6493.3 6510.1 6599.5 5878.4 5966.1 5966.3 5972.1 5976.5 4097.8 4178.0 4253.6 4334.6 4360.2 4235.6 4340.3 4352.6 4409.6 4467.3 10:00:08 INFO - PROCESS | 14041 | 10:00:08 INFO - PROCESS | 14041 | [#4] prototype.html Cycles:180 Average:4125.21 Median:4682.98 stddev:1214.03 (25.9%) stddev-sans-first:1182.92 10:00:08 INFO - PROCESS | 14041 | Values: 295.3 296.1 304.8 308.6 310.0 4753.1 4764.5 4790.3 4800.8 4865.1 4763.1 4763.3 4772.5 4784.4 4798.3 3837.7 3847.6 3852.2 3866.4 3874.3 3724.4 3808.0 3846.8 3848.3 3851.5 3744.6 3751.5 3764.8 3769.9 3769.9 3735.4 3755.9 3758.5 3765.1 3778.6 3141.2 3223.0 3230.7 3310.5 3357.8 4604.7 4613.6 4675.7 4682.0 4684.0 4318.6 4329.2 4342.8 4346.3 4349.5 4659.6 4756.1 4970.1 5025.7 5030.5 3607.8 3612.3 3614.1 3615.5 3623.7 5245.2 5245.8 5262.0 5265.0 5274.2 3416.4 3598.6 3619.8 3729.5 3738.7 3647.6 3650.5 3662.3 3664.7 3681.1 4194.9 4232.8 4237.0 4240.4 4240.9 4899.8 4976.2 4982.7 4989.8 5025.6 1257.7 1270.2 1276.8 1286.8 1286.8 786.9 815.2 829.5 835.5 837.7 3971.6 3971.7 3990.6 3990.6 4010.5 4541.6 4570.6 4588.9 4590.9 4612.4 3960.5 3962.3 3964.7 3999.0 4024.3 2334.7 2409.0 2424.9 2441.0 2446.3 4648.2 4714.2 4806.9 4827.4 4889.7 5287.7 5299.2 5310.9 5313.8 5324.9 4704.6 4906.7 4920.7 4951.3 4954.7 5111.3 5132.6 5134.9 5140.5 5144.3 5027.8 5043.2 5073.0 5080.3 5089.8 4698.8 4832.3 4849.2 4875.8 4880.8 3605.8 3619.9 3645.8 3663.6 3668.9 5131.5 5134.2 5151.0 5209.7 5246.8 4807.2 5055.5 5074.2 5081.3 5098.6 5032.2 5038.2 5047.2 5047.5 5060.2 4976.9 4994.8 4996.4 5044.7 5055.1 4961.0 5052.8 5098.9 5118.6 5127.5 4923.1 4930.2 4933.6 4934.7 4937.8 10:00:08 INFO - PROCESS | 14041 | 10:00:08 INFO - PROCESS | 14041 | [#5] yui.html Cycles:180 Average:16878.49 Median:472.77 stddev:22734.74 (4808.8%) stddev-sans-first:22765.68 10:00:08 INFO - PROCESS | 14041 | Values: 604.7 659.3 662.7 704.0 723.3 12939.7 14340.0 14356.5 14357.9 14412.9 13336.5 13377.8 13429.0 13481.7 13485.3 594.9 611.6 748.4 755.9 768.0 755.9 767.6 768.7 768.8 769.0 829.4 831.3 831.3 831.4 831.5 633.8 649.8 650.2 653.0 829.2 480.2 590.2 596.7 607.5 608.3 12903.2 12913.7 12930.7 12983.4 13023.7 12220.3 12567.4 12673.9 12930.2 13356.3 11607.7 11835.6 11881.0 11923.5 12484.9 4006.8 4041.5 4097.3 4138.5 4228.5 61113.7 61636.4 62599.7 63345.7 63439.0 9855.5 10163.0 10243.6 10362.4 10411.3 18840.5 19060.0 19065.7 19114.1 19125.1 6557.6 6576.5 6620.8 6678.8 7032.8 3624.8 3674.3 3714.9 3722.0 3766.6 2737.9 2832.2 2833.5 3125.4 3279.0 566.4 570.3 583.8 583.8 591.2 457.4 465.3 515.6 529.8 561.9 7971.1 8971.6 9102.7 9132.9 9195.2 521.0 555.9 630.2 643.8 645.6 3880.3 4155.9 4220.2 4365.3 4473.6 72936.6 76267.0 76339.6 85603.2 88721.0 73110.0 73583.0 77000.1 78113.0 79583.6 64313.4 67578.7 68849.0 70882.6 70951.0 7830.5 8128.3 8225.9 8247.5 8314.5 41567.6 41954.0 42405.8 42995.0 43818.8 54213.5 60034.0 60089.7 62819.7 63416.0 10682.8 10786.2 10807.8 11233.4 11319.8 12513.6 12690.7 13263.7 13705.4 14142.1 11457.7 11646.9 11861.7 11909.6 11928.8 10462.4 10996.9 11149.1 11339.8 11367.6 11610.9 11848.6 12556.5 12819.3 12972.9 9801.8 10084.1 10184.6 10197.9 10249.0 8858.8 8925.1 8989.3 9146.8 10297.3 10:00:08 INFO - PROCESS | 14041 | -------- Summary: end -------- 10:00:08 INFO - PROCESS | 14041 | 10:00:09 INFO - TEST-INFO | 14041: exit 0 10:00:09 INFO - TEST-OK | dromaeo_css | took 1122245ms 10:00:09 INFO - TEST-START | kraken 10:00:09 INFO - operating with platform_type : linux_ 10:00:09 INFO - Initialising browser for kraken test... 10:00:09 INFO - TEST-INFO | started process 14348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmg2Pys/profile http://localhost:57190/getInfo.html) 10:00:13 INFO - PROCESS | 14348 | __metrics Screen width/height:1600/1200 10:00:13 INFO - PROCESS | 14348 | colorDepth:24 10:00:13 INFO - PROCESS | 14348 | Browser inner width/height: 1024/697 10:00:13 INFO - PROCESS | 14348 | __metrics 10:00:13 INFO - PROCESS | 14348 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:00:13 INFO - PROCESS | 14348 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:00:14 INFO - PROCESS | 14348 | console.error: PushService: 10:00:14 INFO - PROCESS | 14348 | stateChangeProcessEnqueue: Error transitioning state 10:00:14 INFO - PROCESS | 14348 | UnknownError 10:00:15 INFO - TEST-INFO | 14348: exit 0 10:00:15 INFO - Browser initialized. 10:00:15 INFO - Running cycle 1/1 for kraken test... 10:00:15 INFO - TEST-INFO | started process 14430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmg2Pys/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:27 INFO - PROCESS | 14430 | RSS: Main: 173232128 10:00:27 INFO - PROCESS | 14430 | 10:00:30 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-beat-detection) 10:00:31 INFO - PROCESS | 14430 | RSS: Main: 238768128 10:00:31 INFO - PROCESS | 14430 | 10:00:34 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-dft) 10:00:34 INFO - PROCESS | 14430 | RSS: Main: 217128960 10:00:34 INFO - PROCESS | 14430 | 10:00:37 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-fft) 10:00:38 INFO - PROCESS | 14430 | RSS: Main: 299610112 10:00:38 INFO - PROCESS | 14430 | 10:00:40 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-oscillator) 10:00:41 INFO - PROCESS | 14430 | RSS: Main: 207994880 10:00:41 INFO - PROCESS | 14430 | 10:00:43 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57190/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:00:44 INFO - PROCESS | 14430 | RSS: Main: 212885504 10:00:44 INFO - PROCESS | 14430 | 10:00:47 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57190/tests/kraken/driver.html?testName=imaging-darkroom) 10:00:47 INFO - PROCESS | 14430 | RSS: Main: 248770560 10:00:47 INFO - PROCESS | 14430 | 10:00:51 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57190/tests/kraken/driver.html?testName=imaging-desaturate) 10:00:52 INFO - PROCESS | 14430 | RSS: Main: 247906304 10:00:52 INFO - PROCESS | 14430 | 10:00:54 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57190/tests/kraken/driver.html?testName=json-parse-financial) 10:00:55 INFO - PROCESS | 14430 | RSS: Main: 248061952 10:00:55 INFO - PROCESS | 14430 | 10:00:57 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57190/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:00:57 INFO - PROCESS | 14430 | RSS: Main: 210710528 10:00:57 INFO - PROCESS | 14430 | 10:00:59 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:01:00 INFO - PROCESS | 14430 | RSS: Main: 217292800 10:01:00 INFO - PROCESS | 14430 | 10:01:02 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:01:03 INFO - PROCESS | 14430 | RSS: Main: 226512896 10:01:03 INFO - PROCESS | 14430 | 10:01:05 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:01:06 INFO - PROCESS | 14430 | RSS: Main: 234688512 10:01:06 INFO - PROCESS | 14430 | 10:01:09 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:01:10 INFO - PROCESS | 14430 | RSS: Main: 231837696 10:01:10 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57190/tests/kraken/driver.html?testName=ai-astar) 10:01:12 INFO - PROCESS | 14430 | RSS: Main: 281702400 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | __start_tp_report 10:01:12 INFO - PROCESS | 14430 | _x_x_mozilla_page_load 10:01:12 INFO - PROCESS | 14430 | _x_x_mozilla_page_load_details 10:01:12 INFO - PROCESS | 14430 | |i|pagename|runs| 10:01:12 INFO - PROCESS | 14430 | |0;ai-astar;106;114;114;114;116;115;114;114;113;114 10:01:12 INFO - PROCESS | 14430 | |1;audio-beat-detection;152;128;126;166;129;128;131;130;169;125 10:01:12 INFO - PROCESS | 14430 | |2;audio-dft;160;162;161;161;161;161;161;160;160;162 10:01:12 INFO - PROCESS | 14430 | |3;audio-fft;76;76;76;120;79;77;76;77;98;75 10:01:12 INFO - PROCESS | 14430 | |4;audio-oscillator;85;83;126;83;83;83;109;83;83;118 10:01:12 INFO - PROCESS | 14430 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;117;117;117 10:01:12 INFO - PROCESS | 14430 | |6;imaging-darkroom;148;146;147;147;146;146;148;147;147;147 10:01:12 INFO - PROCESS | 14430 | |7;imaging-desaturate;85;85;85;85;85;85;85;85;86;85 10:01:12 INFO - PROCESS | 14430 | |8;json-parse-financial;64;63;65;65;65;65;66;67;65;65 10:01:12 INFO - PROCESS | 14430 | |9;json-stringify-tinderbox;67;67;67;67;67;68;67;68;69;68 10:01:12 INFO - PROCESS | 14430 | |10;stanford-crypto-aes;87;91;86;83;83;84;83;84;85;83 10:01:12 INFO - PROCESS | 14430 | |11;stanford-crypto-ccm;141;144;143;142;140;145;137;138;190;153 10:01:12 INFO - PROCESS | 14430 | |12;stanford-crypto-pbkdf2;179;183;177;177;175;175;174;176;175;180 10:01:12 INFO - PROCESS | 14430 | |13;stanford-crypto-sha256-iterative;71;70;69;70;70;70;70;69;69;70 10:01:12 INFO - PROCESS | 14430 | __end_tp_report 10:01:12 INFO - PROCESS | 14430 | __start_cc_report 10:01:12 INFO - PROCESS | 14430 | _x_x_mozilla_cycle_collect,1938 10:01:12 INFO - PROCESS | 14430 | __end_cc_report 10:01:12 INFO - PROCESS | 14430 | __startTimestamp1476982872257__endTimestamp 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | ------- Summary: start ------- 10:01:12 INFO - PROCESS | 14430 | Number of tests: 14 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.72 (2.4%) stddev-sans-first:0.83 10:01:12 INFO - PROCESS | 14430 | Values: 106.0 114.0 114.0 114.0 116.0 115.0 114.0 114.0 113.0 114.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:130.50 stddev:17.15 (13.1%) stddev-sans-first:17.47 10:01:12 INFO - PROCESS | 14430 | Values: 152.0 128.0 126.0 166.0 129.0 128.0 131.0 130.0 169.0 125.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 10:01:12 INFO - PROCESS | 14430 | Values: 160.0 162.0 161.0 161.0 161.0 161.0 161.0 160.0 160.0 162.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:14.69 (19.2%) stddev-sans-first:15.36 10:01:12 INFO - PROCESS | 14430 | Values: 76.0 76.0 76.0 120.0 79.0 77.0 76.0 77.0 98.0 75.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:83.00 stddev:17.10 (20.6%) stddev-sans-first:17.85 10:01:12 INFO - PROCESS | 14430 | Values: 85.0 83.0 126.0 83.0 83.0 83.0 109.0 83.0 83.0 118.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 10:01:12 INFO - PROCESS | 14430 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 10:01:12 INFO - PROCESS | 14430 | Values: 148.0 146.0 147.0 147.0 146.0 146.0 148.0 147.0 147.0 147.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 10:01:12 INFO - PROCESS | 14430 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 86.0 85.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.05 (1.6%) stddev-sans-first:1.05 10:01:12 INFO - PROCESS | 14430 | Values: 64.0 63.0 65.0 65.0 65.0 65.0 66.0 67.0 65.0 65.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 10:01:12 INFO - PROCESS | 14430 | Values: 67.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 69.0 68.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:2.56 (3.0%) stddev-sans-first:2.60 10:01:12 INFO - PROCESS | 14430 | Values: 87.0 91.0 86.0 83.0 83.0 84.0 83.0 84.0 85.0 83.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:143.50 stddev:15.65 (10.9%) stddev-sans-first:16.43 10:01:12 INFO - PROCESS | 14430 | Values: 141.0 144.0 143.0 142.0 140.0 145.0 137.0 138.0 190.0 153.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:177.00 stddev:2.81 (1.6%) stddev-sans-first:2.89 10:01:12 INFO - PROCESS | 14430 | Values: 179.0 183.0 177.0 177.0 175.0 175.0 174.0 176.0 175.0 180.0 10:01:12 INFO - PROCESS | 14430 | 10:01:12 INFO - PROCESS | 14430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 10:01:12 INFO - PROCESS | 14430 | Values: 71.0 70.0 69.0 70.0 70.0 70.0 70.0 69.0 69.0 70.0 10:01:12 INFO - PROCESS | 14430 | -------- Summary: end -------- 10:01:12 INFO - PROCESS | 14430 | 10:01:13 INFO - TEST-INFO | 14430: exit 0 10:01:13 INFO - TEST-OK | kraken | took 64162ms 10:01:13 INFO - SUITE-END | took 1186s 10:01:13 INFO - Completed test suite (00:19:46) 10:01:13 INFO - javascript benchmark 10:01:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2558.923232303031, 2573.1122762646905, 2593.494268617619, 2614.8692565371725, 2615.79073674106, 4496.055828276066, 4611.884702882421, 4657.930131048032, 4675.625949924002, 4695.8356457524, 4645.88385290367, 4655.022445286494, 4659.464161621406, 4665.696729712567, 4666.206744853374, 4212.578742125794, 4248.787560621972, 4250.57494250574, 4293.570642935697, 4326.870193894172, 4321.9783901080455, 4330.718503297291, 4334.77359574414, 4341.6092551670345, 4353.216421044211, 4261.872143835674, 4268.103698223377, 4291.699581029329, 4314.37441570972, 4346.5436129206455, 4345.239583072981, 4348.108637729258, 4349.26062569364, 4376.234159022159, 4379.627731642799, 4201.579842015804, 4232.640225580829, 4253.553376895412, 4259.233337999159, 4267.359896015591, 4664.416947881515, 4675.135100006476, 4679.064187162581, 4690.835820746258, 4759.428868535763, 4988.326575912241, 5035.043341765053, 5049.873753156164, 5053.646244762868, 5093.388793344785, 4814.879628009293, 4854.830080947185, 4855.68438051529, 5098.852758129391, 5121.692698438068, 4547.727136371828, 4576.26779715244, 4583.541645835457, 4589.472210695746, 4636.652251081183, 5049.0, 5053.0399224147295, 5058.570021548209, 5069.188929771219, 5069.467705890902, 4914.361133052752, 4943.678660887031, 4954.554090131834, 5007.0, 5009.423916249605, 4960.851174464772, 5013.924791128136, 5017.272495488134, 5073.061483625467, 5085.898282034413, 4963.106640804617, 4986.401631804207, 5014.2979982802435, 5071.746412679351, 5071.797128114834, 4792.784324705397, 4836.250381190921, 4850.223964165716, 4934.802607895644, 4948.925766113512, 4277.615014648696, 4320.200762858818, 4320.395144679747, 4324.416203812508, 4380.69335146543, 3736.551613806361, 3744.8314825832904, 3745.5318085239346, 3790.3556395412847, 3792.924141517154, 4143.02638879863, 4349.151915376535, 4350.869473915787, 4351.825926962886, 4409.228385032607, 4930.630202734737, 4988.55103040728, 4997.775100120503, 4998.125328067574, 4999.625028122905, 4311.33174357975, 4320.416743739618, 4321.243782338078, 4322.092360604245, 4327.0480494291205, 4065.3698676705158, 4537.954620453753, 4547.454305483363, 4587.0, 4629.398178236875, 4745.217039188633, 4746.098241334135, 4760.78576464053, 4792.736399497921, 4810.759462026955, 5013.097642424399, 5015.322931404214, 5037.420696619935, 5041.218611115283, 5085.77114029877, 4584.908301833878, 4622.930656040229, 4623.468301145412, 4675.181843177498, 4689.601383882272, 4832.057748738962, 4870.707757534559, 4871.805127794849, 4876.366072410564, 4880.219164933594, 4934.259861020875, 4945.4312754033745, 4945.975270123627, 4949.183384741621, 4950.430700469492, 4806.0, 4816.157172494729, 4816.397950256218, 4817.012512434872, 4819.036192761532, 4796.37647105874, 4804.711717296974, 4806.903861922672, 4808.06242782654, 4808.6153107752, 4761.857144285677, 4838.491958344323, 4887.462379138363, 4907.5828554571835, 4967.478414766398, 4987.501249874984, 4988.8752781180765, 4995.275685025578, 5042.495750425075, 5055.368078990126, 4870.805167793249, 4881.145799485147, 4883.413990321184, 4939.950600493949, 4941.160002799605], "value": 4589.171395709383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.4501043966474, 555.7193617223302, 572.6020415811013, 578.9983328841105, 585.7130006296916, 25472.74527254727, 37665.0, 38719.612803871954, 38791.22417551647, 42252.0, 39514.8024259879, 39863.80068099655, 39893.8005309973, 39902.20195596086, 39907.40138897912, 7759.456838021327, 7898.60506974649, 7903.209679032108, 7903.525788452683, 7904.446688731791, 7775.961120194391, 7868.2918537331625, 7870.724524641639, 7871.960640196791, 7872.488288261274, 7832.882506762403, 7901.328387087105, 7902.288794008538, 7913.881291780628, 7919.8416031679335, 7860.371170306362, 7883.36933045355, 7899.328557072656, 7907.920920790776, 7910.644021019068, 7718.151003389623, 7770.728024519115, 7774.300312971804, 7774.572398518079, 7776.183500732398, 37669.43495847564, 37964.0, 38042.80978595117, 38100.0, 38110.80944595259, 2721.249175453626, 2945.175350901751, 2950.867210975511, 3020.894268700607, 3191.888283910052, 28143.155705328874, 28206.717932820615, 28609.99865004715, 29349.706502935125, 29740.405191896258, 3496.5629296337956, 3547.396942519778, 3566.251087271676, 3572.3212589607892, 3632.5822530409077, 243781.0, 244108.0, 244375.0, 245498.0, 245720.0, 49567.76080598014, 49785.75107124441, 49907.50092499029, 49937.0, 49986.0, 31296.687033129834, 31716.841415792773, 32146.517802232986, 34143.65856341405, 52317.0, 12946.352682365845, 13063.281519516519, 13086.803697944539, 13095.345232738326, 13102.672433189247, 9343.299252556086, 9358.812823743487, 9386.530673466299, 9437.433753974783, 9456.8581471278, 17223.449889510004, 17432.0, 17435.215415306342, 17458.214380352914, 17476.650466990588, 6835.872081106661, 6907.378335949788, 6927.93072069283, 7166.355028047396, 7187.820304492325, 766.5975362934392, 783.3615603283306, 931.7810314576069, 977.237754551451, 1020.6529779874878, 26186.607200892002, 27352.726472735416, 27775.861120694266, 28030.43939121247, 28073.0, 700.5691499727631, 874.3966663002635, 879.1516186879564, 879.2482427524375, 898.4339865884582, 14093.577192684235, 14782.09217468569, 14960.0, 14988.250587470582, 14995.475158369405, 347534.0, 348641.0, 349033.0, 350165.0, 350938.0, 45578.0, 45997.310040349425, 46060.3090953636, 46100.0, 46183.0, 977.7604486900755, 1049.8425236214782, 1123.4719681749564, 1147.1224513247373, 1149.9712507187387, 25132.62301065522, 28479.145625631263, 28632.856835715687, 30183.69816301809, 30421.239469013453, 44768.55231447644, 45241.09517809691, 45312.32031519596, 45360.0, 45371.77314113409, 315095.0, 317350.0, 317462.0, 317771.0, 317822.0, 24097.879510602335, 25000.624990625518, 25025.374365641004, 25065.87467062726, 25066.74933250717, 39534.20931581295, 39626.0, 39738.40392394174, 39997.0, 40858.38712419375, 34607.480887787206, 34707.82646086854, 34751.65248347585, 34836.82581587076, 34891.82554087213, 34043.82978085094, 34071.65928340784, 34280.82859585686, 35011.82494087513, 35402.11494712653, 29168.27079323034, 29300.41399171962, 32967.83516082404, 34368.65631343654, 34718.0, 29065.564016540193, 31499.527507086954, 31821.0, 31848.203794905312, 32381.676183238807, 24225.63661545043, 24287.149949751674, 24552.508949821262, 24880.12919547807, 24900.62649060229], "value": 16781.68126175944, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.6604468402296, 354.3533052179771, 361.4036839215295, 367.8712450642275, 384.2526286373004, 12414.255144691313, 13303.20180789152, 13408.530701425452, 16847.157642117876, 16877.746833797504, 12534.874651253485, 12764.744705105892, 14872.24863400269, 14906.850931490682, 14940.327685254162, 4946.975265123679, 5162.819301324435, 5167.844964651066, 5190.4809519047985, 5193.065248255312, 3584.1039740064984, 3804.5814960354337, 5828.650280983134, 6098.14625952367, 6162.106494558287, 5849.941500585003, 6114.724837382329, 6115.143879856823, 6123.663198524079, 6124.050772130305, 6017.578769486137, 6096.329403765582, 6101.2983506896835, 6102.359252278491, 6108.267007959073, 5176.689398636094, 5314.92027619586, 5330.067238233332, 5380.381256155553, 5389.568834493231, 20290.391288261377, 20382.796172038237, 20387.796122038737, 20504.38486845397, 20526.178952841867, 1799.1723807048772, 1801.4505575799376, 1818.9181486833124, 1842.5577861313188, 1868.7383766272733, 12381.319027453486, 13247.337633118306, 13523.39144738489, 13638.113522620997, 13755.518556850462, 1654.7848779658689, 1676.5054308978881, 1723.1125970125395, 1732.3070771691425, 1774.3434929076195, 66967.0, 67133.32866671319, 67511.0, 67627.0, 69227.0, 9306.767330816783, 9506.429614223169, 9517.191038761783, 9596.136347728738, 9687.32188746781, 13001.674958125934, 13041.217526948414, 13054.34728263583, 13124.212547247196, 13125.671858203621, 6602.537822352485, 6690.832729181712, 6862.705901167467, 6879.484038697117, 6882.105326307648, 6260.46786023184, 6325.272593651789, 6407.359264073555, 6457.0, 6524.151860258231, 5890.676012819336, 6108.602940808833, 6169.413905678954, 6178.845528861724, 6333.113364129025, 1685.2500637216567, 1722.336900293371, 1740.6518696260798, 1745.2408202431982, 1783.9821601784076, 840.5083026429485, 847.525385783963, 887.964481420736, 900.1988230474883, 922.3405265235255, 16701.0, 16726.6654666906, 17357.913210433868, 17414.0, 17872.55318617045, 850.6809946270149, 850.7107583421666, 851.0638297872415, 863.0, 922.9307801914749, 9373.578188981512, 10072.59709611622, 10127.493625318704, 10176.333967962775, 10262.640807571699, 328654.0, 335043.0, 336848.0, 337014.0, 337156.0, 65173.0, 65582.01626975599, 65656.67171664111, 67625.3237467619, 68639.65680171567, 923.9399439036441, 927.2628260532892, 929.7210836748948, 934.3039435620507, 955.044955044955, 15089.849101508844, 15333.310001049756, 15467.381304747683, 15830.28763705659, 16080.758788617946, 34625.0, 34644.0, 35385.46921796124, 35721.82139089288, 36074.4588831173, 42788.358174628025, 45455.54544454513, 45811.0, 45826.77086614545, 46065.0, 7136.85726285461, 7463.776086717407, 7650.655720492702, 7783.104942931635, 7890.921090789018, 11553.364564949008, 11639.6508104757, 11739.47172377228, 11983.940080299542, 12072.698182545506, 9161.633534658538, 9813.411195328303, 9922.503874806374, 10626.096781773636, 10801.081908037904, 9812.705618831447, 9917.900820991697, 9950.950245249018, 10017.39895606266, 10021.5490302938, 8960.163166550972, 9972.451515166735, 10125.544350504098, 10479.161667066464, 10646.73383165427, 7651.464397492122, 7741.0, 7767.92232077672, 7817.960910195413, 7871.48835325702, 8495.405321627426, 10072.093511583993, 10232.64185753495, 10375.325603836029, 10673.46632668379], "value": 8135.753581422436, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1172.9824052639217, 1355.5391167003218, 1372.2795532345517, 1449.420231907237, 1700.4303558307975, 6542.803715888525, 7349.338559529641, 7641.08307003159, 7647.158812530617, 7875.92124078759, 7790.727324543642, 7857.1357150713375, 7859.882101768478, 7860.724874629374, 7863.56750378729, 2129.925452609155, 2153.1710291537715, 2156.223759446598, 2158.147531724968, 2161.5676864627058, 2127.7872212778752, 2150.419386765572, 2157.0, 2158.730158730151, 2174.0325555127974, 2076.4289820299464, 2095.434232757155, 2102.5899949509853, 2114.0909408954144, 2121.4802373418456, 2019.1822311963679, 2020.777714451409, 2020.959580808383, 2037.6128535578341, 2039.1129858511595, 1964.0768838645813, 2064.1021155797125, 2066.214838361413, 2071.6271071207175, 2071.927482538104, 7666.501677390952, 7697.615119244016, 7754.069511658637, 7760.301572858413, 7762.029746281715, 4106.322456794625, 4236.957630423687, 4240.724352917051, 4295.699301048928, 4309.913801723979, 2880.9711902880913, 3046.558249053875, 3091.119031076155, 3093.8453077346044, 3103.3482968576627, 891.6032365597312, 897.3135551303258, 907.5099446298991, 932.4079209701821, 937.3438592984937, 10653.147748180127, 10771.299865508718, 10774.19193560486, 10811.837822432592, 10818.837717434244, 3828.8659896903473, 4119.299719047769, 4152.4601801765575, 4219.599138081939, 4220.910649228652, 8441.607134822809, 8445.1977062179, 8446.66213351459, 8453.619587118472, 8458.87311690325, 4482.260427029503, 4501.729896206238, 4508.098380323949, 4508.932366014513, 4513.142502924434, 3575.8212089395424, 3702.0, 3848.826802793881, 4168.520620128664, 4168.624823765815, 3305.4215512285255, 3324.8337583120747, 3412.9829350853583, 3417.384870723244, 3433.9484907726405, 1050.7163065972145, 1061.7717190804015, 1071.3678929431674, 1076.962306319275, 1086.6794295682635, 772.5094564951296, 780.473180603102, 795.1333046978821, 796.7131832540281, 811.9878201826978, 4567.862964111082, 4717.339572459859, 4744.59670927975, 4844.563989240914, 5046.091703493406, 812.4637739092288, 828.5939889454245, 859.5788063848669, 887.4187407248263, 918.2608000559613, 3174.555562221291, 3200.567923330321, 3247.9837600812316, 3253.7234335081785, 3404.4042292598697, 8984.46093234408, 9326.487043212554, 9327.300452466092, 9377.29670274732, 9377.624895004123, 9339.626414943463, 9420.95289523548, 9424.0, 9432.90567094334, 9437.056294370508, 6455.903161452582, 6581.243157037002, 6591.110200122922, 6676.26561078281, 6694.83262918431, 4766.499517550746, 4774.522547745198, 4802.087603355351, 4816.277558366133, 4954.380702412199, 8591.226789588967, 8630.223279904838, 8670.089640587648, 8793.912060879566, 8800.38397312182, 8238.464499807493, 8447.535385553607, 8540.44487108336, 8823.029466758522, 8875.822483550422, 5831.183634291117, 6033.54748393881, 6591.5056370773345, 6754.696038678369, 6782.660866956534, 7009.579425234502, 7355.0, 7366.558006519626, 7480.962595186989, 7488.5506869588, 6547.508936829661, 6634.104395906684, 6656.36764507371, 6830.863382732218, 6921.688524016331, 6386.201724784402, 6492.513061520499, 6493.253275873335, 6510.088587597835, 6599.505037122139, 5878.441548052928, 5966.075258334965, 5966.313873904556, 5972.074328479092, 5976.521878249642, 4097.815598298143, 4177.97911010443, 4253.638440732572, 4334.566543345641, 4360.215161271001, 4235.63997060241, 4340.262155433521, 4352.608265256142, 4409.559044095693, 4467.262901621196], "value": 3968.943691011361, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.3428621317569, 296.1234745154343, 304.7942638718864, 308.6358097445014, 310.04815217282936, 4753.144434001878, 4764.498638214939, 4790.329353890458, 4800.759962001899, 4865.148598995175, 4763.14263432582, 4763.261694437368, 4772.475027746945, 4784.44978827435, 4798.344571122966, 3837.6929845612353, 3847.6344747249104, 3852.229554089179, 3866.4007078902673, 3874.302625527404, 3724.385476396405, 3807.9809600951958, 3846.788426636534, 3848.3073046851555, 3851.4607954886337, 3744.6255374462608, 3751.5181503306176, 3764.849406023756, 3769.9434508482395, 3769.9434508482395, 3735.4210097434943, 3755.868544600926, 3758.455024021529, 3765.1008723283057, 3778.6019172905926, 3141.15188898996, 3222.9677703223138, 3230.709236168733, 3310.5034244863223, 3357.8321083945707, 4604.654650901196, 4613.607843333287, 4675.742834144121, 4681.976590117028, 4683.976580117078, 4318.568143185687, 4329.177456283296, 4342.826286948518, 4346.326319420463, 4349.456317960255, 4659.5573420525, 4756.143894099061, 4970.080535100982, 5025.748712564357, 5030.547250747413, 3607.8376473058775, 3612.349777040132, 3614.1326081740194, 3615.4757560153894, 3623.691986181178, 5245.220033382314, 5245.763940622681, 5262.0, 5265.0, 5274.156135018456, 3416.419208734521, 3598.568171819346, 3619.7647152934974, 3729.4965179700935, 3738.700903927679, 3647.635236476331, 3650.525431693916, 3662.285854258447, 3664.688501477351, 3681.134933290728, 4194.895127621834, 4232.788360581959, 4237.0, 4240.427542281815, 4240.91518169641, 4899.755012249373, 4976.2038073908, 4982.725950072709, 4989.800407983713, 5025.6482046256415, 1257.6792917805901, 1270.2378572856212, 1276.789329760579, 1286.7748144074749, 1286.7941129419435, 786.8544319300947, 815.176671561727, 829.5064436660177, 835.5154010673795, 837.7403005068327, 3971.590085519657, 3971.72197946141, 3990.5610382857863, 3990.6009399059863, 4010.498687664042, 4541.568550987651, 4570.588647021784, 4588.88527786808, 4590.94408286096, 4612.379282263407, 3960.544537378181, 3962.32640451124, 3964.691651754914, 3999.0202400411504, 4024.2957482440456, 2334.743178250391, 2408.9764597737985, 2424.8908799104083, 2440.999190331991, 2446.3272600035134, 4648.163330600524, 4714.22215334466, 4806.855794326176, 4827.372441582572, 4889.682170658896, 5287.656302340336, 5299.198272587339, 5310.8937821244135, 5313.760880760375, 5324.866878328073, 4704.6236301096515, 4906.705597664151, 4920.72935988524, 4951.282064100686, 4954.727489988013, 5111.3355263815465, 5132.563732082815, 5134.897302053863, 5140.511651393112, 5144.30551875492, 5027.84916452507, 5043.218301163325, 5072.9746351268, 5080.288759573737, 5089.821856235014, 4698.788554515123, 4832.323474713613, 4849.175640141114, 4875.80496780139, 4880.804767809248, 3605.7836529808296, 3619.9276014480088, 3645.76302540334, 3663.5603727551797, 3668.8899333020054, 5131.512506311894, 5134.204198349262, 5151.0, 5209.661372010807, 5246.790128394974, 4807.18277892766, 5055.483354993561, 5074.238864170404, 5081.314022606901, 5098.617603679665, 5032.220005899091, 5038.193888977746, 5047.167217409086, 5047.498226932661, 5060.240963855451, 4976.900461990812, 4994.80020799164, 4996.3504744383, 5044.722540260321, 5055.140626093499, 4960.950390496048, 5052.791477411796, 5098.898022039612, 5118.641695081308, 5127.512886275797, 4923.138450771173, 4930.161872481615, 4933.58064564516, 4934.654574179916, 4937.777799998937], "value": 3740.1870136064886, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.6592576017503, 659.3439527669967, 662.6885363878978, 703.9788806335812, 723.3489859126788, 12939.741205175902, 14340.0, 14356.497522586698, 14357.856421435783, 14412.927935360321, 13336.466541338335, 13377.799333010013, 13429.0, 13481.662958426019, 13485.3257337133, 594.925634295713, 611.5994023914321, 748.3825843678959, 755.928186822251, 768.0476209500235, 755.9433042521805, 767.6430459836175, 768.6733138416179, 768.7655265144128, 768.9577073260969, 829.3613917283687, 831.2809419851845, 831.3141658132035, 831.3889291370867, 831.5343407691712, 633.8478765096366, 649.7530938243484, 650.151552224347, 653.0335104045992, 829.1873963515758, 480.219643079995, 590.2385922160408, 596.7434003378589, 607.5230943709167, 608.3277977834473, 12903.161294515827, 12913.741725165444, 12930.741385172338, 12983.415746291439, 13023.674408139777, 12220.327881966488, 12567.371631418393, 12673.93663031688, 12930.224186548743, 13356.265405402699, 11607.709807254887, 11835.644930652094, 11881.0, 11923.523059077626, 12484.937575312157, 4006.759594424344, 4041.5150181978056, 4097.282975479279, 4138.461999940018, 4228.513720922103, 61113.694431528005, 61636.38363616351, 62599.68700156516, 63345.683271583344, 63439.0, 9855.507224638739, 10163.0, 10243.630684135587, 10362.378257304586, 10411.271211015308, 18840.52898677544, 19060.0, 19065.714014289795, 19114.13986370617, 19125.13936872844, 6557.573757705733, 6576.473882089422, 6620.801375958729, 6678.799636010927, 7032.824179395454, 3624.7643903146213, 3674.2829941687473, 3714.9442758358105, 3722.0, 3766.642168993941, 2737.904173353963, 2832.178668186203, 2833.546632538825, 3125.4217969675683, 3279.0, 566.4194200943983, 570.3213176320165, 583.7606581301646, 583.8423625621059, 591.2432086928738, 457.3848174205688, 465.32810581758764, 515.5746509129983, 529.8251576979587, 561.9129034999581, 7971.108602483616, 8971.551422428853, 9102.681406150752, 9132.863007054899, 9195.218406435393, 521.0386836287045, 555.8610347413147, 630.2437075509407, 643.7585905285518, 645.5932762359777, 3880.2821478026653, 4155.854545090907, 4220.198162349144, 4365.301551751768, 4473.642108631302, 72936.63531682413, 76267.0, 76339.61830190924, 85603.15952607158, 88721.0, 73110.0, 73583.0, 77000.06498992666, 78113.0, 79583.60208198921, 64313.35686643167, 67578.66210668915, 68849.0, 70882.64558677276, 70951.0, 7830.491018083806, 8128.309093727099, 8225.917740822515, 8247.463914845515, 8314.470876867057, 41567.58432415637, 41954.0, 42405.787971059945, 42995.0, 43818.780906095264, 54213.45786542084, 60034.0, 60089.69955150371, 62819.685901572026, 63416.0, 10682.786344272916, 10786.191035672513, 10807.783844323227, 11233.438328083726, 11319.830202547133, 12513.624591262276, 12690.746185076063, 13263.734725305247, 13705.383257753225, 14142.080764750259, 11457.65627031157, 11646.88353116458, 11861.703457413634, 11909.642710718346, 11928.76142477163, 10462.424566648908, 10996.890031099587, 11149.10807135411, 11339.829902551633, 11367.602133925604, 11610.88389116098, 11848.644540663794, 12556.497740090294, 12819.294938778457, 12972.870271297166, 9801.803963920824, 10084.14284785772, 10184.643537476153, 10197.9490102549, 10249.0, 8858.778530536789, 8925.072663911347, 8989.325800565115, 9146.771330716785, 10297.330673506198], "value": 6516.523703905896, "unit": "score"}], "name": "dromaeo_css", "value": 6267.586640822952, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 114.0, 114.0, 116.0, 115.0, 114.0, 114.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 126.0, 166.0, 129.0, 128.0, 131.0, 130.0, 169.0, 125.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 120.0, 79.0, 77.0, 76.0, 77.0, 98.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 126.0, 83.0, 83.0, 83.0, 109.0, 83.0, 83.0, 118.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 65.0, 65.0, 65.0, 66.0, 67.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0], "value": 67.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 86.0, 83.0, 83.0, 84.0, 83.0, 84.0, 85.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 143.0, 142.0, 140.0, 145.0, 137.0, 138.0, 190.0, 153.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 183.0, 177.0, 177.0, 175.0, 175.0, 174.0, 176.0, 175.0, 180.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 69.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 70.0], "value": 69.8, "unit": "score"}], "name": "kraken", "value": 1549.9, "alertThreshold": 2.0}]} 10:01:13 INFO - Return code: 0 10:01:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:01:14 INFO - # TBPL SUCCESS # 10:01:14 INFO - Running post-action listener: _resource_record_post_action 10:01:14 INFO - [mozharness: 2016-10-20 17:01:14.045344Z] Finished run-tests step (success) 10:01:14 INFO - Running post-run listener: _resource_record_post_run 10:01:14 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399233024; Read time: 16; Write time: 254896 10:01:14 INFO - TinderboxPrint: CPU usage
13.0% 10:01:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:01:14 INFO - TinderboxPrint: I/O write bytes / time
399,233,024 / 254,896 10:01:14 INFO - TinderboxPrint: CPU idle
8,345.3 (86.9%) 10:01:14 INFO - TinderboxPrint: CPU user
1,206.2 (12.6%) 10:01:14 INFO - TinderboxPrint: Swap in / out
0 / 0 10:01:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107761664; Read time: 0; Write time: 74680 10:01:14 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291471360; Read time: 0; Write time: 180216 10:01:14 INFO - Running post-run listener: _upload_blobber_files 10:01:14 INFO - Blob upload gear active. 10:01:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:01:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:01:15 INFO - (blobuploader) - INFO - Open directory for files ... 10:01:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:01:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:01:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:15 INFO - (blobuploader) - INFO - Done attempting. 10:01:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:01:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:01:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:16 INFO - (blobuploader) - INFO - Done attempting. 10:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:01:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:01:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:01:19 INFO - (blobuploader) - INFO - Done attempting. 10:01:19 INFO - (blobuploader) - INFO - Iteration through files over. 10:01:19 INFO - Return code: 0 10:01:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:01:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:01:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd4318ebd8dbb445e289811fd94851b3889aebaa6b741aba524ab243480b508973c63bae48070358dbe205e4a421d57488915c6bd9aad8bdc76693c80aa6fb7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2abc6dc29901a81f7110b8d440db0f2bfccd1192de30219699436eee29a207eb54c0c3bfd7f45473bea15eb5140a6b9c483d7c2f5a9a7c18214bed6069244ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1697e074fb5129b105b44d0111c7fc7554bead09888b28570a3421e5e9c2f12cdc5288bc613ef4fee7ce68491031053bf6cf4692efbf847c92c5148de7cc4617"} 10:01:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:01:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:01:19 INFO - Contents: 10:01:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd4318ebd8dbb445e289811fd94851b3889aebaa6b741aba524ab243480b508973c63bae48070358dbe205e4a421d57488915c6bd9aad8bdc76693c80aa6fb7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2abc6dc29901a81f7110b8d440db0f2bfccd1192de30219699436eee29a207eb54c0c3bfd7f45473bea15eb5140a6b9c483d7c2f5a9a7c18214bed6069244ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1697e074fb5129b105b44d0111c7fc7554bead09888b28570a3421e5e9c2f12cdc5288bc613ef4fee7ce68491031053bf6cf4692efbf847c92c5148de7cc4617"} 10:01:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:01:19 INFO - Copying logs to upload dir... 10:01:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:01:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.708813 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-20 10:01:19.521911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 10:01:19.525180) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627 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/bd4318ebd8dbb445e289811fd94851b3889aebaa6b741aba524ab243480b508973c63bae48070358dbe205e4a421d57488915c6bd9aad8bdc76693c80aa6fb7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2abc6dc29901a81f7110b8d440db0f2bfccd1192de30219699436eee29a207eb54c0c3bfd7f45473bea15eb5140a6b9c483d7c2f5a9a7c18214bed6069244ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1697e074fb5129b105b44d0111c7fc7554bead09888b28570a3421e5e9c2f12cdc5288bc613ef4fee7ce68491031053bf6cf4692efbf847c92c5148de7cc4617"} build_url:https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/HDDl2XfrSx6E1TOmHPoWGQ/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/bd4318ebd8dbb445e289811fd94851b3889aebaa6b741aba524ab243480b508973c63bae48070358dbe205e4a421d57488915c6bd9aad8bdc76693c80aa6fb7c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b2abc6dc29901a81f7110b8d440db0f2bfccd1192de30219699436eee29a207eb54c0c3bfd7f45473bea15eb5140a6b9c483d7c2f5a9a7c18214bed6069244ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1697e074fb5129b105b44d0111c7fc7554bead09888b28570a3421e5e9c2f12cdc5288bc613ef4fee7ce68491031053bf6cf4692efbf847c92c5148de7cc4617"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 10:01:19.551371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 10:01:19.551764) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476981632.18935-676117627 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 10:01:19.636885) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 10:01:19.637259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 10:01:19.637588) ========= ========= Total master_lag: 0.17 =========