builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1484259496.21 results: success (0) buildid: 20170112123541 builduid: dea6d35996314dbb9632b89c473d34c8 revision: 98ecf719163d1c0cf19359186ab1cac6f34bb621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:16.210794) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:16.211375) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:16.211665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:16.226810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:16.227225) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 14:18:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.4M=0s 2017-01-12 14:18:16 (45.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:16.405036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:16.405362) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:16.455107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:16.455469) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 98ecf719163d1c0cf19359186ab1cac6f34bb621 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 98ecf719163d1c0cf19359186ab1cac6f34bb621 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 14:18:16,715 truncating revision to first 12 chars 2017-01-12 14:18:16,715 Setting DEBUG logging. 2017-01-12 14:18:16,715 attempt 1/10 2017-01-12 14:18:16,715 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/98ecf719163d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 14:18:17,039 unpacking tar archive at: mozilla-aurora-98ecf719163d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:17.084452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:17.084778) ========= script_repo_revision: 98ecf719163d1c0cf19359186ab1cac6f34bb621 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:17.085192) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:17.085459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 14:18:17.096172) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-12 14:18:17.096558) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:18:17 INFO - MultiFileLogger online at 20170112 14:18:17 in /builds/slave/test 14:18:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:18:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:18:17 INFO - {'append_to_log': False, 14:18:17 INFO - 'base_work_dir': '/builds/slave/test', 14:18:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:18:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:18:17 INFO - 'branch': 'Mozilla-Aurora', 14:18:17 INFO - 'buildbot_json_path': 'buildprops.json', 14:18:17 INFO - 'config_files': ('talos/linux_config.py',), 14:18:17 INFO - 'default_actions': ('clobber', 14:18:17 INFO - 'read-buildbot-config', 14:18:17 INFO - 'download-and-extract', 14:18:17 INFO - 'populate-webroot', 14:18:17 INFO - 'create-virtualenv', 14:18:17 INFO - 'install', 14:18:17 INFO - 'run-tests'), 14:18:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:18:17 INFO - 'download_minidump_stackwalk': True, 14:18:17 INFO - 'download_symbols': 'ondemand', 14:18:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:18:17 INFO - 'tooltool.py': '/tools/tooltool.py', 14:18:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:18:17 INFO - '/tools/misc-python/virtualenv.py')}, 14:18:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:18:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:18:17 INFO - 'installer_path': 'installer.exe', 14:18:17 INFO - 'log_level': 'info', 14:18:17 INFO - 'log_name': 'talos', 14:18:17 INFO - 'log_to_console': True, 14:18:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:18:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:18:17 INFO - 'opt_config_files': (), 14:18:17 INFO - 'pip_index': False, 14:18:17 INFO - 'sps_profile': False, 14:18:17 INFO - 'sps_profile_interval': 0, 14:18:17 INFO - 'suite': 'dromaeojs', 14:18:17 INFO - 'system_bits': '32', 14:18:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:18:17 INFO - 'title': 'talos-linux64-ix-023', 14:18:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:18:17 INFO - 'use_talos_json': True, 14:18:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:18:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:18:17 INFO - 'work_dir': 'build'} 14:18:17 INFO - [mozharness: 2017-01-12 22:18:17.451644Z] Running clobber step. 14:18:17 INFO - Running pre-action listener: _resource_record_pre_action 14:18:17 INFO - Running main action method: clobber 14:18:17 INFO - rmtree: /builds/slave/test/build 14:18:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:18:17 INFO - Running post-action listener: _resource_record_post_action 14:18:17 INFO - [mozharness: 2017-01-12 22:18:17.901197Z] Finished clobber step (success) 14:18:17 INFO - [mozharness: 2017-01-12 22:18:17.901296Z] Running read-buildbot-config step. 14:18:17 INFO - Running pre-action listener: _resource_record_pre_action 14:18:17 INFO - Running main action method: read_buildbot_config 14:18:17 INFO - Using buildbot properties: 14:18:17 INFO - { 14:18:17 INFO - "project": "", 14:18:17 INFO - "product": "firefox", 14:18:17 INFO - "script_repo_revision": "production", 14:18:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:18:17 INFO - "repository": "", 14:18:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:18:17 INFO - "buildid": "20170112123541", 14:18:17 INFO - "pgo_build": "True", 14:18:17 INFO - "basedir": "/builds/slave/test", 14:18:17 INFO - "buildnumber": 698, 14:18:17 INFO - "slavename": "talos-linux64-ix-023", 14:18:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:18:17 INFO - "platform": "ubuntu64_hw", 14:18:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:18:17 INFO - "branch": "mozilla-aurora", 14:18:17 INFO - "repo_path": "releases/mozilla-aurora", 14:18:17 INFO - "revision": "98ecf719163d1c0cf19359186ab1cac6f34bb621", 14:18:17 INFO - "stage_platform": "linux64-pgo", 14:18:17 INFO - "builduid": "dea6d35996314dbb9632b89c473d34c8", 14:18:17 INFO - "slavebuilddir": "test" 14:18:17 INFO - } 14:18:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 14:18:17 INFO - Running post-action listener: _resource_record_post_action 14:18:17 INFO - [mozharness: 2017-01-12 22:18:17.903699Z] Finished read-buildbot-config step (success) 14:18:17 INFO - [mozharness: 2017-01-12 22:18:17.903788Z] Running download-and-extract step. 14:18:17 INFO - Running pre-action listener: _resource_record_pre_action 14:18:17 INFO - Running main action method: download_and_extract 14:18:17 INFO - mkdir: /builds/slave/test/build/tests 14:18:17 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')]} 14:18:17 INFO - trying https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:18:17 INFO - Downloading https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:18:18 INFO - Downloaded 1361 bytes. 14:18:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 14:18:18 INFO - Using the following test package requirements: 14:18:18 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:18:18 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:18:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:18:18 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:18:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:18:18 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:18:18 INFO - u'jsshell-linux-x86_64.zip'], 14:18:18 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:18:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:18:18 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 14:18:18 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:18:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:18:18 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:18:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:18:18 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:18:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:18:18 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 14:18:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:18:18 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:18:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:18:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:18:18 INFO - Fetch https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:18:19 INFO - Http code: 200 14:18:19 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 14:18:19 INFO - x-amz-cf-id: --neo_Lfe66zf19UP2jy6FwV3PdNTQ54CmzTTnBMuLiA1oK7g2YanA== 14:18:19 INFO - x-amz-version-id: MrPY2VgdA4k3gJT.pS4tlyi7U3uvK7GR 14:18:19 INFO - Expected file size: 21949108 14:18:19 INFO - Obtained file size: 21949108 14:18:23 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:18:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:18:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:18:23 INFO - Fetch https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:18:23 INFO - Http code: 200 14:18:23 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 14:18:23 INFO - x-amz-cf-id: G6haDUDEXqPblyT0pbyeluMcXpLW6gxFhq4usAYc-gQg5Q57wzy57A== 14:18:23 INFO - x-amz-version-id: MrPY2VgdA4k3gJT.pS4tlyi7U3uvK7GR 14:18:24 INFO - Expected file size: 21949108 14:18:24 INFO - Obtained file size: 21949108 14:18:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 14:18:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:18:28 INFO - Fetch https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:18:28 INFO - Http code: 200 14:18:28 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 14:18:28 INFO - x-amz-cf-id: tgh-J9Yme2NmTIGmIsPq-E2PU3oE-FwPh9RvOvxPaPenFK1UNuN2dA== 14:18:28 INFO - x-amz-version-id: cBPSOUFTUvx8pPHRes2xsRnBG0McsMRY 14:18:29 INFO - Expected file size: 14409038 14:18:29 INFO - Obtained file size: 14409038 14:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:29 INFO - trying https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:18:29 INFO - Downloading https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:18:30 INFO - Downloaded 64142325 bytes. 14:18:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:18:30 INFO - mkdir: /builds/slave/test/properties 14:18:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:18:30 INFO - Writing to file /builds/slave/test/properties/build_url 14:18:30 INFO - Contents: 14:18:30 INFO - build_url:https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:18:31 INFO - Running post-action listener: _resource_record_post_action 14:18:31 INFO - Running post-action listener: set_extra_try_arguments 14:18:31 INFO - [mozharness: 2017-01-12 22:18:31.139137Z] Finished download-and-extract step (success) 14:18:31 INFO - [mozharness: 2017-01-12 22:18:31.139362Z] Running populate-webroot step. 14:18:31 INFO - Running pre-action listener: _resource_record_pre_action 14:18:31 INFO - Running main action method: populate_webroot 14:18:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:31 INFO - '--tppagecycles', 14:18:31 INFO - '7'], 14:18:31 INFO - 'tests': ['tsvgm']}}, 14:18:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:18:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:18:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:31 INFO - 'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:31 INFO - 'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['damp', 'tps']}, 14:18:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:31 INFO - 'tests': ['damp', 'tps']}, 14:18:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['dromaeo_dom']}, 14:18:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['basic_compositor_video']}, 14:18:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:18:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['a11yr', 14:18:31 INFO - 'ts_paint', 14:18:31 INFO - 'tpaint', 14:18:31 INFO - 'sessionrestore', 14:18:31 INFO - 'sessionrestore_no_auto_restore', 14:18:31 INFO - 'tabpaint']}, 14:18:31 INFO - 'other-e10s': {'tests': ['a11yr', 14:18:31 INFO - 'ts_paint', 14:18:31 INFO - 'tpaint', 14:18:31 INFO - 'sessionrestore', 14:18:31 INFO - 'sessionrestore_no_auto_restore', 14:18:31 INFO - 'tabpaint']}, 14:18:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:18:31 INFO - 'ts_paint', 14:18:31 INFO - 'tpaint', 14:18:31 INFO - 'sessionrestore', 14:18:31 INFO - 'sessionrestore_no_auto_restore', 14:18:31 INFO - 'tabpaint']}, 14:18:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:18:31 INFO - 'ts_paint', 14:18:31 INFO - 'tpaint', 14:18:31 INFO - 'sessionrestore', 14:18:31 INFO - 'sessionrestore_no_auto_restore', 14:18:31 INFO - 'tabpaint']}, 14:18:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['a11yr', 14:18:31 INFO - 'ts_paint', 14:18:31 INFO - 'tpaint', 14:18:31 INFO - 'sessionrestore', 14:18:31 INFO - 'sessionrestore_no_auto_restore', 14:18:31 INFO - 'tabpaint']}, 14:18:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['a11yr', 14:18:31 INFO - 'ts_paint', 14:18:31 INFO - 'tpaint', 14:18:31 INFO - 'sessionrestore', 14:18:31 INFO - 'sessionrestore_no_auto_restore', 14:18:31 INFO - 'tabpaint']}, 14:18:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['tsvgx', 14:18:31 INFO - 'tsvgr_opacity', 14:18:31 INFO - 'tart', 14:18:31 INFO - 'tscrollx', 14:18:31 INFO - 'cart']}, 14:18:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:18:31 INFO - 'tsvgr_opacity', 14:18:31 INFO - 'tart', 14:18:31 INFO - 'tscrollx', 14:18:31 INFO - 'cart']}, 14:18:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:31 INFO - 'talos_options': ['--disable-e10s'], 14:18:31 INFO - 'tests': ['tp5o']}, 14:18:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:31 INFO - 'tests': ['tp5o']}, 14:18:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:31 INFO - 'talos_options': ['--disable-e10s', 14:18:31 INFO - '--xperf_path', 14:18:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:31 INFO - 'tests': ['tp5n']}, 14:18:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:31 INFO - 'talos_options': ['--xperf_path', 14:18:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:31 INFO - 'tests': ['tp5n']}}, 14:18:31 INFO - 'talos.zip': {'path': '', 14:18:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:31 INFO - Running post-action listener: _resource_record_post_action 14:18:31 INFO - [mozharness: 2017-01-12 22:18:31.160564Z] Finished populate-webroot step (success) 14:18:31 INFO - [mozharness: 2017-01-12 22:18:31.160651Z] Running create-virtualenv step. 14:18:31 INFO - Running pre-action listener: _resource_record_pre_action 14:18:31 INFO - Running main action method: create_virtualenv 14:18:31 INFO - Creating virtualenv /builds/slave/test/build/venv 14:18:31 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 14:18:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:18:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:31 INFO - Using real prefix '/usr' 14:18:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:18:31 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:33 INFO - Installing pip.................done. 14:18:33 INFO - Return code: 0 14:18:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:18:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:18:33 INFO - Reading from file tmpfile_stdout 14:18:33 INFO - Output received: 14:18: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) 14:18:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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 0x7f3cca489f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', '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 14:18: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 14:18: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 14:18:33 INFO - Using env: {'DISPLAY': ':0', 14:18:33 INFO - 'HOME': '/home/cltbld', 14:18:33 INFO - 'LANG': 'en_US.UTF-8', 14:18:33 INFO - 'LANGUAGE': 'en_US:en', 14:18:33 INFO - 'LOGNAME': 'cltbld', 14:18:33 INFO - 'MAIL': '/var/mail/cltbld', 14:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:33 INFO - 'MOZ_NO_REMOTE': '1', 14:18:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:33 INFO - 'NO_EM_RESTART': '1', 14:18:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:33 INFO - 'PWD': '/builds/slave/test', 14:18:33 INFO - 'SHELL': '/bin/bash', 14:18:33 INFO - 'SHLVL': '1', 14:18:33 INFO - 'TERM': 'linux', 14:18:33 INFO - 'TMOUT': '86400', 14:18:33 INFO - 'USER': 'cltbld', 14:18:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:33 INFO - '_': '/tools/buildbot/bin/python'} 14:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:34 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 14:18:34 INFO - Cleaning up... 14:18:34 INFO - Return code: 0 14:18:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3cca489f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', '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 14:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:18:34 INFO - Using env: {'DISPLAY': ':0', 14:18:34 INFO - 'HOME': '/home/cltbld', 14:18:34 INFO - 'LANG': 'en_US.UTF-8', 14:18:34 INFO - 'LANGUAGE': 'en_US:en', 14:18:34 INFO - 'LOGNAME': 'cltbld', 14:18:34 INFO - 'MAIL': '/var/mail/cltbld', 14:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:34 INFO - 'MOZ_NO_REMOTE': '1', 14:18:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:34 INFO - 'NO_EM_RESTART': '1', 14:18:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:34 INFO - 'PWD': '/builds/slave/test', 14:18:34 INFO - 'SHELL': '/bin/bash', 14:18:34 INFO - 'SHLVL': '1', 14:18:34 INFO - 'TERM': 'linux', 14:18:34 INFO - 'TMOUT': '86400', 14:18:34 INFO - 'USER': 'cltbld', 14:18:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:34 INFO - '_': '/tools/buildbot/bin/python'} 14:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:34 INFO - Downloading/unpacking psutil>=3.1.1 14:18:34 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 14:18:34 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 14:18:34 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 14:18:34 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 14:18:34 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 14:18:34 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 14:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:36 INFO - Installing collected packages: psutil 14:18:36 INFO - Running setup.py install for psutil 14:18:36 INFO - building 'psutil._psutil_linux' extension 14:18:36 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 14:18: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:18:36 INFO - building 'psutil._psutil_posix' extension 14:18:36 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 14:18: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 14:18:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:36 INFO - Successfully installed psutil 14:18:36 INFO - Cleaning up... 14:18:37 INFO - Return code: 0 14:18:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3cca489f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', '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 14:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:18:37 INFO - Using env: {'DISPLAY': ':0', 14:18:37 INFO - 'HOME': '/home/cltbld', 14:18:37 INFO - 'LANG': 'en_US.UTF-8', 14:18:37 INFO - 'LANGUAGE': 'en_US:en', 14:18:37 INFO - 'LOGNAME': 'cltbld', 14:18:37 INFO - 'MAIL': '/var/mail/cltbld', 14:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:37 INFO - 'MOZ_NO_REMOTE': '1', 14:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:37 INFO - 'NO_EM_RESTART': '1', 14:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:37 INFO - 'PWD': '/builds/slave/test', 14:18:37 INFO - 'SHELL': '/bin/bash', 14:18:37 INFO - 'SHLVL': '1', 14:18:37 INFO - 'TERM': 'linux', 14:18:37 INFO - 'TMOUT': '86400', 14:18:37 INFO - 'USER': 'cltbld', 14:18:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:37 INFO - '_': '/tools/buildbot/bin/python'} 14:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:18:39 INFO - Installing collected packages: mozsystemmonitor 14:18:39 INFO - Running setup.py install for mozsystemmonitor 14:18:39 INFO - Successfully installed mozsystemmonitor 14:18:39 INFO - Cleaning up... 14:18:39 INFO - Return code: 0 14:18:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3cca489f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', '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 14:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:18:39 INFO - Using env: {'DISPLAY': ':0', 14:18:39 INFO - 'HOME': '/home/cltbld', 14:18:39 INFO - 'LANG': 'en_US.UTF-8', 14:18:39 INFO - 'LANGUAGE': 'en_US:en', 14:18:39 INFO - 'LOGNAME': 'cltbld', 14:18:39 INFO - 'MAIL': '/var/mail/cltbld', 14:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:39 INFO - 'MOZ_NO_REMOTE': '1', 14:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:39 INFO - 'NO_EM_RESTART': '1', 14:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:39 INFO - 'PWD': '/builds/slave/test', 14:18:39 INFO - 'SHELL': '/bin/bash', 14:18:39 INFO - 'SHLVL': '1', 14:18:39 INFO - 'TERM': 'linux', 14:18:39 INFO - 'TMOUT': '86400', 14:18:39 INFO - 'USER': 'cltbld', 14:18:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:39 INFO - '_': '/tools/buildbot/bin/python'} 14:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:39 INFO - Downloading/unpacking jsonschema==2.5.1 14:18:39 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 14:18:39 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 14:18:39 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 14:18:39 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 14:18:39 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 14:18:39 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 14:18:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:41 INFO - warning: no files found matching '*.txt' 14:18:41 INFO - no previously-included directories found matching 'build' 14:18:41 INFO - no previously-included directories found matching 'dist' 14:18:41 INFO - no previously-included directories found matching '.git*' 14:18:41 INFO - Installing collected packages: jsonschema, functools32 14:18:42 INFO - Running setup.py install for functools32 14:18:42 INFO - warning: no files found matching '*.txt' 14:18:42 INFO - no previously-included directories found matching 'build' 14:18:42 INFO - no previously-included directories found matching 'dist' 14:18:42 INFO - no previously-included directories found matching '.git*' 14:18:42 INFO - Successfully installed jsonschema functools32 14:18:42 INFO - Cleaning up... 14:18:42 INFO - Return code: 0 14:18:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3cca489f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', '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 14:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:18:42 INFO - Using env: {'DISPLAY': ':0', 14:18:42 INFO - 'HOME': '/home/cltbld', 14:18:42 INFO - 'LANG': 'en_US.UTF-8', 14:18:42 INFO - 'LANGUAGE': 'en_US:en', 14:18:42 INFO - 'LOGNAME': 'cltbld', 14:18:42 INFO - 'MAIL': '/var/mail/cltbld', 14:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:42 INFO - 'MOZ_NO_REMOTE': '1', 14:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:42 INFO - 'NO_EM_RESTART': '1', 14:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:42 INFO - 'PWD': '/builds/slave/test', 14:18:42 INFO - 'SHELL': '/bin/bash', 14:18:42 INFO - 'SHLVL': '1', 14:18:42 INFO - 'TERM': 'linux', 14:18:42 INFO - 'TMOUT': '86400', 14:18:42 INFO - 'USER': 'cltbld', 14:18:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:42 INFO - '_': '/tools/buildbot/bin/python'} 14:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:18:42 INFO - Cleaning up... 14:18:42 INFO - Return code: 0 14:18:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3cca489f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', '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 14:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:18:42 INFO - Using env: {'DISPLAY': ':0', 14:18:42 INFO - 'HOME': '/home/cltbld', 14:18:42 INFO - 'LANG': 'en_US.UTF-8', 14:18:42 INFO - 'LANGUAGE': 'en_US:en', 14:18:42 INFO - 'LOGNAME': 'cltbld', 14:18:42 INFO - 'MAIL': '/var/mail/cltbld', 14:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:42 INFO - 'MOZ_NO_REMOTE': '1', 14:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:42 INFO - 'NO_EM_RESTART': '1', 14:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:42 INFO - 'PWD': '/builds/slave/test', 14:18:42 INFO - 'SHELL': '/bin/bash', 14:18:42 INFO - 'SHLVL': '1', 14:18:42 INFO - 'TERM': 'linux', 14:18:42 INFO - 'TMOUT': '86400', 14:18:42 INFO - 'USER': 'cltbld', 14:18:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:42 INFO - '_': '/tools/buildbot/bin/python'} 14:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:45 INFO - Downloading docopt-0.6.1.tar.gz 14:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:45 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:45 INFO - Running setup.py install for blobuploader 14:18:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:45 INFO - Running setup.py install for requests 14:18:46 INFO - Running setup.py install for docopt 14:18:46 INFO - Successfully installed blobuploader requests docopt 14:18:46 INFO - Cleaning up... 14:18:46 INFO - Return code: 0 14:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:46 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 0x7f3cca489f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', '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 14:18:46 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 14:18:46 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 14:18:46 INFO - Using env: {'DISPLAY': ':0', 14:18:46 INFO - 'HOME': '/home/cltbld', 14:18:46 INFO - 'LANG': 'en_US.UTF-8', 14:18:46 INFO - 'LANGUAGE': 'en_US:en', 14:18:46 INFO - 'LOGNAME': 'cltbld', 14:18:46 INFO - 'MAIL': '/var/mail/cltbld', 14:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:46 INFO - 'MOZ_NO_REMOTE': '1', 14:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:46 INFO - 'NO_EM_RESTART': '1', 14:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:46 INFO - 'PWD': '/builds/slave/test', 14:18:46 INFO - 'SHELL': '/bin/bash', 14:18:46 INFO - 'SHLVL': '1', 14:18:46 INFO - 'TERM': 'linux', 14:18:46 INFO - 'TMOUT': '86400', 14:18:46 INFO - 'USER': 'cltbld', 14:18:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:46 INFO - '_': '/tools/buildbot/bin/python'} 14:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:46 INFO - Running setup.py (path:/tmp/pip-bhHcsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:46 INFO - Running setup.py (path:/tmp/pip-p6ysSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:46 INFO - Running setup.py (path:/tmp/pip-p67gqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:46 INFO - Running setup.py (path:/tmp/pip-nyRMJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:46 INFO - Running setup.py (path:/tmp/pip-5B19Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:46 INFO - Running setup.py (path:/tmp/pip-ps5V79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:46 INFO - Running setup.py (path:/tmp/pip-KeQMAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:47 INFO - Running setup.py (path:/tmp/pip-9XVbSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:47 INFO - Running setup.py (path:/tmp/pip-Cimbop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:47 INFO - Running setup.py (path:/tmp/pip-C5rdqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:47 INFO - Running setup.py (path:/tmp/pip-4jXBsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:47 INFO - Running setup.py (path:/tmp/pip-81zASE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:47 INFO - Running setup.py (path:/tmp/pip-GIBlIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:47 INFO - Running setup.py (path:/tmp/pip-LY30mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:47 INFO - Running setup.py (path:/tmp/pip-cWY1Zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:47 INFO - Running setup.py (path:/tmp/pip-txVMYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:47 INFO - Running setup.py (path:/tmp/pip-J4vVb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:47 INFO - Running setup.py install for manifestparser 14:18:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:47 INFO - Running setup.py install for mozcrash 14:18:47 INFO - Running setup.py install for mozdebug 14:18:48 INFO - Running setup.py install for mozdevice 14:18:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Running setup.py install for mozfile 14:18:48 INFO - Running setup.py install for mozhttpd 14:18:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Running setup.py install for mozinfo 14:18:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Running setup.py install for mozInstall 14:18:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Running setup.py install for mozleak 14:18:48 INFO - Running setup.py install for mozlog 14:18:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Running setup.py install for moznetwork 14:18:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:48 INFO - Running setup.py install for mozprocess 14:18:48 INFO - Running setup.py install for mozprofile 14:18:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:49 INFO - Running setup.py install for mozrunner 14:18:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:49 INFO - Running setup.py install for mozscreenshot 14:18:49 INFO - Running setup.py install for moztest 14:18:49 INFO - Running setup.py install for mozversion 14:18:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:49 INFO - Cleaning up... 14:18:49 INFO - Return code: 0 14:18:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:49 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 0x7f3cca489f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', '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 14:18:49 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 14:18:49 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 14:18:49 INFO - Using env: {'DISPLAY': ':0', 14:18:49 INFO - 'HOME': '/home/cltbld', 14:18:49 INFO - 'LANG': 'en_US.UTF-8', 14:18:49 INFO - 'LANGUAGE': 'en_US:en', 14:18:49 INFO - 'LOGNAME': 'cltbld', 14:18:49 INFO - 'MAIL': '/var/mail/cltbld', 14:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:49 INFO - 'MOZ_NO_REMOTE': '1', 14:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:49 INFO - 'NO_EM_RESTART': '1', 14:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:49 INFO - 'PWD': '/builds/slave/test', 14:18:49 INFO - 'SHELL': '/bin/bash', 14:18:49 INFO - 'SHLVL': '1', 14:18:49 INFO - 'TERM': 'linux', 14:18:49 INFO - 'TMOUT': '86400', 14:18:49 INFO - 'USER': 'cltbld', 14:18:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:49 INFO - '_': '/tools/buildbot/bin/python'} 14:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:49 INFO - Running setup.py (path:/tmp/pip-IT4fSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:49 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)) 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:49 INFO - Running setup.py (path:/tmp/pip-VWRbVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:49 INFO - Running setup.py (path:/tmp/pip-M1HIh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:49 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)) 14:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:50 INFO - Running setup.py (path:/tmp/pip-zP4eM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:50 INFO - Running setup.py (path:/tmp/pip-BY3lHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:50 INFO - Running setup.py (path:/tmp/pip-sA_e91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:50 INFO - Running setup.py (path:/tmp/pip-TzGtTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:50 INFO - Running setup.py (path:/tmp/pip-Zz9ibU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:50 INFO - Running setup.py (path:/tmp/pip-RF1E8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:50 INFO - Running setup.py (path:/tmp/pip-gAZfIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:50 INFO - Running setup.py (path:/tmp/pip-XDxbhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:50 INFO - Running setup.py (path:/tmp/pip-watQ8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:50 INFO - Running setup.py (path:/tmp/pip-yadC2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:50 INFO - Running setup.py (path:/tmp/pip-icYFKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:50 INFO - Running setup.py (path:/tmp/pip-9Qi0_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:50 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:50 INFO - Running setup.py (path:/tmp/pip-7DrxD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:50 INFO - Running setup.py (path:/tmp/pip-3dwxlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:51 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)) 14:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:18:51 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)) 14:18:51 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)) 14:18:51 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)) 14:18:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:53 INFO - Downloading blessings-1.6.tar.gz 14:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:53 INFO - Installing collected packages: blessings 14:18:53 INFO - Running setup.py install for blessings 14:18:53 INFO - Successfully installed blessings 14:18:53 INFO - Cleaning up... 14:18:53 INFO - Return code: 0 14:18:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:53 INFO - Reading from file tmpfile_stdout 14:18:53 INFO - Current package versions: 14:18:53 INFO - argparse == 1.2.1 14:18:53 INFO - blessings == 1.6 14:18:53 INFO - blobuploader == 1.2.4 14:18:53 INFO - docopt == 0.6.1 14:18:53 INFO - functools32 == 3.2.3-2 14:18:53 INFO - jsonschema == 2.5.1 14:18:53 INFO - manifestparser == 1.1 14:18:53 INFO - mozInstall == 1.12 14:18:53 INFO - mozcrash == 1.0 14:18:53 INFO - mozdebug == 0.1 14:18:53 INFO - mozdevice == 0.48 14:18:53 INFO - mozfile == 1.2 14:18:53 INFO - mozhttpd == 0.7 14:18:53 INFO - mozinfo == 0.9 14:18:53 INFO - mozleak == 0.1 14:18:53 INFO - mozlog == 3.4 14:18:53 INFO - moznetwork == 0.27 14:18:53 INFO - mozprocess == 0.23 14:18:53 INFO - mozprofile == 0.28 14:18:53 INFO - mozrunner == 6.13 14:18:53 INFO - mozscreenshot == 0.1 14:18:53 INFO - mozsystemmonitor == 0.3 14:18:53 INFO - moztest == 0.8 14:18:53 INFO - mozversion == 1.4 14:18:53 INFO - psutil == 3.1.1 14:18:53 INFO - requests == 1.2.3 14:18:53 INFO - wsgiref == 0.1.2 14:18:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:53 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')]} 14:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:53 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')]} 14:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:53 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 0x7f3cca489f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', '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 14:18:53 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 14:18:53 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 14:18:53 INFO - Using env: {'DISPLAY': ':0', 14:18:53 INFO - 'HOME': '/home/cltbld', 14:18:53 INFO - 'LANG': 'en_US.UTF-8', 14:18:53 INFO - 'LANGUAGE': 'en_US:en', 14:18:53 INFO - 'LOGNAME': 'cltbld', 14:18:53 INFO - 'MAIL': '/var/mail/cltbld', 14:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:53 INFO - 'MOZ_NO_REMOTE': '1', 14:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:53 INFO - 'NO_EM_RESTART': '1', 14:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:53 INFO - 'PWD': '/builds/slave/test', 14:18:53 INFO - 'SHELL': '/bin/bash', 14:18:53 INFO - 'SHLVL': '1', 14:18:53 INFO - 'TERM': 'linux', 14:18:53 INFO - 'TMOUT': '86400', 14:18:53 INFO - 'USER': 'cltbld', 14:18:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:53 INFO - '_': '/tools/buildbot/bin/python'} 14:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:53 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)) 14:18:53 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)) 14:18:53 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)) 14:18:53 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)) 14:18:53 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)) 14:18:53 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)) 14:18:53 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)) 14:18:53 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)) 14:18:53 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)) 14:18:53 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)) 14:18:53 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)) 14:18:53 INFO - Cleaning up... 14:18:53 INFO - Return code: 0 14:18:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18:53 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')]} 14:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:53 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')]} 14:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:53 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 0x7f3cca489f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', '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 14:18:53 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 14:18:53 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 14:18:53 INFO - Using env: {'DISPLAY': ':0', 14:18:53 INFO - 'HOME': '/home/cltbld', 14:18:53 INFO - 'LANG': 'en_US.UTF-8', 14:18:53 INFO - 'LANGUAGE': 'en_US:en', 14:18:53 INFO - 'LOGNAME': 'cltbld', 14:18:53 INFO - 'MAIL': '/var/mail/cltbld', 14:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:53 INFO - 'MOZ_NO_REMOTE': '1', 14:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:53 INFO - 'NO_EM_RESTART': '1', 14:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:53 INFO - 'PWD': '/builds/slave/test', 14:18:53 INFO - 'SHELL': '/bin/bash', 14:18:53 INFO - 'SHLVL': '1', 14:18:53 INFO - 'TERM': 'linux', 14:18:53 INFO - 'TMOUT': '86400', 14:18:53 INFO - 'USER': 'cltbld', 14:18:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:53 INFO - '_': '/tools/buildbot/bin/python'} 14:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:18:54 INFO - Cleaning up... 14:18:54 INFO - Return code: 0 14:18:54 INFO - Running post-action listener: _resource_record_post_action 14:18:54 INFO - Running post-action listener: _start_resource_monitoring 14:18:54 INFO - Starting resource monitoring. 14:18:54 INFO - [mozharness: 2017-01-12 22:18:54.142574Z] Finished create-virtualenv step (success) 14:18:54 INFO - [mozharness: 2017-01-12 22:18:54.143035Z] Running install step. 14:18:54 INFO - Running pre-action listener: _resource_record_pre_action 14:18:54 INFO - Running main action method: install 14:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:54 INFO - Reading from file tmpfile_stdout 14:18:54 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:54 INFO - Reading from file tmpfile_stdout 14:18:54 INFO - Output received: 14:18:54 INFO - Usage: mozinstall [options] installer 14:18:54 INFO - Options: 14:18:54 INFO - -h, --help show this help message and exit 14:18:54 INFO - -d DEST, --destination=DEST 14:18:54 INFO - Directory to install application into. [default: 14:18:54 INFO - "/builds/slave/test"] 14:18:54 INFO - --app=APP Application being installed. [default: firefox] 14:18:54 INFO - mkdir: /builds/slave/test/build/application 14:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:19:10 INFO - Reading from file tmpfile_stdout 14:19:10 INFO - Output received: 14:19:10 INFO - /builds/slave/test/build/application/firefox/firefox 14:19:10 INFO - Running post-action listener: _resource_record_post_action 14:19:10 INFO - [mozharness: 2017-01-12 22:19:10.394526Z] Finished install step (success) 14:19:10 INFO - [mozharness: 2017-01-12 22:19:10.394768Z] Running run-tests step. 14:19:10 INFO - Running pre-action listener: _resource_record_pre_action 14:19:10 INFO - Running main action method: run_tests 14:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:19:10 INFO - Python 2.7.3 14:19:10 INFO - Return code: 0 14:19:10 INFO - grabbing minidump binary from tooltool 14:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:19:10 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 0xdf1f60>, '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 0xdf2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:19:10 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 14:19:10 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 14:19:10 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 14:19:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:19:10 INFO - Return code: 0 14:19:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:19:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:19:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:19:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:19:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:19:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:19:10 INFO - Using env: {'DISPLAY': ':0', 14:19:10 INFO - 'HOME': '/home/cltbld', 14:19:10 INFO - 'LANG': 'en_US.UTF-8', 14:19:10 INFO - 'LANGUAGE': 'en_US:en', 14:19:10 INFO - 'LOGNAME': 'cltbld', 14:19:10 INFO - 'MAIL': '/var/mail/cltbld', 14:19:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:19:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:19:10 INFO - 'MOZ_NO_REMOTE': '1', 14:19:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:19:10 INFO - 'NO_EM_RESTART': '1', 14:19:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:19:10 INFO - 'PWD': '/builds/slave/test', 14:19:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:19:10 INFO - 'SHELL': '/bin/bash', 14:19:10 INFO - 'SHLVL': '1', 14:19:10 INFO - 'TERM': 'linux', 14:19:10 INFO - 'TMOUT': '86400', 14:19:10 INFO - 'USER': 'cltbld', 14:19:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469', 14:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:19:10 INFO - '_': '/tools/buildbot/bin/python'} 14:19:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:19:10 INFO - mozversion application_buildid: 20170112123541 14:19:10 INFO - mozversion application_changeset: 98ecf719163d1c0cf19359186ab1cac6f34bb621 14:19:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:19:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:19:10 INFO - mozversion application_name: Firefox 14:19:10 INFO - mozversion application_remotingname: firefox-dev 14:19:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:19:10 INFO - mozversion application_vendor: Mozilla 14:19:10 INFO - mozversion application_version: 52.0a2 14:19:10 INFO - mozversion platform_buildid: 20170112123541 14:19:10 INFO - mozversion platform_changeset: 98ecf719163d1c0cf19359186ab1cac6f34bb621 14:19:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:19:10 INFO - mozversion platform_version: 52.0a2 14:19:10 INFO - using testdate: 1484259550 14:19:10 INFO - actual date: 1484259550 14:19:10 INFO - starting webserver on 'localhost:60629' 14:19:10 INFO - SUITE-START | Running 2 tests 14:19:10 INFO - TEST-START | dromaeo_css 14:19:10 INFO - operating with platform_type : linux_ 14:19:10 INFO - Initialising browser for dromaeo_css test... 14:19:10 INFO - TEST-INFO | started process 2488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9LbNSZ/profile http://localhost:60629/getInfo.html) 14:19:14 INFO - PROCESS | 2488 | __metrics Screen width/height:1600/1200 14:19:14 INFO - PROCESS | 2488 | colorDepth:24 14:19:14 INFO - PROCESS | 2488 | Browser inner width/height: 1024/697 14:19:14 INFO - PROCESS | 2488 | __metrics 14:19:15 INFO - PROCESS | 2488 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:19:15 INFO - PROCESS | 2488 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:19:15 INFO - PROCESS | 2488 | console.error: PushService: 14:19:15 INFO - PROCESS | 2488 | stateChangeProcessEnqueue: Error transitioning state 14:19:15 INFO - PROCESS | 2488 | UnknownError 14:19:16 INFO - TEST-INFO | 2488: exit 0 14:19:16 INFO - Browser initialized. 14:19:16 INFO - Running cycle 1/1 for dromaeo_css test... 14:19:16 INFO - TEST-INFO | started process 2599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9LbNSZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:28 INFO - PROCESS | 2599 | RSS: Main: 144019456 14:19:28 INFO - PROCESS | 2599 | 14:22:29 INFO - PROCESS | 2599 | Cycle 1(1): loaded http://localhost:60629/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60629/tests/dromaeo/cssquery-ext.html) 14:22:31 INFO - PROCESS | 2599 | RSS: Main: 243159040 14:22:31 INFO - PROCESS | 2599 | 14:25:33 INFO - PROCESS | 2599 | Cycle 1(1): loaded http://localhost:60629/tests/dromaeo/cssquery-ext.html (next: http://localhost:60629/tests/dromaeo/cssquery-jquery.html) 14:25:33 INFO - PROCESS | 2599 | RSS: Main: 232026112 14:25:33 INFO - PROCESS | 2599 | 14:28:36 INFO - PROCESS | 2599 | Cycle 1(1): loaded http://localhost:60629/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60629/tests/dromaeo/cssquery-mootools.html) 14:28:36 INFO - PROCESS | 2599 | RSS: Main: 218943488 14:28:36 INFO - PROCESS | 2599 | 14:31:38 INFO - PROCESS | 2599 | Cycle 1(1): loaded http://localhost:60629/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60629/tests/dromaeo/cssquery-prototype.html) 14:31:39 INFO - PROCESS | 2599 | RSS: Main: 173568000 14:31:39 INFO - PROCESS | 2599 | 14:34:41 INFO - PROCESS | 2599 | Cycle 1(1): loaded http://localhost:60629/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60629/tests/dromaeo/cssquery-yui.html) 14:34:42 INFO - PROCESS | 2599 | RSS: Main: 176328704 14:34:42 INFO - PROCESS | 2599 | 14:37:44 INFO - PROCESS | 2599 | Cycle 1(1): loaded http://localhost:60629/tests/dromaeo/cssquery-yui.html (next: http://localhost:60629/tests/dromaeo/cssquery-dojo.html) 14:37:45 INFO - PROCESS | 2599 | RSS: Main: 270594048 14:37:45 INFO - PROCESS | 2599 | 14:37:45 INFO - PROCESS | 2599 | __start_tp_report 14:37:45 INFO - PROCESS | 2599 | _x_x_mozilla_page_load 14:37:45 INFO - PROCESS | 2599 | _x_x_mozilla_page_load_details 14:37:45 INFO - PROCESS | 2599 | |i|pagename|runs| 14:37:45 INFO - PROCESS | 2599 | |0;dojo.html;3285.9835700821495;3322.850471728772;3332.1836150143213;3336.0825772912463;3364.7476439267048;5596.916046259309;5670.177824215486;5675.801346952852;5683.062294721366;5693.658380497168;5614.887702245953;5666.688332141731;5672.886542269162;5677.063284558043;5707.400722924095;5103.183490641507;5124.436312005676;5128.794848206067;5155.922661160085;5200.5059519345605;5015.247712843066;5212.739363031833;5221.425643179247;5223.216517522383;5244.68531888086;5003.049420610072;5030.446650868402;5059.544640982311;5073.467285934979;5121.257417674454;5133.974330128344;5174.586033117342;5186.170212765977;5253.317068781034;5254.21186821976;5100.413452452978;5140.614453915971;5209.661372010807;5221.556167725748;5252.3171987641745;5369.865753356158;5410.945890541123;5467.917981230285;5473.06957817172;5521.1442226454965;5945.137954996501;5948.702564871739;5971.641701497924;6037.094435834616;6039.758409663608;6061.151438798572;6069.514438844882;6075.27096748393;6075.939240607626;6080.2399700037495;5477.643953143072;5538.778448862;5550.111982082847;5599.44005599445;5599.636023658449;6128.9693551531955;6153.84615384619;6155.876882462326;6163.9383606164265;6169;5908.231929849092;5917.171595976567;5932.851678708067;5942.6731529766275;5944.464998150187;5749.511291540266;5814.360420353758;5963.463288304073;6022.789202377983;6030.819075427744;6026.457618814327;6038.215032045806;6050.152978583002;6051.243594550681;6068.878622427526;5988.431099045583;6008.24896887889;6047.03247480401;6058.333583305833;6061.605995610271;4499.055198408371;4545.8636240912165;4556.794944227518;4613.815447382134;4655.557722016403;4135.627793498599;4149.647279981175;4172.415861779354;4178.958210417857;4207.97896010518;5768.105943578668;5769.68266745333;5770.538356931519;5775.075987841925;5792.9710351447975;5842.941570584239;5867.970660146672;5874.5887787854435;6068.423499767515;6088.817335479854;5651.237082993744;5694.487496125369;5708.828735137952;5716.885662286814;5733.942660573424;5113.616478764107;5131.358580177403;5131.692098474104;5134.666246693953;5152.355955505562;5989.8203053908455;6092.482139018233;6162.075688646649;6163.9383606164265;6168.722407491584;5953.732082056231;5989.071693887455;6038.184845046038;6118.449339559283;6124.418180272867;6281.811545653638;6331.081993110881;6334.778282760081;6334.809955701337;6336.904946425715;5653.717314134195;5967.940320596738;5972.044472884318;5979.073243647242;5981.491573216325;5755.395683453177;5943.019401798828;5994.550408719277;6000.129981152796;6096.146539484387;5867.6772777497645;5898.616589921641;5916.585838991401;5918.852028699144;5921.703914804157;5844.415558444121;5853.707314634166;5863.20846685692;5863.413658634103;5865.120231965239;5574.968630803314;5685.147227915846;5850.970745146247;5923.111533270044;5926.525877929842;6019.337872833898;6023.1266466363;6029.095635654687;6036.124761909411;6047.66737829406;5598.3282006159525;5639.7744090237575;5840.737166827588;5853.707314634336;5860.677662728591 14:37:45 INFO - PROCESS | 2599 | |1;ext.html;591.1959734760725;614.1432701381573;628.214731585518;648.1735786871737;654.7413771560236;34083.31833363331;44468.66485013625;44624.33063504042;44672.3299150513;44740.552594474044;46280.76859615705;46436.76781616096;46562.30156547646;46723;46804;8270.586470676442;8726.214640682321;8882.555872206396;8883;8887.600057997373;8460.703875364363;10661.147108231324;10906.781864362709;10929.234953553214;10937.015668589826;10795.2443328967;10842.72893177669;10842.837357439645;10855.51150198239;10863.29388589743;10642.57429702811;10672.679819605424;10690.62582809598;10701.518431670593;10720;10578.100861426788;10617.991290827436;10637.255392122555;10654.78690426195;10663.84004239937;42460.57539424628;42727.35908961368;42858.35712464315;42886;42899.35650965238;3591.497190393347;3604.945925811115;3669.2661467706566;3675.5038069860493;3738.158914244273;32261.677383226102;32380.83809580937;32382.352352953043;32434.837825810955;32524.18689532757;4247.256730072225;4451.2655411857;4456.153330867125;4508.954910450919;4588;349441;349949;350824.24587877153;351470;352008;37998;38603.80698096548;58101;58571;58755.706221468616;39484;39880.60119398827;39881.80059099744;39896.80051599781;39935.400968984904;14626.341814618369;14760.852391476163;14764.778528322084;14768.335424905905;14781.408743650134;11294.491747871365;11466.713332166595;11834.17160798753;11879.109066820023;11959.760804783855;9188.310876684141;9412.764680883032;9448.196903263299;9469.621215151454;9520.476373799507;3551.8224088795455;3553.09396103997;3572.5712914450432;3590.551181102362;3657.305112028706;998.8451789972565;1074.2909679611419;1077.2620754783;1098.23123813331;1210.7094297368744;32193.81422826807;33926.83036584851;33945.151371215914;34250;34491.827540862636;1128.9266197697123;1137.181229514748;1142.6971852459105;1152.6369193704124;1155.7226265696172;17945.551361215814;18208.726869096976;18549.165287562093;18597.7210341845;19592;496353;500118;500136;500737;503198;61827;62125.68937155376;62135.37864621387;62136;62238.68880655658;1243.7325974915436;1365.1945352242026;1410.6473381654587;1418.432626949208;1425.8398526232972;32128.839355803073;34006.82996585001;34057.318853622295;34515.13712157216;34578;50750.49249507458;51402.48597513977;51456;51484.485155147966;51498.48501514937;306245;307962;308012;308165;308508;30441.847790760905;31165.532517012718;32567;32584.185395365304;33169.66830331762;48626.756866215444;48819;49715.50284497109;49811.25283120829;49962.25056624081;41898.37152442655;42242;42450.36324455074;43109.78445107755;43944.78027609841;42054.57945420629;42800.35799463073;43364.34953475637;44370.55629443664;44836;43799.781001094794;44033;44430.11139777251;45180.77409612931;45224.32163517616;36975.63024369722;38603.61396386;38872.416913746885;39129;39655.60344396519;29276.268093297836;29516;29530.675502882736;29543.409131817672;29787 14:37:45 INFO - PROCESS | 2599 | |2;jquery.html;393.2410447835676;408.08385175281495;417.3947775725199;417.43854515676406;420.11775271928946;14679.486217982372;16529.173541322933;19879.105440255204;20172;20515.692264616006;19533.80466195341;19841.10715017824;19878.304259350927;20039.899800500978;20072.59854802903;5704.65772053676;5742.942570574282;5746.913796293059;5816.476517113459;5963.866865295601;4251.149770045988;4420.8010639521135;5708.65748055118;5820.068788993762;5820.82537523875;6234.563580549363;6450.903236451457;6484.837879053038;6553.115329430513;6566.34336566342;6261.686915654222;6503;6549.476041916635;6555.737770489175;6561.540692151551;5765.394633563499;5832.941670583325;5835.44563266489;5839.153322768218;5840.737166827503;23436.64845027326;23696.052157913662;23712.525749484914;23930.64104038441;24030.27909162728;2368.2658375903525;2471.9011239550396;2514.710808257037;2556.6676332076713;2571.395722005327;14650.926745366312;14660.41358345665;14851.331690073865;14930.70138597222;15106.244687765568;1900.840487302758;1990.7511561054869;2016.2237538547618;2032.634125857345;2044.0188709419413;67109.66445167792;78988.21011789866;79270.6036469814;88790;93096.53451732697;10791.946040269748;10812.459377031275;11006.614768483225;11214.327140371604;11246.606368777053;15623.453179138904;15707;15746.055236685836;15771;15786.921065394828;7804.570748608768;7943.761687149395;8006.83986320282;8094.392920530984;8110.918890811135;7609.201033891472;7680.193579674165;7764.301212890754;7818.530888146729;7851.842963140705;6638.933610663928;6734.191896972395;6779.220389655155;6817.625030623264;6851.691673874588;1947.4547126804518;1967.3409407848244;1971.2607772085469;1980.7821139674625;1992;923.8383282925461;935.7146070448442;1029.6499190275192;1035.782485678001;1106.25880659958;19464.610707785763;19919.10364033593;20173.394798156078;20234.392968210977;20439.284625038053;1026.645807196531;1053.6733612580124;1060.7931453366673;1079.2607064161075;1081.8431327457474;10174.440405777605;10657.946710266398;11163.092593054864;11419.143564232716;11670.358130302746;450728;452293;471348;516611;519254;95760;97870;102375;103962.48018760009;105911.47044264729;1026.2610920137488;1065.8614380130534;1068.1348108032673;1083.9349639021684;1087.6410784441116;17637.118144093;17893.463196104138;17915.19381627804;18089.638207236047;18441.26234950587;43441.34837977496;43689.56310436855;44188.33717494176;44651;44775.10449790921;61230.55077796838;61362.0795688074;62080.689596551725;62459.37540624536;65296.347036530926;8299.223853146925;8715.433496822687;8719.738407847775;8914.955425222832;9054.275657947217;11322.716932076764;12771.808422873479;12814.615561533168;12906;13091.541796037092;11617;11678.70803229926;11729.706757331134;11801.881981180079;11883.405829708652;11548.133889958119;11579;11593;11630.6510804676;11682.357470338873;11480.368579728196;11562.47968841421;11770.58802941893;11838.644840654793;11851.881481185077;8594.226519613265;8689.565521724015;8751.168638979287;8828.117188281378;9010.414323068979;9681.322307438411;11306.434678266218;11389.715257118307;11567.074634029426;11950.880491194977 14:37:45 INFO - PROCESS | 2599 | |3;mootools.html;1466.4207637982993;1491.179851081905;1620.1656147084254;1734.2369357482698;1792.6952418088931;8071.91928080719;8546.615402306896;8550.486970781758;8561.101084386135;8562.614682339294;7333.853322933538;7550.81122971926;8033.0761962374345;8278.461899976497;8373.539455329954;2400.0759707512557;2400.0879665726998;2419.8064154867657;2427.5509030829267;2427.8300518963592;2397.61638137898;2400.627902675088;2446.559619268531;2447.2658202539255;2447.510497900418;2380.702412198475;2390.988045059772;2406.95186096278;2409.301302622246;2422.878856057199;2371.383440305533;2384.463495713468;2387.3673476528734;2406.1217655555683;2406.4465173010217;2350.424146084203;2364.5034542746043;2367.3844800351862;2369.336585755991;2369.4194922243987;8352.123027082129;8389.286910612605;8403.621837017348;8414.368922330788;8417.537035463047;5053.545180933734;5144.845654630367;5160.303359046518;5199.402068762065;5199.974000130013;3328.134684981898;3333.949990750141;3428.142964258935;3443.1736383268085;3451.11996440906;1095.5617752898825;1116.3357802107732;1132.3206076354122;1135.1769966774104;1145.8854114588557;11595.94202028993;11623.883761162364;11669.649910502614;11691.707707307216;11696.12279079064;4298.312270036779;4432.601065904084;4511.5262897395305;4565.452145742465;4567.132244873464;9064.274858011344;9066.727998160066;9068.274538036942;9072.591733372014;9072.81854362909;5233.528982391603;5235.60732945023;5236.607254455931;5242.213667949762;5243.056249875059;4375.258739793799;4379.386885835986;4793.880152996133;4812.5668689818085;4906.55840974314;3776.15036616759;3819.52255968004;3915.4909861718365;3920.8039598019986;3927.646511813893;1227.699213692651;1239.8202260672151;1242.8570714367963;1245.3524167432884;1258.1570347866768;943.306669597845;966.6665000574791;967.2310513142069;973.5862258540092;984.4733067808688;5576.890467118197;5680.517156041783;5869.941300587025;5949.791757288474;5950.19672344228;479.52526998272157;479.9640026997989;484.79638551808324;490.32335377179265;492.8546078906731;3945.151792364655;3946.940795888064;3995.1210733638554;4003.7797921114034;4014.0566966762785;9996.900030999743;10244.948775256076;10363.896361036293;10373.429461379697;10388.065074143364;10241.74395640115;10290.536925838354;10294.588216471408;10301.587936482607;10317.638882639221;7925.405594580314;7933.048034235929;7996.120426753168;8027.357811375076;8037.397195210383;5703.800366987136;5741.483266506035;5753.2520772301;5764.106563482667;5765.538756899354;9520.809583808146;9529.952350238205;9538.189253913495;9613.182879455324;9653.951730241304;9464.432134071978;9704.854427183456;9785.315027947976;9785.461799601091;9810.65662701802;6226.50187984951;6407.519436042408;7055.435565154878;7108.715651373887;7131.358177764027;7905.209479052049;8103.270705636521;8198.918010819816;8296.128906464975;8314.79213019655;7350.264973502607;7441.702331906879;7476.177620461854;7519.812004699927;7570.129435115033;7089.0784198053925;7169.713211471482;7191.748288809867;7230.530015549183;7371.557706537625;6682.3317668232785;6778.932210678027;6796.218434880052;6802.455803535804;6803.625800581016;5056.494350564914;5140.801562468819;5164.845054648366;5220.086484865057;5229.790808367623;5081.92377114351;5125.333706618116;5152.093725321655;5221.190715439113;5310.495502927216 14:37:45 INFO - PROCESS | 2599 | |4;prototype.html;348.7349614293137;349.84082242579626;350.87894178100964;355.5875184785649;356.82872221333776;5513.696746678931;5527.170924361348;5528.585356098289;5540.944590554098;5570.04787462645;5399.298091248133;5447.863803404917;5499.945000549993;5540.584456165783;5547.500724934755;3814.4278358246206;4123.134421577005;4233.491980962289;4313.09425020746;4322.935155972663;4295.6588659180825;4297.80659870305;4298.763568003758;4299.31211006239;4302.419173411597;4282.088180037573;4294.613484786369;4300.1829652366105;4302.160574021147;4310;4102.507699076115;4144.668426525871;4217.135487225111;4279.828806847722;4293.076988447483;3777.395616701315;3792.374258247386;3807.248665613821;3814.313423583754;3820.9044773880873;5270.6047046471285;5273.736313184326;5310.415854256029;5337.973310133463;5359.5712343012465;4727.605356419865;4815.181419158716;4834.6374021948495;4864.713584615225;4879.146149423872;5615.213870058195;5626.606137570372;5634.887302253973;5636.689982050985;5637.436256374371;4181.519125300599;4187.225363307767;4192.4759405074365;4199.790010499462;4211.347241177622;5664.461876121762;5828.388019257959;5852.795152169696;5881.999999999957;5893.290945625807;4248.787560621957;4249.3625956106835;4269.7224680395675;4274.914501710011;4293.849715259951;4341.305391137403;4347.804348804311;4354;4367.868963931087;4373.890652733707;4774.618030557547;4827.9137194131745;4834.20235661119;4871.5128487151005;4910.165271903785;5660.349059858169;5666.490015898589;5670.177824215466;5688.459596338341;5710.486056254957;1455.3523681961638;1456.7232225877049;1458.5405597236836;1459.5402448228774;1472.3374481483374;942.9387089839139;989.223459584223;997.6209040564539;1049.8530205771199;1057.3444464432102;5314.256004159421;5322.520973112439;5355.544778693855;5357.383900851452;5385.703786291791;5583.302087239095;5601.29983752031;5620.18507316445;5659.5755318351285;5677.744501497443;5223.216517522326;5327.600429967768;5366.517013468807;5369.328833895763;5387.218853266255;2955.2516159971433;2991.5811786349927;2993.655729591081;2998.250437390652;3009.9247518812203;5591.832245032656;5752;5781.306243250753;5825.533957283407;5863.355030946593;5665.943340566624;5705.402487303561;5722.542196624343;5730.713464326767;5867.031939729897;5951.464368206882;6096.542759293071;6108.648170454407;6117.809300629084;6124.295705993868;5845.707714614337;5863.355030946678;5877.178954102141;5903.940960590511;5913.994620914369;5590.468905453975;5844.766209351578;5867.853303667272;5888.998870192163;5896.3514013457625;6123.234595675541;6125.84685382869;6151.477124444473;6154;6179.505639548735;4072.3484242521054;4231.301835197158;4243.851465198703;4263.488381394252;4268.402423660628;5869.35437101927;5876.764929402947;5883.94116058834;5888.587798854039;5889.764409423747;5782.45066718661;5783.732191311895;5799.507041901317;5806.332271788799;5811.506021988009;5543.695096769555;5676.460736230051;5758.740856661377;5759.222504961776;5772.797952071657;5702;5720.399358067343;5729.882672878749;5739.454751798572;5786.566007549366;5695.544356451391;5805.303363596396;5838.912416313844;5877.206577112035;5881.2942446906645;5629.662220266797;5666.263385759825;5698.401667824819;5701.942980570141;5705.572082093777 14:37:45 INFO - PROCESS | 2599 | |5;yui.html;753.4725692015587;769.1539306762559;784.5018413307548;785.1990969211405;813.585071613477;13976.440942362306;14512.709745805078;14660.047096938704;14690.192039437827;16334.18329083547;14729.26353682317;15087.773683394758;15098.16960067196;15120.470783522578;15138.470153544627;721.9278072192791;738.3133685672323;823.6911158315631;832.7751507093081;832.8375966686499;849.9660013599448;860.0625318402939;861.2593169873903;869.9043105258417;870.4342177584557;916.3585490156884;918.0773322810566;918.3112665500875;918.3984490158956;919.5632074764467;747.2863415438244;763.9388848892075;851.9872201916976;911.1207684584375;911.1799380557518;633.9714712837887;634.0077778276982;634.2769243062912;634.4670476799511;640.7276907314373;15345.846541534553;15374.461893833774;15375.769363459556;15387.076775393512;15399.538013859603;13888.305584720825;13894.444222231099;14036.228007459586;14261;14313.141211527238;13029.543965961146;13052.869471305261;13070.514609160176;13425;13511.594652160451;4503.684742068057;4507.774611269456;4526.094781043805;4528.909421811545;4663.88340291492;67404.32595674078;67458.66270668665;67540.32459675439;67743.3225667742;68128;11297.830532542019;11334.94332528332;11494.540218391337;11516.654500365003;11711.648650540497;21086.367408977756;21260.25589104374;21306.254281100086;21387.57224855494;21415.678764818542;8037.598120093972;8235.094139644634;8298.128696486903;8426.705065322683;8505.532195729294;4532.546745325507;4732.382621126518;4866.416030076413;4944.950550494521;5015.598752099896;3377.966220337765;3491.9127021824656;3492.4935884296633;3492.6158122606494;3495.3708332500396;578.2425023219596;586.5366360575098;587.1750190981678;587.5064945445846;587.665030932373;626.8088233088952;639.4117411980989;660.7489154121403;679.2019377231733;722.2380388689983;8863.468191908507;9418.434893906388;9606.471644059644;9690;9717.61129554824;544.9209864569615;575.4389470266541;588.2911092133968;702.9015937768717;713.8072720365473;4423.911521769611;4647.790849411785;4669.509701481295;4698.483166851644;4758.286257061469;57353.13970290449;57515;57739.42260577424;70554.64722676354;89895.55052224828;51002.489975100514;74858;77212.84180737294;85831;86432;46758.5324146761;47973.280400794014;48556;48652.7567362168;73300.90048649274;8921.553922303989;9000.68497602607;9044.14080662336;9045.231155351605;9116.817663646558;49518.75240623918;50010.49989500058;50400.49599503958;50520.7265673053;51650.48349516457;65865.67067164634;65984.67007664932;67428;69082.65458672674;69843.30156698571;10113.59545618167;10318.174546036149;10583.31208471447;10610.310329828537;10777.407242601419;12835.679108022374;13024.934875325564;13039.630053204488;13055.804162937753;13082.345882705637;11674.416279186176;11715.765684686428;11819.704507387383;11966.880331196577;12007.939960300142;11686.298822070703;11902;11949.581764638197;12408.317542535247;12433.751324973631;11604.767904642029;11742;11986.700332491757;12311.19977201479;12452.31512266834;9292.16370526656;9410.858837117312;9569.760755980878;9692.321537492307;9836.458994755358;9337.159655631025;9572.425654460754;9605.087516685904;9647.01332315196;9728.951355243178 14:37:45 INFO - PROCESS | 2599 | __end_tp_report 14:37:45 INFO - PROCESS | 2599 | __start_cc_report 14:37:45 INFO - PROCESS | 2599 | _x_x_mozilla_cycle_collect,1021 14:37:45 INFO - PROCESS | 2599 | __end_cc_report 14:37:45 INFO - PROCESS | 2599 | __startTimestamp1484260665171__endTimestamp 14:37:45 INFO - PROCESS | 2599 | 14:37:45 INFO - PROCESS | 2599 | ------- Summary: start ------- 14:37:45 INFO - PROCESS | 2599 | Number of tests: 6 14:37:45 INFO - PROCESS | 2599 | 14:37:45 INFO - PROCESS | 2599 | [#0] dojo.html Cycles:165 Average:5593.00 Median:5814.36 stddev:622.39 (10.7%) stddev-sans-first:597.41 14:37:45 INFO - PROCESS | 2599 | Values: 3286.0 3322.9 3332.2 3336.1 3364.7 5596.9 5670.2 5675.8 5683.1 5693.7 5614.9 5666.7 5672.9 5677.1 5707.4 5103.2 5124.4 5128.8 5155.9 5200.5 5015.2 5212.7 5221.4 5223.2 5244.7 5003.0 5030.4 5059.5 5073.5 5121.3 5134.0 5174.6 5186.2 5253.3 5254.2 5100.4 5140.6 5209.7 5221.6 5252.3 5369.9 5410.9 5467.9 5473.1 5521.1 5945.1 5948.7 5971.6 6037.1 6039.8 6061.2 6069.5 6075.3 6075.9 6080.2 5477.6 5538.8 5550.1 5599.4 5599.6 6129.0 6153.8 6155.9 6163.9 6169.0 5908.2 5917.2 5932.9 5942.7 5944.5 5749.5 5814.4 5963.5 6022.8 6030.8 6026.5 6038.2 6050.2 6051.2 6068.9 5988.4 6008.2 6047.0 6058.3 6061.6 4499.1 4545.9 4556.8 4613.8 4655.6 4135.6 4149.6 4172.4 4179.0 4208.0 5768.1 5769.7 5770.5 5775.1 5793.0 5842.9 5868.0 5874.6 6068.4 6088.8 5651.2 5694.5 5708.8 5716.9 5733.9 5113.6 5131.4 5131.7 5134.7 5152.4 5989.8 6092.5 6162.1 6163.9 6168.7 5953.7 5989.1 6038.2 6118.4 6124.4 6281.8 6331.1 6334.8 6334.8 6336.9 5653.7 5967.9 5972.0 5979.1 5981.5 5755.4 5943.0 5994.6 6000.1 6096.1 5867.7 5898.6 5916.6 5918.9 5921.7 5844.4 5853.7 5863.2 5863.4 5865.1 5575.0 5685.1 5851.0 5923.1 5926.5 6019.3 6023.1 6029.1 6036.1 6047.7 5598.3 5639.8 5840.7 5853.7 5860.7 14:37:45 INFO - PROCESS | 2599 | 14:37:45 INFO - PROCESS | 2599 | [#1] ext.html Cycles:180 Average:55445.06 Median:3663.29 stddev:104368.69 (2849.0%) stddev-sans-first:104580.22 14:37:45 INFO - PROCESS | 2599 | Values: 591.2 614.1 628.2 648.2 654.7 34083.3 44468.7 44624.3 44672.3 44740.6 46280.8 46436.8 46562.3 46723.0 46804.0 8270.6 8726.2 8882.6 8883.0 8887.6 8460.7 10661.1 10906.8 10929.2 10937.0 10795.2 10842.7 10842.8 10855.5 10863.3 10642.6 10672.7 10690.6 10701.5 10720.0 10578.1 10618.0 10637.3 10654.8 10663.8 42460.6 42727.4 42858.4 42886.0 42899.4 3591.5 3604.9 3669.3 3675.5 3738.2 32261.7 32380.8 32382.4 32434.8 32524.2 4247.3 4451.3 4456.2 4509.0 4588.0 349441.0 349949.0 350824.2 351470.0 352008.0 37998.0 38603.8 58101.0 58571.0 58755.7 39484.0 39880.6 39881.8 39896.8 39935.4 14626.3 14760.9 14764.8 14768.3 14781.4 11294.5 11466.7 11834.2 11879.1 11959.8 9188.3 9412.8 9448.2 9469.6 9520.5 3551.8 3553.1 3572.6 3590.6 3657.3 998.8 1074.3 1077.3 1098.2 1210.7 32193.8 33926.8 33945.2 34250.0 34491.8 1128.9 1137.2 1142.7 1152.6 1155.7 17945.6 18208.7 18549.2 18597.7 19592.0 496353.0 500118.0 500136.0 500737.0 503198.0 61827.0 62125.7 62135.4 62136.0 62238.7 1243.7 1365.2 1410.6 1418.4 1425.8 32128.8 34006.8 34057.3 34515.1 34578.0 50750.5 51402.5 51456.0 51484.5 51498.5 306245.0 307962.0 308012.0 308165.0 308508.0 30441.8 31165.5 32567.0 32584.2 33169.7 48626.8 48819.0 49715.5 49811.3 49962.3 41898.4 42242.0 42450.4 43109.8 43944.8 42054.6 42800.4 43364.3 44370.6 44836.0 43799.8 44033.0 44430.1 45180.8 45224.3 36975.6 38603.6 38872.4 39129.0 39655.6 29276.3 29516.0 29530.7 29543.4 29787.0 14:37:45 INFO - PROCESS | 2599 | 14:37:45 INFO - PROCESS | 2599 | [#2] jquery.html Cycles:180 Average:29515.00 Median:12902.46 stddev:79925.67 (619.5%) stddev-sans-first:80119.97 14:37:45 INFO - PROCESS | 2599 | Values: 393.2 408.1 417.4 417.4 420.1 14679.5 16529.2 19879.1 20172.0 20515.7 19533.8 19841.1 19878.3 20039.9 20072.6 5704.7 5742.9 5746.9 5816.5 5963.9 4251.1 4420.8 5708.7 5820.1 5820.8 6234.6 6450.9 6484.8 6553.1 6566.3 6261.7 6503.0 6549.5 6555.7 6561.5 5765.4 5832.9 5835.4 5839.2 5840.7 23436.6 23696.1 23712.5 23930.6 24030.3 2368.3 2471.9 2514.7 2556.7 2571.4 14650.9 14660.4 14851.3 14930.7 15106.2 1900.8 1990.8 2016.2 2032.6 2044.0 67109.7 78988.2 79270.6 88790.0 93096.5 10791.9 10812.5 11006.6 11214.3 11246.6 15623.5 15707.0 15746.1 15771.0 15786.9 7804.6 7943.8 8006.8 8094.4 8110.9 7609.2 7680.2 7764.3 7818.5 7851.8 6638.9 6734.2 6779.2 6817.6 6851.7 1947.5 1967.3 1971.3 1980.8 1992.0 923.8 935.7 1029.6 1035.8 1106.3 19464.6 19919.1 20173.4 20234.4 20439.3 1026.6 1053.7 1060.8 1079.3 1081.8 10174.4 10657.9 11163.1 11419.1 11670.4 450728.0 452293.0 471348.0 516611.0 519254.0 95760.0 97870.0 102375.0 103962.5 105911.5 1026.3 1065.9 1068.1 1083.9 1087.6 17637.1 17893.5 17915.2 18089.6 18441.3 43441.3 43689.6 44188.3 44651.0 44775.1 61230.6 61362.1 62080.7 62459.4 65296.3 8299.2 8715.4 8719.7 8915.0 9054.3 11322.7 12771.8 12814.6 12906.0 13091.5 11617.0 11678.7 11729.7 11801.9 11883.4 11548.1 11579.0 11593.0 11630.7 11682.4 11480.4 11562.5 11770.6 11838.6 11851.9 8594.2 8689.6 8751.2 8828.1 9010.4 9681.3 11306.4 11389.7 11567.1 11950.9 14:37:45 INFO - PROCESS | 2599 | 14:37:45 INFO - PROCESS | 2599 | [#3] mootools.html Cycles:180 Average:5550.73 Median:5156.20 stddev:3059.91 (59.3%) stddev-sans-first:3053.10 14:37:45 INFO - PROCESS | 2599 | Values: 1466.4 1491.2 1620.2 1734.2 1792.7 8071.9 8546.6 8550.5 8561.1 8562.6 7333.9 7550.8 8033.1 8278.5 8373.5 2400.1 2400.1 2419.8 2427.6 2427.8 2397.6 2400.6 2446.6 2447.3 2447.5 2380.7 2391.0 2407.0 2409.3 2422.9 2371.4 2384.5 2387.4 2406.1 2406.4 2350.4 2364.5 2367.4 2369.3 2369.4 8352.1 8389.3 8403.6 8414.4 8417.5 5053.5 5144.8 5160.3 5199.4 5200.0 3328.1 3333.9 3428.1 3443.2 3451.1 1095.6 1116.3 1132.3 1135.2 1145.9 11595.9 11623.9 11669.6 11691.7 11696.1 4298.3 4432.6 4511.5 4565.5 4567.1 9064.3 9066.7 9068.3 9072.6 9072.8 5233.5 5235.6 5236.6 5242.2 5243.1 4375.3 4379.4 4793.9 4812.6 4906.6 3776.2 3819.5 3915.5 3920.8 3927.6 1227.7 1239.8 1242.9 1245.4 1258.2 943.3 966.7 967.2 973.6 984.5 5576.9 5680.5 5869.9 5949.8 5950.2 479.5 480.0 484.8 490.3 492.9 3945.2 3946.9 3995.1 4003.8 4014.1 9996.9 10244.9 10363.9 10373.4 10388.1 10241.7 10290.5 10294.6 10301.6 10317.6 7925.4 7933.0 7996.1 8027.4 8037.4 5703.8 5741.5 5753.3 5764.1 5765.5 9520.8 9530.0 9538.2 9613.2 9654.0 9464.4 9704.9 9785.3 9785.5 9810.7 6226.5 6407.5 7055.4 7108.7 7131.4 7905.2 8103.3 8198.9 8296.1 8314.8 7350.3 7441.7 7476.2 7519.8 7570.1 7089.1 7169.7 7191.7 7230.5 7371.6 6682.3 6778.9 6796.2 6802.5 6803.6 5056.5 5140.8 5164.8 5220.1 5229.8 5081.9 5125.3 5152.1 5221.2 5310.5 14:37:45 INFO - PROCESS | 2599 | 14:37:45 INFO - PROCESS | 2599 | [#4] prototype.html Cycles:180 Average:4808.34 Median:5520.43 stddev:1401.76 (25.4%) stddev-sans-first:1365.15 14:37:45 INFO - PROCESS | 2599 | Values: 348.7 349.8 350.9 355.6 356.8 5513.7 5527.2 5528.6 5540.9 5570.0 5399.3 5447.9 5499.9 5540.6 5547.5 3814.4 4123.1 4233.5 4313.1 4322.9 4295.7 4297.8 4298.8 4299.3 4302.4 4282.1 4294.6 4300.2 4302.2 4310.0 4102.5 4144.7 4217.1 4279.8 4293.1 3777.4 3792.4 3807.2 3814.3 3820.9 5270.6 5273.7 5310.4 5338.0 5359.6 4727.6 4815.2 4834.6 4864.7 4879.1 5615.2 5626.6 5634.9 5636.7 5637.4 4181.5 4187.2 4192.5 4199.8 4211.3 5664.5 5828.4 5852.8 5882.0 5893.3 4248.8 4249.4 4269.7 4274.9 4293.8 4341.3 4347.8 4354.0 4367.9 4373.9 4774.6 4827.9 4834.2 4871.5 4910.2 5660.3 5666.5 5670.2 5688.5 5710.5 1455.4 1456.7 1458.5 1459.5 1472.3 942.9 989.2 997.6 1049.9 1057.3 5314.3 5322.5 5355.5 5357.4 5385.7 5583.3 5601.3 5620.2 5659.6 5677.7 5223.2 5327.6 5366.5 5369.3 5387.2 2955.3 2991.6 2993.7 2998.3 3009.9 5591.8 5752.0 5781.3 5825.5 5863.4 5665.9 5705.4 5722.5 5730.7 5867.0 5951.5 6096.5 6108.6 6117.8 6124.3 5845.7 5863.4 5877.2 5903.9 5914.0 5590.5 5844.8 5867.9 5889.0 5896.4 6123.2 6125.8 6151.5 6154.0 6179.5 4072.3 4231.3 4243.9 4263.5 4268.4 5869.4 5876.8 5883.9 5888.6 5889.8 5782.5 5783.7 5799.5 5806.3 5811.5 5543.7 5676.5 5758.7 5759.2 5772.8 5702.0 5720.4 5729.9 5739.5 5786.6 5695.5 5805.3 5838.9 5877.2 5881.3 5629.7 5666.3 5698.4 5701.9 5705.6 14:37:45 INFO - PROCESS | 2599 | 14:37:45 INFO - PROCESS | 2599 | [#5] yui.html Cycles:180 Average:17090.75 Median:28949.03 stddev:22017.72 (76.1%) stddev-sans-first:22045.31 14:37:45 INFO - PROCESS | 2599 | Values: 753.5 769.2 784.5 785.2 813.6 13976.4 14512.7 14660.0 14690.2 16334.2 14729.3 15087.8 15098.2 15120.5 15138.5 721.9 738.3 823.7 832.8 832.8 850.0 860.1 861.3 869.9 870.4 916.4 918.1 918.3 918.4 919.6 747.3 763.9 852.0 911.1 911.2 634.0 634.0 634.3 634.5 640.7 15345.8 15374.5 15375.8 15387.1 15399.5 13888.3 13894.4 14036.2 14261.0 14313.1 13029.5 13052.9 13070.5 13425.0 13511.6 4503.7 4507.8 4526.1 4528.9 4663.9 67404.3 67458.7 67540.3 67743.3 68128.0 11297.8 11334.9 11494.5 11516.7 11711.6 21086.4 21260.3 21306.3 21387.6 21415.7 8037.6 8235.1 8298.1 8426.7 8505.5 4532.5 4732.4 4866.4 4945.0 5015.6 3378.0 3491.9 3492.5 3492.6 3495.4 578.2 586.5 587.2 587.5 587.7 626.8 639.4 660.7 679.2 722.2 8863.5 9418.4 9606.5 9690.0 9717.6 544.9 575.4 588.3 702.9 713.8 4423.9 4647.8 4669.5 4698.5 4758.3 57353.1 57515.0 57739.4 70554.6 89895.6 51002.5 74858.0 77212.8 85831.0 86432.0 46758.5 47973.3 48556.0 48652.8 73300.9 8921.6 9000.7 9044.1 9045.2 9116.8 49518.8 50010.5 50400.5 50520.7 51650.5 65865.7 65984.7 67428.0 69082.7 69843.3 10113.6 10318.2 10583.3 10610.3 10777.4 12835.7 13024.9 13039.6 13055.8 13082.3 11674.4 11715.8 11819.7 11966.9 12007.9 11686.3 11902.0 11949.6 12408.3 12433.8 11604.8 11742.0 11986.7 12311.2 12452.3 9292.2 9410.9 9569.8 9692.3 9836.5 9337.2 9572.4 9605.1 9647.0 9729.0 14:37:45 INFO - PROCESS | 2599 | -------- Summary: end -------- 14:37:45 INFO - PROCESS | 2599 | 14:37:45 INFO - TEST-INFO | 2599: exit 0 14:37:45 INFO - TEST-OK | dromaeo_css | took 1115225ms 14:37:45 INFO - TEST-START | kraken 14:37:45 INFO - operating with platform_type : linux_ 14:37:45 INFO - Initialising browser for kraken test... 14:37:45 INFO - TEST-INFO | started process 3024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFunNrm/profile http://localhost:60629/getInfo.html) 14:37:49 INFO - PROCESS | 3024 | __metrics Screen width/height:1600/1200 14:37:49 INFO - PROCESS | 3024 | colorDepth:24 14:37:49 INFO - PROCESS | 3024 | Browser inner width/height: 1024/697 14:37:49 INFO - PROCESS | 3024 | __metrics 14:37:50 INFO - PROCESS | 3024 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:37:50 INFO - PROCESS | 3024 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:37:50 INFO - PROCESS | 3024 | console.error: PushService: 14:37:50 INFO - PROCESS | 3024 | stateChangeProcessEnqueue: Error transitioning state 14:37:50 INFO - PROCESS | 3024 | UnknownError 14:37:51 INFO - TEST-INFO | 3024: exit 0 14:37:51 INFO - Browser initialized. 14:37:51 INFO - Running cycle 1/1 for kraken test... 14:37:51 INFO - TEST-INFO | started process 3116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFunNrm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:03 INFO - PROCESS | 3116 | RSS: Main: 144240640 14:38:03 INFO - PROCESS | 3116 | 14:38:05 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60629/tests/kraken/driver.html?testName=audio-beat-detection) 14:38:06 INFO - PROCESS | 3116 | RSS: Main: 185212928 14:38:06 INFO - PROCESS | 3116 | 14:38:09 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60629/tests/kraken/driver.html?testName=audio-dft) 14:38:09 INFO - PROCESS | 3116 | RSS: Main: 174907392 14:38:09 INFO - PROCESS | 3116 | 14:38:12 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60629/tests/kraken/driver.html?testName=audio-fft) 14:38:13 INFO - PROCESS | 3116 | RSS: Main: 266584064 14:38:13 INFO - PROCESS | 3116 | 14:38:15 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60629/tests/kraken/driver.html?testName=audio-oscillator) 14:38:15 INFO - PROCESS | 3116 | RSS: Main: 172404736 14:38:15 INFO - PROCESS | 3116 | 14:38:17 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60629/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:38:18 INFO - PROCESS | 3116 | RSS: Main: 175177728 14:38:18 INFO - PROCESS | 3116 | 14:38:21 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60629/tests/kraken/driver.html?testName=imaging-darkroom) 14:38:21 INFO - PROCESS | 3116 | RSS: Main: 213819392 14:38:21 INFO - PROCESS | 3116 | 14:38:25 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60629/tests/kraken/driver.html?testName=imaging-desaturate) 14:38:25 INFO - PROCESS | 3116 | RSS: Main: 212545536 14:38:25 INFO - PROCESS | 3116 | 14:38:28 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60629/tests/kraken/driver.html?testName=json-parse-financial) 14:38:29 INFO - PROCESS | 3116 | RSS: Main: 211263488 14:38:29 INFO - PROCESS | 3116 | 14:38:30 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60629/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:31 INFO - PROCESS | 3116 | RSS: Main: 173973504 14:38:31 INFO - PROCESS | 3116 | 14:38:32 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60629/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:33 INFO - PROCESS | 3116 | RSS: Main: 180588544 14:38:33 INFO - PROCESS | 3116 | 14:38:35 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60629/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:35 INFO - PROCESS | 3116 | RSS: Main: 189677568 14:38:35 INFO - PROCESS | 3116 | 14:38:38 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:39 INFO - PROCESS | 3116 | RSS: Main: 198926336 14:38:39 INFO - PROCESS | 3116 | 14:38:41 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:42 INFO - PROCESS | 3116 | RSS: Main: 195506176 14:38:42 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | Cycle 1(1): loaded http://localhost:60629/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60629/tests/kraken/driver.html?testName=ai-astar) 14:38:44 INFO - PROCESS | 3116 | RSS: Main: 246935552 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | __start_tp_report 14:38:44 INFO - PROCESS | 3116 | _x_x_mozilla_page_load 14:38:44 INFO - PROCESS | 3116 | _x_x_mozilla_page_load_details 14:38:44 INFO - PROCESS | 3116 | |i|pagename|runs| 14:38:44 INFO - PROCESS | 3116 | |0;ai-astar;101;112;112;111;111;110;111;110;113;110 14:38:44 INFO - PROCESS | 3116 | |1;audio-beat-detection;144;117;120;162;119;123;118;120;159;126 14:38:44 INFO - PROCESS | 3116 | |2;audio-dft;161;162;160;161;160;162;160;160;160;161 14:38:44 INFO - PROCESS | 3116 | |3;audio-fft;74;75;75;111;76;76;76;76;99;75 14:38:44 INFO - PROCESS | 3116 | |4;audio-oscillator;81;81;108;82;82;81;104;82;82;115 14:38:44 INFO - PROCESS | 3116 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;116;118;117 14:38:44 INFO - PROCESS | 3116 | |6;imaging-darkroom;147;146;146;147;146;146;146;146;146;147 14:38:44 INFO - PROCESS | 3116 | |7;imaging-desaturate;84;84;84;84;85;85;84;84;84;84 14:38:44 INFO - PROCESS | 3116 | |8;json-parse-financial;53;51;49;50;49;53;51;50;51;50 14:38:44 INFO - PROCESS | 3116 | |9;json-stringify-tinderbox;58;59;57;58;58;58;58;58;57;59 14:38:44 INFO - PROCESS | 3116 | |10;stanford-crypto-aes;75;75;80;74;75;74;74;76;74;77 14:38:44 INFO - PROCESS | 3116 | |11;stanford-crypto-ccm;124;136;121;131;120;136;124;122;170;123 14:38:44 INFO - PROCESS | 3116 | |12;stanford-crypto-pbkdf2;156;150;154;154;154;154;157;152;157;156 14:38:44 INFO - PROCESS | 3116 | |13;stanford-crypto-sha256-iterative;62;62;61;61;61;62;62;61;62;60 14:38:44 INFO - PROCESS | 3116 | __end_tp_report 14:38:44 INFO - PROCESS | 3116 | __start_cc_report 14:38:44 INFO - PROCESS | 3116 | _x_x_mozilla_cycle_collect,1594 14:38:44 INFO - PROCESS | 3116 | __end_cc_report 14:38:44 INFO - PROCESS | 3116 | __startTimestamp1484260724342__endTimestamp 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | ------- Summary: start ------- 14:38:44 INFO - PROCESS | 3116 | Number of tests: 14 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.35 (3.0%) stddev-sans-first:1.05 14:38:44 INFO - PROCESS | 3116 | Values: 101.0 112.0 112.0 111.0 111.0 110.0 111.0 110.0 113.0 110.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:124.50 stddev:17.49 (14.0%) stddev-sans-first:17.89 14:38:44 INFO - PROCESS | 3116 | Values: 144.0 117.0 120.0 162.0 119.0 123.0 118.0 120.0 159.0 126.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 14:38:44 INFO - PROCESS | 3116 | Values: 161.0 162.0 160.0 161.0 160.0 162.0 160.0 160.0 160.0 161.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:12.82 (16.9%) stddev-sans-first:13.33 14:38:44 INFO - PROCESS | 3116 | Values: 74.0 75.0 75.0 111.0 76.0 76.0 76.0 76.0 99.0 75.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:81.50 stddev:13.51 (16.6%) stddev-sans-first:13.95 14:38:44 INFO - PROCESS | 3116 | Values: 81.0 81.0 108.0 82.0 82.0 81.0 104.0 82.0 82.0 115.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:38:44 INFO - PROCESS | 3116 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 14:38:44 INFO - PROCESS | 3116 | Values: 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 14:38:44 INFO - PROCESS | 3116 | Values: 84.0 84.0 84.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:1.42 (2.8%) stddev-sans-first:1.24 14:38:44 INFO - PROCESS | 3116 | Values: 53.0 51.0 49.0 50.0 49.0 53.0 51.0 50.0 51.0 50.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 14:38:44 INFO - PROCESS | 3116 | Values: 58.0 59.0 57.0 58.0 58.0 58.0 58.0 58.0 57.0 59.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.00 stddev:1.90 (2.5%) stddev-sans-first:2.01 14:38:44 INFO - PROCESS | 3116 | Values: 75.0 75.0 80.0 74.0 75.0 74.0 74.0 76.0 74.0 77.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:127.50 stddev:15.03 (11.8%) stddev-sans-first:15.75 14:38:44 INFO - PROCESS | 3116 | Values: 124.0 136.0 121.0 131.0 120.0 136.0 124.0 122.0 170.0 123.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:155.00 stddev:2.22 (1.4%) stddev-sans-first:2.28 14:38:44 INFO - PROCESS | 3116 | Values: 156.0 150.0 154.0 154.0 154.0 154.0 157.0 152.0 157.0 156.0 14:38:44 INFO - PROCESS | 3116 | 14:38:44 INFO - PROCESS | 3116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 14:38:44 INFO - PROCESS | 3116 | Values: 62.0 62.0 61.0 61.0 61.0 62.0 62.0 61.0 62.0 60.0 14:38:44 INFO - PROCESS | 3116 | -------- Summary: end -------- 14:38:44 INFO - PROCESS | 3116 | 14:38:45 INFO - TEST-INFO | 3116: exit 0 14:38:45 INFO - TEST-OK | kraken | took 59485ms 14:38:45 INFO - SUITE-END | took 1174s 14:38:45 INFO - Completed test suite (00:19:34) 14:38:45 INFO - javascript benchmark 14:38:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.9835700821495, 3322.850471728772, 3332.1836150143213, 3336.0825772912463, 3364.7476439267048, 5596.916046259309, 5670.177824215486, 5675.801346952852, 5683.062294721366, 5693.658380497168, 5614.887702245953, 5666.688332141731, 5672.886542269162, 5677.063284558043, 5707.400722924095, 5103.183490641507, 5124.436312005676, 5128.794848206067, 5155.922661160085, 5200.5059519345605, 5015.247712843066, 5212.739363031833, 5221.425643179247, 5223.216517522383, 5244.68531888086, 5003.049420610072, 5030.446650868402, 5059.544640982311, 5073.467285934979, 5121.257417674454, 5133.974330128344, 5174.586033117342, 5186.170212765977, 5253.317068781034, 5254.21186821976, 5100.413452452978, 5140.614453915971, 5209.661372010807, 5221.556167725748, 5252.3171987641745, 5369.865753356158, 5410.945890541123, 5467.917981230285, 5473.06957817172, 5521.1442226454965, 5945.137954996501, 5948.702564871739, 5971.641701497924, 6037.094435834616, 6039.758409663608, 6061.151438798572, 6069.514438844882, 6075.27096748393, 6075.939240607626, 6080.2399700037495, 5477.643953143072, 5538.778448862, 5550.111982082847, 5599.44005599445, 5599.636023658449, 6128.9693551531955, 6153.84615384619, 6155.876882462326, 6163.9383606164265, 6169.0, 5908.231929849092, 5917.171595976567, 5932.851678708067, 5942.6731529766275, 5944.464998150187, 5749.511291540266, 5814.360420353758, 5963.463288304073, 6022.789202377983, 6030.819075427744, 6026.457618814327, 6038.215032045806, 6050.152978583002, 6051.243594550681, 6068.878622427526, 5988.431099045583, 6008.24896887889, 6047.03247480401, 6058.333583305833, 6061.605995610271, 4499.055198408371, 4545.8636240912165, 4556.794944227518, 4613.815447382134, 4655.557722016403, 4135.627793498599, 4149.647279981175, 4172.415861779354, 4178.958210417857, 4207.97896010518, 5768.105943578668, 5769.68266745333, 5770.538356931519, 5775.075987841925, 5792.9710351447975, 5842.941570584239, 5867.970660146672, 5874.5887787854435, 6068.423499767515, 6088.817335479854, 5651.237082993744, 5694.487496125369, 5708.828735137952, 5716.885662286814, 5733.942660573424, 5113.616478764107, 5131.358580177403, 5131.692098474104, 5134.666246693953, 5152.355955505562, 5989.8203053908455, 6092.482139018233, 6162.075688646649, 6163.9383606164265, 6168.722407491584, 5953.732082056231, 5989.071693887455, 6038.184845046038, 6118.449339559283, 6124.418180272867, 6281.811545653638, 6331.081993110881, 6334.778282760081, 6334.809955701337, 6336.904946425715, 5653.717314134195, 5967.940320596738, 5972.044472884318, 5979.073243647242, 5981.491573216325, 5755.395683453177, 5943.019401798828, 5994.550408719277, 6000.129981152796, 6096.146539484387, 5867.6772777497645, 5898.616589921641, 5916.585838991401, 5918.852028699144, 5921.703914804157, 5844.415558444121, 5853.707314634166, 5863.20846685692, 5863.413658634103, 5865.120231965239, 5574.968630803314, 5685.147227915846, 5850.970745146247, 5923.111533270044, 5926.525877929842, 6019.337872833898, 6023.1266466363, 6029.095635654687, 6036.124761909411, 6047.66737829406, 5598.3282006159525, 5639.7744090237575, 5840.737166827588, 5853.707314634336, 5860.677662728591], "value": 5552.3468845110365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.1959734760725, 614.1432701381573, 628.214731585518, 648.1735786871737, 654.7413771560236, 34083.31833363331, 44468.66485013625, 44624.33063504042, 44672.3299150513, 44740.552594474044, 46280.76859615705, 46436.76781616096, 46562.30156547646, 46723.0, 46804.0, 8270.586470676442, 8726.214640682321, 8882.555872206396, 8883.0, 8887.600057997373, 8460.703875364363, 10661.147108231324, 10906.781864362709, 10929.234953553214, 10937.015668589826, 10795.2443328967, 10842.72893177669, 10842.837357439645, 10855.51150198239, 10863.29388589743, 10642.57429702811, 10672.679819605424, 10690.62582809598, 10701.518431670593, 10720.0, 10578.100861426788, 10617.991290827436, 10637.255392122555, 10654.78690426195, 10663.84004239937, 42460.57539424628, 42727.35908961368, 42858.35712464315, 42886.0, 42899.35650965238, 3591.497190393347, 3604.945925811115, 3669.2661467706566, 3675.5038069860493, 3738.158914244273, 32261.677383226102, 32380.83809580937, 32382.352352953043, 32434.837825810955, 32524.18689532757, 4247.256730072225, 4451.2655411857, 4456.153330867125, 4508.954910450919, 4588.0, 349441.0, 349949.0, 350824.24587877153, 351470.0, 352008.0, 37998.0, 38603.80698096548, 58101.0, 58571.0, 58755.706221468616, 39484.0, 39880.60119398827, 39881.80059099744, 39896.80051599781, 39935.400968984904, 14626.341814618369, 14760.852391476163, 14764.778528322084, 14768.335424905905, 14781.408743650134, 11294.491747871365, 11466.713332166595, 11834.17160798753, 11879.109066820023, 11959.760804783855, 9188.310876684141, 9412.764680883032, 9448.196903263299, 9469.621215151454, 9520.476373799507, 3551.8224088795455, 3553.09396103997, 3572.5712914450432, 3590.551181102362, 3657.305112028706, 998.8451789972565, 1074.2909679611419, 1077.2620754783, 1098.23123813331, 1210.7094297368744, 32193.81422826807, 33926.83036584851, 33945.151371215914, 34250.0, 34491.827540862636, 1128.9266197697123, 1137.181229514748, 1142.6971852459105, 1152.6369193704124, 1155.7226265696172, 17945.551361215814, 18208.726869096976, 18549.165287562093, 18597.7210341845, 19592.0, 496353.0, 500118.0, 500136.0, 500737.0, 503198.0, 61827.0, 62125.68937155376, 62135.37864621387, 62136.0, 62238.68880655658, 1243.7325974915436, 1365.1945352242026, 1410.6473381654587, 1418.432626949208, 1425.8398526232972, 32128.839355803073, 34006.82996585001, 34057.318853622295, 34515.13712157216, 34578.0, 50750.49249507458, 51402.48597513977, 51456.0, 51484.485155147966, 51498.48501514937, 306245.0, 307962.0, 308012.0, 308165.0, 308508.0, 30441.847790760905, 31165.532517012718, 32567.0, 32584.185395365304, 33169.66830331762, 48626.756866215444, 48819.0, 49715.50284497109, 49811.25283120829, 49962.25056624081, 41898.37152442655, 42242.0, 42450.36324455074, 43109.78445107755, 43944.78027609841, 42054.57945420629, 42800.35799463073, 43364.34953475637, 44370.55629443664, 44836.0, 43799.781001094794, 44033.0, 44430.11139777251, 45180.77409612931, 45224.32163517616, 36975.63024369722, 38603.61396386, 38872.416913746885, 39129.0, 39655.60344396519, 29276.268093297836, 29516.0, 29530.675502882736, 29543.409131817672, 29787.0], "value": 19615.475882126244, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.2410447835676, 408.08385175281495, 417.3947775725199, 417.43854515676406, 420.11775271928946, 14679.486217982372, 16529.173541322933, 19879.105440255204, 20172.0, 20515.692264616006, 19533.80466195341, 19841.10715017824, 19878.304259350927, 20039.899800500978, 20072.59854802903, 5704.65772053676, 5742.942570574282, 5746.913796293059, 5816.476517113459, 5963.866865295601, 4251.149770045988, 4420.8010639521135, 5708.65748055118, 5820.068788993762, 5820.82537523875, 6234.563580549363, 6450.903236451457, 6484.837879053038, 6553.115329430513, 6566.34336566342, 6261.686915654222, 6503.0, 6549.476041916635, 6555.737770489175, 6561.540692151551, 5765.394633563499, 5832.941670583325, 5835.44563266489, 5839.153322768218, 5840.737166827503, 23436.64845027326, 23696.052157913662, 23712.525749484914, 23930.64104038441, 24030.27909162728, 2368.2658375903525, 2471.9011239550396, 2514.710808257037, 2556.6676332076713, 2571.395722005327, 14650.926745366312, 14660.41358345665, 14851.331690073865, 14930.70138597222, 15106.244687765568, 1900.840487302758, 1990.7511561054869, 2016.2237538547618, 2032.634125857345, 2044.0188709419413, 67109.66445167792, 78988.21011789866, 79270.6036469814, 88790.0, 93096.53451732697, 10791.946040269748, 10812.459377031275, 11006.614768483225, 11214.327140371604, 11246.606368777053, 15623.453179138904, 15707.0, 15746.055236685836, 15771.0, 15786.921065394828, 7804.570748608768, 7943.761687149395, 8006.83986320282, 8094.392920530984, 8110.918890811135, 7609.201033891472, 7680.193579674165, 7764.301212890754, 7818.530888146729, 7851.842963140705, 6638.933610663928, 6734.191896972395, 6779.220389655155, 6817.625030623264, 6851.691673874588, 1947.4547126804518, 1967.3409407848244, 1971.2607772085469, 1980.7821139674625, 1992.0, 923.8383282925461, 935.7146070448442, 1029.6499190275192, 1035.782485678001, 1106.25880659958, 19464.610707785763, 19919.10364033593, 20173.394798156078, 20234.392968210977, 20439.284625038053, 1026.645807196531, 1053.6733612580124, 1060.7931453366673, 1079.2607064161075, 1081.8431327457474, 10174.440405777605, 10657.946710266398, 11163.092593054864, 11419.143564232716, 11670.358130302746, 450728.0, 452293.0, 471348.0, 516611.0, 519254.0, 95760.0, 97870.0, 102375.0, 103962.48018760009, 105911.47044264729, 1026.2610920137488, 1065.8614380130534, 1068.1348108032673, 1083.9349639021684, 1087.6410784441116, 17637.118144093, 17893.463196104138, 17915.19381627804, 18089.638207236047, 18441.26234950587, 43441.34837977496, 43689.56310436855, 44188.33717494176, 44651.0, 44775.10449790921, 61230.55077796838, 61362.0795688074, 62080.689596551725, 62459.37540624536, 65296.347036530926, 8299.223853146925, 8715.433496822687, 8719.738407847775, 8914.955425222832, 9054.275657947217, 11322.716932076764, 12771.808422873479, 12814.615561533168, 12906.0, 13091.541796037092, 11617.0, 11678.70803229926, 11729.706757331134, 11801.881981180079, 11883.405829708652, 11548.133889958119, 11579.0, 11593.0, 11630.6510804676, 11682.357470338873, 11480.368579728196, 11562.47968841421, 11770.58802941893, 11838.644840654793, 11851.881481185077, 8594.226519613265, 8689.565521724015, 8751.168638979287, 8828.117188281378, 9010.414323068979, 9681.322307438411, 11306.434678266218, 11389.715257118307, 11567.074634029426, 11950.880491194977], "value": 9608.874080991569, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.4207637982993, 1491.179851081905, 1620.1656147084254, 1734.2369357482698, 1792.6952418088931, 8071.91928080719, 8546.615402306896, 8550.486970781758, 8561.101084386135, 8562.614682339294, 7333.853322933538, 7550.81122971926, 8033.0761962374345, 8278.461899976497, 8373.539455329954, 2400.0759707512557, 2400.0879665726998, 2419.8064154867657, 2427.5509030829267, 2427.8300518963592, 2397.61638137898, 2400.627902675088, 2446.559619268531, 2447.2658202539255, 2447.510497900418, 2380.702412198475, 2390.988045059772, 2406.95186096278, 2409.301302622246, 2422.878856057199, 2371.383440305533, 2384.463495713468, 2387.3673476528734, 2406.1217655555683, 2406.4465173010217, 2350.424146084203, 2364.5034542746043, 2367.3844800351862, 2369.336585755991, 2369.4194922243987, 8352.123027082129, 8389.286910612605, 8403.621837017348, 8414.368922330788, 8417.537035463047, 5053.545180933734, 5144.845654630367, 5160.303359046518, 5199.402068762065, 5199.974000130013, 3328.134684981898, 3333.949990750141, 3428.142964258935, 3443.1736383268085, 3451.11996440906, 1095.5617752898825, 1116.3357802107732, 1132.3206076354122, 1135.1769966774104, 1145.8854114588557, 11595.94202028993, 11623.883761162364, 11669.649910502614, 11691.707707307216, 11696.12279079064, 4298.312270036779, 4432.601065904084, 4511.5262897395305, 4565.452145742465, 4567.132244873464, 9064.274858011344, 9066.727998160066, 9068.274538036942, 9072.591733372014, 9072.81854362909, 5233.528982391603, 5235.60732945023, 5236.607254455931, 5242.213667949762, 5243.056249875059, 4375.258739793799, 4379.386885835986, 4793.880152996133, 4812.5668689818085, 4906.55840974314, 3776.15036616759, 3819.52255968004, 3915.4909861718365, 3920.8039598019986, 3927.646511813893, 1227.699213692651, 1239.8202260672151, 1242.8570714367963, 1245.3524167432884, 1258.1570347866768, 943.306669597845, 966.6665000574791, 967.2310513142069, 973.5862258540092, 984.4733067808688, 5576.890467118197, 5680.517156041783, 5869.941300587025, 5949.791757288474, 5950.19672344228, 479.52526998272157, 479.9640026997989, 484.79638551808324, 490.32335377179265, 492.8546078906731, 3945.151792364655, 3946.940795888064, 3995.1210733638554, 4003.7797921114034, 4014.0566966762785, 9996.900030999743, 10244.948775256076, 10363.896361036293, 10373.429461379697, 10388.065074143364, 10241.74395640115, 10290.536925838354, 10294.588216471408, 10301.587936482607, 10317.638882639221, 7925.405594580314, 7933.048034235929, 7996.120426753168, 8027.357811375076, 8037.397195210383, 5703.800366987136, 5741.483266506035, 5753.2520772301, 5764.106563482667, 5765.538756899354, 9520.809583808146, 9529.952350238205, 9538.189253913495, 9613.182879455324, 9653.951730241304, 9464.432134071978, 9704.854427183456, 9785.315027947976, 9785.461799601091, 9810.65662701802, 6226.50187984951, 6407.519436042408, 7055.435565154878, 7108.715651373887, 7131.358177764027, 7905.209479052049, 8103.270705636521, 8198.918010819816, 8296.128906464975, 8314.79213019655, 7350.264973502607, 7441.702331906879, 7476.177620461854, 7519.812004699927, 7570.129435115033, 7089.0784198053925, 7169.713211471482, 7191.748288809867, 7230.530015549183, 7371.557706537625, 6682.3317668232785, 6778.932210678027, 6796.218434880052, 6802.455803535804, 6803.625800581016, 5056.494350564914, 5140.801562468819, 5164.845054648366, 5220.086484865057, 5229.790808367623, 5081.92377114351, 5125.333706618116, 5152.093725321655, 5221.190715439113, 5310.495502927216], "value": 4444.728029038463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.7349614293137, 349.84082242579626, 350.87894178100964, 355.5875184785649, 356.82872221333776, 5513.696746678931, 5527.170924361348, 5528.585356098289, 5540.944590554098, 5570.04787462645, 5399.298091248133, 5447.863803404917, 5499.945000549993, 5540.584456165783, 5547.500724934755, 3814.4278358246206, 4123.134421577005, 4233.491980962289, 4313.09425020746, 4322.935155972663, 4295.6588659180825, 4297.80659870305, 4298.763568003758, 4299.31211006239, 4302.419173411597, 4282.088180037573, 4294.613484786369, 4300.1829652366105, 4302.160574021147, 4310.0, 4102.507699076115, 4144.668426525871, 4217.135487225111, 4279.828806847722, 4293.076988447483, 3777.395616701315, 3792.374258247386, 3807.248665613821, 3814.313423583754, 3820.9044773880873, 5270.6047046471285, 5273.736313184326, 5310.415854256029, 5337.973310133463, 5359.5712343012465, 4727.605356419865, 4815.181419158716, 4834.6374021948495, 4864.713584615225, 4879.146149423872, 5615.213870058195, 5626.606137570372, 5634.887302253973, 5636.689982050985, 5637.436256374371, 4181.519125300599, 4187.225363307767, 4192.4759405074365, 4199.790010499462, 4211.347241177622, 5664.461876121762, 5828.388019257959, 5852.795152169696, 5881.999999999957, 5893.290945625807, 4248.787560621957, 4249.3625956106835, 4269.7224680395675, 4274.914501710011, 4293.849715259951, 4341.305391137403, 4347.804348804311, 4354.0, 4367.868963931087, 4373.890652733707, 4774.618030557547, 4827.9137194131745, 4834.20235661119, 4871.5128487151005, 4910.165271903785, 5660.349059858169, 5666.490015898589, 5670.177824215466, 5688.459596338341, 5710.486056254957, 1455.3523681961638, 1456.7232225877049, 1458.5405597236836, 1459.5402448228774, 1472.3374481483374, 942.9387089839139, 989.223459584223, 997.6209040564539, 1049.8530205771199, 1057.3444464432102, 5314.256004159421, 5322.520973112439, 5355.544778693855, 5357.383900851452, 5385.703786291791, 5583.302087239095, 5601.29983752031, 5620.18507316445, 5659.5755318351285, 5677.744501497443, 5223.216517522326, 5327.600429967768, 5366.517013468807, 5369.328833895763, 5387.218853266255, 2955.2516159971433, 2991.5811786349927, 2993.655729591081, 2998.250437390652, 3009.9247518812203, 5591.832245032656, 5752.0, 5781.306243250753, 5825.533957283407, 5863.355030946593, 5665.943340566624, 5705.402487303561, 5722.542196624343, 5730.713464326767, 5867.031939729897, 5951.464368206882, 6096.542759293071, 6108.648170454407, 6117.809300629084, 6124.295705993868, 5845.707714614337, 5863.355030946678, 5877.178954102141, 5903.940960590511, 5913.994620914369, 5590.468905453975, 5844.766209351578, 5867.853303667272, 5888.998870192163, 5896.3514013457625, 6123.234595675541, 6125.84685382869, 6151.477124444473, 6154.0, 6179.505639548735, 4072.3484242521054, 4231.301835197158, 4243.851465198703, 4263.488381394252, 4268.402423660628, 5869.35437101927, 5876.764929402947, 5883.94116058834, 5888.587798854039, 5889.764409423747, 5782.45066718661, 5783.732191311895, 5799.507041901317, 5806.332271788799, 5811.506021988009, 5543.695096769555, 5676.460736230051, 5758.740856661377, 5759.222504961776, 5772.797952071657, 5702.0, 5720.399358067343, 5729.882672878749, 5739.454751798572, 5786.566007549366, 5695.544356451391, 5805.303363596396, 5838.912416313844, 5877.206577112035, 5881.2942446906645, 5629.662220266797, 5666.263385759825, 5698.401667824819, 5701.942980570141, 5705.572082093777], "value": 4366.013769662524, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.4725692015587, 769.1539306762559, 784.5018413307548, 785.1990969211405, 813.585071613477, 13976.440942362306, 14512.709745805078, 14660.047096938704, 14690.192039437827, 16334.18329083547, 14729.26353682317, 15087.773683394758, 15098.16960067196, 15120.470783522578, 15138.470153544627, 721.9278072192791, 738.3133685672323, 823.6911158315631, 832.7751507093081, 832.8375966686499, 849.9660013599448, 860.0625318402939, 861.2593169873903, 869.9043105258417, 870.4342177584557, 916.3585490156884, 918.0773322810566, 918.3112665500875, 918.3984490158956, 919.5632074764467, 747.2863415438244, 763.9388848892075, 851.9872201916976, 911.1207684584375, 911.1799380557518, 633.9714712837887, 634.0077778276982, 634.2769243062912, 634.4670476799511, 640.7276907314373, 15345.846541534553, 15374.461893833774, 15375.769363459556, 15387.076775393512, 15399.538013859603, 13888.305584720825, 13894.444222231099, 14036.228007459586, 14261.0, 14313.141211527238, 13029.543965961146, 13052.869471305261, 13070.514609160176, 13425.0, 13511.594652160451, 4503.684742068057, 4507.774611269456, 4526.094781043805, 4528.909421811545, 4663.88340291492, 67404.32595674078, 67458.66270668665, 67540.32459675439, 67743.3225667742, 68128.0, 11297.830532542019, 11334.94332528332, 11494.540218391337, 11516.654500365003, 11711.648650540497, 21086.367408977756, 21260.25589104374, 21306.254281100086, 21387.57224855494, 21415.678764818542, 8037.598120093972, 8235.094139644634, 8298.128696486903, 8426.705065322683, 8505.532195729294, 4532.546745325507, 4732.382621126518, 4866.416030076413, 4944.950550494521, 5015.598752099896, 3377.966220337765, 3491.9127021824656, 3492.4935884296633, 3492.6158122606494, 3495.3708332500396, 578.2425023219596, 586.5366360575098, 587.1750190981678, 587.5064945445846, 587.665030932373, 626.8088233088952, 639.4117411980989, 660.7489154121403, 679.2019377231733, 722.2380388689983, 8863.468191908507, 9418.434893906388, 9606.471644059644, 9690.0, 9717.61129554824, 544.9209864569615, 575.4389470266541, 588.2911092133968, 702.9015937768717, 713.8072720365473, 4423.911521769611, 4647.790849411785, 4669.509701481295, 4698.483166851644, 4758.286257061469, 57353.13970290449, 57515.0, 57739.42260577424, 70554.64722676354, 89895.55052224828, 51002.489975100514, 74858.0, 77212.84180737294, 85831.0, 86432.0, 46758.5324146761, 47973.280400794014, 48556.0, 48652.7567362168, 73300.90048649274, 8921.553922303989, 9000.68497602607, 9044.14080662336, 9045.231155351605, 9116.817663646558, 49518.75240623918, 50010.49989500058, 50400.49599503958, 50520.7265673053, 51650.48349516457, 65865.67067164634, 65984.67007664932, 67428.0, 69082.65458672674, 69843.30156698571, 10113.59545618167, 10318.174546036149, 10583.31208471447, 10610.310329828537, 10777.407242601419, 12835.679108022374, 13024.934875325564, 13039.630053204488, 13055.804162937753, 13082.345882705637, 11674.416279186176, 11715.765684686428, 11819.704507387383, 11966.880331196577, 12007.939960300142, 11686.298822070703, 11902.0, 11949.581764638197, 12408.317542535247, 12433.751324973631, 11604.767904642029, 11742.0, 11986.700332491757, 12311.19977201479, 12452.31512266834, 9292.16370526656, 9410.858837117312, 9569.760755980878, 9692.321537492307, 9836.458994755358, 9337.159655631025, 9572.425654460754, 9605.087516685904, 9647.01332315196, 9728.951355243178], "value": 7040.814041694251, "unit": "score"}], "name": "dromaeo_css", "value": 7231.430162074335, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 111.0, 111.0, 110.0, 111.0, 110.0, 113.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 120.0, 162.0, 119.0, 123.0, 118.0, 120.0, 159.0, 126.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 160.0, 162.0, 160.0, 160.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 111.0, 76.0, 76.0, 76.0, 76.0, 99.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 108.0, 82.0, 82.0, 81.0, 104.0, 82.0, 82.0, 115.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 49.0, 50.0, 49.0, 53.0, 51.0, 50.0, 51.0, 50.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 57.0, 59.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 80.0, 74.0, 75.0, 74.0, 74.0, 76.0, 74.0, 77.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 136.0, 121.0, 131.0, 120.0, 136.0, 124.0, 122.0, 170.0, 123.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 150.0, 154.0, 154.0, 154.0, 154.0, 157.0, 152.0, 157.0, 156.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 60.0], "value": 61.4, "unit": "score"}], "name": "kraken", "value": 1450.9000000000005, "alertThreshold": 2.0}]} 14:38:45 INFO - Return code: 0 14:38:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:38:45 INFO - # TBPL SUCCESS # 14:38:45 INFO - Running post-action listener: _resource_record_post_action 14:38:45 INFO - [mozharness: 2017-01-12 22:38:45.640849Z] Finished run-tests step (success) 14:38:45 INFO - Running post-run listener: _resource_record_post_run 14:38:45 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 357412864; Read time: 12; Write time: 240608 14:38:45 INFO - TinderboxPrint: CPU usage
13.0% 14:38:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:38:45 INFO - TinderboxPrint: I/O write bytes / time
357,412,864 / 240,608 14:38:45 INFO - TinderboxPrint: CPU idle
8,272.8 (87.0%) 14:38:45 INFO - TinderboxPrint: CPU user
1,188.9 (12.5%) 14:38:45 INFO - TinderboxPrint: Swap in / out
0 / 0 14:38:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108298240; Read time: 0; Write time: 97876 14:38:45 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 249114624; Read time: 0; Write time: 142732 14:38:46 INFO - Running post-run listener: _upload_blobber_files 14:38:46 INFO - Blob upload gear active. 14:38:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:46 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 14:38:46 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:38:46 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:38:46 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:47 INFO - (blobuploader) - INFO - Done attempting. 14:38:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:38:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:38:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:48 INFO - (blobuploader) - INFO - Done attempting. 14:38:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:38:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:51 INFO - (blobuploader) - INFO - Done attempting. 14:38:51 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:51 INFO - Return code: 0 14:38:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41c0fdfdec425848a069516cba94e14ce97e9c07e369d5c9f16607b4ef9fe8afc3b38890679526bff559341afdb812bf0c4f5694524b2f17219ed9111e4416f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6e4c1543dd7e5476ef8dd68b4f5c34629911ab4eae7e1f9f25fa813dafbf11311ff0c61de267b302cb3c3a7207a1ec02d6efc864284de1677fc6b26e456ec1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039443ed578347b204c7c4e5056b1559117a12b004c93cb694ea17d97df40e11b6b850c6c0ee8f52b9fd9ca0f58eb37750da3bedc56c826ed722b5e5ac0ea943"} 14:38:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:51 INFO - Contents: 14:38:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41c0fdfdec425848a069516cba94e14ce97e9c07e369d5c9f16607b4ef9fe8afc3b38890679526bff559341afdb812bf0c4f5694524b2f17219ed9111e4416f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6e4c1543dd7e5476ef8dd68b4f5c34629911ab4eae7e1f9f25fa813dafbf11311ff0c61de267b302cb3c3a7207a1ec02d6efc864284de1677fc6b26e456ec1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039443ed578347b204c7c4e5056b1559117a12b004c93cb694ea17d97df40e11b6b850c6c0ee8f52b9fd9ca0f58eb37750da3bedc56c826ed722b5e5ac0ea943"} 14:38:51 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:51 INFO - Copying logs to upload dir... 14:38:51 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.156939 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-12 14:38:51.259283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 14:38:51.262599) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41c0fdfdec425848a069516cba94e14ce97e9c07e369d5c9f16607b4ef9fe8afc3b38890679526bff559341afdb812bf0c4f5694524b2f17219ed9111e4416f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6e4c1543dd7e5476ef8dd68b4f5c34629911ab4eae7e1f9f25fa813dafbf11311ff0c61de267b302cb3c3a7207a1ec02d6efc864284de1677fc6b26e456ec1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039443ed578347b204c7c4e5056b1559117a12b004c93cb694ea17d97df40e11b6b850c6c0ee8f52b9fd9ca0f58eb37750da3bedc56c826ed722b5e5ac0ea943"} build_url:https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/eQLX4f8lS4WaXv-4ylkV_g/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/41c0fdfdec425848a069516cba94e14ce97e9c07e369d5c9f16607b4ef9fe8afc3b38890679526bff559341afdb812bf0c4f5694524b2f17219ed9111e4416f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5e6e4c1543dd7e5476ef8dd68b4f5c34629911ab4eae7e1f9f25fa813dafbf11311ff0c61de267b302cb3c3a7207a1ec02d6efc864284de1677fc6b26e456ec1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/039443ed578347b204c7c4e5056b1559117a12b004c93cb694ea17d97df40e11b6b850c6c0ee8f52b9fd9ca0f58eb37750da3bedc56c826ed722b5e5ac0ea943"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 14:38:51.287692) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:38:51.288007) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1484259495.718357-305429469 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 14:38:51.373356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 14:38:51.373672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 14:38:51.374040) ========= ========= Total master_lag: 0.16 =========