builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1477005674.42 results: success (0) buildid: 20161020133011 builduid: 7244656da3d04d92a484e6958b57bafe revision: f0f1aaf051d6798e1e73d1feee07ca847333167a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:14.421790) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:14.422861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:14.423811) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:14.436286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:14.436938) ========= 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=cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 16:21:14-- 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% 224M=0s 2016-10-20 16:21:14 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118915 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:14.569202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:14.569568) ========= 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=cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018517 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:14.619861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:14.620510) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0f1aaf051d6798e1e73d1feee07ca847333167a --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 f0f1aaf051d6798e1e73d1feee07ca847333167a --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=cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 16:21:14,974 truncating revision to first 12 chars 2016-10-20 16:21:14,974 Setting DEBUG logging. 2016-10-20 16:21:14,975 attempt 1/10 2016-10-20 16:21:14,975 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0f1aaf051d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 16:21:15,562 unpacking tar archive at: mozilla-central-f0f1aaf051d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.902595 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:15.541430) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:15.542326) ========= script_repo_revision: f0f1aaf051d6798e1e73d1feee07ca847333167a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:15.543356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:15.544112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 16:21:15.558153) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-20 16:21:15.558907) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:21:16 INFO - MultiFileLogger online at 20161020 16:21:16 in /builds/slave/test 16:21:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:21:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:21:16 INFO - {'append_to_log': False, 16:21:16 INFO - 'base_work_dir': '/builds/slave/test', 16:21:16 INFO - 'blob_upload_branch': 'Firefox', 16:21:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:21:16 INFO - 'branch': 'Firefox', 16:21:16 INFO - 'buildbot_json_path': 'buildprops.json', 16:21:16 INFO - 'config_files': ('talos/linux_config.py',), 16:21:16 INFO - 'default_actions': ('clobber', 16:21:16 INFO - 'read-buildbot-config', 16:21:16 INFO - 'download-and-extract', 16:21:16 INFO - 'populate-webroot', 16:21:16 INFO - 'create-virtualenv', 16:21:16 INFO - 'install', 16:21:16 INFO - 'run-tests'), 16:21:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:21:16 INFO - 'download_minidump_stackwalk': True, 16:21:16 INFO - 'download_symbols': 'ondemand', 16:21:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:21:16 INFO - 'tooltool.py': '/tools/tooltool.py', 16:21:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:21:16 INFO - '/tools/misc-python/virtualenv.py')}, 16:21:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:21:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:21:16 INFO - 'installer_path': 'installer.exe', 16:21:16 INFO - 'log_level': 'info', 16:21:16 INFO - 'log_name': 'talos', 16:21:16 INFO - 'log_to_console': True, 16:21:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:21:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:21:16 INFO - 'opt_config_files': (), 16:21:16 INFO - 'pip_index': False, 16:21:16 INFO - 'sps_profile': False, 16:21:16 INFO - 'sps_profile_interval': 0, 16:21:16 INFO - 'suite': 'dromaeojs', 16:21:16 INFO - 'system_bits': '32', 16:21:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:21:16 INFO - 'title': 'talos-linux64-ix-054', 16:21:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:21:16 INFO - 'use_talos_json': True, 16:21:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:21:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:21:16 INFO - 'work_dir': 'build'} 16:21:16 INFO - [mozharness: 2016-10-20 23:21:16.017736Z] Running clobber step. 16:21:16 INFO - Running pre-action listener: _resource_record_pre_action 16:21:16 INFO - Running main action method: clobber 16:21:16 INFO - rmtree: /builds/slave/test/build 16:21:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:21:16 INFO - Running post-action listener: _resource_record_post_action 16:21:16 INFO - [mozharness: 2016-10-20 23:21:16.484957Z] Finished clobber step (success) 16:21:16 INFO - [mozharness: 2016-10-20 23:21:16.485057Z] Running read-buildbot-config step. 16:21:16 INFO - Running pre-action listener: _resource_record_pre_action 16:21:16 INFO - Running main action method: read_buildbot_config 16:21:16 INFO - Using buildbot properties: 16:21:16 INFO - { 16:21:16 INFO - "project": "", 16:21:16 INFO - "product": "firefox", 16:21:16 INFO - "script_repo_revision": "production", 16:21:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:21:16 INFO - "repository": "", 16:21:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:21:16 INFO - "buildid": "20161020133011", 16:21:16 INFO - "pgo_build": "True", 16:21:16 INFO - "basedir": "/builds/slave/test", 16:21:16 INFO - "buildnumber": 21, 16:21:16 INFO - "slavename": "talos-linux64-ix-054", 16:21:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:21:16 INFO - "platform": "ubuntu64_hw", 16:21:16 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 16:21:16 INFO - "branch": "mozilla-central", 16:21:16 INFO - "repo_path": "mozilla-central", 16:21:16 INFO - "revision": "f0f1aaf051d6798e1e73d1feee07ca847333167a", 16:21:16 INFO - "stage_platform": "linux64-pgo", 16:21:16 INFO - "builduid": "7244656da3d04d92a484e6958b57bafe", 16:21:16 INFO - "slavebuilddir": "test" 16:21:16 INFO - } 16:21:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:21:16 INFO - Running post-action listener: _resource_record_post_action 16:21:16 INFO - [mozharness: 2016-10-20 23:21:16.487506Z] Finished read-buildbot-config step (success) 16:21:16 INFO - [mozharness: 2016-10-20 23:21:16.487595Z] Running download-and-extract step. 16:21:16 INFO - Running pre-action listener: _resource_record_pre_action 16:21:16 INFO - Running main action method: download_and_extract 16:21:16 INFO - mkdir: /builds/slave/test/build/tests 16:21:16 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')]} 16:21:16 INFO - trying https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:21:16 INFO - Downloading https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/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 16:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/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 16:21:17 INFO - Downloaded 1361 bytes. 16:21:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:21:17 INFO - Using the following test package requirements: 16:21:17 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:21:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:21:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:21:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:17 INFO - u'jsshell-linux-x86_64.zip'], 16:21:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:21:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:21:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:21:17 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:21:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:21:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:21:17 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:21:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:21:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:21:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:21:17 INFO - Fetch https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:21:17 INFO - Http code: 200 16:21:17 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 16:21:17 INFO - x-amz-cf-id: tj13mmv52NWkg9P1ICx63czFsj2_nBFkUWhfzX_QIc_T4WwCTLcDDA== 16:21:17 INFO - x-amz-version-id: AJswPfplR5tVzpotJpnjf4Vv5OBIDHkE 16:21:17 INFO - Expected file size: 22118123 16:21:17 INFO - Obtained file size: 22118123 16:21:21 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 16:21:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:21:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:21:21 INFO - Fetch https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:21:22 INFO - Http code: 200 16:21:22 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 16:21:22 INFO - x-amz-cf-id: IfAKjyMglzeWu9AX7R_seDbsZhC5cUMOXVNN5MgjoAt2XoPa9orelA== 16:21:22 INFO - x-amz-version-id: AJswPfplR5tVzpotJpnjf4Vv5OBIDHkE 16:21:22 INFO - Expected file size: 22118123 16:21:22 INFO - Obtained file size: 22118123 16:21:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:21:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:21:27 INFO - Fetch https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:21:27 INFO - Http code: 200 16:21:27 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 16:21:27 INFO - x-amz-cf-id: BirG43BNyVT5NxoFeSyjkipESR8iqlQnGbNetnBOhUwdyK6XHUKTqQ== 16:21:27 INFO - x-amz-version-id: j5OoHEKoB9d072ZqnYD3GDRVIKkZJ3qg 16:21:27 INFO - Expected file size: 14409028 16:21:27 INFO - Obtained file size: 14409028 16:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:28 INFO - trying https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:21:28 INFO - Downloading https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/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 16:21:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/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 16:21:29 INFO - Downloaded 59481712 bytes. 16:21:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:21:29 INFO - mkdir: /builds/slave/test/properties 16:21:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:21:29 INFO - Writing to file /builds/slave/test/properties/build_url 16:21:29 INFO - Contents: 16:21:29 INFO - build_url:https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:21:30 INFO - Running post-action listener: _resource_record_post_action 16:21:30 INFO - Running post-action listener: set_extra_try_arguments 16:21:30 INFO - [mozharness: 2016-10-20 23:21:30.262983Z] Finished download-and-extract step (success) 16:21:30 INFO - [mozharness: 2016-10-20 23:21:30.263208Z] Running populate-webroot step. 16:21:30 INFO - Running pre-action listener: _resource_record_pre_action 16:21:30 INFO - Running main action method: populate_webroot 16:21:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:21:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:21:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:21:30 INFO - '--tppagecycles', 16:21:30 INFO - '7'], 16:21:30 INFO - 'tests': ['tsvgm']}}, 16:21:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:21:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:21:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:21:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:21:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:30 INFO - 'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:21:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:30 INFO - 'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['damp', 'tps']}, 16:21:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:30 INFO - 'tests': ['damp', 'tps']}, 16:21:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['dromaeo_dom']}, 16:21:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:21:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['basic_compositor_video']}, 16:21:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:21:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['a11yr', 16:21:30 INFO - 'ts_paint', 16:21:30 INFO - 'tpaint', 16:21:30 INFO - 'sessionrestore', 16:21:30 INFO - 'sessionrestore_no_auto_restore', 16:21:30 INFO - 'tabpaint']}, 16:21:30 INFO - 'other-e10s': {'tests': ['a11yr', 16:21:30 INFO - 'ts_paint', 16:21:30 INFO - 'tpaint', 16:21:30 INFO - 'sessionrestore', 16:21:30 INFO - 'sessionrestore_no_auto_restore', 16:21:30 INFO - 'tabpaint']}, 16:21:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:21:30 INFO - 'ts_paint', 16:21:30 INFO - 'tpaint', 16:21:30 INFO - 'sessionrestore', 16:21:30 INFO - 'sessionrestore_no_auto_restore', 16:21:30 INFO - 'tabpaint']}, 16:21:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:21:30 INFO - 'ts_paint', 16:21:30 INFO - 'tpaint', 16:21:30 INFO - 'sessionrestore', 16:21:30 INFO - 'sessionrestore_no_auto_restore', 16:21:30 INFO - 'tabpaint']}, 16:21:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['a11yr', 16:21:30 INFO - 'ts_paint', 16:21:30 INFO - 'tpaint', 16:21:30 INFO - 'sessionrestore', 16:21:30 INFO - 'sessionrestore_no_auto_restore', 16:21:30 INFO - 'tabpaint']}, 16:21:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['a11yr', 16:21:30 INFO - 'ts_paint', 16:21:30 INFO - 'tpaint', 16:21:30 INFO - 'sessionrestore', 16:21:30 INFO - 'sessionrestore_no_auto_restore', 16:21:30 INFO - 'tabpaint']}, 16:21:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['tsvgx', 16:21:30 INFO - 'tsvgr_opacity', 16:21:30 INFO - 'tart', 16:21:30 INFO - 'tscrollx', 16:21:30 INFO - 'cart']}, 16:21:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:21:30 INFO - 'tsvgr_opacity', 16:21:30 INFO - 'tart', 16:21:30 INFO - 'tscrollx', 16:21:30 INFO - 'cart']}, 16:21:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:30 INFO - 'talos_options': ['--disable-e10s'], 16:21:30 INFO - 'tests': ['tp5o']}, 16:21:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:30 INFO - 'tests': ['tp5o']}, 16:21:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:30 INFO - 'talos_options': ['--disable-e10s', 16:21:30 INFO - '--xperf_path', 16:21:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:30 INFO - 'tests': ['tp5n']}, 16:21:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:21:30 INFO - 'talos_options': ['--xperf_path', 16:21:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:21:30 INFO - 'tests': ['tp5n']}}, 16:21:30 INFO - 'talos.zip': {'path': '', 16:21:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:21:30 INFO - Running post-action listener: _resource_record_post_action 16:21:30 INFO - [mozharness: 2016-10-20 23:21:30.283298Z] Finished populate-webroot step (success) 16:21:30 INFO - [mozharness: 2016-10-20 23:21:30.283385Z] Running create-virtualenv step. 16:21:30 INFO - Running pre-action listener: _resource_record_pre_action 16:21:30 INFO - Running main action method: create_virtualenv 16:21:30 INFO - Creating virtualenv /builds/slave/test/build/venv 16:21:30 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 16:21:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:21:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:21:30 INFO - Using real prefix '/usr' 16:21:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:21:30 INFO - Installing distribute.............................................................................................................................................................................................done. 16:21:32 INFO - Installing pip.................done. 16:21:32 INFO - Return code: 0 16:21:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:21:33 INFO - Reading from file tmpfile_stdout 16:21:33 INFO - Output received: 16:21:33 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) 16:21:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:33 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 0x7f364ab58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cd790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', '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 16:21:33 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 16:21:33 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 16:21:33 INFO - Using env: {'DISPLAY': ':0', 16:21:33 INFO - 'HOME': '/home/cltbld', 16:21:33 INFO - 'LANG': 'en_US.UTF-8', 16:21:33 INFO - 'LANGUAGE': 'en_US:en', 16:21:33 INFO - 'LOGNAME': 'cltbld', 16:21:33 INFO - 'MAIL': '/var/mail/cltbld', 16:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:33 INFO - 'MOZ_NO_REMOTE': '1', 16:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:33 INFO - 'NO_EM_RESTART': '1', 16:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:33 INFO - 'PWD': '/builds/slave/test', 16:21:33 INFO - 'SHELL': '/bin/bash', 16:21:33 INFO - 'SHLVL': '1', 16:21:33 INFO - 'TERM': 'linux', 16:21:33 INFO - 'TMOUT': '86400', 16:21:33 INFO - 'USER': 'cltbld', 16:21:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:33 INFO - '_': '/tools/buildbot/bin/python'} 16:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:33 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 16:21:33 INFO - Cleaning up... 16:21:33 INFO - Return code: 0 16:21:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:33 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 0x7f364ab58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cd790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', '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 16:21:33 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 16:21:33 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 16:21:33 INFO - Using env: {'DISPLAY': ':0', 16:21:33 INFO - 'HOME': '/home/cltbld', 16:21:33 INFO - 'LANG': 'en_US.UTF-8', 16:21:33 INFO - 'LANGUAGE': 'en_US:en', 16:21:33 INFO - 'LOGNAME': 'cltbld', 16:21:33 INFO - 'MAIL': '/var/mail/cltbld', 16:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:33 INFO - 'MOZ_NO_REMOTE': '1', 16:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:33 INFO - 'NO_EM_RESTART': '1', 16:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:33 INFO - 'PWD': '/builds/slave/test', 16:21:33 INFO - 'SHELL': '/bin/bash', 16:21:33 INFO - 'SHLVL': '1', 16:21:33 INFO - 'TERM': 'linux', 16:21:33 INFO - 'TMOUT': '86400', 16:21:33 INFO - 'USER': 'cltbld', 16:21:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:33 INFO - '_': '/tools/buildbot/bin/python'} 16:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:33 INFO - Downloading/unpacking psutil>=3.1.1 16:21:33 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 16:21:33 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 16:21:33 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 16:21:33 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 16:21:33 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 16:21:33 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 16:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:21:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:35 INFO - Installing collected packages: psutil 16:21:35 INFO - Running setup.py install for psutil 16:21:35 INFO - building 'psutil._psutil_linux' extension 16:21:35 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 16:21:35 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 16:21:35 INFO - building 'psutil._psutil_posix' extension 16:21:35 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 16:21:36 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 16:21:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:21:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:21:36 INFO - Successfully installed psutil 16:21:36 INFO - Cleaning up... 16:21:36 INFO - Return code: 0 16:21:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f364ab58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cd790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', '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 16:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:21:36 INFO - Using env: {'DISPLAY': ':0', 16:21:36 INFO - 'HOME': '/home/cltbld', 16:21:36 INFO - 'LANG': 'en_US.UTF-8', 16:21:36 INFO - 'LANGUAGE': 'en_US:en', 16:21:36 INFO - 'LOGNAME': 'cltbld', 16:21:36 INFO - 'MAIL': '/var/mail/cltbld', 16:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:36 INFO - 'MOZ_NO_REMOTE': '1', 16:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:36 INFO - 'NO_EM_RESTART': '1', 16:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:36 INFO - 'PWD': '/builds/slave/test', 16:21:36 INFO - 'SHELL': '/bin/bash', 16:21:36 INFO - 'SHLVL': '1', 16:21:36 INFO - 'TERM': 'linux', 16:21:36 INFO - 'TMOUT': '86400', 16:21:36 INFO - 'USER': 'cltbld', 16:21:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:36 INFO - '_': '/tools/buildbot/bin/python'} 16:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:21:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:21:38 INFO - Installing collected packages: mozsystemmonitor 16:21:38 INFO - Running setup.py install for mozsystemmonitor 16:21:38 INFO - Successfully installed mozsystemmonitor 16:21:38 INFO - Cleaning up... 16:21:38 INFO - Return code: 0 16:21:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:21:38 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')]} 16:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:38 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')]} 16:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:38 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 0x7f364ab58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cd790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', '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 16:21:38 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 16:21:38 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 16:21:38 INFO - Using env: {'DISPLAY': ':0', 16:21:38 INFO - 'HOME': '/home/cltbld', 16:21:38 INFO - 'LANG': 'en_US.UTF-8', 16:21:38 INFO - 'LANGUAGE': 'en_US:en', 16:21:38 INFO - 'LOGNAME': 'cltbld', 16:21:38 INFO - 'MAIL': '/var/mail/cltbld', 16:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:38 INFO - 'MOZ_NO_REMOTE': '1', 16:21:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:38 INFO - 'NO_EM_RESTART': '1', 16:21:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:38 INFO - 'PWD': '/builds/slave/test', 16:21:38 INFO - 'SHELL': '/bin/bash', 16:21:38 INFO - 'SHLVL': '1', 16:21:38 INFO - 'TERM': 'linux', 16:21:38 INFO - 'TMOUT': '86400', 16:21:38 INFO - 'USER': 'cltbld', 16:21:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:38 INFO - '_': '/tools/buildbot/bin/python'} 16:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:38 INFO - Downloading/unpacking jsonschema==2.5.1 16:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:21:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:40 INFO - Downloading functools32-3.2.3-2.tar.gz 16:21:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:21:40 INFO - warning: no files found matching '*.txt' 16:21:40 INFO - no previously-included directories found matching 'build' 16:21:40 INFO - no previously-included directories found matching 'dist' 16:21:40 INFO - no previously-included directories found matching '.git*' 16:21:40 INFO - Installing collected packages: jsonschema, functools32 16:21:40 INFO - Running setup.py install for functools32 16:21:41 INFO - warning: no files found matching '*.txt' 16:21:41 INFO - no previously-included directories found matching 'build' 16:21:41 INFO - no previously-included directories found matching 'dist' 16:21:41 INFO - no previously-included directories found matching '.git*' 16:21:41 INFO - Successfully installed jsonschema functools32 16:21:41 INFO - Cleaning up... 16:21:41 INFO - Return code: 0 16:21:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:41 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 0x7f364ab58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cd790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', '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 16:21:41 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 16:21:41 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 16:21:41 INFO - Using env: {'DISPLAY': ':0', 16:21:41 INFO - 'HOME': '/home/cltbld', 16:21:41 INFO - 'LANG': 'en_US.UTF-8', 16:21:41 INFO - 'LANGUAGE': 'en_US:en', 16:21:41 INFO - 'LOGNAME': 'cltbld', 16:21:41 INFO - 'MAIL': '/var/mail/cltbld', 16:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:41 INFO - 'MOZ_NO_REMOTE': '1', 16:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:41 INFO - 'NO_EM_RESTART': '1', 16:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:41 INFO - 'PWD': '/builds/slave/test', 16:21:41 INFO - 'SHELL': '/bin/bash', 16:21:41 INFO - 'SHLVL': '1', 16:21:41 INFO - 'TERM': 'linux', 16:21:41 INFO - 'TMOUT': '86400', 16:21:41 INFO - 'USER': 'cltbld', 16:21:41 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:41 INFO - '_': '/tools/buildbot/bin/python'} 16:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:21:41 INFO - Cleaning up... 16:21:41 INFO - Return code: 0 16:21:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:41 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 0x7f364ab58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cd790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', '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 16:21:41 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 16:21:41 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 16:21:41 INFO - Using env: {'DISPLAY': ':0', 16:21:41 INFO - 'HOME': '/home/cltbld', 16:21:41 INFO - 'LANG': 'en_US.UTF-8', 16:21:41 INFO - 'LANGUAGE': 'en_US:en', 16:21:41 INFO - 'LOGNAME': 'cltbld', 16:21:41 INFO - 'MAIL': '/var/mail/cltbld', 16:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:41 INFO - 'MOZ_NO_REMOTE': '1', 16:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:41 INFO - 'NO_EM_RESTART': '1', 16:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:41 INFO - 'PWD': '/builds/slave/test', 16:21:41 INFO - 'SHELL': '/bin/bash', 16:21:41 INFO - 'SHLVL': '1', 16:21:41 INFO - 'TERM': 'linux', 16:21:41 INFO - 'TMOUT': '86400', 16:21:41 INFO - 'USER': 'cltbld', 16:21:41 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:41 INFO - '_': '/tools/buildbot/bin/python'} 16:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:21:41 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 16:21:41 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 16:21:41 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 16:21:41 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 16:21:41 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 16:21:41 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 16:21:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:21:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:21:43 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 16:21:43 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 16:21:43 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 16:21:43 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 16:21:43 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 16:21:43 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 16:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:21:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:21:43 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 16:21:43 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 16:21:43 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 16:21:43 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 16:21:43 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 16:21:43 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 16:21:44 INFO - Downloading docopt-0.6.1.tar.gz 16:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:21:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:21:44 INFO - Running setup.py install for blobuploader 16:21:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:21:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:21:44 INFO - Running setup.py install for requests 16:21:44 INFO - Running setup.py install for docopt 16:21:44 INFO - Successfully installed blobuploader requests docopt 16:21:44 INFO - Cleaning up... 16:21:44 INFO - Return code: 0 16:21:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:44 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 0x7f364ab58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cd790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', '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 16:21:44 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 16:21:44 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 16:21:44 INFO - Using env: {'DISPLAY': ':0', 16:21:44 INFO - 'HOME': '/home/cltbld', 16:21:44 INFO - 'LANG': 'en_US.UTF-8', 16:21:44 INFO - 'LANGUAGE': 'en_US:en', 16:21:44 INFO - 'LOGNAME': 'cltbld', 16:21:44 INFO - 'MAIL': '/var/mail/cltbld', 16:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:44 INFO - 'MOZ_NO_REMOTE': '1', 16:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:44 INFO - 'NO_EM_RESTART': '1', 16:21:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:44 INFO - 'PWD': '/builds/slave/test', 16:21:44 INFO - 'SHELL': '/bin/bash', 16:21:44 INFO - 'SHLVL': '1', 16:21:44 INFO - 'TERM': 'linux', 16:21:44 INFO - 'TMOUT': '86400', 16:21:44 INFO - 'USER': 'cltbld', 16:21:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:44 INFO - '_': '/tools/buildbot/bin/python'} 16:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:45 INFO - Running setup.py (path:/tmp/pip-_owgJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:45 INFO - Running setup.py (path:/tmp/pip-YxphSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:45 INFO - Running setup.py (path:/tmp/pip-N5gd9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:45 INFO - Running setup.py (path:/tmp/pip-tC2A9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:45 INFO - Running setup.py (path:/tmp/pip-9IGh6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:45 INFO - Running setup.py (path:/tmp/pip-wui1hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:45 INFO - Running setup.py (path:/tmp/pip-gR7njr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:45 INFO - Running setup.py (path:/tmp/pip-mViUBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:45 INFO - Running setup.py (path:/tmp/pip-Vryaeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:45 INFO - Running setup.py (path:/tmp/pip-8fbM1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:45 INFO - Running setup.py (path:/tmp/pip-WhHweY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:45 INFO - Running setup.py (path:/tmp/pip-F4S9G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:45 INFO - Running setup.py (path:/tmp/pip-XiAcw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:46 INFO - Running setup.py (path:/tmp/pip-U2iS5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:46 INFO - Running setup.py (path:/tmp/pip-NGA0GU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:46 INFO - Running setup.py (path:/tmp/pip-FWbzfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:46 INFO - Running setup.py (path:/tmp/pip-aD7bgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:21:46 INFO - Running setup.py install for manifestparser 16:21:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:21:46 INFO - Running setup.py install for mozcrash 16:21:46 INFO - Running setup.py install for mozdebug 16:21:46 INFO - Running setup.py install for mozdevice 16:21:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:21:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:21:46 INFO - Running setup.py install for mozfile 16:21:46 INFO - Running setup.py install for mozhttpd 16:21:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:21:46 INFO - Running setup.py install for mozinfo 16:21:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Running setup.py install for mozInstall 16:21:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Running setup.py install for mozleak 16:21:47 INFO - Running setup.py install for mozlog 16:21:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Running setup.py install for moznetwork 16:21:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Running setup.py install for mozprocess 16:21:47 INFO - Running setup.py install for mozprofile 16:21:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Running setup.py install for mozrunner 16:21:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:21:47 INFO - Running setup.py install for mozscreenshot 16:21:47 INFO - Running setup.py install for moztest 16:21:48 INFO - Running setup.py install for mozversion 16:21:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:21:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:21:48 INFO - Cleaning up... 16:21:48 INFO - Return code: 0 16:21:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:48 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 0x7f364ab58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cd790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', '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 16:21:48 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 16:21:48 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 16:21:48 INFO - Using env: {'DISPLAY': ':0', 16:21:48 INFO - 'HOME': '/home/cltbld', 16:21:48 INFO - 'LANG': 'en_US.UTF-8', 16:21:48 INFO - 'LANGUAGE': 'en_US:en', 16:21:48 INFO - 'LOGNAME': 'cltbld', 16:21:48 INFO - 'MAIL': '/var/mail/cltbld', 16:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:48 INFO - 'MOZ_NO_REMOTE': '1', 16:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:48 INFO - 'NO_EM_RESTART': '1', 16:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:48 INFO - 'PWD': '/builds/slave/test', 16:21:48 INFO - 'SHELL': '/bin/bash', 16:21:48 INFO - 'SHLVL': '1', 16:21:48 INFO - 'TERM': 'linux', 16:21:48 INFO - 'TMOUT': '86400', 16:21:48 INFO - 'USER': 'cltbld', 16:21:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:48 INFO - '_': '/tools/buildbot/bin/python'} 16:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:48 INFO - Running setup.py (path:/tmp/pip-cj7cJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:48 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)) 16:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:48 INFO - Running setup.py (path:/tmp/pip-_dfQVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:48 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)) 16:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:48 INFO - Running setup.py (path:/tmp/pip-Qn9DNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:48 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)) 16:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:48 INFO - Running setup.py (path:/tmp/pip-5xYvEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:48 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)) 16:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:48 INFO - Running setup.py (path:/tmp/pip-ai80SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:48 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)) 16:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:48 INFO - Running setup.py (path:/tmp/pip-JWuLXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:48 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)) 16:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:48 INFO - Running setup.py (path:/tmp/pip-GDYA1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:48 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)) 16:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:48 INFO - Running setup.py (path:/tmp/pip-ZgCXqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:48 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)) 16:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:48 INFO - Running setup.py (path:/tmp/pip-45yPH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:49 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)) 16:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:49 INFO - Running setup.py (path:/tmp/pip-Hk0Afs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:49 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)) 16:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:49 INFO - Running setup.py (path:/tmp/pip-soymJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:49 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)) 16:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:49 INFO - Running setup.py (path:/tmp/pip-r4gOJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:49 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)) 16:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:49 INFO - Running setup.py (path:/tmp/pip-zqw1eO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:49 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)) 16:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:49 INFO - Running setup.py (path:/tmp/pip-nBhfv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:49 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)) 16:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:49 INFO - Running setup.py (path:/tmp/pip-4RQyC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:49 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)) 16:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:49 INFO - Running setup.py (path:/tmp/pip-Js6xxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:49 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)) 16:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:49 INFO - Running setup.py (path:/tmp/pip-ElWDGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:49 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)) 16:21:49 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)) 16:21:49 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)) 16:21:49 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)) 16:21:49 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)) 16:21:49 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)) 16:21:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21:49 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 16:21:49 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 16:21:49 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 16:21:49 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 16:21:49 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 16:21:49 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 16:21:51 INFO - Downloading blessings-1.6.tar.gz 16:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:21:51 INFO - Installing collected packages: blessings 16:21:51 INFO - Running setup.py install for blessings 16:21:51 INFO - Successfully installed blessings 16:21:51 INFO - Cleaning up... 16:21:51 INFO - Return code: 0 16:21:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:51 INFO - Reading from file tmpfile_stdout 16:21:51 INFO - Current package versions: 16:21:51 INFO - argparse == 1.2.1 16:21:51 INFO - blessings == 1.6 16:21:51 INFO - blobuploader == 1.2.4 16:21:51 INFO - docopt == 0.6.1 16:21:51 INFO - functools32 == 3.2.3-2 16:21:51 INFO - jsonschema == 2.5.1 16:21:51 INFO - manifestparser == 1.1 16:21:51 INFO - mozInstall == 1.12 16:21:51 INFO - mozcrash == 0.17 16:21:51 INFO - mozdebug == 0.1 16:21:51 INFO - mozdevice == 0.48 16:21:51 INFO - mozfile == 1.2 16:21:51 INFO - mozhttpd == 0.7 16:21:51 INFO - mozinfo == 0.9 16:21:51 INFO - mozleak == 0.1 16:21:51 INFO - mozlog == 3.4 16:21:51 INFO - moznetwork == 0.27 16:21:51 INFO - mozprocess == 0.23 16:21:51 INFO - mozprofile == 0.28 16:21:51 INFO - mozrunner == 6.12 16:21:51 INFO - mozscreenshot == 0.1 16:21:51 INFO - mozsystemmonitor == 0.3 16:21:51 INFO - moztest == 0.7 16:21:51 INFO - mozversion == 1.4 16:21:51 INFO - psutil == 3.1.1 16:21:51 INFO - requests == 1.2.3 16:21:51 INFO - wsgiref == 0.1.2 16:21:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21: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')]} 16:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21: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')]} 16:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:51 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 0x7f364ab58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cd790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', '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 16:21:51 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 16:21:51 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 16:21:51 INFO - Using env: {'DISPLAY': ':0', 16:21:51 INFO - 'HOME': '/home/cltbld', 16:21:51 INFO - 'LANG': 'en_US.UTF-8', 16:21:51 INFO - 'LANGUAGE': 'en_US:en', 16:21:51 INFO - 'LOGNAME': 'cltbld', 16:21:51 INFO - 'MAIL': '/var/mail/cltbld', 16:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:51 INFO - 'MOZ_NO_REMOTE': '1', 16:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:51 INFO - 'NO_EM_RESTART': '1', 16:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:51 INFO - 'PWD': '/builds/slave/test', 16:21:51 INFO - 'SHELL': '/bin/bash', 16:21:51 INFO - 'SHLVL': '1', 16:21:51 INFO - 'TERM': 'linux', 16:21:51 INFO - 'TMOUT': '86400', 16:21:51 INFO - 'USER': 'cltbld', 16:21:51 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:51 INFO - '_': '/tools/buildbot/bin/python'} 16:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:52 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)) 16:21:52 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)) 16:21:52 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)) 16:21:52 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)) 16:21:52 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)) 16:21:52 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)) 16:21:52 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)) 16:21:52 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)) 16:21:52 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)) 16:21:52 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)) 16:21:52 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)) 16:21:52 INFO - Cleaning up... 16:21:52 INFO - Return code: 0 16:21:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f364ab58f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cd790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', '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 16:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:21:52 INFO - Using env: {'DISPLAY': ':0', 16:21:52 INFO - 'HOME': '/home/cltbld', 16:21:52 INFO - 'LANG': 'en_US.UTF-8', 16:21:52 INFO - 'LANGUAGE': 'en_US:en', 16:21:52 INFO - 'LOGNAME': 'cltbld', 16:21:52 INFO - 'MAIL': '/var/mail/cltbld', 16:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:52 INFO - 'MOZ_NO_REMOTE': '1', 16:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:52 INFO - 'NO_EM_RESTART': '1', 16:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:52 INFO - 'PWD': '/builds/slave/test', 16:21:52 INFO - 'SHELL': '/bin/bash', 16:21:52 INFO - 'SHLVL': '1', 16:21:52 INFO - 'TERM': 'linux', 16:21:52 INFO - 'TMOUT': '86400', 16:21:52 INFO - 'USER': 'cltbld', 16:21:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:52 INFO - '_': '/tools/buildbot/bin/python'} 16:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:21:52 INFO - Cleaning up... 16:21:52 INFO - Return code: 0 16:21:52 INFO - Running post-action listener: _resource_record_post_action 16:21:52 INFO - Running post-action listener: _start_resource_monitoring 16:21:52 INFO - Starting resource monitoring. 16:21:52 INFO - [mozharness: 2016-10-20 23:21:52.452852Z] Finished create-virtualenv step (success) 16:21:52 INFO - [mozharness: 2016-10-20 23:21:52.453321Z] Running install step. 16:21:52 INFO - Running pre-action listener: _resource_record_pre_action 16:21:52 INFO - Running main action method: install 16:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:52 INFO - Reading from file tmpfile_stdout 16:21:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:21:52 INFO - Reading from file tmpfile_stdout 16:21:52 INFO - Output received: 16:21:52 INFO - Usage: mozinstall [options] installer 16:21:52 INFO - Options: 16:21:52 INFO - -h, --help show this help message and exit 16:21:52 INFO - -d DEST, --destination=DEST 16:21:52 INFO - Directory to install application into. [default: 16:21:52 INFO - "/builds/slave/test"] 16:21:52 INFO - --app=APP Application being installed. [default: firefox] 16:21:52 INFO - mkdir: /builds/slave/test/build/application 16:21:52 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'] 16:21:52 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 16:22:09 INFO - Reading from file tmpfile_stdout 16:22:09 INFO - Output received: 16:22:09 INFO - /builds/slave/test/build/application/firefox/firefox 16:22:09 INFO - Running post-action listener: _resource_record_post_action 16:22:09 INFO - [mozharness: 2016-10-20 23:22:09.687135Z] Finished install step (success) 16:22:09 INFO - [mozharness: 2016-10-20 23:22:09.687378Z] Running run-tests step. 16:22:09 INFO - Running pre-action listener: _resource_record_pre_action 16:22:09 INFO - Running main action method: run_tests 16:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:22:09 INFO - Python 2.7.3 16:22:09 INFO - Return code: 0 16:22:09 INFO - grabbing minidump binary from tooltool 16:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:22:09 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 0x19ca930>, '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 0x19cb830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19cbcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:22:09 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 16:22:09 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 16:22:09 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 16:22:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:22:09 INFO - Return code: 0 16:22:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:22:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:22:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:22:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:22:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:22:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 16:22:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 16:22:09 INFO - Using env: {'DISPLAY': ':0', 16:22:09 INFO - 'HOME': '/home/cltbld', 16:22:09 INFO - 'LANG': 'en_US.UTF-8', 16:22:09 INFO - 'LANGUAGE': 'en_US:en', 16:22:09 INFO - 'LOGNAME': 'cltbld', 16:22:09 INFO - 'MAIL': '/var/mail/cltbld', 16:22:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:22:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:22:09 INFO - 'MOZ_NO_REMOTE': '1', 16:22:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:22:09 INFO - 'NO_EM_RESTART': '1', 16:22:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:22:09 INFO - 'PWD': '/builds/slave/test', 16:22:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:22:09 INFO - 'SHELL': '/bin/bash', 16:22:09 INFO - 'SHLVL': '1', 16:22:09 INFO - 'TERM': 'linux', 16:22:09 INFO - 'TMOUT': '86400', 16:22:09 INFO - 'USER': 'cltbld', 16:22:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177', 16:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:22:09 INFO - '_': '/tools/buildbot/bin/python'} 16:22:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 16:22:09 INFO - mozversion application_buildid: 20161020133011 16:22:09 INFO - mozversion application_changeset: f0f1aaf051d6798e1e73d1feee07ca847333167a 16:22:09 INFO - mozversion application_display_name: Nightly 16:22:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:22:09 INFO - mozversion application_name: Firefox 16:22:09 INFO - mozversion application_remotingname: firefox 16:22:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:22:09 INFO - mozversion application_vendor: Mozilla 16:22:09 INFO - mozversion application_version: 52.0a1 16:22:09 INFO - mozversion platform_buildid: 20161020133011 16:22:09 INFO - mozversion platform_changeset: f0f1aaf051d6798e1e73d1feee07ca847333167a 16:22:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:22:09 INFO - mozversion platform_version: 52.0a1 16:22:09 INFO - using testdate: 1477005729 16:22:09 INFO - actual date: 1477005729 16:22:09 INFO - starting webserver on 'localhost:59992' 16:22:09 INFO - SUITE-START | Running 2 tests 16:22:09 INFO - TEST-START | dromaeo_css 16:22:09 INFO - operating with platform_type : linux_ 16:22:09 INFO - Initialising browser for dromaeo_css test... 16:22:09 INFO - TEST-INFO | started process 28251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9RUWOt/profile http://localhost:59992/getInfo.html) 16:22:14 INFO - PROCESS | 28251 | __metrics Screen width/height:1600/1200 16:22:14 INFO - PROCESS | 28251 | colorDepth:24 16:22:14 INFO - PROCESS | 28251 | Browser inner width/height: 1024/697 16:22:14 INFO - PROCESS | 28251 | __metrics 16:22:14 INFO - PROCESS | 28251 | 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" 16:22:14 INFO - PROCESS | 28251 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:22:15 INFO - PROCESS | 28251 | console.error: PushService: 16:22:15 INFO - PROCESS | 28251 | stateChangeProcessEnqueue: Error transitioning state 16:22:15 INFO - PROCESS | 28251 | UnknownError 16:22:16 INFO - TEST-INFO | 28251: exit 0 16:22:16 INFO - Browser initialized. 16:22:16 INFO - Running cycle 1/1 for dromaeo_css test... 16:22:16 INFO - TEST-INFO | started process 28335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9RUWOt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:28 INFO - PROCESS | 28335 | RSS: Main: 171585536 16:22:28 INFO - PROCESS | 28335 | 16:23:19 INFO - PROCESS | 28335 | 1477005799399 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] 16:25:29 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:59992/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59992/tests/dromaeo/cssquery-ext.html) 16:25:31 INFO - PROCESS | 28335 | RSS: Main: 303710208 16:25:31 INFO - PROCESS | 28335 | 16:28:33 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:59992/tests/dromaeo/cssquery-ext.html (next: http://localhost:59992/tests/dromaeo/cssquery-jquery.html) 16:28:34 INFO - PROCESS | 28335 | RSS: Main: 263921664 16:28:34 INFO - PROCESS | 28335 | 16:31:36 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:59992/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59992/tests/dromaeo/cssquery-mootools.html) 16:31:36 INFO - PROCESS | 28335 | RSS: Main: 246349824 16:31:36 INFO - PROCESS | 28335 | 16:34:38 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:59992/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59992/tests/dromaeo/cssquery-prototype.html) 16:34:39 INFO - PROCESS | 28335 | RSS: Main: 273649664 16:34:39 INFO - PROCESS | 28335 | 16:37:42 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:59992/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59992/tests/dromaeo/cssquery-yui.html) 16:37:42 INFO - PROCESS | 28335 | RSS: Main: 215506944 16:37:42 INFO - PROCESS | 28335 | 16:40:45 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:59992/tests/dromaeo/cssquery-yui.html (next: http://localhost:59992/tests/dromaeo/cssquery-dojo.html) 16:40:46 INFO - PROCESS | 28335 | RSS: Main: 307843072 16:40:46 INFO - PROCESS | 28335 | 16:40:46 INFO - PROCESS | 28335 | __start_tp_report 16:40:46 INFO - PROCESS | 28335 | _x_x_mozilla_page_load 16:40:46 INFO - PROCESS | 28335 | _x_x_mozilla_page_load_details 16:40:46 INFO - PROCESS | 28335 | |i|pagename|runs| 16:40:46 INFO - PROCESS | 28335 | |0;dojo.html;3014.6834582368847;3026.515757478801;3072.093732348957;3084.383123375324;3090.984545077274;5154.175331946889;5240.528352448279;5319.89360212796;5385.246065550826;5404;5286.947130528693;5292.973535132319;5296.390915044771;5306.7346632668405;5315.521603055724;4791.976040119804;4819.373481447407;4834.057358815033;4861.756912154396;4877.829275975341;4812.711237325754;4849.054434385296;4874.512548745132;4905.705657660534;5016.2224855147515;4986.177280748672;4990;4990.925136122961;5040;5045.722485263309;271.7897383369028;4813.229883218668;4989.401271847401;4992.900141997158;5064.012517559077;3131.4363414585364;4771.8091276348905;4787.329773831631;4884.7069175849565;4942.8764280893265;5384.165454354581;5393.029254734146;5393.1370980643305;5397.109476936301;5399.082156033483;5484.561235101222;5609;5742.913856292117;5750.108733146369;5810;5559.694216818073;5633.943660563383;5679.744411501492;5719.170720245541;5759;5357.785688572452;5371.248025276464;5385.569154467672;5390.272313237741;5392.4337944515655;5875.9118613220835;5879.059350503899;5881.647101173858;5888.087346461305;5892.852678683067;5382.434844341366;5423.132298832247;5427.457254274541;5487.42382049887;5615.9157612635845;5699.287589051369;5702.914456283159;5703.74333155009;5732.0255556555485;5773.134029895549;5680.431956804369;5682.204491371212;5688.516476099578;5692.402297758758;5699.316082070178;5496.725163741797;5526.088195447786;5555.749991250404;5647.858803529944;5764.538836893123;4328.913421731548;4354.390385346054;4384.8246070157475;4385.912281754347;4434.290513517886;3883.7475564088245;3885.2618002579984;3889.3776995680555;3932.2725295820364;3939.980300098481;5210.557102646242;5388.110961691277;5398.8920221595345;5404.0272750905215;5404.405515393382;5560.165975103767;5590.91613625796;5664.405237450091;5664.631798933056;5756.136579513023;5324.787008519694;5332.440093790174;5339.946600533945;5341.5459685927135;5343.919841202385;4762.047590481849;4915.361003069578;4923.433805112386;4924.359833221658;4988.301637770643;5606.775728970877;5669.40471250521;5808.36108028125;5817.127430885316;5903.970480147572;5662.8301150965535;5702.800401985911;5707;5709.200711900255;5710.143478478261;5816.302043754777;5816.331121921034;5841.32824725162;5845.240118784531;5848.824535263949;5425.782968681208;5471.8084867029465;5500.834974950758;5570.3315602128005;5581.10702287632;5655.406182350958;5659.943400566106;5662.2639056922335;5669.234653321749;5720.056190728483;5518.392976772471;5532.3637781655625;5546.500814926676;5555.972220139035;5559.694216817952;5389.51494365509;5441.102218133963;5495.477929596682;5561.360443549043;5601.887962240651;5584.357798853021;5588.329400471969;5595.468430499096;5642.6614403135945;5653.067243904709;5594.888102238014;5607.43925607436;5623.943760562342;5624.971875140598;5643.802466913638;5315.893682126259;5359.356877174764;5365.892682146413;5429.647072940246;5514.283143191359 16:40:46 INFO - PROCESS | 28335 | |1;ext.html;564.5422898338811;566.3062748133536;616.42364389296;622.4304761143551;639.9584027038245;32485;44123.33814992774;45316.38988592165;45318.5468145318;45451.545484545146;45503.31745023819;45753.08493830122;46049.76975115128;46091.76954115233;46131.538684613144;8021.358291336679;8919.24186444153;9068.637254509811;9069.909300907006;9077.455352678828;8043.235892590224;10516.842247366296;10807.729806754816;10829.783404331909;11140.888591114106;10975.725606859813;11040;11057.668269951873;11061.668149955514;11062.446877656084;10819.513121909533;10888.727781805439;10906.61826836065;10912.127029837673;10923.344599324026;10665.36007839532;10705.625303114353;10731.463426828705;10738.08726258269;10743.301685390425;43312.13375732499;43540.3468947966;43648.127037459075;43775.34336984948;43881.34177987333;3257.4136655402017;3272.4109660261142;3338.833058347097;3341.983290083534;3357.9328413431595;31262.531062034086;31700.841495792603;31924.521132183036;32088.518672219936;32893;4326.545712700153;4364.432623758891;4381.561843815625;4402.823887044515;4424.668149888771;333620;335831;337015;337441;339351;34149.48775768365;59321.40678593245;59436.702816486504;59565.70217148887;59584.702076490204;34936.650633493846;36982.815085924936;37080.81459592739;37088.258234835695;37120.257594848496;14512.854871451362;14530.709385812224;14591.489297874523;14596.489122880648;14617.415303387745;11546.249493782878;11774.470148843322;11846.526138954345;12221.450034748457;12241.938790305992;8148.144444833207;8202.466839655403;8289.502629842229;8340.04089529712;8347;3144.371125774854;3207.5028370602595;3232.6767323267954;3239.3521295740948;3266.918327041843;956.6460409648336;986.6300137448313;1045.4720366215165;1060.824963880951;1173.8063219568676;32216.19459513531;32539.18652033671;32549.349013019608;32872.531418312195;33137.3372532548;1077.0468135699805;1092.579356947565;1138.1918837625378;1138.299945533491;1143.2968724234702;16187.514374568782;17082.743758843626;17159.866054818307;17177.656446871242;17507.649847003242;507390;510704;510953;512253;512328;57825;58403.70798146067;58447;58491.41508584945;58497;1185.6050777429543;1270.142653708743;1329.7872340425486;1354.2957662015895;1426.7289215049107;30024.64889079953;31568.210794729395;33741.66258337385;33909.152271193416;34071.4889276666;53032.469675304295;54067.72966135144;54094.459055408945;54127.72936135452;54211.45788542064;428332;437132.80140780954;437255;437558;438788;38361.4245786319;38658.2268354637;39778;43911.56088439075;44180.779096104314;47729.28406073842;47924;48010.51989480061;48022.27966580574;48536.271955921395;39990.800046000746;40269.39595906122;40509;41404;41993;40998;41105.79447102745;41537.58462415337;42477;42702.145957080065;40620.1875962485;41548.37677434902;41623.37564936589;41931.7903410481;42178.1564368717;34551.30897382089;37047.25905481929;37346.626533734314;37540.436893447164;38053.809730951165;27409.31476713098;27700;27854.721452785212;28035.57946630843;28051.626802848194 16:40:46 INFO - PROCESS | 28335 | |2;jquery.html;359.43389162069747;368.3388317969244;375.6675342322045;386.88393481955404;395.80209895052474;13970.511032113865;14264.786028209584;15176.772348414768;18684.439466816017;19653.21387144516;18550;19323.033848307565;19711.211551537956;19939.21154980553;19987.20051197954;5599.692016939077;5870.941290587103;5877.941220587803;5880.764769409218;5880.882382352351;5373.113436283009;5500.532454741352;5807.216025836521;5839.861227060704;5853.64878107315;5797.5651826113;5798.855028624276;5804.245448091763;5805.796797112102;5807.1579620954935;5365.597580181482;5630.296212973379;5647.802326918538;5731.742071606787;5737.942620573783;5387.649802762808;5525.364583072917;5547.33431988164;5559.694216818073;5572.693501857396;13721.70679037034;13943.093698909539;13945;13952.372143253579;19154;2137.8824164670937;2203.3389983005195;2242.55148970205;2538.3780973661387;2656.070375368625;9628.27787915902;9982.800343993153;9991.900080999243;10141.645042423479;14117.294135293298;1855.9721604175948;1885.33070759881;1896.1846406045534;1904.419152158591;1942.3295965469686;80939;80997;82481;83245.58377208136;84920.57539712262;10574.471276436147;10709.609060285246;10843.566257349617;10906.127509799197;10956.233063685466;15265.923670381577;15278.923605381902;15293.541193764206;15302.846971530142;15305.540833775005;7526.086356194737;7625.618719064025;7802;7805.492642978188;8012.599370031475;7342.632868356561;7405.222451642608;7599.278068583586;7663.463557551029;7676.886851406626;4551.931721024187;4626.167289887785;4666.673332866734;4695.788689508912;4772.141014617333;1909.3699079303797;1955.5697746495748;1991.143808162504;2000.2699014859763;2039.9082041308177;939.9201067909304;976.584951395654;1025.9794804103876;1035.7255327338262;1064.8722153341494;17413.3034678614;19008.239670413306;20110.195592176147;20673.896630516752;20674.58650826975;943.2783920300975;962.31675510387;977.5942983661843;985.69936169469;995.6017592962872;10265.846012309821;10861.565537378574;10889.945550272198;10945.179111566664;11028.22802403824;340241;345122;347492;476617;478364;78360.33937115408;80727.4752709131;83627;89360;96592.51703741578;937.9953100234592;1006.9899301006897;1050.2595670052594;1056.5984925728173;1057.7937302225992;16901.661966760843;16990.23543940501;17557.736633950244;17702.557436063686;18303;28765.856170719013;32696.18259543435;35773;41292;42205.78897105495;55397.737214964516;56360.154597680244;58839.41160588339;59442;59602.50993725018;7182.4972251943955;7304.890426643498;7467.92532074694;7589.962050189713;7956.761297161094;12704.237745735285;12818.166819156724;13260.07179497426;13385.531506397228;13580.185188888698;11325.603603873826;11339.376334301363;11725.88274117248;12217.266963981834;12344.074194435632;11396.715082123013;11582.536698531965;11735.23720958135;11922.463489142836;12198.695032624255;11656.475458604213;11673.182877198515;11757.294562325946;11878.762424751283;12378.566750164062;7824.100228473799;7881.290683838482;7891.224474493193;7998.200179981955;8127;9818.852717209105;11342.262752921033;11460.770784584429;11668.649940501798;11682.94158529202 16:40:46 INFO - PROCESS | 28335 | |3;mootools.html;1465.384538493833;1498.2733374313457;1598.7521934100212;1743.3026789284277;1771.9379821706234;8336.916630833697;8982.730518084452;8983.101689831014;8986.05646407127;8987.460752354864;7215.711371545145;7459.365953893912;8283.171682831713;8577.871331930026;8752.649894004233;2270.829687773415;2312.075169932032;2316.7219933607907;2319.489712263308;2319.8376113672048;2286.3941055620276;2290.8167346612313;2333.929982100531;2334.241371554243;2339.63735620979;2274.0676322707695;2294.2314324701247;2299.2297580310615;2326.5230627721276;2329.1149363241943;2231.631780756173;2236.798688118061;2241.081156725743;2252;2261.4685548896077;2204.0963205086;2240.484688521633;2241.764614715464;2243.203662699734;2250.246167533878;8845.248153906861;8886.333524985588;8890.110988901122;8902.287816974691;8918;5104.64267501275;5202.97398513005;5232.3459567554055;5249.763760630781;5280.894382112375;3364.680355366236;3372.5109859070544;3519;3541.592716837571;3559.839807208682;1062.9468526573717;1064.2816099133054;1082.5020490574345;1091.825307950732;1113.5378817790606;12151.878481215163;12175.51297948081;12200.877991220152;12256.81614775779;12275.386230688518;4394.75867307669;4409.559044095629;4584.633229341644;4617.3304870793545;4705.764711764398;10317.84523232152;10344.37933723964;10346.689599312032;10347.379157250589;10354.11989980845;5233.842984710464;5264.0261551613075;5267.236250743621;5275.314209152785;5282.128448805981;4064.695147863863;4161.83352665896;4214.009707718745;4518.412606361152;4867.853964381075;3773.2453509298252;3808.1241314497265;3928.685705143582;3958.089639382958;4048.554658987509;1233.1244816180433;1248.7003119251497;1250.0686988193854;1263.3935710858839;1271.446920589528;770.2143813310504;772.2316295286226;939.6899023322287;942.2885721280527;974.2595627323285;5637.267155269788;5710.143478478261;6008.669523176267;6015.3383127855905;6156.6921653917125;443.3925522034833;445.46099219943585;446.18125739268805;456.4408599465628;456.92917597772396;4174.332106862948;4176.1230141670585;4176.58234176586;4178.895527611773;4181.330987042059;10522.263441559171;10818.24272300947;10934.398608076473;10945.507452164671;10948.397838118979;10842.186835987333;10842.891571084347;10843.07833834117;10854.511546980404;10865.45672716361;7691.538507689556;8025.678972841138;8036.075851277061;8192.877106843402;8193.71322003727;5725.826205627753;5829.679367634821;5847.44449277318;5992.221011268507;5997.880042399215;10073.748156296151;10081;10098.394096353948;10119;10210.540525676512;9736.561854716696;10262.58949642006;10381.53283102247;10387.792244154924;10428.478576071015;6606.504512161703;6792.456603471809;7851.9214807851195;7926.286634202949;7980.042394912648;8080.393970452122;8286.461380010522;8347.749567512985;8413.579321034047;8596.656133754579;7528.887066694114;7884.053913530413;7927.722529711433;8019.318357939641;8051.315638170587;7746;7758.146603873683;7874.645640946057;7884.329831964118;8005.599720014093;6959.686814093479;7051.012858199959;7076.504644674823;7078.539894906815;7087.681054352463;4962.925556116589;5080.593552515864;5097.7706003229205;5189.351331083614;5322.201669749568;5303.496167864047;5379.090422899814;5383.973080134574;5387.865303367447;5455.563554915677 16:40:46 INFO - PROCESS | 28335 | |4;prototype.html;309.5836100444902;313.69728212275163;321.3620962389656;332.24248712934485;337.3809060374213;4813.868740845898;4979.576735977437;5303.204519322104;5329.893402131955;5335.519803217705;5179.792808287664;5250.343707036621;5266.262723218752;5293.364796224449;5309.33633295838;4202.936955945664;4210.452641156646;4213.957860421395;4223.894402639928;4228.534861165269;3951.802409879509;4201.558836322188;4202.621764041236;4239.236937351276;4247.320428731404;3880.7671539707567;4159.2721273777115;4165.895852603694;4172.7287726297845;4186.204621121992;4128.834846606147;4129.359949207863;4140;4146.4402305688645;4175.8516407988045;3708.8145592720525;3708.9814550927344;3722.497462842509;3723.696706152852;3724.832382542792;4920.138975679278;5159.406668233164;5169.508896654812;5179.378474583036;5228.529432351069;4652.464966528825;4660;4669.95330046702;4677;4684.953150468486;5532.834014979557;5542.39033706292;5546.975353995803;5580.38615752271;5612.859678508029;3846.903827404309;3975.7813320267373;3977.8209980550655;3997.3004724173443;4013.237484877864;5428.294321738188;5579.804706835242;5694.572907031989;5716.256886604715;5731.168980497804;3881.398383250544;4035.6771458283265;4048.2105989332385;4071.1043570414463;4078.1435898461064;4120.526139493936;4132.380142978577;4133.979330103391;4135.627793498599;4136.91726165475;4526.23054080807;4729.753367150576;4734.455537613149;4741.383620129361;4742.099001189832;5518.688786727931;5535.916961245584;5541.9168712469345;5543.501084902378;5555.138953462219;1390.7218556288783;1408.9154650720989;1409.344654735553;1414.6463384153963;1417.4401111560876;858.3262139220682;886.3131073418024;899.2850683706469;915.5579961560569;920.769807548113;4695.718256904528;4716.339712440261;4720.12677654635;4722.598579120813;4758.904821903542;4942.2949082567175;4954.702717836942;4962.404511458648;5019.799208031638;5029.485257371314;4705.670603057822;4715.7642117893965;4750.429948406213;4772.832950846704;5001.624878134155;2991.2970451943775;3013.804102733315;3015.909522714322;3021.3806169735153;3024.652165001053;5789.218455508537;5801.3328467225965;5805.461552688541;5806.996586177762;5824.446677565625;5574.721263936868;5767.914165921212;5776.249087618667;5796.449337312949;5813.5349172066135;5822.155787410717;5832.854178645568;5845.532357411482;5849.005669036274;5866;5471.644343117685;5593.161025846156;5678.176664383559;5696.231008813757;5722.483541861493;5658.377578466448;5661.999999999835;5663.830085097454;5678.3753787084215;5679.801206957736;5532.529734972572;5718.456746609066;5734.168545560787;5799.913001305068;5862.443067908542;4073.429719839284;4098.303288440912;4131.173765246903;4136.110736191733;4137.751734895915;5718.42598376015;5800.767969281182;5806.158107074366;5821.27234095738;5823.650580965155;5533.727242734113;5538.97230513861;5545.944540554704;5568.359638641608;5608.756497400909;5509.669419834822;5511.145772405283;5515.448455154453;5520.392756796829;5529.585281103853;5313.54834839043;5508.20131080999;5562.193481945176;5584.636998595079;5601.495865372136;5550.334899530206;5595.356533998643;5596.272484576979;5608.270924779753;5615.859603509945;5399.43305952885;5446.284420407559;5454.4545545445135;5477.178423236546;5526.972365138148 16:40:46 INFO - PROCESS | 28335 | |5;yui.html;727.8398752274501;734.313416955147;769.6498093367518;791.6674996501469;798.6326289906642;15994.360225590977;16686.91656541717;16688.41590544331;16780.077095759727;16781.580460488494;15796.44712435065;15981.680366392666;15984.120873351962;15984.520464386087;16004.679906401894;666.3636227402818;682.0315152483486;784.945053846231;803.3653413803089;823.8105235795771;816.7549735079482;821.1911267401605;828.2090603473669;828.5153185386556;828.5774255129897;854.0818619983512;854.2653318146389;854.5855260198798;854.5940678177878;854.8162145138793;696.2306651150457;713.2688993781363;840.7898025493627;857.0529564830865;857.5197889182047;629.3957800511514;630.5176539946945;634.815903388017;635.0347471842773;635.8537536366615;15680.372785088583;15726.37094516218;15751.291191896393;15776.842231577652;15800.762988555181;14476.565703028926;14795.40818367264;14875.909124990605;14956.40174393023;15054.397824087024;12902.225866448043;13049.804252936214;13269.203847769068;13335.73328533424;13472.326383680776;4246.11384824536;4246.639035681971;4297.97851010746;4330.328799036154;4344.978275108604;80617.59691201565;81211.59394203051;81608.59195703984;85037;85789;11021.228514004104;11195.160362972809;11240.887591123985;11294.096472282197;11607.883921160848;22255.44361390978;22320.88839555792;22328.665070023962;22464;22473.550528989657;7808.219178082147;8160.959195203986;8387.664493420318;8520.957395213109;8639.827203455896;4298.871033868989;4396.912061758747;4409.581089796464;4445.755483448442;4642.930356044662;3446.603640581365;3528.4530897710897;3559.857605695795;3559.982200089035;3561.5726112866105;583.3670467542679;601.8164459839791;605.9492294014527;612.4549151255386;623.9064140378889;674.6019848289435;685.3934268172603;704.8836941904631;706.1138271469273;713.1014921199326;9003.549822508849;9334.953325233331;9864.210863130933;10013.09882110599;10108.39349639024;684.3635419060222;686.7630667419733;701.4738945790657;701.8982247574073;702.153904545022;4583.633309335311;4835.2505361669;4874.073925954058;4886.120498310338;4944.554990050912;71004.64497677582;72006;91034;93328;95359.52320238354;75586;84080;91388;91525.54237228772;93104;50189.23580731387;66138.66930665316;80038;80895;82234.9999999988;9225.861612075958;9668.323217374716;9698.078682525149;9717.271204659537;9844.064813842673;33997.32005359929;40446.59553404428;44844.32733508935;45348.09303813971;48052.27921581249;68259.65870170816;68647.31352686409;68693.3130668687;71222;73134.26865731487;13066.281354525212;13287.335633218107;13401.476999024359;13405.195688258736;13687.851794087615;15057.322420491324;15275.388984440498;15288.694226115193;16033.759493607839;16442.506724798277;13725.45098196061;14253.429862805786;14639.341229644479;14879.776803347742;15279.465218717292;13934.163950163023;14006.64983375383;14022.859771402156;14588;14994.175320357484;14197;14349.856501434851;14665.193414362313;14733.116013039253;15368.692626147638;10092.24308176875;10231.181505479693;10410.947945260225;10524.631637892637;10769.353838769699;10558;10975.52451044024;11078.169137314573;11215.887841121485;11259.09927205838 16:40:46 INFO - PROCESS | 28335 | __end_tp_report 16:40:46 INFO - PROCESS | 28335 | __start_cc_report 16:40:46 INFO - PROCESS | 28335 | _x_x_mozilla_cycle_collect,1241 16:40:46 INFO - PROCESS | 28335 | __end_cc_report 16:40:46 INFO - PROCESS | 28335 | __startTimestamp1477006846176__endTimestamp 16:40:46 INFO - PROCESS | 28335 | 16:40:46 INFO - PROCESS | 28335 | ------- Summary: start ------- 16:40:46 INFO - PROCESS | 28335 | Number of tests: 6 16:40:46 INFO - PROCESS | 28335 | 16:40:46 INFO - PROCESS | 28335 | [#0] dojo.html Cycles:165 Average:5245.05 Median:5427.46 stddev:721.19 (13.3%) stddev-sans-first:701.85 16:40:46 INFO - PROCESS | 28335 | Values: 3014.7 3026.5 3072.1 3084.4 3091.0 5154.2 5240.5 5319.9 5385.2 5404.0 5286.9 5293.0 5296.4 5306.7 5315.5 4792.0 4819.4 4834.1 4861.8 4877.8 4812.7 4849.1 4874.5 4905.7 5016.2 4986.2 4990.0 4990.9 5040.0 5045.7 271.8 4813.2 4989.4 4992.9 5064.0 3131.4 4771.8 4787.3 4884.7 4942.9 5384.2 5393.0 5393.1 5397.1 5399.1 5484.6 5609.0 5742.9 5750.1 5810.0 5559.7 5633.9 5679.7 5719.2 5759.0 5357.8 5371.2 5385.6 5390.3 5392.4 5875.9 5879.1 5881.6 5888.1 5892.9 5382.4 5423.1 5427.5 5487.4 5615.9 5699.3 5702.9 5703.7 5732.0 5773.1 5680.4 5682.2 5688.5 5692.4 5699.3 5496.7 5526.1 5555.7 5647.9 5764.5 4328.9 4354.4 4384.8 4385.9 4434.3 3883.7 3885.3 3889.4 3932.3 3940.0 5210.6 5388.1 5398.9 5404.0 5404.4 5560.2 5590.9 5664.4 5664.6 5756.1 5324.8 5332.4 5339.9 5341.5 5343.9 4762.0 4915.4 4923.4 4924.4 4988.3 5606.8 5669.4 5808.4 5817.1 5904.0 5662.8 5702.8 5707.0 5709.2 5710.1 5816.3 5816.3 5841.3 5845.2 5848.8 5425.8 5471.8 5500.8 5570.3 5581.1 5655.4 5659.9 5662.3 5669.2 5720.1 5518.4 5532.4 5546.5 5556.0 5559.7 5389.5 5441.1 5495.5 5561.4 5601.9 5584.4 5588.3 5595.5 5642.7 5653.1 5594.9 5607.4 5623.9 5625.0 5643.8 5315.9 5359.4 5365.9 5429.6 5514.3 16:40:46 INFO - PROCESS | 28335 | 16:40:46 INFO - PROCESS | 28335 | [#1] ext.html Cycles:180 Average:58674.92 Median:37233.44 stddev:114881.79 (308.5%) stddev-sans-first:115121.22 16:40:46 INFO - PROCESS | 28335 | Values: 564.5 566.3 616.4 622.4 640.0 32485.0 44123.3 45316.4 45318.5 45451.5 45503.3 45753.1 46049.8 46091.8 46131.5 8021.4 8919.2 9068.6 9069.9 9077.5 8043.2 10516.8 10807.7 10829.8 11140.9 10975.7 11040.0 11057.7 11061.7 11062.4 10819.5 10888.7 10906.6 10912.1 10923.3 10665.4 10705.6 10731.5 10738.1 10743.3 43312.1 43540.3 43648.1 43775.3 43881.3 3257.4 3272.4 3338.8 3342.0 3357.9 31262.5 31700.8 31924.5 32088.5 32893.0 4326.5 4364.4 4381.6 4402.8 4424.7 333620.0 335831.0 337015.0 337441.0 339351.0 34149.5 59321.4 59436.7 59565.7 59584.7 34936.7 36982.8 37080.8 37088.3 37120.3 14512.9 14530.7 14591.5 14596.5 14617.4 11546.2 11774.5 11846.5 12221.5 12241.9 8148.1 8202.5 8289.5 8340.0 8347.0 3144.4 3207.5 3232.7 3239.4 3266.9 956.6 986.6 1045.5 1060.8 1173.8 32216.2 32539.2 32549.3 32872.5 33137.3 1077.0 1092.6 1138.2 1138.3 1143.3 16187.5 17082.7 17159.9 17177.7 17507.6 507390.0 510704.0 510953.0 512253.0 512328.0 57825.0 58403.7 58447.0 58491.4 58497.0 1185.6 1270.1 1329.8 1354.3 1426.7 30024.6 31568.2 33741.7 33909.2 34071.5 53032.5 54067.7 54094.5 54127.7 54211.5 428332.0 437132.8 437255.0 437558.0 438788.0 38361.4 38658.2 39778.0 43911.6 44180.8 47729.3 47924.0 48010.5 48022.3 48536.3 39990.8 40269.4 40509.0 41404.0 41993.0 40998.0 41105.8 41537.6 42477.0 42702.1 40620.2 41548.4 41623.4 41931.8 42178.2 34551.3 37047.3 37346.6 37540.4 38053.8 27409.3 27700.0 27854.7 28035.6 28051.6 16:40:46 INFO - PROCESS | 28335 | 16:40:46 INFO - PROCESS | 28335 | [#2] jquery.html Cycles:180 Average:25795.44 Median:342681.50 stddev:66973.06 (19.5%) stddev-sans-first:67133.70 16:40:46 INFO - PROCESS | 28335 | Values: 359.4 368.3 375.7 386.9 395.8 13970.5 14264.8 15176.8 18684.4 19653.2 18550.0 19323.0 19711.2 19939.2 19987.2 5599.7 5870.9 5877.9 5880.8 5880.9 5373.1 5500.5 5807.2 5839.9 5853.6 5797.6 5798.9 5804.2 5805.8 5807.2 5365.6 5630.3 5647.8 5731.7 5737.9 5387.6 5525.4 5547.3 5559.7 5572.7 13721.7 13943.1 13945.0 13952.4 19154.0 2137.9 2203.3 2242.6 2538.4 2656.1 9628.3 9982.8 9991.9 10141.6 14117.3 1856.0 1885.3 1896.2 1904.4 1942.3 80939.0 80997.0 82481.0 83245.6 84920.6 10574.5 10709.6 10843.6 10906.1 10956.2 15265.9 15278.9 15293.5 15302.8 15305.5 7526.1 7625.6 7802.0 7805.5 8012.6 7342.6 7405.2 7599.3 7663.5 7676.9 4551.9 4626.2 4666.7 4695.8 4772.1 1909.4 1955.6 1991.1 2000.3 2039.9 939.9 976.6 1026.0 1035.7 1064.9 17413.3 19008.2 20110.2 20673.9 20674.6 943.3 962.3 977.6 985.7 995.6 10265.8 10861.6 10889.9 10945.2 11028.2 340241.0 345122.0 347492.0 476617.0 478364.0 78360.3 80727.5 83627.0 89360.0 96592.5 938.0 1007.0 1050.3 1056.6 1057.8 16901.7 16990.2 17557.7 17702.6 18303.0 28765.9 32696.2 35773.0 41292.0 42205.8 55397.7 56360.2 58839.4 59442.0 59602.5 7182.5 7304.9 7467.9 7590.0 7956.8 12704.2 12818.2 13260.1 13385.5 13580.2 11325.6 11339.4 11725.9 12217.3 12344.1 11396.7 11582.5 11735.2 11922.5 12198.7 11656.5 11673.2 11757.3 11878.8 12378.6 7824.1 7881.3 7891.2 7998.2 8127.0 9818.9 11342.3 11460.8 11668.6 11682.9 16:40:46 INFO - PROCESS | 28335 | 16:40:46 INFO - PROCESS | 28335 | [#3] mootools.html Cycles:180 Average:5747.58 Median:445.82 stddev:3308.85 (742.2%) stddev-sans-first:3302.48 16:40:46 INFO - PROCESS | 28335 | Values: 1465.4 1498.3 1598.8 1743.3 1771.9 8336.9 8982.7 8983.1 8986.1 8987.5 7215.7 7459.4 8283.2 8577.9 8752.6 2270.8 2312.1 2316.7 2319.5 2319.8 2286.4 2290.8 2333.9 2334.2 2339.6 2274.1 2294.2 2299.2 2326.5 2329.1 2231.6 2236.8 2241.1 2252.0 2261.5 2204.1 2240.5 2241.8 2243.2 2250.2 8845.2 8886.3 8890.1 8902.3 8918.0 5104.6 5203.0 5232.3 5249.8 5280.9 3364.7 3372.5 3519.0 3541.6 3559.8 1062.9 1064.3 1082.5 1091.8 1113.5 12151.9 12175.5 12200.9 12256.8 12275.4 4394.8 4409.6 4584.6 4617.3 4705.8 10317.8 10344.4 10346.7 10347.4 10354.1 5233.8 5264.0 5267.2 5275.3 5282.1 4064.7 4161.8 4214.0 4518.4 4867.9 3773.2 3808.1 3928.7 3958.1 4048.6 1233.1 1248.7 1250.1 1263.4 1271.4 770.2 772.2 939.7 942.3 974.3 5637.3 5710.1 6008.7 6015.3 6156.7 443.4 445.5 446.2 456.4 456.9 4174.3 4176.1 4176.6 4178.9 4181.3 10522.3 10818.2 10934.4 10945.5 10948.4 10842.2 10842.9 10843.1 10854.5 10865.5 7691.5 8025.7 8036.1 8192.9 8193.7 5725.8 5829.7 5847.4 5992.2 5997.9 10073.7 10081.0 10098.4 10119.0 10210.5 9736.6 10262.6 10381.5 10387.8 10428.5 6606.5 6792.5 7851.9 7926.3 7980.0 8080.4 8286.5 8347.7 8413.6 8596.7 7528.9 7884.1 7927.7 8019.3 8051.3 7746.0 7758.1 7874.6 7884.3 8005.6 6959.7 7051.0 7076.5 7078.5 7087.7 4962.9 5080.6 5097.8 5189.4 5322.2 5303.5 5379.1 5384.0 5387.9 5455.6 16:40:46 INFO - PROCESS | 28335 | 16:40:46 INFO - PROCESS | 28335 | [#4] prototype.html Cycles:180 Average:4617.46 Median:5179.59 stddev:1350.37 (26.1%) stddev-sans-first:1314.88 16:40:46 INFO - PROCESS | 28335 | Values: 309.6 313.7 321.4 332.2 337.4 4813.9 4979.6 5303.2 5329.9 5335.5 5179.8 5250.3 5266.3 5293.4 5309.3 4202.9 4210.5 4214.0 4223.9 4228.5 3951.8 4201.6 4202.6 4239.2 4247.3 3880.8 4159.3 4165.9 4172.7 4186.2 4128.8 4129.4 4140.0 4146.4 4175.9 3708.8 3709.0 3722.5 3723.7 3724.8 4920.1 5159.4 5169.5 5179.4 5228.5 4652.5 4660.0 4670.0 4677.0 4685.0 5532.8 5542.4 5547.0 5580.4 5612.9 3846.9 3975.8 3977.8 3997.3 4013.2 5428.3 5579.8 5694.6 5716.3 5731.2 3881.4 4035.7 4048.2 4071.1 4078.1 4120.5 4132.4 4134.0 4135.6 4136.9 4526.2 4729.8 4734.5 4741.4 4742.1 5518.7 5535.9 5541.9 5543.5 5555.1 1390.7 1408.9 1409.3 1414.6 1417.4 858.3 886.3 899.3 915.6 920.8 4695.7 4716.3 4720.1 4722.6 4758.9 4942.3 4954.7 4962.4 5019.8 5029.5 4705.7 4715.8 4750.4 4772.8 5001.6 2991.3 3013.8 3015.9 3021.4 3024.7 5789.2 5801.3 5805.5 5807.0 5824.4 5574.7 5767.9 5776.2 5796.4 5813.5 5822.2 5832.9 5845.5 5849.0 5866.0 5471.6 5593.2 5678.2 5696.2 5722.5 5658.4 5662.0 5663.8 5678.4 5679.8 5532.5 5718.5 5734.2 5799.9 5862.4 4073.4 4098.3 4131.2 4136.1 4137.8 5718.4 5800.8 5806.2 5821.3 5823.7 5533.7 5539.0 5545.9 5568.4 5608.8 5509.7 5511.1 5515.4 5520.4 5529.6 5313.5 5508.2 5562.2 5584.6 5601.5 5550.3 5595.4 5596.3 5608.3 5615.9 5399.4 5446.3 5454.5 5477.2 5527.0 16:40:46 INFO - PROCESS | 28335 | 16:40:46 INFO - PROCESS | 28335 | [#5] yui.html Cycles:180 Average:19282.55 Median:4613.28 stddev:25815.80 (559.6%) stddev-sans-first:25850.62 16:40:46 INFO - PROCESS | 28335 | Values: 727.8 734.3 769.6 791.7 798.6 15994.4 16686.9 16688.4 16780.1 16781.6 15796.4 15981.7 15984.1 15984.5 16004.7 666.4 682.0 784.9 803.4 823.8 816.8 821.2 828.2 828.5 828.6 854.1 854.3 854.6 854.6 854.8 696.2 713.3 840.8 857.1 857.5 629.4 630.5 634.8 635.0 635.9 15680.4 15726.4 15751.3 15776.8 15800.8 14476.6 14795.4 14875.9 14956.4 15054.4 12902.2 13049.8 13269.2 13335.7 13472.3 4246.1 4246.6 4298.0 4330.3 4345.0 80617.6 81211.6 81608.6 85037.0 85789.0 11021.2 11195.2 11240.9 11294.1 11607.9 22255.4 22320.9 22328.7 22464.0 22473.6 7808.2 8161.0 8387.7 8521.0 8639.8 4298.9 4396.9 4409.6 4445.8 4642.9 3446.6 3528.5 3559.9 3560.0 3561.6 583.4 601.8 605.9 612.5 623.9 674.6 685.4 704.9 706.1 713.1 9003.5 9335.0 9864.2 10013.1 10108.4 684.4 686.8 701.5 701.9 702.2 4583.6 4835.3 4874.1 4886.1 4944.6 71004.6 72006.0 91034.0 93328.0 95359.5 75586.0 84080.0 91388.0 91525.5 93104.0 50189.2 66138.7 80038.0 80895.0 82235.0 9225.9 9668.3 9698.1 9717.3 9844.1 33997.3 40446.6 44844.3 45348.1 48052.3 68259.7 68647.3 68693.3 71222.0 73134.3 13066.3 13287.3 13401.5 13405.2 13687.9 15057.3 15275.4 15288.7 16033.8 16442.5 13725.5 14253.4 14639.3 14879.8 15279.5 13934.2 14006.6 14022.9 14588.0 14994.2 14197.0 14349.9 14665.2 14733.1 15368.7 10092.2 10231.2 10410.9 10524.6 10769.4 10558.0 10975.5 11078.2 11215.9 11259.1 16:40:46 INFO - PROCESS | 28335 | -------- Summary: end -------- 16:40:46 INFO - PROCESS | 28335 | 16:40:47 INFO - TEST-INFO | 28335: exit 0 16:40:47 INFO - TEST-OK | dromaeo_css | took 1117136ms 16:40:47 INFO - TEST-START | kraken 16:40:47 INFO - operating with platform_type : linux_ 16:40:47 INFO - Initialising browser for kraken test... 16:40:47 INFO - TEST-INFO | started process 28642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVZzoNM/profile http://localhost:59992/getInfo.html) 16:40:51 INFO - PROCESS | 28642 | __metrics Screen width/height:1600/1200 16:40:51 INFO - PROCESS | 28642 | colorDepth:24 16:40:51 INFO - PROCESS | 28642 | Browser inner width/height: 1024/697 16:40:51 INFO - PROCESS | 28642 | __metrics 16:40:51 INFO - PROCESS | 28642 | 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" 16:40:51 INFO - PROCESS | 28642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:40:52 INFO - PROCESS | 28642 | console.error: PushService: 16:40:52 INFO - PROCESS | 28642 | stateChangeProcessEnqueue: Error transitioning state 16:40:52 INFO - PROCESS | 28642 | UnknownError 16:40:53 INFO - TEST-INFO | 28642: exit 0 16:40:53 INFO - Browser initialized. 16:40:53 INFO - Running cycle 1/1 for kraken test... 16:40:53 INFO - TEST-INFO | started process 28728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVZzoNM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:41:05 INFO - PROCESS | 28728 | RSS: Main: 171536384 16:41:05 INFO - PROCESS | 28728 | 16:41:07 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59992/tests/kraken/driver.html?testName=audio-beat-detection) 16:41:08 INFO - PROCESS | 28728 | RSS: Main: 228876288 16:41:08 INFO - PROCESS | 28728 | 16:41:11 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59992/tests/kraken/driver.html?testName=audio-dft) 16:41:11 INFO - PROCESS | 28728 | RSS: Main: 215384064 16:41:11 INFO - PROCESS | 28728 | 16:41:14 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59992/tests/kraken/driver.html?testName=audio-fft) 16:41:15 INFO - PROCESS | 28728 | RSS: Main: 297140224 16:41:15 INFO - PROCESS | 28728 | 16:41:17 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59992/tests/kraken/driver.html?testName=audio-oscillator) 16:41:18 INFO - PROCESS | 28728 | RSS: Main: 208564224 16:41:18 INFO - PROCESS | 28728 | 16:41:20 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59992/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:41:21 INFO - PROCESS | 28728 | RSS: Main: 211238912 16:41:21 INFO - PROCESS | 28728 | 16:41:23 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59992/tests/kraken/driver.html?testName=imaging-darkroom) 16:41:24 INFO - PROCESS | 28728 | RSS: Main: 247246848 16:41:24 INFO - PROCESS | 28728 | 16:41:27 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59992/tests/kraken/driver.html?testName=imaging-desaturate) 16:41:28 INFO - PROCESS | 28728 | RSS: Main: 245960704 16:41:28 INFO - PROCESS | 28728 | 16:41:31 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59992/tests/kraken/driver.html?testName=json-parse-financial) 16:41:31 INFO - PROCESS | 28728 | RSS: Main: 246116352 16:41:31 INFO - PROCESS | 28728 | 16:41:33 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59992/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:41:33 INFO - PROCESS | 28728 | RSS: Main: 208113664 16:41:33 INFO - PROCESS | 28728 | 16:41:35 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59992/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:41:36 INFO - PROCESS | 28728 | RSS: Main: 215273472 16:41:36 INFO - PROCESS | 28728 | 16:41:38 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59992/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:41:38 INFO - PROCESS | 28728 | RSS: Main: 224866304 16:41:38 INFO - PROCESS | 28728 | 16:41:41 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:41:42 INFO - PROCESS | 28728 | RSS: Main: 226471936 16:41:42 INFO - PROCESS | 28728 | 16:41:45 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:41:45 INFO - PROCESS | 28728 | RSS: Main: 229494784 16:41:45 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | Cycle 1(1): loaded http://localhost:59992/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59992/tests/kraken/driver.html?testName=ai-astar) 16:41:47 INFO - PROCESS | 28728 | RSS: Main: 280543232 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | __start_tp_report 16:41:47 INFO - PROCESS | 28728 | _x_x_mozilla_page_load 16:41:47 INFO - PROCESS | 28728 | _x_x_mozilla_page_load_details 16:41:47 INFO - PROCESS | 28728 | |i|pagename|runs| 16:41:47 INFO - PROCESS | 28728 | |0;ai-astar;104;112;113;113;112;111;113;111;111;112 16:41:47 INFO - PROCESS | 28728 | |1;audio-beat-detection;154;123;127;160;127;123;123;123;153;122 16:41:47 INFO - PROCESS | 28728 | |2;audio-dft;161;162;161;162;161;161;161;162;161;161 16:41:47 INFO - PROCESS | 28728 | |3;audio-fft;75;75;75;117;75;76;75;76;109;75 16:41:47 INFO - PROCESS | 28728 | |4;audio-oscillator;83;82;115;83;84;84;114;83;82;117 16:41:47 INFO - PROCESS | 28728 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;118;118;118 16:41:47 INFO - PROCESS | 28728 | |6;imaging-darkroom;145;145;146;145;148;146;146;145;148;145 16:41:47 INFO - PROCESS | 28728 | |7;imaging-desaturate;84;84;84;85;85;84;84;84;85;84 16:41:47 INFO - PROCESS | 28728 | |8;json-parse-financial;55;53;53;53;54;56;55;54;54;54 16:41:47 INFO - PROCESS | 28728 | |9;json-stringify-tinderbox;59;60;59;58;59;59;59;60;58;61 16:41:47 INFO - PROCESS | 28728 | |10;stanford-crypto-aes;90;82;81;83;80;81;85;81;89;84 16:41:47 INFO - PROCESS | 28728 | |11;stanford-crypto-ccm;146;138;142;134;134;131;133;141;169;134 16:41:47 INFO - PROCESS | 28728 | |12;stanford-crypto-pbkdf2;172;169;170;165;166;167;174;165;170;165 16:41:47 INFO - PROCESS | 28728 | |13;stanford-crypto-sha256-iterative;66;70;66;66;67;66;72;66;65;64 16:41:47 INFO - PROCESS | 28728 | __end_tp_report 16:41:47 INFO - PROCESS | 28728 | __start_cc_report 16:41:47 INFO - PROCESS | 28728 | _x_x_mozilla_cycle_collect,1695 16:41:47 INFO - PROCESS | 28728 | __end_cc_report 16:41:47 INFO - PROCESS | 28728 | __startTimestamp1477006907584__endTimestamp 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | ------- Summary: start ------- 16:41:47 INFO - PROCESS | 28728 | Number of tests: 14 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.66 (2.4%) stddev-sans-first:0.87 16:41:47 INFO - PROCESS | 28728 | Values: 104.0 112.0 113.0 113.0 112.0 111.0 113.0 111.0 111.0 112.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:127.00 stddev:15.49 (12.2%) stddev-sans-first:14.55 16:41:47 INFO - PROCESS | 28728 | Values: 154.0 123.0 127.0 160.0 127.0 123.0 123.0 123.0 153.0 122.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:41:47 INFO - PROCESS | 28728 | Values: 161.0 162.0 161.0 162.0 161.0 161.0 161.0 162.0 161.0 161.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:16.03 (21.4%) stddev-sans-first:16.76 16:41:47 INFO - PROCESS | 28728 | Values: 75.0 75.0 75.0 117.0 75.0 76.0 75.0 76.0 109.0 75.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:83.00 stddev:15.65 (18.9%) stddev-sans-first:16.20 16:41:47 INFO - PROCESS | 28728 | Values: 83.0 82.0 115.0 83.0 84.0 84.0 114.0 83.0 82.0 117.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 16:41:47 INFO - PROCESS | 28728 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 118.0 118.0 118.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 16:41:47 INFO - PROCESS | 28728 | Values: 145.0 145.0 146.0 145.0 148.0 146.0 146.0 145.0 148.0 145.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 16:41:47 INFO - PROCESS | 28728 | Values: 84.0 84.0 84.0 85.0 85.0 84.0 84.0 84.0 85.0 84.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.99 (1.8%) stddev-sans-first:1.00 16:41:47 INFO - PROCESS | 28728 | Values: 55.0 53.0 53.0 53.0 54.0 56.0 55.0 54.0 54.0 54.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 16:41:47 INFO - PROCESS | 28728 | Values: 59.0 60.0 59.0 58.0 59.0 59.0 59.0 60.0 58.0 61.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:3.47 (4.2%) stddev-sans-first:2.80 16:41:47 INFO - PROCESS | 28728 | Values: 90.0 82.0 81.0 83.0 80.0 81.0 85.0 81.0 89.0 84.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:139.50 stddev:11.17 (8.0%) stddev-sans-first:11.65 16:41:47 INFO - PROCESS | 28728 | Values: 146.0 138.0 142.0 134.0 134.0 131.0 133.0 141.0 169.0 134.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:169.50 stddev:3.20 (1.9%) stddev-sans-first:3.10 16:41:47 INFO - PROCESS | 28728 | Values: 172.0 169.0 170.0 165.0 166.0 167.0 174.0 165.0 170.0 165.0 16:41:47 INFO - PROCESS | 28728 | 16:41:47 INFO - PROCESS | 28728 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.00 stddev:2.39 (3.6%) stddev-sans-first:2.52 16:41:47 INFO - PROCESS | 28728 | Values: 66.0 70.0 66.0 66.0 67.0 66.0 72.0 66.0 65.0 64.0 16:41:47 INFO - PROCESS | 28728 | -------- Summary: end -------- 16:41:47 INFO - PROCESS | 28728 | 16:41:48 INFO - TEST-INFO | 28728: exit 0 16:41:48 INFO - TEST-OK | kraken | took 61713ms 16:41:48 INFO - SUITE-END | took 1178s 16:41:49 INFO - Completed test suite (00:19:39) 16:41:49 INFO - javascript benchmark 16:41:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3014.6834582368847, 3026.515757478801, 3072.093732348957, 3084.383123375324, 3090.984545077274, 5154.175331946889, 5240.528352448279, 5319.89360212796, 5385.246065550826, 5404.0, 5286.947130528693, 5292.973535132319, 5296.390915044771, 5306.7346632668405, 5315.521603055724, 4791.976040119804, 4819.373481447407, 4834.057358815033, 4861.756912154396, 4877.829275975341, 4812.711237325754, 4849.054434385296, 4874.512548745132, 4905.705657660534, 5016.2224855147515, 4986.177280748672, 4990.0, 4990.925136122961, 5040.0, 5045.722485263309, 271.7897383369028, 4813.229883218668, 4989.401271847401, 4992.900141997158, 5064.012517559077, 3131.4363414585364, 4771.8091276348905, 4787.329773831631, 4884.7069175849565, 4942.8764280893265, 5384.165454354581, 5393.029254734146, 5393.1370980643305, 5397.109476936301, 5399.082156033483, 5484.561235101222, 5609.0, 5742.913856292117, 5750.108733146369, 5810.0, 5559.694216818073, 5633.943660563383, 5679.744411501492, 5719.170720245541, 5759.0, 5357.785688572452, 5371.248025276464, 5385.569154467672, 5390.272313237741, 5392.4337944515655, 5875.9118613220835, 5879.059350503899, 5881.647101173858, 5888.087346461305, 5892.852678683067, 5382.434844341366, 5423.132298832247, 5427.457254274541, 5487.42382049887, 5615.9157612635845, 5699.287589051369, 5702.914456283159, 5703.74333155009, 5732.0255556555485, 5773.134029895549, 5680.431956804369, 5682.204491371212, 5688.516476099578, 5692.402297758758, 5699.316082070178, 5496.725163741797, 5526.088195447786, 5555.749991250404, 5647.858803529944, 5764.538836893123, 4328.913421731548, 4354.390385346054, 4384.8246070157475, 4385.912281754347, 4434.290513517886, 3883.7475564088245, 3885.2618002579984, 3889.3776995680555, 3932.2725295820364, 3939.980300098481, 5210.557102646242, 5388.110961691277, 5398.8920221595345, 5404.0272750905215, 5404.405515393382, 5560.165975103767, 5590.91613625796, 5664.405237450091, 5664.631798933056, 5756.136579513023, 5324.787008519694, 5332.440093790174, 5339.946600533945, 5341.5459685927135, 5343.919841202385, 4762.047590481849, 4915.361003069578, 4923.433805112386, 4924.359833221658, 4988.301637770643, 5606.775728970877, 5669.40471250521, 5808.36108028125, 5817.127430885316, 5903.970480147572, 5662.8301150965535, 5702.800401985911, 5707.0, 5709.200711900255, 5710.143478478261, 5816.302043754777, 5816.331121921034, 5841.32824725162, 5845.240118784531, 5848.824535263949, 5425.782968681208, 5471.8084867029465, 5500.834974950758, 5570.3315602128005, 5581.10702287632, 5655.406182350958, 5659.943400566106, 5662.2639056922335, 5669.234653321749, 5720.056190728483, 5518.392976772471, 5532.3637781655625, 5546.500814926676, 5555.972220139035, 5559.694216817952, 5389.51494365509, 5441.102218133963, 5495.477929596682, 5561.360443549043, 5601.887962240651, 5584.357798853021, 5588.329400471969, 5595.468430499096, 5642.6614403135945, 5653.067243904709, 5594.888102238014, 5607.43925607436, 5623.943760562342, 5624.971875140598, 5643.802466913638, 5315.893682126259, 5359.356877174764, 5365.892682146413, 5429.647072940246, 5514.283143191359], "value": 5200.246949117108, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.5422898338811, 566.3062748133536, 616.42364389296, 622.4304761143551, 639.9584027038245, 32485.0, 44123.33814992774, 45316.38988592165, 45318.5468145318, 45451.545484545146, 45503.31745023819, 45753.08493830122, 46049.76975115128, 46091.76954115233, 46131.538684613144, 8021.358291336679, 8919.24186444153, 9068.637254509811, 9069.909300907006, 9077.455352678828, 8043.235892590224, 10516.842247366296, 10807.729806754816, 10829.783404331909, 11140.888591114106, 10975.725606859813, 11040.0, 11057.668269951873, 11061.668149955514, 11062.446877656084, 10819.513121909533, 10888.727781805439, 10906.61826836065, 10912.127029837673, 10923.344599324026, 10665.36007839532, 10705.625303114353, 10731.463426828705, 10738.08726258269, 10743.301685390425, 43312.13375732499, 43540.3468947966, 43648.127037459075, 43775.34336984948, 43881.34177987333, 3257.4136655402017, 3272.4109660261142, 3338.833058347097, 3341.983290083534, 3357.9328413431595, 31262.531062034086, 31700.841495792603, 31924.521132183036, 32088.518672219936, 32893.0, 4326.545712700153, 4364.432623758891, 4381.561843815625, 4402.823887044515, 4424.668149888771, 333620.0, 335831.0, 337015.0, 337441.0, 339351.0, 34149.48775768365, 59321.40678593245, 59436.702816486504, 59565.70217148887, 59584.702076490204, 34936.650633493846, 36982.815085924936, 37080.81459592739, 37088.258234835695, 37120.257594848496, 14512.854871451362, 14530.709385812224, 14591.489297874523, 14596.489122880648, 14617.415303387745, 11546.249493782878, 11774.470148843322, 11846.526138954345, 12221.450034748457, 12241.938790305992, 8148.144444833207, 8202.466839655403, 8289.502629842229, 8340.04089529712, 8347.0, 3144.371125774854, 3207.5028370602595, 3232.6767323267954, 3239.3521295740948, 3266.918327041843, 956.6460409648336, 986.6300137448313, 1045.4720366215165, 1060.824963880951, 1173.8063219568676, 32216.19459513531, 32539.18652033671, 32549.349013019608, 32872.531418312195, 33137.3372532548, 1077.0468135699805, 1092.579356947565, 1138.1918837625378, 1138.299945533491, 1143.2968724234702, 16187.514374568782, 17082.743758843626, 17159.866054818307, 17177.656446871242, 17507.649847003242, 507390.0, 510704.0, 510953.0, 512253.0, 512328.0, 57825.0, 58403.70798146067, 58447.0, 58491.41508584945, 58497.0, 1185.6050777429543, 1270.142653708743, 1329.7872340425486, 1354.2957662015895, 1426.7289215049107, 30024.64889079953, 31568.210794729395, 33741.66258337385, 33909.152271193416, 34071.4889276666, 53032.469675304295, 54067.72966135144, 54094.459055408945, 54127.72936135452, 54211.45788542064, 428332.0, 437132.80140780954, 437255.0, 437558.0, 438788.0, 38361.4245786319, 38658.2268354637, 39778.0, 43911.56088439075, 44180.779096104314, 47729.28406073842, 47924.0, 48010.51989480061, 48022.27966580574, 48536.271955921395, 39990.800046000746, 40269.39595906122, 40509.0, 41404.0, 41993.0, 40998.0, 41105.79447102745, 41537.58462415337, 42477.0, 42702.145957080065, 40620.1875962485, 41548.37677434902, 41623.37564936589, 41931.7903410481, 42178.1564368717, 34551.30897382089, 37047.25905481929, 37346.626533734314, 37540.436893447164, 38053.809730951165, 27409.31476713098, 27700.0, 27854.721452785212, 28035.57946630843, 28051.626802848194], "value": 19428.64054163035, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.43389162069747, 368.3388317969244, 375.6675342322045, 386.88393481955404, 395.80209895052474, 13970.511032113865, 14264.786028209584, 15176.772348414768, 18684.439466816017, 19653.21387144516, 18550.0, 19323.033848307565, 19711.211551537956, 19939.21154980553, 19987.20051197954, 5599.692016939077, 5870.941290587103, 5877.941220587803, 5880.764769409218, 5880.882382352351, 5373.113436283009, 5500.532454741352, 5807.216025836521, 5839.861227060704, 5853.64878107315, 5797.5651826113, 5798.855028624276, 5804.245448091763, 5805.796797112102, 5807.1579620954935, 5365.597580181482, 5630.296212973379, 5647.802326918538, 5731.742071606787, 5737.942620573783, 5387.649802762808, 5525.364583072917, 5547.33431988164, 5559.694216818073, 5572.693501857396, 13721.70679037034, 13943.093698909539, 13945.0, 13952.372143253579, 19154.0, 2137.8824164670937, 2203.3389983005195, 2242.55148970205, 2538.3780973661387, 2656.070375368625, 9628.27787915902, 9982.800343993153, 9991.900080999243, 10141.645042423479, 14117.294135293298, 1855.9721604175948, 1885.33070759881, 1896.1846406045534, 1904.419152158591, 1942.3295965469686, 80939.0, 80997.0, 82481.0, 83245.58377208136, 84920.57539712262, 10574.471276436147, 10709.609060285246, 10843.566257349617, 10906.127509799197, 10956.233063685466, 15265.923670381577, 15278.923605381902, 15293.541193764206, 15302.846971530142, 15305.540833775005, 7526.086356194737, 7625.618719064025, 7802.0, 7805.492642978188, 8012.599370031475, 7342.632868356561, 7405.222451642608, 7599.278068583586, 7663.463557551029, 7676.886851406626, 4551.931721024187, 4626.167289887785, 4666.673332866734, 4695.788689508912, 4772.141014617333, 1909.3699079303797, 1955.5697746495748, 1991.143808162504, 2000.2699014859763, 2039.9082041308177, 939.9201067909304, 976.584951395654, 1025.9794804103876, 1035.7255327338262, 1064.8722153341494, 17413.3034678614, 19008.239670413306, 20110.195592176147, 20673.896630516752, 20674.58650826975, 943.2783920300975, 962.31675510387, 977.5942983661843, 985.69936169469, 995.6017592962872, 10265.846012309821, 10861.565537378574, 10889.945550272198, 10945.179111566664, 11028.22802403824, 340241.0, 345122.0, 347492.0, 476617.0, 478364.0, 78360.33937115408, 80727.4752709131, 83627.0, 89360.0, 96592.51703741578, 937.9953100234592, 1006.9899301006897, 1050.2595670052594, 1056.5984925728173, 1057.7937302225992, 16901.661966760843, 16990.23543940501, 17557.736633950244, 17702.557436063686, 18303.0, 28765.856170719013, 32696.18259543435, 35773.0, 41292.0, 42205.78897105495, 55397.737214964516, 56360.154597680244, 58839.41160588339, 59442.0, 59602.50993725018, 7182.4972251943955, 7304.890426643498, 7467.92532074694, 7589.962050189713, 7956.761297161094, 12704.237745735285, 12818.166819156724, 13260.07179497426, 13385.531506397228, 13580.185188888698, 11325.603603873826, 11339.376334301363, 11725.88274117248, 12217.266963981834, 12344.074194435632, 11396.715082123013, 11582.536698531965, 11735.23720958135, 11922.463489142836, 12198.695032624255, 11656.475458604213, 11673.182877198515, 11757.294562325946, 11878.762424751283, 12378.566750164062, 7824.100228473799, 7881.290683838482, 7891.224474493193, 7998.200179981955, 8127.0, 9818.852717209105, 11342.262752921033, 11460.770784584429, 11668.649940501798, 11682.94158529202], "value": 8891.167108643025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.384538493833, 1498.2733374313457, 1598.7521934100212, 1743.3026789284277, 1771.9379821706234, 8336.916630833697, 8982.730518084452, 8983.101689831014, 8986.05646407127, 8987.460752354864, 7215.711371545145, 7459.365953893912, 8283.171682831713, 8577.871331930026, 8752.649894004233, 2270.829687773415, 2312.075169932032, 2316.7219933607907, 2319.489712263308, 2319.8376113672048, 2286.3941055620276, 2290.8167346612313, 2333.929982100531, 2334.241371554243, 2339.63735620979, 2274.0676322707695, 2294.2314324701247, 2299.2297580310615, 2326.5230627721276, 2329.1149363241943, 2231.631780756173, 2236.798688118061, 2241.081156725743, 2252.0, 2261.4685548896077, 2204.0963205086, 2240.484688521633, 2241.764614715464, 2243.203662699734, 2250.246167533878, 8845.248153906861, 8886.333524985588, 8890.110988901122, 8902.287816974691, 8918.0, 5104.64267501275, 5202.97398513005, 5232.3459567554055, 5249.763760630781, 5280.894382112375, 3364.680355366236, 3372.5109859070544, 3519.0, 3541.592716837571, 3559.839807208682, 1062.9468526573717, 1064.2816099133054, 1082.5020490574345, 1091.825307950732, 1113.5378817790606, 12151.878481215163, 12175.51297948081, 12200.877991220152, 12256.81614775779, 12275.386230688518, 4394.75867307669, 4409.559044095629, 4584.633229341644, 4617.3304870793545, 4705.764711764398, 10317.84523232152, 10344.37933723964, 10346.689599312032, 10347.379157250589, 10354.11989980845, 5233.842984710464, 5264.0261551613075, 5267.236250743621, 5275.314209152785, 5282.128448805981, 4064.695147863863, 4161.83352665896, 4214.009707718745, 4518.412606361152, 4867.853964381075, 3773.2453509298252, 3808.1241314497265, 3928.685705143582, 3958.089639382958, 4048.554658987509, 1233.1244816180433, 1248.7003119251497, 1250.0686988193854, 1263.3935710858839, 1271.446920589528, 770.2143813310504, 772.2316295286226, 939.6899023322287, 942.2885721280527, 974.2595627323285, 5637.267155269788, 5710.143478478261, 6008.669523176267, 6015.3383127855905, 6156.6921653917125, 443.3925522034833, 445.46099219943585, 446.18125739268805, 456.4408599465628, 456.92917597772396, 4174.332106862948, 4176.1230141670585, 4176.58234176586, 4178.895527611773, 4181.330987042059, 10522.263441559171, 10818.24272300947, 10934.398608076473, 10945.507452164671, 10948.397838118979, 10842.186835987333, 10842.891571084347, 10843.07833834117, 10854.511546980404, 10865.45672716361, 7691.538507689556, 8025.678972841138, 8036.075851277061, 8192.877106843402, 8193.71322003727, 5725.826205627753, 5829.679367634821, 5847.44449277318, 5992.221011268507, 5997.880042399215, 10073.748156296151, 10081.0, 10098.394096353948, 10119.0, 10210.540525676512, 9736.561854716696, 10262.58949642006, 10381.53283102247, 10387.792244154924, 10428.478576071015, 6606.504512161703, 6792.456603471809, 7851.9214807851195, 7926.286634202949, 7980.042394912648, 8080.393970452122, 8286.461380010522, 8347.749567512985, 8413.579321034047, 8596.656133754579, 7528.887066694114, 7884.053913530413, 7927.722529711433, 8019.318357939641, 8051.315638170587, 7746.0, 7758.146603873683, 7874.645640946057, 7884.329831964118, 8005.599720014093, 6959.686814093479, 7051.012858199959, 7076.504644674823, 7078.539894906815, 7087.681054352463, 4962.925556116589, 5080.593552515864, 5097.7706003229205, 5189.351331083614, 5322.201669749568, 5303.496167864047, 5379.090422899814, 5383.973080134574, 5387.865303367447, 5455.563554915677], "value": 4503.518052326807, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.5836100444902, 313.69728212275163, 321.3620962389656, 332.24248712934485, 337.3809060374213, 4813.868740845898, 4979.576735977437, 5303.204519322104, 5329.893402131955, 5335.519803217705, 5179.792808287664, 5250.343707036621, 5266.262723218752, 5293.364796224449, 5309.33633295838, 4202.936955945664, 4210.452641156646, 4213.957860421395, 4223.894402639928, 4228.534861165269, 3951.802409879509, 4201.558836322188, 4202.621764041236, 4239.236937351276, 4247.320428731404, 3880.7671539707567, 4159.2721273777115, 4165.895852603694, 4172.7287726297845, 4186.204621121992, 4128.834846606147, 4129.359949207863, 4140.0, 4146.4402305688645, 4175.8516407988045, 3708.8145592720525, 3708.9814550927344, 3722.497462842509, 3723.696706152852, 3724.832382542792, 4920.138975679278, 5159.406668233164, 5169.508896654812, 5179.378474583036, 5228.529432351069, 4652.464966528825, 4660.0, 4669.95330046702, 4677.0, 4684.953150468486, 5532.834014979557, 5542.39033706292, 5546.975353995803, 5580.38615752271, 5612.859678508029, 3846.903827404309, 3975.7813320267373, 3977.8209980550655, 3997.3004724173443, 4013.237484877864, 5428.294321738188, 5579.804706835242, 5694.572907031989, 5716.256886604715, 5731.168980497804, 3881.398383250544, 4035.6771458283265, 4048.2105989332385, 4071.1043570414463, 4078.1435898461064, 4120.526139493936, 4132.380142978577, 4133.979330103391, 4135.627793498599, 4136.91726165475, 4526.23054080807, 4729.753367150576, 4734.455537613149, 4741.383620129361, 4742.099001189832, 5518.688786727931, 5535.916961245584, 5541.9168712469345, 5543.501084902378, 5555.138953462219, 1390.7218556288783, 1408.9154650720989, 1409.344654735553, 1414.6463384153963, 1417.4401111560876, 858.3262139220682, 886.3131073418024, 899.2850683706469, 915.5579961560569, 920.769807548113, 4695.718256904528, 4716.339712440261, 4720.12677654635, 4722.598579120813, 4758.904821903542, 4942.2949082567175, 4954.702717836942, 4962.404511458648, 5019.799208031638, 5029.485257371314, 4705.670603057822, 4715.7642117893965, 4750.429948406213, 4772.832950846704, 5001.624878134155, 2991.2970451943775, 3013.804102733315, 3015.909522714322, 3021.3806169735153, 3024.652165001053, 5789.218455508537, 5801.3328467225965, 5805.461552688541, 5806.996586177762, 5824.446677565625, 5574.721263936868, 5767.914165921212, 5776.249087618667, 5796.449337312949, 5813.5349172066135, 5822.155787410717, 5832.854178645568, 5845.532357411482, 5849.005669036274, 5866.0, 5471.644343117685, 5593.161025846156, 5678.176664383559, 5696.231008813757, 5722.483541861493, 5658.377578466448, 5661.999999999835, 5663.830085097454, 5678.3753787084215, 5679.801206957736, 5532.529734972572, 5718.456746609066, 5734.168545560787, 5799.913001305068, 5862.443067908542, 4073.429719839284, 4098.303288440912, 4131.173765246903, 4136.110736191733, 4137.751734895915, 5718.42598376015, 5800.767969281182, 5806.158107074366, 5821.27234095738, 5823.650580965155, 5533.727242734113, 5538.97230513861, 5545.944540554704, 5568.359638641608, 5608.756497400909, 5509.669419834822, 5511.145772405283, 5515.448455154453, 5520.392756796829, 5529.585281103853, 5313.54834839043, 5508.20131080999, 5562.193481945176, 5584.636998595079, 5601.495865372136, 5550.334899530206, 5595.356533998643, 5596.272484576979, 5608.270924779753, 5615.859603509945, 5399.43305952885, 5446.284420407559, 5454.4545545445135, 5477.178423236546, 5526.972365138148], "value": 4183.000586809779, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.8398752274501, 734.313416955147, 769.6498093367518, 791.6674996501469, 798.6326289906642, 15994.360225590977, 16686.91656541717, 16688.41590544331, 16780.077095759727, 16781.580460488494, 15796.44712435065, 15981.680366392666, 15984.120873351962, 15984.520464386087, 16004.679906401894, 666.3636227402818, 682.0315152483486, 784.945053846231, 803.3653413803089, 823.8105235795771, 816.7549735079482, 821.1911267401605, 828.2090603473669, 828.5153185386556, 828.5774255129897, 854.0818619983512, 854.2653318146389, 854.5855260198798, 854.5940678177878, 854.8162145138793, 696.2306651150457, 713.2688993781363, 840.7898025493627, 857.0529564830865, 857.5197889182047, 629.3957800511514, 630.5176539946945, 634.815903388017, 635.0347471842773, 635.8537536366615, 15680.372785088583, 15726.37094516218, 15751.291191896393, 15776.842231577652, 15800.762988555181, 14476.565703028926, 14795.40818367264, 14875.909124990605, 14956.40174393023, 15054.397824087024, 12902.225866448043, 13049.804252936214, 13269.203847769068, 13335.73328533424, 13472.326383680776, 4246.11384824536, 4246.639035681971, 4297.97851010746, 4330.328799036154, 4344.978275108604, 80617.59691201565, 81211.59394203051, 81608.59195703984, 85037.0, 85789.0, 11021.228514004104, 11195.160362972809, 11240.887591123985, 11294.096472282197, 11607.883921160848, 22255.44361390978, 22320.88839555792, 22328.665070023962, 22464.0, 22473.550528989657, 7808.219178082147, 8160.959195203986, 8387.664493420318, 8520.957395213109, 8639.827203455896, 4298.871033868989, 4396.912061758747, 4409.581089796464, 4445.755483448442, 4642.930356044662, 3446.603640581365, 3528.4530897710897, 3559.857605695795, 3559.982200089035, 3561.5726112866105, 583.3670467542679, 601.8164459839791, 605.9492294014527, 612.4549151255386, 623.9064140378889, 674.6019848289435, 685.3934268172603, 704.8836941904631, 706.1138271469273, 713.1014921199326, 9003.549822508849, 9334.953325233331, 9864.210863130933, 10013.09882110599, 10108.39349639024, 684.3635419060222, 686.7630667419733, 701.4738945790657, 701.8982247574073, 702.153904545022, 4583.633309335311, 4835.2505361669, 4874.073925954058, 4886.120498310338, 4944.554990050912, 71004.64497677582, 72006.0, 91034.0, 93328.0, 95359.52320238354, 75586.0, 84080.0, 91388.0, 91525.54237228772, 93104.0, 50189.23580731387, 66138.66930665316, 80038.0, 80895.0, 82234.9999999988, 9225.861612075958, 9668.323217374716, 9698.078682525149, 9717.271204659537, 9844.064813842673, 33997.32005359929, 40446.59553404428, 44844.32733508935, 45348.09303813971, 48052.27921581249, 68259.65870170816, 68647.31352686409, 68693.3130668687, 71222.0, 73134.26865731487, 13066.281354525212, 13287.335633218107, 13401.476999024359, 13405.195688258736, 13687.851794087615, 15057.322420491324, 15275.388984440498, 15288.694226115193, 16033.759493607839, 16442.506724798277, 13725.45098196061, 14253.429862805786, 14639.341229644479, 14879.776803347742, 15279.465218717292, 13934.163950163023, 14006.64983375383, 14022.859771402156, 14588.0, 14994.175320357484, 14197.0, 14349.856501434851, 14665.193414362313, 14733.116013039253, 15368.692626147638, 10092.24308176875, 10231.181505479693, 10410.947945260225, 10524.631637892637, 10769.353838769699, 10558.0, 10975.52451044024, 11078.169137314573, 11215.887841121485, 11259.09927205838], "value": 7486.039401034476, "unit": "score"}], "name": "dromaeo_css", "value": 7086.966786429244, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 113.0, 112.0, 111.0, 113.0, 111.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 127.0, 160.0, 127.0, 123.0, 123.0, 123.0, 153.0, 122.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 117.0, 75.0, 76.0, 75.0, 76.0, 109.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 115.0, 83.0, 84.0, 84.0, 114.0, 83.0, 82.0, 117.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 118.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 148.0, 146.0, 146.0, 145.0, 148.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 54.0, 56.0, 55.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 60.0, 58.0, 61.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 81.0, 83.0, 80.0, 81.0, 85.0, 81.0, 89.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 138.0, 142.0, 134.0, 134.0, 131.0, 133.0, 141.0, 169.0, 134.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 170.0, 165.0, 166.0, 167.0, 174.0, 165.0, 170.0, 165.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 66.0, 66.0, 67.0, 66.0, 72.0, 66.0, 65.0, 64.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1500.9999999999998, "alertThreshold": 2.0}]} 16:41:49 INFO - Return code: 0 16:41:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:41:49 INFO - # TBPL SUCCESS # 16:41:49 INFO - Running post-action listener: _resource_record_post_action 16:41:49 INFO - [mozharness: 2016-10-20 23:41:49.385843Z] Finished run-tests step (success) 16:41:49 INFO - Running post-run listener: _resource_record_post_run 16:41:49 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392785920; Read time: 20; Write time: 320804 16:41:49 INFO - TinderboxPrint: CPU usage
13.1% 16:41:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 16:41:49 INFO - TinderboxPrint: I/O write bytes / time
392,785,920 / 320,804 16:41:49 INFO - TinderboxPrint: CPU idle
8,293.8 (86.9%) 16:41:49 INFO - TinderboxPrint: CPU user
1,198.8 (12.6%) 16:41:49 INFO - TinderboxPrint: Swap in / out
0 / 0 16:41:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105209856; Read time: 0; Write time: 99464 16:41:49 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287240192; Read time: 0; Write time: 221336 16:41:50 INFO - Running post-run listener: _upload_blobber_files 16:41:50 INFO - Blob upload gear active. 16:41:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:41:50 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 16:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:41:50 INFO - (blobuploader) - INFO - Open directory for files ... 16:41:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:41:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:41:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:51 INFO - (blobuploader) - INFO - Done attempting. 16:41:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:41:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:41:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:56 INFO - (blobuploader) - INFO - Done attempting. 16:41:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:41:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:41:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:56 INFO - (blobuploader) - INFO - Done attempting. 16:41:56 INFO - (blobuploader) - INFO - Iteration through files over. 16:41:56 INFO - Return code: 0 16:41:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:41:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:41:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13e88d6fbb76aa7947181fb4f9f67cf4b00b09dd7ae96c37c3d66947c1c5b04866c276a311949beb3776acddea2ce5d6914566d415d2cc0a230ca57e893add8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/623e9086d6f53ea26f5606804d8d9371e11822549ac0a8f81ea9687d836f79786b77d3e9b9a3ec5306b2138d31212c8a7a9635fcca4e30b790dbc699c0d4b14c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b3dcab882b3e6e0fea996c612198fa32fa5d34872815b612b806873ae21e6cb6551ccd1c1a3135dc7407a8a370ab93df4047006d77a5d5cff1e4b6d863467cc"} 16:41:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:41:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:41:56 INFO - Contents: 16:41:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13e88d6fbb76aa7947181fb4f9f67cf4b00b09dd7ae96c37c3d66947c1c5b04866c276a311949beb3776acddea2ce5d6914566d415d2cc0a230ca57e893add8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/623e9086d6f53ea26f5606804d8d9371e11822549ac0a8f81ea9687d836f79786b77d3e9b9a3ec5306b2138d31212c8a7a9635fcca4e30b790dbc699c0d4b14c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b3dcab882b3e6e0fea996c612198fa32fa5d34872815b612b806873ae21e6cb6551ccd1c1a3135dc7407a8a370ab93df4047006d77a5d5cff1e4b6d863467cc"} 16:41:56 INFO - Running post-run listener: copy_logs_to_upload_dir 16:41:56 INFO - Copying logs to upload dir... 16:41:56 INFO - mkdir: /builds/slave/test/build/upload/logs 16:41:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.017281 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-20 16:41:56.597036) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 16:41:56.601121) ========= 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=cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13e88d6fbb76aa7947181fb4f9f67cf4b00b09dd7ae96c37c3d66947c1c5b04866c276a311949beb3776acddea2ce5d6914566d415d2cc0a230ca57e893add8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/623e9086d6f53ea26f5606804d8d9371e11822549ac0a8f81ea9687d836f79786b77d3e9b9a3ec5306b2138d31212c8a7a9635fcca4e30b790dbc699c0d4b14c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b3dcab882b3e6e0fea996c612198fa32fa5d34872815b612b806873ae21e6cb6551ccd1c1a3135dc7407a8a370ab93df4047006d77a5d5cff1e4b6d863467cc"} build_url:https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/LIow__kUSlSJqMDmB286Mw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13e88d6fbb76aa7947181fb4f9f67cf4b00b09dd7ae96c37c3d66947c1c5b04866c276a311949beb3776acddea2ce5d6914566d415d2cc0a230ca57e893add8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/623e9086d6f53ea26f5606804d8d9371e11822549ac0a8f81ea9687d836f79786b77d3e9b9a3ec5306b2138d31212c8a7a9635fcca4e30b790dbc699c0d4b14c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b3dcab882b3e6e0fea996c612198fa32fa5d34872815b612b806873ae21e6cb6551ccd1c1a3135dc7407a8a370ab93df4047006d77a5d5cff1e4b6d863467cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 16:41:56.629771) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:41:56.630652) ========= 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=cbe409c6de289db6ac707de3000001d4-1477005673.879203-1411409177 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 16:41:56.713667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 16:41:56.714270) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 16:41:56.714698) ========= ========= Total master_lag: 0.18 =========