builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1482403322.04 results: success (0) buildid: 20161222004019 builduid: 6c33d445397e4fe18aad9c26c94d8d82 revision: 40e863f1e8180487fa1011ed6ac807a30905d617 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:02.038361) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:02.038898) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:02.039302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:02.054572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:02.054869) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-22 02:42:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 72.3K=0.2s 2016-12-22 02:42:02 (72.3 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.282164 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:02.351032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:02.351362) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020944 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:02.401563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:02.401923) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 40e863f1e8180487fa1011ed6ac807a30905d617 --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 40e863f1e8180487fa1011ed6ac807a30905d617 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-22 02:42:02,575 truncating revision to first 12 chars 2016-12-22 02:42:02,575 Setting DEBUG logging. 2016-12-22 02:42:02,575 attempt 1/10 2016-12-22 02:42:02,575 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/40e863f1e818?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 02:42:02,973 unpacking tar archive at: mozilla-aurora-40e863f1e818/testing/mozharness/ program finished with exit code 0 elapsedTime=0.780879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:03.196398) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:03.196725) ========= script_repo_revision: 40e863f1e8180487fa1011ed6ac807a30905d617 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:03.197133) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:03.197403) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 02:42:03.207063) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-22 02:42:03.207452) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:42:03 INFO - MultiFileLogger online at 20161222 02:42:03 in /builds/slave/test 02:42:03 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 02:42:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:42:03 INFO - {'append_to_log': False, 02:42:03 INFO - 'base_work_dir': '/builds/slave/test', 02:42:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:42:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:42:03 INFO - 'branch': 'Mozilla-Aurora', 02:42:03 INFO - 'buildbot_json_path': 'buildprops.json', 02:42:03 INFO - 'config_files': ('talos/linux_config.py',), 02:42:03 INFO - 'default_actions': ('clobber', 02:42:03 INFO - 'read-buildbot-config', 02:42:03 INFO - 'download-and-extract', 02:42:03 INFO - 'populate-webroot', 02:42:03 INFO - 'create-virtualenv', 02:42:03 INFO - 'install', 02:42:03 INFO - 'run-tests'), 02:42:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:42:03 INFO - 'download_minidump_stackwalk': True, 02:42:03 INFO - 'download_symbols': 'ondemand', 02:42:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:42:03 INFO - 'tooltool.py': '/tools/tooltool.py', 02:42:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:42:03 INFO - '/tools/misc-python/virtualenv.py')}, 02:42:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:42:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:42:03 INFO - 'installer_path': 'installer.exe', 02:42:03 INFO - 'log_level': 'info', 02:42:03 INFO - 'log_name': 'talos', 02:42:03 INFO - 'log_to_console': True, 02:42:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:42:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:42:03 INFO - 'opt_config_files': (), 02:42:03 INFO - 'pip_index': False, 02:42:03 INFO - 'sps_profile': False, 02:42:03 INFO - 'sps_profile_interval': 0, 02:42:03 INFO - 'suite': 'dromaeojs', 02:42:03 INFO - 'system_bits': '32', 02:42:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:42:03 INFO - 'title': 'talos-linux64-ix-041', 02:42:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:42:03 INFO - 'use_talos_json': True, 02:42:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:42:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:42:03 INFO - 'work_dir': 'build'} 02:42:03 INFO - [mozharness: 2016-12-22 10:42:03.479994Z] Running clobber step. 02:42:03 INFO - Running pre-action listener: _resource_record_pre_action 02:42:03 INFO - Running main action method: clobber 02:42:03 INFO - rmtree: /builds/slave/test/build 02:42:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:42:03 INFO - Running post-action listener: _resource_record_post_action 02:42:03 INFO - [mozharness: 2016-12-22 10:42:03.952863Z] Finished clobber step (success) 02:42:03 INFO - [mozharness: 2016-12-22 10:42:03.952963Z] Running read-buildbot-config step. 02:42:03 INFO - Running pre-action listener: _resource_record_pre_action 02:42:03 INFO - Running main action method: read_buildbot_config 02:42:03 INFO - Using buildbot properties: 02:42:03 INFO - { 02:42:03 INFO - "project": "", 02:42:03 INFO - "product": "firefox", 02:42:03 INFO - "script_repo_revision": "production", 02:42:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:42:03 INFO - "repository": "", 02:42:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:42:03 INFO - "buildid": "20161222004019", 02:42:03 INFO - "stage_platform": "linux64-pgo", 02:42:03 INFO - "basedir": "/builds/slave/test", 02:42:03 INFO - "nightly_build": "True", 02:42:03 INFO - "buildnumber": 692, 02:42:03 INFO - "slavename": "talos-linux64-ix-041", 02:42:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:42:03 INFO - "platform": "ubuntu64_hw", 02:42:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:42:03 INFO - "branch": "mozilla-aurora", 02:42:03 INFO - "repo_path": "releases/mozilla-aurora", 02:42:03 INFO - "revision": "40e863f1e8180487fa1011ed6ac807a30905d617", 02:42:03 INFO - "pgo_build": "True", 02:42:03 INFO - "builduid": "6c33d445397e4fe18aad9c26c94d8d82", 02:42:03 INFO - "slavebuilddir": "test" 02:42:03 INFO - } 02:42:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:42:03 INFO - Running post-action listener: _resource_record_post_action 02:42:03 INFO - [mozharness: 2016-12-22 10:42:03.955449Z] Finished read-buildbot-config step (success) 02:42:03 INFO - [mozharness: 2016-12-22 10:42:03.955537Z] Running download-and-extract step. 02:42:03 INFO - Running pre-action listener: _resource_record_pre_action 02:42:03 INFO - Running main action method: download_and_extract 02:42:03 INFO - mkdir: /builds/slave/test/build/tests 02:42:03 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')]} 02:42:03 INFO - trying https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:42:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/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 02:42:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/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 02:42:04 INFO - Downloaded 1361 bytes. 02:42:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:42:04 INFO - Using the following test package requirements: 02:42:04 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:42:04 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:42:04 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:42:04 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:04 INFO - u'jsshell-linux-x86_64.zip'], 02:42:04 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:42:04 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:42:04 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:42:04 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:42:04 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:42:04 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:42:04 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:42:04 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:42:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:42:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:42:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:42:05 INFO - Http code: 200 02:42:05 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 02:42:05 INFO - x-amz-cf-id: 6PjFhjPX4Gba6GY0lFUOlWaxymh8qQZ83zw-GfSi6mACsMjB-8EDHw== 02:42:05 INFO - x-amz-version-id: 6tk4g926Bqqbnayf_aB8Eqg_4rXulz1t 02:42:05 INFO - Expected file size: 21942558 02:42:05 INFO - Obtained file size: 21942558 02:42:09 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 02:42:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:42:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:42:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:42:09 INFO - Http code: 200 02:42:09 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 02:42:09 INFO - x-amz-cf-id: GDkOKXLSkuVZAaon-0E8WvxlvOVsiqjx5uGMgHWPYWpnoeHolUI1Dw== 02:42:09 INFO - x-amz-version-id: 6tk4g926Bqqbnayf_aB8Eqg_4rXulz1t 02:42:10 INFO - Expected file size: 21942558 02:42:10 INFO - Obtained file size: 21942558 02:42:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:42:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:42:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:42:15 INFO - Http code: 200 02:42:15 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 02:42:15 INFO - x-amz-cf-id: WLvtQceGrWuahDEBavZYbRcPv4xPmwCvNN7oKNvHSgztPnwBI1vVhw== 02:42:15 INFO - x-amz-version-id: yqCSykbToxMQnAbyQuyRnSlNC0xpi0Ni 02:42:15 INFO - Expected file size: 14409038 02:42:15 INFO - Obtained file size: 14409038 02:42:15 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')]} 02:42:15 INFO - trying https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:42:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/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 02:42:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/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 02:42:16 INFO - Downloaded 63980655 bytes. 02:42:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:42:16 INFO - mkdir: /builds/slave/test/properties 02:42:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:42:16 INFO - Writing to file /builds/slave/test/properties/build_url 02:42:16 INFO - Contents: 02:42:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:42:17 INFO - Running post-action listener: _resource_record_post_action 02:42:17 INFO - Running post-action listener: set_extra_try_arguments 02:42:17 INFO - [mozharness: 2016-12-22 10:42:17.500291Z] Finished download-and-extract step (success) 02:42:17 INFO - [mozharness: 2016-12-22 10:42:17.500592Z] Running populate-webroot step. 02:42:17 INFO - Running pre-action listener: _resource_record_pre_action 02:42:17 INFO - Running main action method: populate_webroot 02:42:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:42:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:42:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:42:17 INFO - '--tppagecycles', 02:42:17 INFO - '7'], 02:42:17 INFO - 'tests': ['tsvgm']}}, 02:42:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:42:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:42:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:42:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:42:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:17 INFO - 'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:42:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:42:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:17 INFO - 'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['damp', 'tps']}, 02:42:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:17 INFO - 'tests': ['damp', 'tps']}, 02:42:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['dromaeo_dom']}, 02:42:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:42:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['basic_compositor_video']}, 02:42:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:42:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['a11yr', 02:42:17 INFO - 'ts_paint', 02:42:17 INFO - 'tpaint', 02:42:17 INFO - 'sessionrestore', 02:42:17 INFO - 'sessionrestore_no_auto_restore', 02:42:17 INFO - 'tabpaint']}, 02:42:17 INFO - 'other-e10s': {'tests': ['a11yr', 02:42:17 INFO - 'ts_paint', 02:42:17 INFO - 'tpaint', 02:42:17 INFO - 'sessionrestore', 02:42:17 INFO - 'sessionrestore_no_auto_restore', 02:42:17 INFO - 'tabpaint']}, 02:42:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:42:17 INFO - 'ts_paint', 02:42:17 INFO - 'tpaint', 02:42:17 INFO - 'sessionrestore', 02:42:17 INFO - 'sessionrestore_no_auto_restore', 02:42:17 INFO - 'tabpaint']}, 02:42:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:42:17 INFO - 'ts_paint', 02:42:17 INFO - 'tpaint', 02:42:17 INFO - 'sessionrestore', 02:42:17 INFO - 'sessionrestore_no_auto_restore', 02:42:17 INFO - 'tabpaint']}, 02:42:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['a11yr', 02:42:17 INFO - 'ts_paint', 02:42:17 INFO - 'tpaint', 02:42:17 INFO - 'sessionrestore', 02:42:17 INFO - 'sessionrestore_no_auto_restore', 02:42:17 INFO - 'tabpaint']}, 02:42:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['a11yr', 02:42:17 INFO - 'ts_paint', 02:42:17 INFO - 'tpaint', 02:42:17 INFO - 'sessionrestore', 02:42:17 INFO - 'sessionrestore_no_auto_restore', 02:42:17 INFO - 'tabpaint']}, 02:42:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['tsvgx', 02:42:17 INFO - 'tsvgr_opacity', 02:42:17 INFO - 'tart', 02:42:17 INFO - 'tscrollx', 02:42:17 INFO - 'cart']}, 02:42:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:42:17 INFO - 'tsvgr_opacity', 02:42:17 INFO - 'tart', 02:42:17 INFO - 'tscrollx', 02:42:17 INFO - 'cart']}, 02:42:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:17 INFO - 'talos_options': ['--disable-e10s'], 02:42:17 INFO - 'tests': ['tp5o']}, 02:42:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:17 INFO - 'tests': ['tp5o']}, 02:42:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:17 INFO - 'talos_options': ['--disable-e10s', 02:42:17 INFO - '--xperf_path', 02:42:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:42:17 INFO - 'tests': ['tp5n']}, 02:42:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:17 INFO - 'talos_options': ['--xperf_path', 02:42:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:42:17 INFO - 'tests': ['tp5n']}}, 02:42:17 INFO - 'talos.zip': {'path': '', 02:42:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:42:17 INFO - Running post-action listener: _resource_record_post_action 02:42:17 INFO - [mozharness: 2016-12-22 10:42:17.518453Z] Finished populate-webroot step (success) 02:42:17 INFO - [mozharness: 2016-12-22 10:42:17.518546Z] Running create-virtualenv step. 02:42:17 INFO - Running pre-action listener: _resource_record_pre_action 02:42:17 INFO - Running main action method: create_virtualenv 02:42:17 INFO - Creating virtualenv /builds/slave/test/build/venv 02:42:17 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 02:42:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:42:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:42:17 INFO - Using real prefix '/usr' 02:42:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:42:18 INFO - Installing distribute.............................................................................................................................................................................................done. 02:42:20 INFO - Installing pip.................done. 02:42:20 INFO - Return code: 0 02:42:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:42:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:42:20 INFO - Reading from file tmpfile_stdout 02:42:20 INFO - Output received: 02:42:20 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) 02:42:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:42:20 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')]} 02:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:20 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')]} 02:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:20 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 0x7f06dc594f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', '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 02:42:20 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 02:42:20 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 02:42:20 INFO - Using env: {'DISPLAY': ':0', 02:42:20 INFO - 'HOME': '/home/cltbld', 02:42:20 INFO - 'LANG': 'en_US.UTF-8', 02:42:20 INFO - 'LANGUAGE': 'en_US:en', 02:42:20 INFO - 'LOGNAME': 'cltbld', 02:42:20 INFO - 'MAIL': '/var/mail/cltbld', 02:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:20 INFO - 'MOZ_NO_REMOTE': '1', 02:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:20 INFO - 'NO_EM_RESTART': '1', 02:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:20 INFO - 'PWD': '/builds/slave/test', 02:42:20 INFO - 'SHELL': '/bin/bash', 02:42:20 INFO - 'SHLVL': '1', 02:42:20 INFO - 'TERM': 'linux', 02:42:20 INFO - 'TMOUT': '86400', 02:42:20 INFO - 'USER': 'cltbld', 02:42:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:20 INFO - '_': '/tools/buildbot/bin/python'} 02:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:20 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 02:42:20 INFO - Cleaning up... 02:42:20 INFO - Return code: 0 02:42:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:42:20 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')]} 02:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:20 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')]} 02:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:20 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 0x7f06dc594f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', '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 02:42:20 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 02:42:20 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 02:42:20 INFO - Using env: {'DISPLAY': ':0', 02:42:20 INFO - 'HOME': '/home/cltbld', 02:42:20 INFO - 'LANG': 'en_US.UTF-8', 02:42:20 INFO - 'LANGUAGE': 'en_US:en', 02:42:20 INFO - 'LOGNAME': 'cltbld', 02:42:20 INFO - 'MAIL': '/var/mail/cltbld', 02:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:20 INFO - 'MOZ_NO_REMOTE': '1', 02:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:20 INFO - 'NO_EM_RESTART': '1', 02:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:20 INFO - 'PWD': '/builds/slave/test', 02:42:20 INFO - 'SHELL': '/bin/bash', 02:42:20 INFO - 'SHLVL': '1', 02:42:20 INFO - 'TERM': 'linux', 02:42:20 INFO - 'TMOUT': '86400', 02:42:20 INFO - 'USER': 'cltbld', 02:42:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:20 INFO - '_': '/tools/buildbot/bin/python'} 02:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:20 INFO - Downloading/unpacking psutil>=3.1.1 02:42:20 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 02:42:20 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 02:42:20 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 02:42:20 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 02:42:20 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 02:42:20 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 02:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:42:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:42:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:42:22 INFO - Installing collected packages: psutil 02:42:22 INFO - Running setup.py install for psutil 02:42:22 INFO - building 'psutil._psutil_linux' extension 02:42:22 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 02:42:23 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 02:42:23 INFO - building 'psutil._psutil_posix' extension 02:42:23 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 02:42:23 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 02:42:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:42:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:42:23 INFO - Successfully installed psutil 02:42:23 INFO - Cleaning up... 02:42:23 INFO - Return code: 0 02:42:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:42:23 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')]} 02:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:23 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')]} 02:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:23 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 0x7f06dc594f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', '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 02:42:23 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 02:42:23 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 02:42:23 INFO - Using env: {'DISPLAY': ':0', 02:42:23 INFO - 'HOME': '/home/cltbld', 02:42:23 INFO - 'LANG': 'en_US.UTF-8', 02:42:23 INFO - 'LANGUAGE': 'en_US:en', 02:42:23 INFO - 'LOGNAME': 'cltbld', 02:42:23 INFO - 'MAIL': '/var/mail/cltbld', 02:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:23 INFO - 'MOZ_NO_REMOTE': '1', 02:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:23 INFO - 'NO_EM_RESTART': '1', 02:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:23 INFO - 'PWD': '/builds/slave/test', 02:42:23 INFO - 'SHELL': '/bin/bash', 02:42:23 INFO - 'SHLVL': '1', 02:42:23 INFO - 'TERM': 'linux', 02:42:23 INFO - 'TMOUT': '86400', 02:42:23 INFO - 'USER': 'cltbld', 02:42:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:23 INFO - '_': '/tools/buildbot/bin/python'} 02:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:42:23 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 02:42:23 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 02:42:23 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 02:42:23 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 02:42:23 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 02:42:23 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 02:42:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:42:25 INFO - Installing collected packages: mozsystemmonitor 02:42:25 INFO - Running setup.py install for mozsystemmonitor 02:42:25 INFO - Successfully installed mozsystemmonitor 02:42:25 INFO - Cleaning up... 02:42:25 INFO - Return code: 0 02:42:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:42:25 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')]} 02:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:25 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')]} 02:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:25 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 0x7f06dc594f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', '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 02:42:25 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 02:42:25 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 02:42:25 INFO - Using env: {'DISPLAY': ':0', 02:42:25 INFO - 'HOME': '/home/cltbld', 02:42:25 INFO - 'LANG': 'en_US.UTF-8', 02:42:25 INFO - 'LANGUAGE': 'en_US:en', 02:42:25 INFO - 'LOGNAME': 'cltbld', 02:42:25 INFO - 'MAIL': '/var/mail/cltbld', 02:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:25 INFO - 'MOZ_NO_REMOTE': '1', 02:42:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:25 INFO - 'NO_EM_RESTART': '1', 02:42:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:25 INFO - 'PWD': '/builds/slave/test', 02:42:25 INFO - 'SHELL': '/bin/bash', 02:42:25 INFO - 'SHLVL': '1', 02:42:25 INFO - 'TERM': 'linux', 02:42:25 INFO - 'TMOUT': '86400', 02:42:25 INFO - 'USER': 'cltbld', 02:42:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:25 INFO - '_': '/tools/buildbot/bin/python'} 02:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:26 INFO - Downloading/unpacking jsonschema==2.5.1 02:42:26 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 02:42:26 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 02:42:26 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 02:42:26 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 02:42:26 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 02:42:26 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 02:42:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:42:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:42:28 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 02:42:28 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 02:42:28 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 02:42:28 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 02:42:28 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 02:42:28 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 02:42:28 INFO - Downloading functools32-3.2.3-2.tar.gz 02:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:42:28 INFO - warning: no files found matching '*.txt' 02:42:28 INFO - no previously-included directories found matching 'build' 02:42:28 INFO - no previously-included directories found matching 'dist' 02:42:28 INFO - no previously-included directories found matching '.git*' 02:42:28 INFO - Installing collected packages: jsonschema, functools32 02:42:28 INFO - Running setup.py install for functools32 02:42:28 INFO - warning: no files found matching '*.txt' 02:42:28 INFO - no previously-included directories found matching 'build' 02:42:28 INFO - no previously-included directories found matching 'dist' 02:42:28 INFO - no previously-included directories found matching '.git*' 02:42:28 INFO - Successfully installed jsonschema functools32 02:42:28 INFO - Cleaning up... 02:42:28 INFO - Return code: 0 02:42:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:28 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 0x7f06dc594f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', '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 02:42:28 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 02:42:28 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 02:42:28 INFO - Using env: {'DISPLAY': ':0', 02:42:28 INFO - 'HOME': '/home/cltbld', 02:42:28 INFO - 'LANG': 'en_US.UTF-8', 02:42:28 INFO - 'LANGUAGE': 'en_US:en', 02:42:28 INFO - 'LOGNAME': 'cltbld', 02:42:28 INFO - 'MAIL': '/var/mail/cltbld', 02:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:28 INFO - 'MOZ_NO_REMOTE': '1', 02:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:28 INFO - 'NO_EM_RESTART': '1', 02:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:28 INFO - 'PWD': '/builds/slave/test', 02:42:28 INFO - 'SHELL': '/bin/bash', 02:42:28 INFO - 'SHLVL': '1', 02:42:28 INFO - 'TERM': 'linux', 02:42:28 INFO - 'TMOUT': '86400', 02:42:28 INFO - 'USER': 'cltbld', 02:42:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:28 INFO - '_': '/tools/buildbot/bin/python'} 02:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:42:28 INFO - Cleaning up... 02:42:28 INFO - Return code: 0 02:42:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:28 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 0x7f06dc594f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', '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 02:42:28 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 02:42:28 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 02:42:28 INFO - Using env: {'DISPLAY': ':0', 02:42:28 INFO - 'HOME': '/home/cltbld', 02:42:28 INFO - 'LANG': 'en_US.UTF-8', 02:42:28 INFO - 'LANGUAGE': 'en_US:en', 02:42:28 INFO - 'LOGNAME': 'cltbld', 02:42:28 INFO - 'MAIL': '/var/mail/cltbld', 02:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:28 INFO - 'MOZ_NO_REMOTE': '1', 02:42:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:28 INFO - 'NO_EM_RESTART': '1', 02:42:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:28 INFO - 'PWD': '/builds/slave/test', 02:42:28 INFO - 'SHELL': '/bin/bash', 02:42:28 INFO - 'SHLVL': '1', 02:42:28 INFO - 'TERM': 'linux', 02:42:28 INFO - 'TMOUT': '86400', 02:42:28 INFO - 'USER': 'cltbld', 02:42:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:28 INFO - '_': '/tools/buildbot/bin/python'} 02:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:29 INFO - Downloading/unpacking blobuploader==1.2.4 02:42:29 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 02:42:29 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 02:42:29 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 02:42:29 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 02:42:29 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 02:42:29 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 02:42:31 INFO - Downloading blobuploader-1.2.4.tar.gz 02:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:42:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:42:31 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 02:42:31 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 02:42:31 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 02:42:31 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 02:42:31 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 02:42:31 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 02:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:42:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:42:31 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 02:42:31 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 02:42:31 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 02:42:31 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 02:42:31 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 02:42:31 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 02:42:31 INFO - Downloading docopt-0.6.1.tar.gz 02:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:42:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:42:31 INFO - Running setup.py install for blobuploader 02:42:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:42:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:42:31 INFO - Running setup.py install for requests 02:42:32 INFO - Running setup.py install for docopt 02:42:32 INFO - Successfully installed blobuploader requests docopt 02:42:32 INFO - Cleaning up... 02:42:32 INFO - Return code: 0 02:42:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:32 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 0x7f06dc594f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', '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 02:42:32 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 02:42:32 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 02:42:32 INFO - Using env: {'DISPLAY': ':0', 02:42:32 INFO - 'HOME': '/home/cltbld', 02:42:32 INFO - 'LANG': 'en_US.UTF-8', 02:42:32 INFO - 'LANGUAGE': 'en_US:en', 02:42:32 INFO - 'LOGNAME': 'cltbld', 02:42:32 INFO - 'MAIL': '/var/mail/cltbld', 02:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:32 INFO - 'MOZ_NO_REMOTE': '1', 02:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:32 INFO - 'NO_EM_RESTART': '1', 02:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:32 INFO - 'PWD': '/builds/slave/test', 02:42:32 INFO - 'SHELL': '/bin/bash', 02:42:32 INFO - 'SHLVL': '1', 02:42:32 INFO - 'TERM': 'linux', 02:42:32 INFO - 'TMOUT': '86400', 02:42:32 INFO - 'USER': 'cltbld', 02:42:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:32 INFO - '_': '/tools/buildbot/bin/python'} 02:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:32 INFO - Running setup.py (path:/tmp/pip-tgiOr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:32 INFO - Running setup.py (path:/tmp/pip-21d67L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:32 INFO - Running setup.py (path:/tmp/pip-UxFkPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:32 INFO - Running setup.py (path:/tmp/pip-sICM9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:32 INFO - Running setup.py (path:/tmp/pip-7acyaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:33 INFO - Running setup.py (path:/tmp/pip-hvZ5w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:33 INFO - Running setup.py (path:/tmp/pip-AvYJ71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:33 INFO - Running setup.py (path:/tmp/pip-Fi8KzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:33 INFO - Running setup.py (path:/tmp/pip-WW4Eom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:33 INFO - Running setup.py (path:/tmp/pip-32Sv5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:33 INFO - Running setup.py (path:/tmp/pip-dlB75j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:33 INFO - Running setup.py (path:/tmp/pip-TXMuXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:33 INFO - Running setup.py (path:/tmp/pip-kRKses-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:33 INFO - Running setup.py (path:/tmp/pip-jaPkgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:33 INFO - Running setup.py (path:/tmp/pip-aDqzoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:33 INFO - Running setup.py (path:/tmp/pip-0FoJnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:33 INFO - Running setup.py (path:/tmp/pip-smkGeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:42:33 INFO - Running setup.py install for manifestparser 02:42:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:42:34 INFO - Running setup.py install for mozcrash 02:42:34 INFO - Running setup.py install for mozdebug 02:42:34 INFO - Running setup.py install for mozdevice 02:42:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:42:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:42:34 INFO - Running setup.py install for mozfile 02:42:34 INFO - Running setup.py install for mozhttpd 02:42:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:42:34 INFO - Running setup.py install for mozinfo 02:42:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:42:34 INFO - Running setup.py install for mozInstall 02:42:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:42:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:42:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:42:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:42:34 INFO - Running setup.py install for mozleak 02:42:34 INFO - Running setup.py install for mozlog 02:42:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:42:34 INFO - Running setup.py install for moznetwork 02:42:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:42:35 INFO - Running setup.py install for mozprocess 02:42:35 INFO - Running setup.py install for mozprofile 02:42:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:42:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:42:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:42:35 INFO - Running setup.py install for mozrunner 02:42:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:42:35 INFO - Running setup.py install for mozscreenshot 02:42:35 INFO - Running setup.py install for moztest 02:42:35 INFO - Running setup.py install for mozversion 02:42:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:42:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:42:35 INFO - Cleaning up... 02:42:35 INFO - Return code: 0 02:42:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:35 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')]} 02:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:35 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')]} 02:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:35 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 0x7f06dc594f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', '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 02:42:35 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 02:42:35 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 02:42:35 INFO - Using env: {'DISPLAY': ':0', 02:42:35 INFO - 'HOME': '/home/cltbld', 02:42:35 INFO - 'LANG': 'en_US.UTF-8', 02:42:35 INFO - 'LANGUAGE': 'en_US:en', 02:42:35 INFO - 'LOGNAME': 'cltbld', 02:42:35 INFO - 'MAIL': '/var/mail/cltbld', 02:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:35 INFO - 'MOZ_NO_REMOTE': '1', 02:42:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:35 INFO - 'NO_EM_RESTART': '1', 02:42:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:35 INFO - 'PWD': '/builds/slave/test', 02:42:35 INFO - 'SHELL': '/bin/bash', 02:42:35 INFO - 'SHLVL': '1', 02:42:35 INFO - 'TERM': 'linux', 02:42:35 INFO - 'TMOUT': '86400', 02:42:35 INFO - 'USER': 'cltbld', 02:42:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:35 INFO - '_': '/tools/buildbot/bin/python'} 02:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:35 INFO - Running setup.py (path:/tmp/pip-TbZQV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:35 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)) 02:42:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:35 INFO - Running setup.py (path:/tmp/pip-Wp7FQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:36 INFO - Running setup.py (path:/tmp/pip-wfN1jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:36 INFO - Running setup.py (path:/tmp/pip-odvXjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:36 INFO - Running setup.py (path:/tmp/pip-QyyrTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:36 INFO - Running setup.py (path:/tmp/pip-KDcdKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:36 INFO - Running setup.py (path:/tmp/pip-q97SYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:36 INFO - Running setup.py (path:/tmp/pip-Y6FAf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:36 INFO - Running setup.py (path:/tmp/pip-HpzSCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:36 INFO - Running setup.py (path:/tmp/pip-w0n7v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:36 INFO - Running setup.py (path:/tmp/pip-k2iEYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:36 INFO - Running setup.py (path:/tmp/pip-m_PTi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:36 INFO - Running setup.py (path:/tmp/pip-aDFIH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:36 INFO - Running setup.py (path:/tmp/pip-wHJNtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:36 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)) 02:42:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:36 INFO - Running setup.py (path:/tmp/pip-xrP1U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:37 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)) 02:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:37 INFO - Running setup.py (path:/tmp/pip-iSmsQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:37 INFO - Running setup.py (path:/tmp/pip-UTH9R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:37 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)) 02:42:37 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)) 02:42:37 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)) 02:42:37 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)) 02:42:37 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)) 02:42:37 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)) 02:42:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42:39 INFO - Downloading blessings-1.6.tar.gz 02:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:42:39 INFO - Installing collected packages: blessings 02:42:39 INFO - Running setup.py install for blessings 02:42:39 INFO - Successfully installed blessings 02:42:39 INFO - Cleaning up... 02:42:39 INFO - Return code: 0 02:42:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:42:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:39 INFO - Reading from file tmpfile_stdout 02:42:39 INFO - Current package versions: 02:42:39 INFO - argparse == 1.2.1 02:42:39 INFO - blessings == 1.6 02:42:39 INFO - blobuploader == 1.2.4 02:42:39 INFO - docopt == 0.6.1 02:42:39 INFO - functools32 == 3.2.3-2 02:42:39 INFO - jsonschema == 2.5.1 02:42:39 INFO - manifestparser == 1.1 02:42:39 INFO - mozInstall == 1.12 02:42:39 INFO - mozcrash == 1.0 02:42:39 INFO - mozdebug == 0.1 02:42:39 INFO - mozdevice == 0.48 02:42:39 INFO - mozfile == 1.2 02:42:39 INFO - mozhttpd == 0.7 02:42:39 INFO - mozinfo == 0.9 02:42:39 INFO - mozleak == 0.1 02:42:39 INFO - mozlog == 3.4 02:42:39 INFO - moznetwork == 0.27 02:42:39 INFO - mozprocess == 0.23 02:42:39 INFO - mozprofile == 0.28 02:42:39 INFO - mozrunner == 6.13 02:42:39 INFO - mozscreenshot == 0.1 02:42:39 INFO - mozsystemmonitor == 0.3 02:42:39 INFO - moztest == 0.7 02:42:39 INFO - mozversion == 1.4 02:42:39 INFO - psutil == 3.1.1 02:42:39 INFO - requests == 1.2.3 02:42:39 INFO - wsgiref == 0.1.2 02:42:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:39 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 0x7f06dc594f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', '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 02:42:39 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 02:42:39 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 02:42:39 INFO - Using env: {'DISPLAY': ':0', 02:42:39 INFO - 'HOME': '/home/cltbld', 02:42:39 INFO - 'LANG': 'en_US.UTF-8', 02:42:39 INFO - 'LANGUAGE': 'en_US:en', 02:42:39 INFO - 'LOGNAME': 'cltbld', 02:42:39 INFO - 'MAIL': '/var/mail/cltbld', 02:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:39 INFO - 'MOZ_NO_REMOTE': '1', 02:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:39 INFO - 'NO_EM_RESTART': '1', 02:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:39 INFO - 'PWD': '/builds/slave/test', 02:42:39 INFO - 'SHELL': '/bin/bash', 02:42:39 INFO - 'SHLVL': '1', 02:42:39 INFO - 'TERM': 'linux', 02:42:39 INFO - 'TMOUT': '86400', 02:42:39 INFO - 'USER': 'cltbld', 02:42:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:39 INFO - '_': '/tools/buildbot/bin/python'} 02:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:39 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)) 02:42:39 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)) 02:42:39 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)) 02:42:39 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)) 02:42:39 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)) 02:42:39 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)) 02:42:39 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)) 02:42:39 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)) 02:42:39 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)) 02:42:39 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)) 02:42:39 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)) 02:42:39 INFO - Cleaning up... 02:42:39 INFO - Return code: 0 02:42:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06dc594f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1604ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', '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 02:42: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'] in /builds/slave/test/build 02:42: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 02:42:39 INFO - Using env: {'DISPLAY': ':0', 02:42:39 INFO - 'HOME': '/home/cltbld', 02:42:39 INFO - 'LANG': 'en_US.UTF-8', 02:42:39 INFO - 'LANGUAGE': 'en_US:en', 02:42:39 INFO - 'LOGNAME': 'cltbld', 02:42:39 INFO - 'MAIL': '/var/mail/cltbld', 02:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:39 INFO - 'MOZ_NO_REMOTE': '1', 02:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:39 INFO - 'NO_EM_RESTART': '1', 02:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:39 INFO - 'PWD': '/builds/slave/test', 02:42:39 INFO - 'SHELL': '/bin/bash', 02:42:39 INFO - 'SHLVL': '1', 02:42:39 INFO - 'TERM': 'linux', 02:42:39 INFO - 'TMOUT': '86400', 02:42:39 INFO - 'USER': 'cltbld', 02:42:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:39 INFO - '_': '/tools/buildbot/bin/python'} 02:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:42:40 INFO - Cleaning up... 02:42:40 INFO - Return code: 0 02:42:40 INFO - Running post-action listener: _resource_record_post_action 02:42:40 INFO - Running post-action listener: _start_resource_monitoring 02:42:40 INFO - Starting resource monitoring. 02:42:40 INFO - [mozharness: 2016-12-22 10:42:40.140023Z] Finished create-virtualenv step (success) 02:42:40 INFO - [mozharness: 2016-12-22 10:42:40.140485Z] Running install step. 02:42:40 INFO - Running pre-action listener: _resource_record_pre_action 02:42:40 INFO - Running main action method: install 02:42:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:40 INFO - Reading from file tmpfile_stdout 02:42:40 INFO - Detecting whether we're running mozinstall >=1.0... 02:42:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:42:40 INFO - Reading from file tmpfile_stdout 02:42:40 INFO - Output received: 02:42:40 INFO - Usage: mozinstall [options] installer 02:42:40 INFO - Options: 02:42:40 INFO - -h, --help show this help message and exit 02:42:40 INFO - -d DEST, --destination=DEST 02:42:40 INFO - Directory to install application into. [default: 02:42:40 INFO - "/builds/slave/test"] 02:42:40 INFO - --app=APP Application being installed. [default: firefox] 02:42:40 INFO - mkdir: /builds/slave/test/build/application 02:42:40 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'] 02:42:40 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 02:42:56 INFO - Reading from file tmpfile_stdout 02:42:56 INFO - Output received: 02:42:56 INFO - /builds/slave/test/build/application/firefox/firefox 02:42:56 INFO - Running post-action listener: _resource_record_post_action 02:42:56 INFO - [mozharness: 2016-12-22 10:42:56.356522Z] Finished install step (success) 02:42:56 INFO - [mozharness: 2016-12-22 10:42:56.356831Z] Running run-tests step. 02:42:56 INFO - Running pre-action listener: _resource_record_pre_action 02:42:56 INFO - Running main action method: run_tests 02:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:42:56 INFO - Python 2.7.3 02:42:56 INFO - Return code: 0 02:42:56 INFO - grabbing minidump binary from tooltool 02:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:56 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 0x1601f60>, '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 0x1602d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16031d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:42:56 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 02:42:56 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 02:42:56 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 02:42:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:42:56 INFO - Return code: 0 02:42:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:42:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:42:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:42:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:42:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:42:56 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/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 02:42:56 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/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 02:42:56 INFO - Using env: {'DISPLAY': ':0', 02:42:56 INFO - 'HOME': '/home/cltbld', 02:42:56 INFO - 'LANG': 'en_US.UTF-8', 02:42:56 INFO - 'LANGUAGE': 'en_US:en', 02:42:56 INFO - 'LOGNAME': 'cltbld', 02:42:56 INFO - 'MAIL': '/var/mail/cltbld', 02:42:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:42:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:56 INFO - 'MOZ_NO_REMOTE': '1', 02:42:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:42:56 INFO - 'NO_EM_RESTART': '1', 02:42:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:56 INFO - 'PWD': '/builds/slave/test', 02:42:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:42:56 INFO - 'SHELL': '/bin/bash', 02:42:56 INFO - 'SHLVL': '1', 02:42:56 INFO - 'TERM': 'linux', 02:42:56 INFO - 'TMOUT': '86400', 02:42:56 INFO - 'USER': 'cltbld', 02:42:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856', 02:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:56 INFO - '_': '/tools/buildbot/bin/python'} 02:42:56 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/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 02:42:56 INFO - mozversion application_buildid: 20161222004019 02:42:56 INFO - mozversion application_changeset: 40e863f1e8180487fa1011ed6ac807a30905d617 02:42:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:42:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:42:56 INFO - mozversion application_name: Firefox 02:42:56 INFO - mozversion application_remotingname: firefox-dev 02:42:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:56 INFO - mozversion application_vendor: Mozilla 02:42:56 INFO - mozversion application_version: 52.0a2 02:42:56 INFO - mozversion platform_buildid: 20161222004019 02:42:56 INFO - mozversion platform_changeset: 40e863f1e8180487fa1011ed6ac807a30905d617 02:42:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:56 INFO - mozversion platform_version: 52.0a2 02:42:56 INFO - using testdate: 1482403376 02:42:56 INFO - actual date: 1482403376 02:42:56 INFO - starting webserver on 'localhost:49451' 02:42:56 INFO - SUITE-START | Running 2 tests 02:42:56 INFO - TEST-START | dromaeo_css 02:42:56 INFO - operating with platform_type : linux_ 02:42:56 INFO - Initialising browser for dromaeo_css test... 02:42:56 INFO - TEST-INFO | started process 20634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxgPbp/profile http://localhost:49451/getInfo.html) 02:43:00 INFO - PROCESS | 20634 | __metrics Screen width/height:1600/1200 02:43:00 INFO - PROCESS | 20634 | colorDepth:24 02:43:00 INFO - PROCESS | 20634 | Browser inner width/height: 1024/697 02:43:00 INFO - PROCESS | 20634 | __metrics 02:43:01 INFO - PROCESS | 20634 | 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" 02:43:01 INFO - PROCESS | 20634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:43:01 INFO - PROCESS | 20634 | console.error: PushService: 02:43:01 INFO - PROCESS | 20634 | stateChangeProcessEnqueue: Error transitioning state 02:43:01 INFO - PROCESS | 20634 | UnknownError 02:43:02 INFO - TEST-INFO | 20634: exit 0 02:43:02 INFO - Browser initialized. 02:43:02 INFO - Running cycle 1/1 for dromaeo_css test... 02:43:02 INFO - TEST-INFO | started process 20729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYxgPbp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:14 INFO - PROCESS | 20729 | RSS: Main: 144363520 02:43:14 INFO - PROCESS | 20729 | 02:44:07 INFO - PROCESS | 20729 | 1482403447157 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:46:16 INFO - PROCESS | 20729 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49451/tests/dromaeo/cssquery-ext.html) 02:46:17 INFO - PROCESS | 20729 | RSS: Main: 224845824 02:46:17 INFO - PROCESS | 20729 | 02:49:19 INFO - PROCESS | 20729 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-ext.html (next: http://localhost:49451/tests/dromaeo/cssquery-jquery.html) 02:49:20 INFO - PROCESS | 20729 | RSS: Main: 228691968 02:49:20 INFO - PROCESS | 20729 | 02:52:22 INFO - PROCESS | 20729 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49451/tests/dromaeo/cssquery-mootools.html) 02:52:23 INFO - PROCESS | 20729 | RSS: Main: 173940736 02:52:23 INFO - PROCESS | 20729 | 02:55:25 INFO - PROCESS | 20729 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49451/tests/dromaeo/cssquery-prototype.html) 02:55:25 INFO - PROCESS | 20729 | RSS: Main: 174915584 02:55:25 INFO - PROCESS | 20729 | 02:58:28 INFO - PROCESS | 20729 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49451/tests/dromaeo/cssquery-yui.html) 02:58:28 INFO - PROCESS | 20729 | RSS: Main: 176164864 02:58:28 INFO - PROCESS | 20729 | 03:01:31 INFO - PROCESS | 20729 | Cycle 1(1): loaded http://localhost:49451/tests/dromaeo/cssquery-yui.html (next: http://localhost:49451/tests/dromaeo/cssquery-dojo.html) 03:01:31 INFO - PROCESS | 20729 | RSS: Main: 269709312 03:01:31 INFO - PROCESS | 20729 | 03:01:31 INFO - PROCESS | 20729 | __start_tp_report 03:01:31 INFO - PROCESS | 20729 | _x_x_mozilla_page_load 03:01:31 INFO - PROCESS | 20729 | _x_x_mozilla_page_load_details 03:01:31 INFO - PROCESS | 20729 | |i|pagename|runs| 03:01:31 INFO - PROCESS | 20729 | |0;dojo.html;3242.708156265936;3282.294306724054;3284.0804574719086;3309.3712194683026;3313.0889005523477;5505.724713764311;5545.86135346616;5553.444655534449;5555.083411237141;5568.303962004749;5574.526165275946;5597.804076857311;5604.691741954191;5615.185798059279;5646.802361917334;5078.1874900016;5103.897922041557;5130.050940575987;5135.871603209931;5184.7148406837605;4949.208126699728;4986.551210391064;5130.51260130287;5172.40517340505;5182.481751824825;5030.446650868402;5088.4148322942965;5095.0319439306595;5103.387593488768;5104.8979020419565;5025.949740502585;5031.119554078058;5080.542751152414;5081.974590127044;5098.668586541863;4996.975015124937;4999.450060493343;5007.32401125847;5022.673526220784;5035.093683137034;5454.91817622736;5472.2338872557875;5536.141898005815;5537.473939975695;5554.944450555524;5783.652980821164;5858.648481091148;5864.941350586482;5887.882242355172;5936.050231962865;5761.884762304772;5767.36558978512;5782.335031471351;5783.161441590988;5784.739686714108;5546.362168350651;5551;5552.083906155439;5552.167174923713;5553.361363443175;5922.466977972003;5948.85127871798;5983.790567330123;6007.579469437097;6010.278766547955;5821.621594596338;5845.620034697731;5848.415158484203;5848.590598658053;5875.970620146872;5884.882302354014;5897.941020589739;5900.64596124234;5904.350521442638;5917.55618328627;5690.715464226772;5743.138529220567;5852.385499522574;5880.0297950838485;5895.322037965689;5953.553483488756;5964.254468191476;5967.940320596826;5985.610935289193;5994.670293133832;4617.238155704338;4620.884477888079;4622.930656040162;4627.097715945426;4648;4037.8788636340955;4057.634812866856;4074.5517993020744;4089.795510224477;4177.895552611209;5647.576431767552;5781.913271300934;5784.855378615568;5789.421057894177;5812.3025236971835;6021.42796434338;6075.936711075632;6077.1491991121275;6079.544034197364;6090.390960903874;5486.286782718221;5554.72226388679;5562.332520097533;5775.8556036099435;5777.364489906107;5155.61332900034;5207.140821764442;5217.399999000164;5232.136697444879;5234.685918844882;6188.597741146721;6190.226221722285;6190.350013248634;6202.41077097675;6203.96898015507;5708.429157084258;5848.590598658053;5976.7908123215475;5982.4316689914385;5982.820515384546;6013.639181649115;6043.516518678407;6068.271807383142;6161.383861613803;6172;5852.561057920588;5856.677882716492;5857.765689372377;5874.236349274567;5896.852578685395;5727.799527016535;5790;5920.407959204217;5927.377625349449;5943.465088142088;5736.024875771045;5778.27771528559;5779.942200578109;5859.736311865891;5889.087191485327;5809.970950145223;5810.099434587646;5811.767529298781;5816.127580862735;5816.94183058164;5693.975084484832;5705.543556515552;5801.1878337032;5831.212786273799;5832.766689332379;5753.942460575508;5819.970900145472;5828.475437210502;5831.096180092092;5926.822195334147;5740.942590574041;5754.510866576388;5763.4812866842185;5769.567282453917;5806.129080637769 03:01:31 INFO - PROCESS | 20729 | |1;ext.html;589.9174115623813;625.6058683029692;638.7540796793235;672.3377473188912;685.4173952140684;33144.171395715086;37315.81342093289;37367.25265494688;44444;45499;46236.768816155956;46748;46751;46790.76604616972;47097.764511177396;8807.911920880806;8959.910400895973;8967.192952634261;8970.820583588324;8971.775705607346;8385;8500;8924.241439477652;10596.841047384296;10823.458827058656;10918.890811091867;11035.39305338206;11048;11061.723456913562;11070.778584428306;10816.296940698829;10819.729506762314;10834.67495975122;10851.945740271249;10857.34855908648;10675.893241067568;10743.623973160902;10747.19396045292;10755.569777208902;10760;43406.78296608497;43604.127917441474;44009;44059.77970110129;44063.55936440627;3777.244551089793;3836.3669994450884;3866.168773713637;4074.0629655179473;4420.6242469390145;32740.836295818608;32925;33363.83318083394;33708;34341.313173736635;4104.0970986383245;4123.237201117773;4153.273177193979;4163.125743593849;4242.257604919127;343475;344967;345664;346619.9999999975;346823;38137.80931095327;39355.606443935765;63732.36267637264;64075.35924640694;64094.35905640884;40828.38757418641;41141.1771764563;41168.38247426291;41183;41216.58783412188;17441.65116697659;17595.120243988007;17601.559961001076;17609.383671571435;17630.294788208583;13369.598912032654;14464.566063018126;14545.27273636314;14550.781738273934;14560.854391456161;8857.778555536162;9281.767955801024;9580.520973951274;9596.23230141587;9604.231661467065;3582.731295152874;3604.476866193675;3618.185908170693;3628.5282913221113;3681.6686498214754;1038.0191963818838;1050.779336339362;1053.331134729437;1084.1543595995136;1135.642272684102;34021;34312.65687343144;34500.13749656228;34543.30913381718;34774.30451390958;977.4330888084894;1105.0330960409642;1143.6740528949376;1151.83874257604;1162.436218434059;16413.6717265654;18921.05394730258;18967.525811854815;18967.620647587246;19050.714239286423;262541;263548;263735;263897;264622;61695;62147.37852621416;62205;62244.37755622386;62358;1338.6519504928594;1386.7989141574415;1389.5553422904775;1446.8046813680228;1463.0636392708675;30359.200490838564;35690.821545892104;35720;35734.64265357417;36029;54916;55641.72179139078;55693.16460253018;55712.44287557073;55766.442335576125;396095;396787;397295;398755;400019;30841.69158308478;31611.683883160873;31960.52059219067;33226.833865830515;33511.49732753962;51215.487845121075;51633.48366516437;51740.482595175075;51744.48255517396;52146.47853521416;43519.564804351554;44021;44456.33315500205;44663;44744.10417816531;43573.34639980339;43836;44513.777431112634;44906;45414.772926135156;44177;45328.32007519824;45511.31733023941;45606.77196613995;45641.54358456506;37748.81125594355;38914;39131.80434097811;39817.80091099526;40188.39717404183;29398.265043374086;29625.40749184961;29651;29657;29824.701752982193 03:01:31 INFO - PROCESS | 20729 | |2;jquery.html;396.8273800896612;407.5150570820723;410.12438443922224;424.5902703890745;441.67316186022333;16009;19164.808351916476;19680;19834.305799297046;20649.277275295368;16490.75263871043;16623.168841557905;16904.83095169048;20127.094280757363;20623.27818526352;4684.976575117136;5541.833744987657;5756.136579513065;5757.337906140785;5758.74085666146;4328.350747387901;4556.225441674923;5665.660060396369;6158.291796443422;6478.319776423478;6467.441339670068;6521.15225020749;6529.444997175246;6529.902051469232;6537.575057621263;6329.873402531946;6436.517261205381;6443.774467893625;6449.516286278501;6451.580647257913;5638.5635871434715;5707.857303567444;5791.623544469639;5796.275465566804;5804.158397032449;24702;24781.87609061961;24869.129580464596;25125.24624261275;25176.24471265865;2456.6192240202795;2491.377155711072;2536.4927014597156;2822;3096.4735994880925;10891.400972946485;11177.83233251502;11372.886271137266;14542.491012814606;14940.028898121696;1921.1738952250528;1960.0787629813965;1978.0801927103967;1994.6409646263667;2014.9597008059902;91246.5437672814;91628;91813.54093229491;91920.54039729826;92999.99999999933;11497.252678575866;11803.291802491705;11830.526778928746;11842.230255033395;11871.46578403974;17212.827871721373;17226.397076102276;17248;17271.136443178042;17288.913555432144;8375.072743460589;8462.915370846336;8514.361422893307;8556.957215213884;8731.519766412908;8369.079401265855;8451.830963380698;8609.182127697859;8705.260052895575;8948.060453652402;4712.787924543335;4873.122837889214;4880.585150262267;4922.064807686528;5218.582513398919;1894.5642502224289;1944.2417457191707;2179.9891000544894;2196.286206982737;2212.4358288636295;959;1053.7365658585354;1117.6647005898199;1118.7762447510531;1144.2905398652722;20315.390538283875;20644.17423303081;20785.272515461886;20979.685304720442;21116;1029.0686928329874;1069.3904474449644;1075.2849355178876;1095.479647167589;1126.0597401170114;10814.675559733221;11759.647210583697;11794.52821887132;11912.821307680391;12010.879891201152;468460;468792;478199;480789;493045;88298;88307.55846220856;88976;89477;90375.09624903667;1024.6311327921942;1056.8309070548676;1074.3446497636435;1080.783843231357;1085.0234788690243;17717.291308348038;17870.285188592312;18396.448106556825;18402.539936501693;18510.259589616264;41333;41726.582734173484;41913.58086419097;42305.5769442314;42405.787971059945;54287.45712542824;57645.711771442555;59105.70447147909;59744.70127649334;59947.400525994184;8662.177093176138;9081.228095611947;9245.583948722458;9296.907030929604;9475.4314741113;10245.487725613839;12941.805872912102;13387.866121338662;13457.192568445533;14407.135571865721;12018.158728888893;12061.75876482483;12190.51237950472;12211.389430528616;12499.56251531192;11892.583759568373;12126.211796233216;12387.876121238673;12473.251604903735;12652.17760845542;10905.236633435583;11340.09279257674;11393.202475826612;11725.472353743931;12472.376381180724;9105.135012173832;9448.527573621153;9560.76098097553;9586.137247647745;9674.806503870024;10771.569137234423;11647.359395233343;11724.88275117238;11858.703532411759;12281.815772763237 03:01:31 INFO - PROCESS | 20729 | |3;mootools.html;1504.6464080940978;1519;1706.1213475060338;1817.1186974317445;1831.56042549788;8131.268185863271;8677.175668311516;8681.21869031787;8686.174813392725;8686.826263474726;7584.203658615848;7818.491798033138;8240.58797060146;8461.111583283759;8510.829783404328;2475.257422773165;2503.173952595648;2506.147909710698;2506.686664166979;2507.5611767940627;2473.0973194783865;2514.6982362116573;2521.4704911968415;2523.5079159563893;2527.292358139724;2422.818288628351;2453.2027091195346;2462.273629279367;2484.1057219401;2488.5271798358253;2367.6566897799808;2373.1575290771784;2389.0443822470975;2393.9945223006207;2398.388410955204;2419.0444774314224;2440.9023639054417;2449.3386785567977;2470.7899828514596;2471.2586224132688;8601.096884827128;8669.653213871437;8679.826403471958;8680.218780309802;8681.565921703952;5278.604104692164;5410.053240682865;5410.891782164374;5412.052890744104;5419.295491586068;3283.688049635281;3367.747418943589;3417.487376893461;3545.131442796506;3581.5702115746017;1026.4252018869456;1046.382634245791;1051.8167062055188;1091.307020042271;1091.497910960959;11777.705557361134;11859;11889.702757431134;11898.048156147488;11915.880841191563;4642.2340313847835;4741;4847.80608775645;4850.466448690641;4883;9972.102510774064;9995.100440960348;9995.600175992879;9996.200303975664;9997.750056248506;5459;5468.671879687232;5481.095619222863;5488.067028605146;5488.533474654699;4480.887977800581;4612.238980568169;4950.108980383566;4971.279164521125;5060.240963855377;3994.500687414073;4097.713160078766;4144.41978123063;4192.329227323614;4200.201961627281;1267.0687045021903;1269.3082270162784;1308.8233088533116;1330.381372661717;1335.8129861819352;951.7715748220377;951.9952400238093;1035.8187317219456;1048.8217003109337;1060.81966065769;5961.701914904237;6056.848578785478;6065.029595264825;6093.634381937098;6107.969460152671;478.33033752746434;492.1952607486785;493.9481354457802;499.4431209201714;1024.8257796174669;4006.959930400659;4225.661947044229;4234.9364759528635;4235.618794308527;4259.765712885821;10508.842367364496;10713.196510261761;10810.081143102767;10822;10823.080038196684;10639.787204256027;10639.946800265949;10704.625338113285;10720;10778.514966826511;7764.145943946161;7794.142644309121;7936.761897142979;7956.602169891482;7960.721374751856;5650.915236271541;5657.971710141423;5710.885782284414;5726.79956201531;5814.447627475383;9761.75595610087;9832.60669573209;9836.60653573849;9836.704898853046;9838.803223935623;9365.672201472917;9790;9807.607695692092;10102.24233182529;10138.543765530421;6640.701168447528;6811.693473793592;6813.761518346834;7600.1639819620905;7764;7662.73180438682;7853.332466740391;7897.091834438883;7919.722809701863;8108.837823243384;7283.963580182277;7289.271072892669;7373.3732632726815;7396.593187374531;7533.623318834146;7166.319199676022;7281.490295679251;7381;7466.477346585687;7724.1117271514495;6977.860442791014;7112.50212485121;7112.57324560528;7123.679434425359;7138.785836424916;5016.774245159049;5060.367454068241;5093.18509038552;5115.56517696;5281.57747380201;4939.6542242042715;5085.7457127144235;5102.591792656653;5208.5312321891215;5263.868403289948 03:01:31 INFO - PROCESS | 20729 | |4;prototype.html;361.1278761790277;363.11219069375386;363.61093629816094;364.8467643589692;369.55837773860213;5331.946680533193;5389.676619402839;5404.648697834643;5406.647878315445;5423.484768946953;5336.38631557371;5341.145416733314;5345.358556973169;5356.9732151339285;5375.516203541681;4145.999999999993;4188.246115699173;4235.8093885775215;4238.449001629784;4259.6379307758725;4195.475565554306;4218.746875187483;4219.957800422003;4222.9155416891645;4229.7885105744745;4201.894952626179;4214.8409187473535;4215.873523794291;4227.408162857202;4229.767362795045;4121.237571049351;4174.457320548309;4202.70581059326;4219.683523735702;4228.76741779202;3692.981535092334;3700.4449332600057;3702.1670124222105;3714.368557345231;3715.925681486382;5188.896222075575;5214.921776173361;5240.816571419982;5261.973690131563;5272.1300985337375;4694.319323698045;4733;4797.7601119943865;4810.11012962603;4819.566239038503;5534.640248383842;5540.36285827131;5542.224088627595;5546.334439867202;5556.611037227396;4071.9389209161886;4072.816723247461;4094.160697057096;4098.364753463218;4120.248894219974;5606.21512988182;5709.144528028366;5753.539716822686;5772.538196944276;5795.159701843251;4090.7750073745633;4094.529129150126;4096.770968709376;4099.651529620016;4113.958860411418;4162.188373267184;4165.437665915123;4169.56219596938;4173.937390939138;4180.143070670505;4653.255479123324;4730.344379467228;4790.712557246577;4791.544803243686;4798.480797581297;5464.836054918359;5492.862678433071;5517;5518.44815518453;5533.418991005887;1405.2973513243378;1420.31824724133;1421.2609443089743;1422.267532220907;1425.4369524037947;956.3401253135314;968.2592816495387;987.2299606307092;989.2531138990161;1007.4358359318805;5194.623494728381;5227.529522343008;5248.947510524846;5295.867603309871;5315.441878602691;5533.280673512418;5533.363663178706;5589.245451864028;5606.803761868397;5633.887322253532;5030.899382012412;5201.063808514504;5232.659877107976;5323.281357016753;5375.543078838265;2925.966453314968;2930.8094973826633;2939.8534571517125;2950.749186319144;2957.7633789296806;5662.716864156776;5681.715914204273;5703.828885133453;5709.314882214161;5743;5616.719164041781;5879.3826648202175;5885.970570147208;5906.438888305604;5917.615355001911;5653.575981801381;5797.681127538026;5821.88356232873;5936;5957.987142185925;5771.538276937918;5775.191473193672;5808.883822323614;5842.2405087338375;5844.795432160024;5433.962264150785;5486.149646804752;5722.628029178257;5731.627444216113;5801.5938884279385;5975.372585878594;5981.880362392815;5983;5988;5997.250343707036;4099.959000410077;4173.770442625685;4180.519240287284;4239.448871646666;4244.469441319835;5718.885622287614;5732.226149469769;5739.192154471328;5745.482906538432;5816.272965879265;5601.551875850004;5620.662760234399;5637.915431268452;5641.123027256047;5664.85837854057;5466.890662186814;5648.667286301102;5673;5712;5715.8571035724435;5631.239782629293;5636.154576813511;5637.872425514832;5653.943460565341;5658.670212500141;5690.857728556819;5709.65742055478;5749.252597162342;5773.653580785166;5783.306003279465;5353.688346355168;5487.451254874481;5502.064649009758;5543.695096769717;5546.504073167011 03:01:31 INFO - PROCESS | 20729 | |5;yui.html;801.4630197767495;810.088650268448;838.7316058861164;851.5571902610646;853.2107800284736;13916.44334226631;14644.121352718845;14862.25688715564;14887.404503819835;14984.775228371556;14585.708285834276;14645.707085858276;14765.852341476582;15099.62250943727;15349.539513814603;726.8691635505634;867.6789587852503;881.6297155194834;882.3823323673422;883.0948278015054;756.3306473770725;764.121260550366;764.1365257259289;764.1708746010557;843.5402705525472;914.2411798207505;927.8561822917459;928.4197376639601;928.4290161550631;929.066288380177;919.1314208073373;922.1147698209693;922.3082687984012;922.5341202692631;922.7785331520454;559.4154108956151;579.3974266762561;642.9935700642981;676.3236763236763;677.7864972533686;14334.784978225334;15203.087814731152;15224.238788060553;15238.695226095528;15241.923790381088;14039.929800351036;14505.129692218501;14616;14658.560243192722;14669.48656797007;12918.483260669562;12997.675058123528;13078.607641770763;13098.738025239441;13268;4294.871153865389;4339.804708788112;4348.2607956647125;4389.802458889358;4460.464744230713;64825.67587162081;66460.99999999952;66639.66680166568;67593;68193.31806681919;11534.653960381202;11570.132240082028;11599.246049006788;11653.59212427561;11665.533378664759;19624.41126766199;19632.509187270432;19662.90168549148;19674.311399100963;19712.802871971096;8528.786780330542;8662.393632445668;8865.734027979172;8877.556122193864;8884.244839188612;4937.506249375034;4957.157283261854;4967.329410529533;5028.547430731252;5062.949370506321;3488.5116083748294;3581.7850928944345;3611.0791748104066;3611.7471776975885;3630.1650620356936;601.1313651773146;617.8084793713963;625.0686477149015;630.5145038320468;631.8925782616966;695.4123765418213;695.5756988237172;709.6735501669186;713.9071920650282;747.614978286183;9262.629494820132;9558.535751618725;9565.665201717906;9701.854472182922;9824.459654718916;657.2704989325471;677.376813331736;692.1935944624456;699.923008469068;709.0082833646537;4531.365608814768;4642.3500709900645;4674.182018146811;4708.458527269339;4790.568848803624;56321;67099;90890.54554727185;91099.54450227706;93221;80457.59771201106;81222.18777812265;81522;82235;84416;72691.27308726845;74077.25922740811;74343.25656743364;74754.62622686852;75295.24704752992;8849.4247873888;8975.596098175729;8988.415752976298;9042.73401723746;9347.392419492711;48494.515054849;48526;49092.82710969465;49682.254766177815;50091.74954125352;62874.685626571576;67090.3290967084;69393.65303173654;69436;71846;11303.378314192469;11485;11495.080393568327;11851.644450666494;12006.939965300468;11962.76074478523;12602.810957835824;13363.732725345633;13558.525451609541;13643.249621270528;12170.087243456954;12231.082668799698;12274.386280686109;12339.444724987578;12455.065870059601;11575.305481671126;12010.879891200977;12443.315617641116;12473.812892806434;12680.23918564889;11927.82108268394;11998;12056.819147712617;12154.75690486203;12282.263064216175;9525.380850244712;10204.642837500653;10206.642767503101;10463.68608941733;10737.194710396907;9945.154661853823;10318.793624127626;10369.9481502592;10376.825788655739;10586.89413105859 03:01:31 INFO - PROCESS | 20729 | __end_tp_report 03:01:31 INFO - PROCESS | 20729 | __start_cc_report 03:01:31 INFO - PROCESS | 20729 | _x_x_mozilla_cycle_collect,1315 03:01:31 INFO - PROCESS | 20729 | __end_cc_report 03:01:31 INFO - PROCESS | 20729 | __startTimestamp1482404491608__endTimestamp 03:01:31 INFO - PROCESS | 20729 | 03:01:31 INFO - PROCESS | 20729 | ------- Summary: start ------- 03:01:31 INFO - PROCESS | 20729 | Number of tests: 6 03:01:31 INFO - PROCESS | 20729 | 03:01:31 INFO - PROCESS | 20729 | [#0] dojo.html Cycles:165 Average:5524.90 Median:5769.57 stddev:602.11 (10.4%) stddev-sans-first:576.73 03:01:31 INFO - PROCESS | 20729 | Values: 3242.7 3282.3 3284.1 3309.4 3313.1 5505.7 5545.9 5553.4 5555.1 5568.3 5574.5 5597.8 5604.7 5615.2 5646.8 5078.2 5103.9 5130.1 5135.9 5184.7 4949.2 4986.6 5130.5 5172.4 5182.5 5030.4 5088.4 5095.0 5103.4 5104.9 5025.9 5031.1 5080.5 5082.0 5098.7 4997.0 4999.5 5007.3 5022.7 5035.1 5454.9 5472.2 5536.1 5537.5 5554.9 5783.7 5858.6 5864.9 5887.9 5936.1 5761.9 5767.4 5782.3 5783.2 5784.7 5546.4 5551.0 5552.1 5552.2 5553.4 5922.5 5948.9 5983.8 6007.6 6010.3 5821.6 5845.6 5848.4 5848.6 5876.0 5884.9 5897.9 5900.6 5904.4 5917.6 5690.7 5743.1 5852.4 5880.0 5895.3 5953.6 5964.3 5967.9 5985.6 5994.7 4617.2 4620.9 4622.9 4627.1 4648.0 4037.9 4057.6 4074.6 4089.8 4177.9 5647.6 5781.9 5784.9 5789.4 5812.3 6021.4 6075.9 6077.1 6079.5 6090.4 5486.3 5554.7 5562.3 5775.9 5777.4 5155.6 5207.1 5217.4 5232.1 5234.7 6188.6 6190.2 6190.4 6202.4 6204.0 5708.4 5848.6 5976.8 5982.4 5982.8 6013.6 6043.5 6068.3 6161.4 6172.0 5852.6 5856.7 5857.8 5874.2 5896.9 5727.8 5790.0 5920.4 5927.4 5943.5 5736.0 5778.3 5779.9 5859.7 5889.1 5810.0 5810.1 5811.8 5816.1 5816.9 5694.0 5705.5 5801.2 5831.2 5832.8 5753.9 5820.0 5828.5 5831.1 5926.8 5740.9 5754.5 5763.5 5769.6 5806.1 03:01:31 INFO - PROCESS | 20729 | 03:01:31 INFO - PROCESS | 20729 | [#1] ext.html Cycles:180 Average:51824.94 Median:20957.53 stddev:89219.55 (425.7%) stddev-sans-first:89386.90 03:01:31 INFO - PROCESS | 20729 | Values: 589.9 625.6 638.8 672.3 685.4 33144.2 37315.8 37367.3 44444.0 45499.0 46236.8 46748.0 46751.0 46790.8 47097.8 8807.9 8959.9 8967.2 8970.8 8971.8 8385.0 8500.0 8924.2 10596.8 10823.5 10918.9 11035.4 11048.0 11061.7 11070.8 10816.3 10819.7 10834.7 10851.9 10857.3 10675.9 10743.6 10747.2 10755.6 10760.0 43406.8 43604.1 44009.0 44059.8 44063.6 3777.2 3836.4 3866.2 4074.1 4420.6 32740.8 32925.0 33363.8 33708.0 34341.3 4104.1 4123.2 4153.3 4163.1 4242.3 343475.0 344967.0 345664.0 346620.0 346823.0 38137.8 39355.6 63732.4 64075.4 64094.4 40828.4 41141.2 41168.4 41183.0 41216.6 17441.7 17595.1 17601.6 17609.4 17630.3 13369.6 14464.6 14545.3 14550.8 14560.9 8857.8 9281.8 9580.5 9596.2 9604.2 3582.7 3604.5 3618.2 3628.5 3681.7 1038.0 1050.8 1053.3 1084.2 1135.6 34021.0 34312.7 34500.1 34543.3 34774.3 977.4 1105.0 1143.7 1151.8 1162.4 16413.7 18921.1 18967.5 18967.6 19050.7 262541.0 263548.0 263735.0 263897.0 264622.0 61695.0 62147.4 62205.0 62244.4 62358.0 1338.7 1386.8 1389.6 1446.8 1463.1 30359.2 35690.8 35720.0 35734.6 36029.0 54916.0 55641.7 55693.2 55712.4 55766.4 396095.0 396787.0 397295.0 398755.0 400019.0 30841.7 31611.7 31960.5 33226.8 33511.5 51215.5 51633.5 51740.5 51744.5 52146.5 43519.6 44021.0 44456.3 44663.0 44744.1 43573.3 43836.0 44513.8 44906.0 45414.8 44177.0 45328.3 45511.3 45606.8 45641.5 37748.8 38914.0 39131.8 39817.8 40188.4 29398.3 29625.4 29651.0 29657.0 29824.7 03:01:31 INFO - PROCESS | 20729 | 03:01:31 INFO - PROCESS | 20729 | [#2] jquery.html Cycles:180 Average:29295.02 Median:24741.94 stddev:78952.96 (319.1%) stddev-sans-first:79144.63 03:01:31 INFO - PROCESS | 20729 | Values: 396.8 407.5 410.1 424.6 441.7 16009.0 19164.8 19680.0 19834.3 20649.3 16490.8 16623.2 16904.8 20127.1 20623.3 4685.0 5541.8 5756.1 5757.3 5758.7 4328.4 4556.2 5665.7 6158.3 6478.3 6467.4 6521.2 6529.4 6529.9 6537.6 6329.9 6436.5 6443.8 6449.5 6451.6 5638.6 5707.9 5791.6 5796.3 5804.2 24702.0 24781.9 24869.1 25125.2 25176.2 2456.6 2491.4 2536.5 2822.0 3096.5 10891.4 11177.8 11372.9 14542.5 14940.0 1921.2 1960.1 1978.1 1994.6 2015.0 91246.5 91628.0 91813.5 91920.5 93000.0 11497.3 11803.3 11830.5 11842.2 11871.5 17212.8 17226.4 17248.0 17271.1 17288.9 8375.1 8462.9 8514.4 8557.0 8731.5 8369.1 8451.8 8609.2 8705.3 8948.1 4712.8 4873.1 4880.6 4922.1 5218.6 1894.6 1944.2 2180.0 2196.3 2212.4 959.0 1053.7 1117.7 1118.8 1144.3 20315.4 20644.2 20785.3 20979.7 21116.0 1029.1 1069.4 1075.3 1095.5 1126.1 10814.7 11759.6 11794.5 11912.8 12010.9 468460.0 468792.0 478199.0 480789.0 493045.0 88298.0 88307.6 88976.0 89477.0 90375.1 1024.6 1056.8 1074.3 1080.8 1085.0 17717.3 17870.3 18396.4 18402.5 18510.3 41333.0 41726.6 41913.6 42305.6 42405.8 54287.5 57645.7 59105.7 59744.7 59947.4 8662.2 9081.2 9245.6 9296.9 9475.4 10245.5 12941.8 13387.9 13457.2 14407.1 12018.2 12061.8 12190.5 12211.4 12499.6 11892.6 12126.2 12387.9 12473.3 12652.2 10905.2 11340.1 11393.2 11725.5 12472.4 9105.1 9448.5 9560.8 9586.1 9674.8 10771.6 11647.4 11724.9 11858.7 12281.8 03:01:31 INFO - PROCESS | 20729 | 03:01:31 INFO - PROCESS | 20729 | [#3] mootools.html Cycles:180 Average:5701.89 Median:5038.51 stddev:3143.45 (62.4%) stddev-sans-first:3136.44 03:01:31 INFO - PROCESS | 20729 | Values: 1504.6 1519.0 1706.1 1817.1 1831.6 8131.3 8677.2 8681.2 8686.2 8686.8 7584.2 7818.5 8240.6 8461.1 8510.8 2475.3 2503.2 2506.1 2506.7 2507.6 2473.1 2514.7 2521.5 2523.5 2527.3 2422.8 2453.2 2462.3 2484.1 2488.5 2367.7 2373.2 2389.0 2394.0 2398.4 2419.0 2440.9 2449.3 2470.8 2471.3 8601.1 8669.7 8679.8 8680.2 8681.6 5278.6 5410.1 5410.9 5412.1 5419.3 3283.7 3367.7 3417.5 3545.1 3581.6 1026.4 1046.4 1051.8 1091.3 1091.5 11777.7 11859.0 11889.7 11898.0 11915.9 4642.2 4741.0 4847.8 4850.5 4883.0 9972.1 9995.1 9995.6 9996.2 9997.8 5459.0 5468.7 5481.1 5488.1 5488.5 4480.9 4612.2 4950.1 4971.3 5060.2 3994.5 4097.7 4144.4 4192.3 4200.2 1267.1 1269.3 1308.8 1330.4 1335.8 951.8 952.0 1035.8 1048.8 1060.8 5961.7 6056.8 6065.0 6093.6 6108.0 478.3 492.2 493.9 499.4 1024.8 4007.0 4225.7 4234.9 4235.6 4259.8 10508.8 10713.2 10810.1 10822.0 10823.1 10639.8 10639.9 10704.6 10720.0 10778.5 7764.1 7794.1 7936.8 7956.6 7960.7 5650.9 5658.0 5710.9 5726.8 5814.4 9761.8 9832.6 9836.6 9836.7 9838.8 9365.7 9790.0 9807.6 10102.2 10138.5 6640.7 6811.7 6813.8 7600.2 7764.0 7662.7 7853.3 7897.1 7919.7 8108.8 7284.0 7289.3 7373.4 7396.6 7533.6 7166.3 7281.5 7381.0 7466.5 7724.1 6977.9 7112.5 7112.6 7123.7 7138.8 5016.8 5060.4 5093.2 5115.6 5281.6 4939.7 5085.7 5102.6 5208.5 5263.9 03:01:31 INFO - PROCESS | 20729 | 03:01:31 INFO - PROCESS | 20729 | [#4] prototype.html Cycles:180 Average:4717.98 Median:5366.24 stddev:1373.92 (25.6%) stddev-sans-first:1338.30 03:01:31 INFO - PROCESS | 20729 | Values: 361.1 363.1 363.6 364.8 369.6 5331.9 5389.7 5404.6 5406.6 5423.5 5336.4 5341.1 5345.4 5357.0 5375.5 4146.0 4188.2 4235.8 4238.4 4259.6 4195.5 4218.7 4220.0 4222.9 4229.8 4201.9 4214.8 4215.9 4227.4 4229.8 4121.2 4174.5 4202.7 4219.7 4228.8 3693.0 3700.4 3702.2 3714.4 3715.9 5188.9 5214.9 5240.8 5262.0 5272.1 4694.3 4733.0 4797.8 4810.1 4819.6 5534.6 5540.4 5542.2 5546.3 5556.6 4071.9 4072.8 4094.2 4098.4 4120.2 5606.2 5709.1 5753.5 5772.5 5795.2 4090.8 4094.5 4096.8 4099.7 4114.0 4162.2 4165.4 4169.6 4173.9 4180.1 4653.3 4730.3 4790.7 4791.5 4798.5 5464.8 5492.9 5517.0 5518.4 5533.4 1405.3 1420.3 1421.3 1422.3 1425.4 956.3 968.3 987.2 989.3 1007.4 5194.6 5227.5 5248.9 5295.9 5315.4 5533.3 5533.4 5589.2 5606.8 5633.9 5030.9 5201.1 5232.7 5323.3 5375.5 2926.0 2930.8 2939.9 2950.7 2957.8 5662.7 5681.7 5703.8 5709.3 5743.0 5616.7 5879.4 5886.0 5906.4 5917.6 5653.6 5797.7 5821.9 5936.0 5958.0 5771.5 5775.2 5808.9 5842.2 5844.8 5434.0 5486.1 5722.6 5731.6 5801.6 5975.4 5981.9 5983.0 5988.0 5997.3 4100.0 4173.8 4180.5 4239.4 4244.5 5718.9 5732.2 5739.2 5745.5 5816.3 5601.6 5620.7 5637.9 5641.1 5664.9 5466.9 5648.7 5673.0 5712.0 5715.9 5631.2 5636.2 5637.9 5653.9 5658.7 5690.9 5709.7 5749.3 5773.7 5783.3 5353.7 5487.5 5502.1 5543.7 5546.5 03:01:31 INFO - PROCESS | 20729 | 03:01:31 INFO - PROCESS | 20729 | [#5] yui.html Cycles:180 Average:18254.95 Median:27560.15 stddev:24340.36 (88.3%) stddev-sans-first:24373.36 03:01:31 INFO - PROCESS | 20729 | Values: 801.5 810.1 838.7 851.6 853.2 13916.4 14644.1 14862.3 14887.4 14984.8 14585.7 14645.7 14765.9 15099.6 15349.5 726.9 867.7 881.6 882.4 883.1 756.3 764.1 764.1 764.2 843.5 914.2 927.9 928.4 928.4 929.1 919.1 922.1 922.3 922.5 922.8 559.4 579.4 643.0 676.3 677.8 14334.8 15203.1 15224.2 15238.7 15241.9 14039.9 14505.1 14616.0 14658.6 14669.5 12918.5 12997.7 13078.6 13098.7 13268.0 4294.9 4339.8 4348.3 4389.8 4460.5 64825.7 66461.0 66639.7 67593.0 68193.3 11534.7 11570.1 11599.2 11653.6 11665.5 19624.4 19632.5 19662.9 19674.3 19712.8 8528.8 8662.4 8865.7 8877.6 8884.2 4937.5 4957.2 4967.3 5028.5 5062.9 3488.5 3581.8 3611.1 3611.7 3630.2 601.1 617.8 625.1 630.5 631.9 695.4 695.6 709.7 713.9 747.6 9262.6 9558.5 9565.7 9701.9 9824.5 657.3 677.4 692.2 699.9 709.0 4531.4 4642.4 4674.2 4708.5 4790.6 56321.0 67099.0 90890.5 91099.5 93221.0 80457.6 81222.2 81522.0 82235.0 84416.0 72691.3 74077.3 74343.3 74754.6 75295.2 8849.4 8975.6 8988.4 9042.7 9347.4 48494.5 48526.0 49092.8 49682.3 50091.7 62874.7 67090.3 69393.7 69436.0 71846.0 11303.4 11485.0 11495.1 11851.6 12006.9 11962.8 12602.8 13363.7 13558.5 13643.2 12170.1 12231.1 12274.4 12339.4 12455.1 11575.3 12010.9 12443.3 12473.8 12680.2 11927.8 11998.0 12056.8 12154.8 12282.3 9525.4 10204.6 10206.6 10463.7 10737.2 9945.2 10318.8 10369.9 10376.8 10586.9 03:01:31 INFO - PROCESS | 20729 | -------- Summary: end -------- 03:01:31 INFO - PROCESS | 20729 | 03:01:32 INFO - TEST-INFO | 20729: exit 0 03:01:32 INFO - TEST-OK | dromaeo_css | took 1115768ms 03:01:32 INFO - TEST-START | kraken 03:01:32 INFO - operating with platform_type : linux_ 03:01:32 INFO - Initialising browser for kraken test... 03:01:32 INFO - TEST-INFO | started process 21042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHd24X4/profile http://localhost:49451/getInfo.html) 03:01:36 INFO - PROCESS | 21042 | __metrics Screen width/height:1600/1200 03:01:36 INFO - PROCESS | 21042 | colorDepth:24 03:01:36 INFO - PROCESS | 21042 | Browser inner width/height: 1024/697 03:01:36 INFO - PROCESS | 21042 | __metrics 03:01:36 INFO - PROCESS | 21042 | 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" 03:01:36 INFO - PROCESS | 21042 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:01:37 INFO - PROCESS | 21042 | console.error: PushService: 03:01:37 INFO - PROCESS | 21042 | stateChangeProcessEnqueue: Error transitioning state 03:01:37 INFO - PROCESS | 21042 | UnknownError 03:01:38 INFO - TEST-INFO | 21042: exit 0 03:01:38 INFO - Browser initialized. 03:01:38 INFO - Running cycle 1/1 for kraken test... 03:01:38 INFO - TEST-INFO | started process 21135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHd24X4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:49 INFO - PROCESS | 21135 | RSS: Main: 144445440 03:01:49 INFO - PROCESS | 21135 | 03:01:52 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49451/tests/kraken/driver.html?testName=audio-beat-detection) 03:01:53 INFO - PROCESS | 21135 | RSS: Main: 185499648 03:01:53 INFO - PROCESS | 21135 | 03:01:55 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49451/tests/kraken/driver.html?testName=audio-dft) 03:01:56 INFO - PROCESS | 21135 | RSS: Main: 175132672 03:01:56 INFO - PROCESS | 21135 | 03:01:59 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49451/tests/kraken/driver.html?testName=audio-fft) 03:01:59 INFO - PROCESS | 21135 | RSS: Main: 266199040 03:01:59 INFO - PROCESS | 21135 | 03:02:01 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49451/tests/kraken/driver.html?testName=audio-oscillator) 03:02:02 INFO - PROCESS | 21135 | RSS: Main: 172924928 03:02:02 INFO - PROCESS | 21135 | 03:02:04 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49451/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:02:05 INFO - PROCESS | 21135 | RSS: Main: 175058944 03:02:05 INFO - PROCESS | 21135 | 03:02:07 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49451/tests/kraken/driver.html?testName=imaging-darkroom) 03:02:08 INFO - PROCESS | 21135 | RSS: Main: 213766144 03:02:08 INFO - PROCESS | 21135 | 03:02:11 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49451/tests/kraken/driver.html?testName=imaging-desaturate) 03:02:12 INFO - PROCESS | 21135 | RSS: Main: 212168704 03:02:12 INFO - PROCESS | 21135 | 03:02:15 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49451/tests/kraken/driver.html?testName=json-parse-financial) 03:02:15 INFO - PROCESS | 21135 | RSS: Main: 211697664 03:02:15 INFO - PROCESS | 21135 | 03:02:17 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49451/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:02:17 INFO - PROCESS | 21135 | RSS: Main: 174026752 03:02:17 INFO - PROCESS | 21135 | 03:02:19 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:02:20 INFO - PROCESS | 21135 | RSS: Main: 180953088 03:02:20 INFO - PROCESS | 21135 | 03:02:22 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:02:22 INFO - PROCESS | 21135 | RSS: Main: 189673472 03:02:22 INFO - PROCESS | 21135 | 03:02:25 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:02:25 INFO - PROCESS | 21135 | RSS: Main: 198373376 03:02:25 INFO - PROCESS | 21135 | 03:02:28 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:02:29 INFO - PROCESS | 21135 | RSS: Main: 194490368 03:02:29 INFO - PROCESS | 21135 | 03:02:30 INFO - PROCESS | 21135 | Cycle 1(1): loaded http://localhost:49451/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49451/tests/kraken/driver.html?testName=ai-astar) 03:02:31 INFO - PROCESS | 21135 | RSS: Main: 245202944 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | __start_tp_report 03:02:31 INFO - PROCESS | 21135 | _x_x_mozilla_page_load 03:02:31 INFO - PROCESS | 21135 | _x_x_mozilla_page_load_details 03:02:31 INFO - PROCESS | 21135 | |i|pagename|runs| 03:02:31 INFO - PROCESS | 21135 | |0;ai-astar;101;110;111;113;110;111;110;110;112;111 03:02:31 INFO - PROCESS | 21135 | |1;audio-beat-detection;144;123;119;153;129;124;117;116;147;117 03:02:31 INFO - PROCESS | 21135 | |2;audio-dft;161;160;161;160;159;160;160;159;160;160 03:02:31 INFO - PROCESS | 21135 | |3;audio-fft;75;75;74;112;75;75;76;75;103;76 03:02:31 INFO - PROCESS | 21135 | |4;audio-oscillator;81;81;111;81;83;82;109;81;81;106 03:02:31 INFO - PROCESS | 21135 | |5;imaging-gaussian-blur;117;117;116;116;116;116;117;117;116;117 03:02:31 INFO - PROCESS | 21135 | |6;imaging-darkroom;146;145;146;148;147;146;146;146;146;145 03:02:31 INFO - PROCESS | 21135 | |7;imaging-desaturate;84;85;85;85;85;84;85;85;85;84 03:02:31 INFO - PROCESS | 21135 | |8;json-parse-financial;51;51;53;51;50;55;51;53;51;51 03:02:31 INFO - PROCESS | 21135 | |9;json-stringify-tinderbox;59;60;59;58;59;60;59;60;59;59 03:02:31 INFO - PROCESS | 21135 | |10;stanford-crypto-aes;75;75;75;75;80;84;81;78;75;75 03:02:31 INFO - PROCESS | 21135 | |11;stanford-crypto-ccm;124;123;122;137;121;136;120;129;168;123 03:02:31 INFO - PROCESS | 21135 | |12;stanford-crypto-pbkdf2;154;158;153;151;152;161;159;152;153;153 03:02:31 INFO - PROCESS | 21135 | |13;stanford-crypto-sha256-iterative;61;65;62;64;62;66;65;62;62;61 03:02:31 INFO - PROCESS | 21135 | __end_tp_report 03:02:31 INFO - PROCESS | 21135 | __start_cc_report 03:02:31 INFO - PROCESS | 21135 | _x_x_mozilla_cycle_collect,1615 03:02:31 INFO - PROCESS | 21135 | __end_cc_report 03:02:31 INFO - PROCESS | 21135 | __startTimestamp1482404551043__endTimestamp 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | ------- Summary: start ------- 03:02:31 INFO - PROCESS | 21135 | Number of tests: 14 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.28 (3.0%) stddev-sans-first:1.05 03:02:31 INFO - PROCESS | 21135 | Values: 101.0 110.0 111.0 113.0 110.0 111.0 110.0 110.0 112.0 111.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:126.50 stddev:13.92 (11.0%) stddev-sans-first:13.65 03:02:31 INFO - PROCESS | 21135 | Values: 144.0 123.0 119.0 153.0 129.0 124.0 117.0 116.0 147.0 117.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 03:02:31 INFO - PROCESS | 21135 | Values: 161.0 160.0 161.0 160.0 159.0 160.0 160.0 159.0 160.0 160.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:13.83 (18.4%) stddev-sans-first:14.46 03:02:31 INFO - PROCESS | 21135 | Values: 75.0 75.0 74.0 112.0 75.0 75.0 76.0 75.0 103.0 76.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:81.00 stddev:13.23 (16.3%) stddev-sans-first:13.66 03:02:31 INFO - PROCESS | 21135 | Values: 81.0 81.0 111.0 81.0 83.0 82.0 109.0 81.0 81.0 106.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:02:31 INFO - PROCESS | 21135 | Values: 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 03:02:31 INFO - PROCESS | 21135 | Values: 146.0 145.0 146.0 148.0 147.0 146.0 146.0 146.0 146.0 145.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 03:02:31 INFO - PROCESS | 21135 | Values: 84.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 85.0 84.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:51.00 stddev:1.49 (2.9%) stddev-sans-first:1.56 03:02:31 INFO - PROCESS | 21135 | Values: 51.0 51.0 53.0 51.0 50.0 55.0 51.0 53.0 51.0 51.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 03:02:31 INFO - PROCESS | 21135 | Values: 59.0 60.0 59.0 58.0 59.0 60.0 59.0 60.0 59.0 59.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.50 stddev:3.30 (4.3%) stddev-sans-first:3.40 03:02:31 INFO - PROCESS | 21135 | Values: 75.0 75.0 75.0 75.0 80.0 84.0 81.0 78.0 75.0 75.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:126.50 stddev:14.56 (11.5%) stddev-sans-first:15.26 03:02:31 INFO - PROCESS | 21135 | Values: 124.0 123.0 122.0 137.0 121.0 136.0 120.0 129.0 168.0 123.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:153.50 stddev:3.44 (2.2%) stddev-sans-first:3.64 03:02:31 INFO - PROCESS | 21135 | Values: 154.0 158.0 153.0 151.0 152.0 161.0 159.0 152.0 153.0 153.0 03:02:31 INFO - PROCESS | 21135 | 03:02:31 INFO - PROCESS | 21135 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.83 (2.9%) stddev-sans-first:1.79 03:02:31 INFO - PROCESS | 21135 | Values: 61.0 65.0 62.0 64.0 62.0 66.0 65.0 62.0 62.0 61.0 03:02:31 INFO - PROCESS | 21135 | -------- Summary: end -------- 03:02:31 INFO - PROCESS | 21135 | 03:02:32 INFO - TEST-INFO | 21135: exit 0 03:02:32 INFO - TEST-OK | kraken | took 59887ms 03:02:32 INFO - SUITE-END | took 1175s 03:02:32 INFO - Completed test suite (00:19:36) 03:02:32 INFO - javascript benchmark 03:02:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3242.708156265936, 3282.294306724054, 3284.0804574719086, 3309.3712194683026, 3313.0889005523477, 5505.724713764311, 5545.86135346616, 5553.444655534449, 5555.083411237141, 5568.303962004749, 5574.526165275946, 5597.804076857311, 5604.691741954191, 5615.185798059279, 5646.802361917334, 5078.1874900016, 5103.897922041557, 5130.050940575987, 5135.871603209931, 5184.7148406837605, 4949.208126699728, 4986.551210391064, 5130.51260130287, 5172.40517340505, 5182.481751824825, 5030.446650868402, 5088.4148322942965, 5095.0319439306595, 5103.387593488768, 5104.8979020419565, 5025.949740502585, 5031.119554078058, 5080.542751152414, 5081.974590127044, 5098.668586541863, 4996.975015124937, 4999.450060493343, 5007.32401125847, 5022.673526220784, 5035.093683137034, 5454.91817622736, 5472.2338872557875, 5536.141898005815, 5537.473939975695, 5554.944450555524, 5783.652980821164, 5858.648481091148, 5864.941350586482, 5887.882242355172, 5936.050231962865, 5761.884762304772, 5767.36558978512, 5782.335031471351, 5783.161441590988, 5784.739686714108, 5546.362168350651, 5551.0, 5552.083906155439, 5552.167174923713, 5553.361363443175, 5922.466977972003, 5948.85127871798, 5983.790567330123, 6007.579469437097, 6010.278766547955, 5821.621594596338, 5845.620034697731, 5848.415158484203, 5848.590598658053, 5875.970620146872, 5884.882302354014, 5897.941020589739, 5900.64596124234, 5904.350521442638, 5917.55618328627, 5690.715464226772, 5743.138529220567, 5852.385499522574, 5880.0297950838485, 5895.322037965689, 5953.553483488756, 5964.254468191476, 5967.940320596826, 5985.610935289193, 5994.670293133832, 4617.238155704338, 4620.884477888079, 4622.930656040162, 4627.097715945426, 4648.0, 4037.8788636340955, 4057.634812866856, 4074.5517993020744, 4089.795510224477, 4177.895552611209, 5647.576431767552, 5781.913271300934, 5784.855378615568, 5789.421057894177, 5812.3025236971835, 6021.42796434338, 6075.936711075632, 6077.1491991121275, 6079.544034197364, 6090.390960903874, 5486.286782718221, 5554.72226388679, 5562.332520097533, 5775.8556036099435, 5777.364489906107, 5155.61332900034, 5207.140821764442, 5217.399999000164, 5232.136697444879, 5234.685918844882, 6188.597741146721, 6190.226221722285, 6190.350013248634, 6202.41077097675, 6203.96898015507, 5708.429157084258, 5848.590598658053, 5976.7908123215475, 5982.4316689914385, 5982.820515384546, 6013.639181649115, 6043.516518678407, 6068.271807383142, 6161.383861613803, 6172.0, 5852.561057920588, 5856.677882716492, 5857.765689372377, 5874.236349274567, 5896.852578685395, 5727.799527016535, 5790.0, 5920.407959204217, 5927.377625349449, 5943.465088142088, 5736.024875771045, 5778.27771528559, 5779.942200578109, 5859.736311865891, 5889.087191485327, 5809.970950145223, 5810.099434587646, 5811.767529298781, 5816.127580862735, 5816.94183058164, 5693.975084484832, 5705.543556515552, 5801.1878337032, 5831.212786273799, 5832.766689332379, 5753.942460575508, 5819.970900145472, 5828.475437210502, 5831.096180092092, 5926.822195334147, 5740.942590574041, 5754.510866576388, 5763.4812866842185, 5769.567282453917, 5806.129080637769], "value": 5485.97838898485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.9174115623813, 625.6058683029692, 638.7540796793235, 672.3377473188912, 685.4173952140684, 33144.171395715086, 37315.81342093289, 37367.25265494688, 44444.0, 45499.0, 46236.768816155956, 46748.0, 46751.0, 46790.76604616972, 47097.764511177396, 8807.911920880806, 8959.910400895973, 8967.192952634261, 8970.820583588324, 8971.775705607346, 8385.0, 8500.0, 8924.241439477652, 10596.841047384296, 10823.458827058656, 10918.890811091867, 11035.39305338206, 11048.0, 11061.723456913562, 11070.778584428306, 10816.296940698829, 10819.729506762314, 10834.67495975122, 10851.945740271249, 10857.34855908648, 10675.893241067568, 10743.623973160902, 10747.19396045292, 10755.569777208902, 10760.0, 43406.78296608497, 43604.127917441474, 44009.0, 44059.77970110129, 44063.55936440627, 3777.244551089793, 3836.3669994450884, 3866.168773713637, 4074.0629655179473, 4420.6242469390145, 32740.836295818608, 32925.0, 33363.83318083394, 33708.0, 34341.313173736635, 4104.0970986383245, 4123.237201117773, 4153.273177193979, 4163.125743593849, 4242.257604919127, 343475.0, 344967.0, 345664.0, 346619.9999999975, 346823.0, 38137.80931095327, 39355.606443935765, 63732.36267637264, 64075.35924640694, 64094.35905640884, 40828.38757418641, 41141.1771764563, 41168.38247426291, 41183.0, 41216.58783412188, 17441.65116697659, 17595.120243988007, 17601.559961001076, 17609.383671571435, 17630.294788208583, 13369.598912032654, 14464.566063018126, 14545.27273636314, 14550.781738273934, 14560.854391456161, 8857.778555536162, 9281.767955801024, 9580.520973951274, 9596.23230141587, 9604.231661467065, 3582.731295152874, 3604.476866193675, 3618.185908170693, 3628.5282913221113, 3681.6686498214754, 1038.0191963818838, 1050.779336339362, 1053.331134729437, 1084.1543595995136, 1135.642272684102, 34021.0, 34312.65687343144, 34500.13749656228, 34543.30913381718, 34774.30451390958, 977.4330888084894, 1105.0330960409642, 1143.6740528949376, 1151.83874257604, 1162.436218434059, 16413.6717265654, 18921.05394730258, 18967.525811854815, 18967.620647587246, 19050.714239286423, 262541.0, 263548.0, 263735.0, 263897.0, 264622.0, 61695.0, 62147.37852621416, 62205.0, 62244.37755622386, 62358.0, 1338.6519504928594, 1386.7989141574415, 1389.5553422904775, 1446.8046813680228, 1463.0636392708675, 30359.200490838564, 35690.821545892104, 35720.0, 35734.64265357417, 36029.0, 54916.0, 55641.72179139078, 55693.16460253018, 55712.44287557073, 55766.442335576125, 396095.0, 396787.0, 397295.0, 398755.0, 400019.0, 30841.69158308478, 31611.683883160873, 31960.52059219067, 33226.833865830515, 33511.49732753962, 51215.487845121075, 51633.48366516437, 51740.482595175075, 51744.48255517396, 52146.47853521416, 43519.564804351554, 44021.0, 44456.33315500205, 44663.0, 44744.10417816531, 43573.34639980339, 43836.0, 44513.777431112634, 44906.0, 45414.772926135156, 44177.0, 45328.32007519824, 45511.31733023941, 45606.77196613995, 45641.54358456506, 37748.81125594355, 38914.0, 39131.80434097811, 39817.80091099526, 40188.39717404183, 29398.265043374086, 29625.40749184961, 29651.0, 29657.0, 29824.701752982193], "value": 19791.72479590801, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.8273800896612, 407.5150570820723, 410.12438443922224, 424.5902703890745, 441.67316186022333, 16009.0, 19164.808351916476, 19680.0, 19834.305799297046, 20649.277275295368, 16490.75263871043, 16623.168841557905, 16904.83095169048, 20127.094280757363, 20623.27818526352, 4684.976575117136, 5541.833744987657, 5756.136579513065, 5757.337906140785, 5758.74085666146, 4328.350747387901, 4556.225441674923, 5665.660060396369, 6158.291796443422, 6478.319776423478, 6467.441339670068, 6521.15225020749, 6529.444997175246, 6529.902051469232, 6537.575057621263, 6329.873402531946, 6436.517261205381, 6443.774467893625, 6449.516286278501, 6451.580647257913, 5638.5635871434715, 5707.857303567444, 5791.623544469639, 5796.275465566804, 5804.158397032449, 24702.0, 24781.87609061961, 24869.129580464596, 25125.24624261275, 25176.24471265865, 2456.6192240202795, 2491.377155711072, 2536.4927014597156, 2822.0, 3096.4735994880925, 10891.400972946485, 11177.83233251502, 11372.886271137266, 14542.491012814606, 14940.028898121696, 1921.1738952250528, 1960.0787629813965, 1978.0801927103967, 1994.6409646263667, 2014.9597008059902, 91246.5437672814, 91628.0, 91813.54093229491, 91920.54039729826, 92999.99999999933, 11497.252678575866, 11803.291802491705, 11830.526778928746, 11842.230255033395, 11871.46578403974, 17212.827871721373, 17226.397076102276, 17248.0, 17271.136443178042, 17288.913555432144, 8375.072743460589, 8462.915370846336, 8514.361422893307, 8556.957215213884, 8731.519766412908, 8369.079401265855, 8451.830963380698, 8609.182127697859, 8705.260052895575, 8948.060453652402, 4712.787924543335, 4873.122837889214, 4880.585150262267, 4922.064807686528, 5218.582513398919, 1894.5642502224289, 1944.2417457191707, 2179.9891000544894, 2196.286206982737, 2212.4358288636295, 959.0, 1053.7365658585354, 1117.6647005898199, 1118.7762447510531, 1144.2905398652722, 20315.390538283875, 20644.17423303081, 20785.272515461886, 20979.685304720442, 21116.0, 1029.0686928329874, 1069.3904474449644, 1075.2849355178876, 1095.479647167589, 1126.0597401170114, 10814.675559733221, 11759.647210583697, 11794.52821887132, 11912.821307680391, 12010.879891201152, 468460.0, 468792.0, 478199.0, 480789.0, 493045.0, 88298.0, 88307.55846220856, 88976.0, 89477.0, 90375.09624903667, 1024.6311327921942, 1056.8309070548676, 1074.3446497636435, 1080.783843231357, 1085.0234788690243, 17717.291308348038, 17870.285188592312, 18396.448106556825, 18402.539936501693, 18510.259589616264, 41333.0, 41726.582734173484, 41913.58086419097, 42305.5769442314, 42405.787971059945, 54287.45712542824, 57645.711771442555, 59105.70447147909, 59744.70127649334, 59947.400525994184, 8662.177093176138, 9081.228095611947, 9245.583948722458, 9296.907030929604, 9475.4314741113, 10245.487725613839, 12941.805872912102, 13387.866121338662, 13457.192568445533, 14407.135571865721, 12018.158728888893, 12061.75876482483, 12190.51237950472, 12211.389430528616, 12499.56251531192, 11892.583759568373, 12126.211796233216, 12387.876121238673, 12473.251604903735, 12652.17760845542, 10905.236633435583, 11340.09279257674, 11393.202475826612, 11725.472353743931, 12472.376381180724, 9105.135012173832, 9448.527573621153, 9560.76098097553, 9586.137247647745, 9674.806503870024, 10771.569137234423, 11647.359395233343, 11724.88275117238, 11858.703532411759, 12281.815772763237], "value": 9681.347028385182, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.6464080940978, 1519.0, 1706.1213475060338, 1817.1186974317445, 1831.56042549788, 8131.268185863271, 8677.175668311516, 8681.21869031787, 8686.174813392725, 8686.826263474726, 7584.203658615848, 7818.491798033138, 8240.58797060146, 8461.111583283759, 8510.829783404328, 2475.257422773165, 2503.173952595648, 2506.147909710698, 2506.686664166979, 2507.5611767940627, 2473.0973194783865, 2514.6982362116573, 2521.4704911968415, 2523.5079159563893, 2527.292358139724, 2422.818288628351, 2453.2027091195346, 2462.273629279367, 2484.1057219401, 2488.5271798358253, 2367.6566897799808, 2373.1575290771784, 2389.0443822470975, 2393.9945223006207, 2398.388410955204, 2419.0444774314224, 2440.9023639054417, 2449.3386785567977, 2470.7899828514596, 2471.2586224132688, 8601.096884827128, 8669.653213871437, 8679.826403471958, 8680.218780309802, 8681.565921703952, 5278.604104692164, 5410.053240682865, 5410.891782164374, 5412.052890744104, 5419.295491586068, 3283.688049635281, 3367.747418943589, 3417.487376893461, 3545.131442796506, 3581.5702115746017, 1026.4252018869456, 1046.382634245791, 1051.8167062055188, 1091.307020042271, 1091.497910960959, 11777.705557361134, 11859.0, 11889.702757431134, 11898.048156147488, 11915.880841191563, 4642.2340313847835, 4741.0, 4847.80608775645, 4850.466448690641, 4883.0, 9972.102510774064, 9995.100440960348, 9995.600175992879, 9996.200303975664, 9997.750056248506, 5459.0, 5468.671879687232, 5481.095619222863, 5488.067028605146, 5488.533474654699, 4480.887977800581, 4612.238980568169, 4950.108980383566, 4971.279164521125, 5060.240963855377, 3994.500687414073, 4097.713160078766, 4144.41978123063, 4192.329227323614, 4200.201961627281, 1267.0687045021903, 1269.3082270162784, 1308.8233088533116, 1330.381372661717, 1335.8129861819352, 951.7715748220377, 951.9952400238093, 1035.8187317219456, 1048.8217003109337, 1060.81966065769, 5961.701914904237, 6056.848578785478, 6065.029595264825, 6093.634381937098, 6107.969460152671, 478.33033752746434, 492.1952607486785, 493.9481354457802, 499.4431209201714, 1024.8257796174669, 4006.959930400659, 4225.661947044229, 4234.9364759528635, 4235.618794308527, 4259.765712885821, 10508.842367364496, 10713.196510261761, 10810.081143102767, 10822.0, 10823.080038196684, 10639.787204256027, 10639.946800265949, 10704.625338113285, 10720.0, 10778.514966826511, 7764.145943946161, 7794.142644309121, 7936.761897142979, 7956.602169891482, 7960.721374751856, 5650.915236271541, 5657.971710141423, 5710.885782284414, 5726.79956201531, 5814.447627475383, 9761.75595610087, 9832.60669573209, 9836.60653573849, 9836.704898853046, 9838.803223935623, 9365.672201472917, 9790.0, 9807.607695692092, 10102.24233182529, 10138.543765530421, 6640.701168447528, 6811.693473793592, 6813.761518346834, 7600.1639819620905, 7764.0, 7662.73180438682, 7853.332466740391, 7897.091834438883, 7919.722809701863, 8108.837823243384, 7283.963580182277, 7289.271072892669, 7373.3732632726815, 7396.593187374531, 7533.623318834146, 7166.319199676022, 7281.490295679251, 7381.0, 7466.477346585687, 7724.1117271514495, 6977.860442791014, 7112.50212485121, 7112.57324560528, 7123.679434425359, 7138.785836424916, 5016.774245159049, 5060.367454068241, 5093.18509038552, 5115.56517696, 5281.57747380201, 4939.6542242042715, 5085.7457127144235, 5102.591792656653, 5208.5312321891215, 5263.868403289948], "value": 4583.07119385633, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.1278761790277, 363.11219069375386, 363.61093629816094, 364.8467643589692, 369.55837773860213, 5331.946680533193, 5389.676619402839, 5404.648697834643, 5406.647878315445, 5423.484768946953, 5336.38631557371, 5341.145416733314, 5345.358556973169, 5356.9732151339285, 5375.516203541681, 4145.999999999993, 4188.246115699173, 4235.8093885775215, 4238.449001629784, 4259.6379307758725, 4195.475565554306, 4218.746875187483, 4219.957800422003, 4222.9155416891645, 4229.7885105744745, 4201.894952626179, 4214.8409187473535, 4215.873523794291, 4227.408162857202, 4229.767362795045, 4121.237571049351, 4174.457320548309, 4202.70581059326, 4219.683523735702, 4228.76741779202, 3692.981535092334, 3700.4449332600057, 3702.1670124222105, 3714.368557345231, 3715.925681486382, 5188.896222075575, 5214.921776173361, 5240.816571419982, 5261.973690131563, 5272.1300985337375, 4694.319323698045, 4733.0, 4797.7601119943865, 4810.11012962603, 4819.566239038503, 5534.640248383842, 5540.36285827131, 5542.224088627595, 5546.334439867202, 5556.611037227396, 4071.9389209161886, 4072.816723247461, 4094.160697057096, 4098.364753463218, 4120.248894219974, 5606.21512988182, 5709.144528028366, 5753.539716822686, 5772.538196944276, 5795.159701843251, 4090.7750073745633, 4094.529129150126, 4096.770968709376, 4099.651529620016, 4113.958860411418, 4162.188373267184, 4165.437665915123, 4169.56219596938, 4173.937390939138, 4180.143070670505, 4653.255479123324, 4730.344379467228, 4790.712557246577, 4791.544803243686, 4798.480797581297, 5464.836054918359, 5492.862678433071, 5517.0, 5518.44815518453, 5533.418991005887, 1405.2973513243378, 1420.31824724133, 1421.2609443089743, 1422.267532220907, 1425.4369524037947, 956.3401253135314, 968.2592816495387, 987.2299606307092, 989.2531138990161, 1007.4358359318805, 5194.623494728381, 5227.529522343008, 5248.947510524846, 5295.867603309871, 5315.441878602691, 5533.280673512418, 5533.363663178706, 5589.245451864028, 5606.803761868397, 5633.887322253532, 5030.899382012412, 5201.063808514504, 5232.659877107976, 5323.281357016753, 5375.543078838265, 2925.966453314968, 2930.8094973826633, 2939.8534571517125, 2950.749186319144, 2957.7633789296806, 5662.716864156776, 5681.715914204273, 5703.828885133453, 5709.314882214161, 5743.0, 5616.719164041781, 5879.3826648202175, 5885.970570147208, 5906.438888305604, 5917.615355001911, 5653.575981801381, 5797.681127538026, 5821.88356232873, 5936.0, 5957.987142185925, 5771.538276937918, 5775.191473193672, 5808.883822323614, 5842.2405087338375, 5844.795432160024, 5433.962264150785, 5486.149646804752, 5722.628029178257, 5731.627444216113, 5801.5938884279385, 5975.372585878594, 5981.880362392815, 5983.0, 5988.0, 5997.250343707036, 4099.959000410077, 4173.770442625685, 4180.519240287284, 4239.448871646666, 4244.469441319835, 5718.885622287614, 5732.226149469769, 5739.192154471328, 5745.482906538432, 5816.272965879265, 5601.551875850004, 5620.662760234399, 5637.915431268452, 5641.123027256047, 5664.85837854057, 5466.890662186814, 5648.667286301102, 5673.0, 5712.0, 5715.8571035724435, 5631.239782629293, 5636.154576813511, 5637.872425514832, 5653.943460565341, 5658.670212500141, 5690.857728556819, 5709.65742055478, 5749.252597162342, 5773.653580785166, 5783.306003279465, 5353.688346355168, 5487.451254874481, 5502.064649009758, 5543.695096769717, 5546.504073167011], "value": 4288.556694399881, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.4630197767495, 810.088650268448, 838.7316058861164, 851.5571902610646, 853.2107800284736, 13916.44334226631, 14644.121352718845, 14862.25688715564, 14887.404503819835, 14984.775228371556, 14585.708285834276, 14645.707085858276, 14765.852341476582, 15099.62250943727, 15349.539513814603, 726.8691635505634, 867.6789587852503, 881.6297155194834, 882.3823323673422, 883.0948278015054, 756.3306473770725, 764.121260550366, 764.1365257259289, 764.1708746010557, 843.5402705525472, 914.2411798207505, 927.8561822917459, 928.4197376639601, 928.4290161550631, 929.066288380177, 919.1314208073373, 922.1147698209693, 922.3082687984012, 922.5341202692631, 922.7785331520454, 559.4154108956151, 579.3974266762561, 642.9935700642981, 676.3236763236763, 677.7864972533686, 14334.784978225334, 15203.087814731152, 15224.238788060553, 15238.695226095528, 15241.923790381088, 14039.929800351036, 14505.129692218501, 14616.0, 14658.560243192722, 14669.48656797007, 12918.483260669562, 12997.675058123528, 13078.607641770763, 13098.738025239441, 13268.0, 4294.871153865389, 4339.804708788112, 4348.2607956647125, 4389.802458889358, 4460.464744230713, 64825.67587162081, 66460.99999999952, 66639.66680166568, 67593.0, 68193.31806681919, 11534.653960381202, 11570.132240082028, 11599.246049006788, 11653.59212427561, 11665.533378664759, 19624.41126766199, 19632.509187270432, 19662.90168549148, 19674.311399100963, 19712.802871971096, 8528.786780330542, 8662.393632445668, 8865.734027979172, 8877.556122193864, 8884.244839188612, 4937.506249375034, 4957.157283261854, 4967.329410529533, 5028.547430731252, 5062.949370506321, 3488.5116083748294, 3581.7850928944345, 3611.0791748104066, 3611.7471776975885, 3630.1650620356936, 601.1313651773146, 617.8084793713963, 625.0686477149015, 630.5145038320468, 631.8925782616966, 695.4123765418213, 695.5756988237172, 709.6735501669186, 713.9071920650282, 747.614978286183, 9262.629494820132, 9558.535751618725, 9565.665201717906, 9701.854472182922, 9824.459654718916, 657.2704989325471, 677.376813331736, 692.1935944624456, 699.923008469068, 709.0082833646537, 4531.365608814768, 4642.3500709900645, 4674.182018146811, 4708.458527269339, 4790.568848803624, 56321.0, 67099.0, 90890.54554727185, 91099.54450227706, 93221.0, 80457.59771201106, 81222.18777812265, 81522.0, 82235.0, 84416.0, 72691.27308726845, 74077.25922740811, 74343.25656743364, 74754.62622686852, 75295.24704752992, 8849.4247873888, 8975.596098175729, 8988.415752976298, 9042.73401723746, 9347.392419492711, 48494.515054849, 48526.0, 49092.82710969465, 49682.254766177815, 50091.74954125352, 62874.685626571576, 67090.3290967084, 69393.65303173654, 69436.0, 71846.0, 11303.378314192469, 11485.0, 11495.080393568327, 11851.644450666494, 12006.939965300468, 11962.76074478523, 12602.810957835824, 13363.732725345633, 13558.525451609541, 13643.249621270528, 12170.087243456954, 12231.082668799698, 12274.386280686109, 12339.444724987578, 12455.065870059601, 11575.305481671126, 12010.879891200977, 12443.315617641116, 12473.812892806434, 12680.23918564889, 11927.82108268394, 11998.0, 12056.819147712617, 12154.75690486203, 12282.263064216175, 9525.380850244712, 10204.642837500653, 10206.642767503101, 10463.68608941733, 10737.194710396907, 9945.154661853823, 10318.793624127626, 10369.9481502592, 10376.825788655739, 10586.89413105859], "value": 7285.464298630883, "unit": "score"}], "name": "dromaeo_css", "value": 7293.57534766771, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 113.0, 110.0, 111.0, 110.0, 110.0, 112.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 119.0, 153.0, 129.0, 124.0, 117.0, 116.0, 147.0, 117.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 159.0, 160.0, 160.0, 159.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 112.0, 75.0, 75.0, 76.0, 75.0, 103.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 111.0, 81.0, 83.0, 82.0, 109.0, 81.0, 81.0, 106.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 53.0, 51.0, 50.0, 55.0, 51.0, 53.0, 51.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 58.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 80.0, 84.0, 81.0, 78.0, 75.0, 75.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 122.0, 137.0, 121.0, 136.0, 120.0, 129.0, 168.0, 123.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 158.0, 153.0, 151.0, 152.0, 161.0, 159.0, 152.0, 153.0, 153.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 62.0, 64.0, 62.0, 66.0, 65.0, 62.0, 62.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1453.3999999999999, "alertThreshold": 2.0}]} 03:02:32 INFO - Return code: 0 03:02:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:02:32 INFO - # TBPL SUCCESS # 03:02:32 INFO - Running post-action listener: _resource_record_post_action 03:02:32 INFO - [mozharness: 2016-12-22 11:02:32.862629Z] Finished run-tests step (success) 03:02:32 INFO - Running post-run listener: _resource_record_post_run 03:02:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 367734784; Read time: 32; Write time: 215644 03:02:32 INFO - TinderboxPrint: CPU usage
12.9% 03:02:32 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 03:02:32 INFO - TinderboxPrint: I/O write bytes / time
367,734,784 / 215,644 03:02:32 INFO - TinderboxPrint: CPU idle
8,281.1 (87.0%) 03:02:32 INFO - TinderboxPrint: CPU user
1,188.9 (12.5%) 03:02:32 INFO - TinderboxPrint: Swap in / out
0 / 0 03:02:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118681600; Read time: 0; Write time: 73440 03:02:32 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248500224; Read time: 12; Write time: 142204 03:02:33 INFO - Running post-run listener: _upload_blobber_files 03:02:33 INFO - Blob upload gear active. 03:02:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:02:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:02:33 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'] 03:02:33 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 03:02:33 INFO - (blobuploader) - INFO - Open directory for files ... 03:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:02:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:37 INFO - (blobuploader) - INFO - Done attempting. 03:02:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:02:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:02:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:37 INFO - (blobuploader) - INFO - Done attempting. 03:02:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:02:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:02:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:38 INFO - (blobuploader) - INFO - Done attempting. 03:02:38 INFO - (blobuploader) - INFO - Iteration through files over. 03:02:38 INFO - Return code: 0 03:02:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:02:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:02:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd3e84ffc4c4833cb19092d5ebae52c2689343c041e9837f26d568d654b3069f51d982afc2455ec16cf3240aad55994e80feef76ccb14f350510be49a2cbaa23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b83c85428f8e7bedba030a3af4ebeabb7c4f0739e74caa0455ad888146733e85ccf72ede2fb38e51156824118333fbadf4bcc5d78a0c0bca50b6611bd55b23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bb2b3d0b6f2ac456ac3e28dd0b458cceff388be5027156a7c7209f471fa1777e04cb52b688555e80170fe0798efa71fbeb7feccb24f907530cfd9b39a9d73ca"} 03:02:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:02:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:02:38 INFO - Contents: 03:02:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd3e84ffc4c4833cb19092d5ebae52c2689343c041e9837f26d568d654b3069f51d982afc2455ec16cf3240aad55994e80feef76ccb14f350510be49a2cbaa23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b83c85428f8e7bedba030a3af4ebeabb7c4f0739e74caa0455ad888146733e85ccf72ede2fb38e51156824118333fbadf4bcc5d78a0c0bca50b6611bd55b23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bb2b3d0b6f2ac456ac3e28dd0b458cceff388be5027156a7c7209f471fa1777e04cb52b688555e80170fe0798efa71fbeb7feccb24f907530cfd9b39a9d73ca"} 03:02:38 INFO - Running post-run listener: copy_logs_to_upload_dir 03:02:38 INFO - Copying logs to upload dir... 03:02:38 INFO - mkdir: /builds/slave/test/build/upload/logs 03:02:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.323796 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-22 03:02:38.548976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 03:02:38.552417) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856 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/bd3e84ffc4c4833cb19092d5ebae52c2689343c041e9837f26d568d654b3069f51d982afc2455ec16cf3240aad55994e80feef76ccb14f350510be49a2cbaa23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b83c85428f8e7bedba030a3af4ebeabb7c4f0739e74caa0455ad888146733e85ccf72ede2fb38e51156824118333fbadf4bcc5d78a0c0bca50b6611bd55b23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bb2b3d0b6f2ac456ac3e28dd0b458cceff388be5027156a7c7209f471fa1777e04cb52b688555e80170fe0798efa71fbeb7feccb24f907530cfd9b39a9d73ca"} build_url:https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011789 build_url: 'https://queue.taskcluster.net/v1/task/Y7c5LWNxRG2ZThLfqtImFA/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/bd3e84ffc4c4833cb19092d5ebae52c2689343c041e9837f26d568d654b3069f51d982afc2455ec16cf3240aad55994e80feef76ccb14f350510be49a2cbaa23", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/08b83c85428f8e7bedba030a3af4ebeabb7c4f0739e74caa0455ad888146733e85ccf72ede2fb38e51156824118333fbadf4bcc5d78a0c0bca50b6611bd55b23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1bb2b3d0b6f2ac456ac3e28dd0b458cceff388be5027156a7c7209f471fa1777e04cb52b688555e80170fe0798efa71fbeb7feccb24f907530cfd9b39a9d73ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 03:02:38.577597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 03:02:38.577948) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1482403106.506604-82154856 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 03:02:38.662973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 03:02:38.663290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 03:02:38.663598) ========= ========= Total master_lag: 0.17 =========