builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1484027700.42 results: success (0) buildid: 20170109201208 builduid: 9498fab751f84ebb8bace0e92c0c5966 revision: 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:00.423079) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:00.423464) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:00.423738) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:00.438309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:00.438587) ========= 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=af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 21:55:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.9M=0.001s 2017-01-09 21:55:01 (13.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114266 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:00.567466) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:00.567756) ========= 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=af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021953 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:00.616785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:00.617124) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 --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 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 --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=af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 21:55:01,145 truncating revision to first 12 chars 2017-01-09 21:55:01,145 Setting DEBUG logging. 2017-01-09 21:55:01,145 attempt 1/10 2017-01-09 21:55:01,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9e93163b43f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 21:55:01,611 unpacking tar archive at: mozilla-aurora-9e93163b43f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.766686 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:01.396820) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:01.397108) ========= script_repo_revision: 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:01.397495) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:01.397770) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 21:55:01.411792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-09 21:55:01.412051) ========= /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=af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:55:02 INFO - MultiFileLogger online at 20170109 21:55:02 in /builds/slave/test 21:55:02 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 21:55:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:55:02 INFO - {'append_to_log': False, 21:55:02 INFO - 'base_work_dir': '/builds/slave/test', 21:55:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:55:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:55:02 INFO - 'branch': 'Mozilla-Aurora', 21:55:02 INFO - 'buildbot_json_path': 'buildprops.json', 21:55:02 INFO - 'config_files': ('talos/linux_config.py',), 21:55:02 INFO - 'default_actions': ('clobber', 21:55:02 INFO - 'read-buildbot-config', 21:55:02 INFO - 'download-and-extract', 21:55:02 INFO - 'populate-webroot', 21:55:02 INFO - 'create-virtualenv', 21:55:02 INFO - 'install', 21:55:02 INFO - 'run-tests'), 21:55:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:55:02 INFO - 'download_minidump_stackwalk': True, 21:55:02 INFO - 'download_symbols': 'ondemand', 21:55:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:55:02 INFO - 'tooltool.py': '/tools/tooltool.py', 21:55:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:55:02 INFO - '/tools/misc-python/virtualenv.py')}, 21:55:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:55:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:55:02 INFO - 'installer_path': 'installer.exe', 21:55:02 INFO - 'log_level': 'info', 21:55:02 INFO - 'log_name': 'talos', 21:55:02 INFO - 'log_to_console': True, 21:55:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:55:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:55:02 INFO - 'opt_config_files': (), 21:55:02 INFO - 'pip_index': False, 21:55:02 INFO - 'sps_profile': False, 21:55:02 INFO - 'sps_profile_interval': 0, 21:55:02 INFO - 'suite': 'dromaeojs', 21:55:02 INFO - 'system_bits': '32', 21:55:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:55:02 INFO - 'title': 'talos-linux64-ix-020', 21:55:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:55:02 INFO - 'use_talos_json': True, 21:55:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:55:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:55:02 INFO - 'work_dir': 'build'} 21:55:02 INFO - [mozharness: 2017-01-10 05:55:02.039366Z] Running clobber step. 21:55:02 INFO - Running pre-action listener: _resource_record_pre_action 21:55:02 INFO - Running main action method: clobber 21:55:02 INFO - rmtree: /builds/slave/test/build 21:55:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:55:02 INFO - Running post-action listener: _resource_record_post_action 21:55:02 INFO - [mozharness: 2017-01-10 05:55:02.502975Z] Finished clobber step (success) 21:55:02 INFO - [mozharness: 2017-01-10 05:55:02.503083Z] Running read-buildbot-config step. 21:55:02 INFO - Running pre-action listener: _resource_record_pre_action 21:55:02 INFO - Running main action method: read_buildbot_config 21:55:02 INFO - Using buildbot properties: 21:55:02 INFO - { 21:55:02 INFO - "project": "", 21:55:02 INFO - "product": "firefox", 21:55:02 INFO - "script_repo_revision": "production", 21:55:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:55:02 INFO - "repository": "", 21:55:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:55:02 INFO - "buildid": "20170109201208", 21:55:02 INFO - "pgo_build": "True", 21:55:02 INFO - "basedir": "/builds/slave/test", 21:55:02 INFO - "buildnumber": 690, 21:55:02 INFO - "slavename": "talos-linux64-ix-020", 21:55:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:55:02 INFO - "platform": "ubuntu64_hw", 21:55:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:55:02 INFO - "branch": "mozilla-aurora", 21:55:02 INFO - "repo_path": "releases/mozilla-aurora", 21:55:02 INFO - "revision": "9e93163b43f8dd2b7a2a7191dac910ae1259c0e8", 21:55:02 INFO - "stage_platform": "linux64-pgo", 21:55:02 INFO - "builduid": "9498fab751f84ebb8bace0e92c0c5966", 21:55:02 INFO - "slavebuilddir": "test" 21:55:02 INFO - } 21:55:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 21:55:02 INFO - Running post-action listener: _resource_record_post_action 21:55:02 INFO - [mozharness: 2017-01-10 05:55:02.505520Z] Finished read-buildbot-config step (success) 21:55:02 INFO - [mozharness: 2017-01-10 05:55:02.505621Z] Running download-and-extract step. 21:55:02 INFO - Running pre-action listener: _resource_record_pre_action 21:55:02 INFO - Running main action method: download_and_extract 21:55:02 INFO - mkdir: /builds/slave/test/build/tests 21:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:02 INFO - trying https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 21:55:02 INFO - Downloading https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/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 21:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/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 21:55:03 INFO - Downloaded 1361 bytes. 21:55:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 21:55:03 INFO - Using the following test package requirements: 21:55:03 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 21:55:03 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:55:03 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:55:03 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:03 INFO - u'jsshell-linux-x86_64.zip'], 21:55:03 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:55:03 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 21:55:03 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:55:03 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:55:03 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:55:03 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:55:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:55:03 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:55:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 21:55:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:55:03 INFO - Fetch https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:55:03 INFO - Http code: 200 21:55:03 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 21:55:03 INFO - x-amz-cf-id: nXkifHEoQ-nufylTM3lW-WK7QmQjVmFnif_KMQTgFg8QMFL5x9DCEg== 21:55:03 INFO - x-amz-version-id: uBWkAp_8yP0KLQzy2iBvLHrQAd6eNGve 21:55:03 INFO - Expected file size: 21944611 21:55:03 INFO - Obtained file size: 21944611 21:55:08 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 21:55:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 21:55:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:55:08 INFO - Fetch https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:55:08 INFO - Http code: 200 21:55:08 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 21:55:08 INFO - x-amz-cf-id: U_RxjWaJd7oTO4CX_XwqEaTuTnIzCM-2f-bR0BFbAKunjWFA1wpHRQ== 21:55:08 INFO - x-amz-version-id: uBWkAp_8yP0KLQzy2iBvLHrQAd6eNGve 21:55:08 INFO - Expected file size: 21944611 21:55:08 INFO - Obtained file size: 21944611 21:55:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 21:55:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:55:13 INFO - Fetch https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 21:55:13 INFO - Http code: 200 21:55:13 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 21:55:13 INFO - x-amz-cf-id: Ljs9u73ZeLAB5y8FA41BPC3BlX_xxdqKzwMMY1oSwQ809F9M2lDcdA== 21:55:13 INFO - x-amz-version-id: teIib3R6FINROcUqeMGZ9HWeTtzPftd7 21:55:13 INFO - Expected file size: 14409038 21:55:13 INFO - Obtained file size: 14409038 21:55:14 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')]} 21:55:14 INFO - trying https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:55:14 INFO - Downloading https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/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 21:55:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/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 21:55:16 INFO - Downloaded 64075126 bytes. 21:55:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:55:16 INFO - mkdir: /builds/slave/test/properties 21:55:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:55:16 INFO - Writing to file /builds/slave/test/properties/build_url 21:55:16 INFO - Contents: 21:55:16 INFO - build_url:https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:55:16 INFO - Running post-action listener: _resource_record_post_action 21:55:16 INFO - Running post-action listener: set_extra_try_arguments 21:55:16 INFO - [mozharness: 2017-01-10 05:55:16.934090Z] Finished download-and-extract step (success) 21:55:16 INFO - [mozharness: 2017-01-10 05:55:16.934318Z] Running populate-webroot step. 21:55:16 INFO - Running pre-action listener: _resource_record_pre_action 21:55:16 INFO - Running main action method: populate_webroot 21:55:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:55:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:55:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:55:16 INFO - '--tppagecycles', 21:55:16 INFO - '7'], 21:55:16 INFO - 'tests': ['tsvgm']}}, 21:55:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:55:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:55:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:55:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:55:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:16 INFO - 'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:55:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:55:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:16 INFO - 'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['damp', 'tps']}, 21:55:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:16 INFO - 'tests': ['damp', 'tps']}, 21:55:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['dromaeo_dom']}, 21:55:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:55:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['basic_compositor_video']}, 21:55:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:55:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['a11yr', 21:55:16 INFO - 'ts_paint', 21:55:16 INFO - 'tpaint', 21:55:16 INFO - 'sessionrestore', 21:55:16 INFO - 'sessionrestore_no_auto_restore', 21:55:16 INFO - 'tabpaint']}, 21:55:16 INFO - 'other-e10s': {'tests': ['a11yr', 21:55:16 INFO - 'ts_paint', 21:55:16 INFO - 'tpaint', 21:55:16 INFO - 'sessionrestore', 21:55:16 INFO - 'sessionrestore_no_auto_restore', 21:55:16 INFO - 'tabpaint']}, 21:55:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:55:16 INFO - 'ts_paint', 21:55:16 INFO - 'tpaint', 21:55:16 INFO - 'sessionrestore', 21:55:16 INFO - 'sessionrestore_no_auto_restore', 21:55:16 INFO - 'tabpaint']}, 21:55:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:55:16 INFO - 'ts_paint', 21:55:16 INFO - 'tpaint', 21:55:16 INFO - 'sessionrestore', 21:55:16 INFO - 'sessionrestore_no_auto_restore', 21:55:16 INFO - 'tabpaint']}, 21:55:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['a11yr', 21:55:16 INFO - 'ts_paint', 21:55:16 INFO - 'tpaint', 21:55:16 INFO - 'sessionrestore', 21:55:16 INFO - 'sessionrestore_no_auto_restore', 21:55:16 INFO - 'tabpaint']}, 21:55:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['a11yr', 21:55:16 INFO - 'ts_paint', 21:55:16 INFO - 'tpaint', 21:55:16 INFO - 'sessionrestore', 21:55:16 INFO - 'sessionrestore_no_auto_restore', 21:55:16 INFO - 'tabpaint']}, 21:55:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['tsvgx', 21:55:16 INFO - 'tsvgr_opacity', 21:55:16 INFO - 'tart', 21:55:16 INFO - 'tscrollx', 21:55:16 INFO - 'cart']}, 21:55:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:55:16 INFO - 'tsvgr_opacity', 21:55:16 INFO - 'tart', 21:55:16 INFO - 'tscrollx', 21:55:16 INFO - 'cart']}, 21:55:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:16 INFO - 'talos_options': ['--disable-e10s'], 21:55:16 INFO - 'tests': ['tp5o']}, 21:55:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:16 INFO - 'tests': ['tp5o']}, 21:55:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:16 INFO - 'talos_options': ['--disable-e10s', 21:55:16 INFO - '--xperf_path', 21:55:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:55:16 INFO - 'tests': ['tp5n']}, 21:55:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:55:16 INFO - 'talos_options': ['--xperf_path', 21:55:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:55:16 INFO - 'tests': ['tp5n']}}, 21:55:16 INFO - 'talos.zip': {'path': '', 21:55:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:55:16 INFO - Running post-action listener: _resource_record_post_action 21:55:16 INFO - [mozharness: 2017-01-10 05:55:16.953219Z] Finished populate-webroot step (success) 21:55:16 INFO - [mozharness: 2017-01-10 05:55:16.953307Z] Running create-virtualenv step. 21:55:16 INFO - Running pre-action listener: _resource_record_pre_action 21:55:16 INFO - Running main action method: create_virtualenv 21:55:16 INFO - Creating virtualenv /builds/slave/test/build/venv 21:55:16 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 21:55:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:55:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:55:17 INFO - Using real prefix '/usr' 21:55:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:55:17 INFO - Installing distribute.............................................................................................................................................................................................done. 21:55:19 INFO - Installing pip.................done. 21:55:19 INFO - Return code: 0 21:55:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:55:19 INFO - Reading from file tmpfile_stdout 21:55:19 INFO - Output received: 21:55:19 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) 21:55:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:19 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 0x7f6cef9f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf25ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', '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 21:55:19 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 21:55:19 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 21:55:19 INFO - Using env: {'DISPLAY': ':0', 21:55:19 INFO - 'HOME': '/home/cltbld', 21:55:19 INFO - 'LANG': 'en_US.UTF-8', 21:55:19 INFO - 'LANGUAGE': 'en_US:en', 21:55:19 INFO - 'LOGNAME': 'cltbld', 21:55:19 INFO - 'MAIL': '/var/mail/cltbld', 21:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:19 INFO - 'MOZ_NO_REMOTE': '1', 21:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:19 INFO - 'NO_EM_RESTART': '1', 21:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:19 INFO - 'PWD': '/builds/slave/test', 21:55:19 INFO - 'SHELL': '/bin/bash', 21:55:19 INFO - 'SHLVL': '1', 21:55:19 INFO - 'TERM': 'linux', 21:55:19 INFO - 'TMOUT': '86400', 21:55:19 INFO - 'USER': 'cltbld', 21:55:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:19 INFO - '_': '/tools/buildbot/bin/python'} 21:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:19 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 21:55:19 INFO - Cleaning up... 21:55:19 INFO - Return code: 0 21:55:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:19 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 0x7f6cef9f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf25ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', '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 21:55:19 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 21:55:19 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 21:55:19 INFO - Using env: {'DISPLAY': ':0', 21:55:19 INFO - 'HOME': '/home/cltbld', 21:55:19 INFO - 'LANG': 'en_US.UTF-8', 21:55:19 INFO - 'LANGUAGE': 'en_US:en', 21:55:19 INFO - 'LOGNAME': 'cltbld', 21:55:19 INFO - 'MAIL': '/var/mail/cltbld', 21:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:19 INFO - 'MOZ_NO_REMOTE': '1', 21:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:19 INFO - 'NO_EM_RESTART': '1', 21:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:19 INFO - 'PWD': '/builds/slave/test', 21:55:19 INFO - 'SHELL': '/bin/bash', 21:55:19 INFO - 'SHLVL': '1', 21:55:19 INFO - 'TERM': 'linux', 21:55:19 INFO - 'TMOUT': '86400', 21:55:19 INFO - 'USER': 'cltbld', 21:55:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:19 INFO - '_': '/tools/buildbot/bin/python'} 21:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:20 INFO - Downloading/unpacking psutil>=3.1.1 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:55:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:55:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:55:22 INFO - Installing collected packages: psutil 21:55:22 INFO - Running setup.py install for psutil 21:55:22 INFO - building 'psutil._psutil_linux' extension 21:55: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 21:55:22 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 21:55:22 INFO - building 'psutil._psutil_posix' extension 21:55:22 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 21:55:22 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 21:55:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:55:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:55:22 INFO - Successfully installed psutil 21:55:22 INFO - Cleaning up... 21:55:22 INFO - Return code: 0 21:55:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:55:22 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')]} 21:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:22 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')]} 21:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:22 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 0x7f6cef9f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf25ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', '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 21:55:22 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 21:55:22 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 21:55:22 INFO - Using env: {'DISPLAY': ':0', 21:55:22 INFO - 'HOME': '/home/cltbld', 21:55:22 INFO - 'LANG': 'en_US.UTF-8', 21:55:22 INFO - 'LANGUAGE': 'en_US:en', 21:55:22 INFO - 'LOGNAME': 'cltbld', 21:55:22 INFO - 'MAIL': '/var/mail/cltbld', 21:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:22 INFO - 'MOZ_NO_REMOTE': '1', 21:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:22 INFO - 'NO_EM_RESTART': '1', 21:55:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:22 INFO - 'PWD': '/builds/slave/test', 21:55:22 INFO - 'SHELL': '/bin/bash', 21:55:22 INFO - 'SHLVL': '1', 21:55:22 INFO - 'TERM': 'linux', 21:55:22 INFO - 'TMOUT': '86400', 21:55:22 INFO - 'USER': 'cltbld', 21:55:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:22 INFO - '_': '/tools/buildbot/bin/python'} 21:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:55:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:55:25 INFO - Installing collected packages: mozsystemmonitor 21:55:25 INFO - Running setup.py install for mozsystemmonitor 21:55:25 INFO - Successfully installed mozsystemmonitor 21:55:25 INFO - Cleaning up... 21:55:25 INFO - Return code: 0 21:55:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:55: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')]} 21:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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 0x7f6cef9f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf25ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', '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 21:55: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 21:55: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 21:55:25 INFO - Using env: {'DISPLAY': ':0', 21:55:25 INFO - 'HOME': '/home/cltbld', 21:55:25 INFO - 'LANG': 'en_US.UTF-8', 21:55:25 INFO - 'LANGUAGE': 'en_US:en', 21:55:25 INFO - 'LOGNAME': 'cltbld', 21:55:25 INFO - 'MAIL': '/var/mail/cltbld', 21:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:25 INFO - 'MOZ_NO_REMOTE': '1', 21:55:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:25 INFO - 'NO_EM_RESTART': '1', 21:55:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:25 INFO - 'PWD': '/builds/slave/test', 21:55:25 INFO - 'SHELL': '/bin/bash', 21:55:25 INFO - 'SHLVL': '1', 21:55:25 INFO - 'TERM': 'linux', 21:55:25 INFO - 'TMOUT': '86400', 21:55:25 INFO - 'USER': 'cltbld', 21:55:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:25 INFO - '_': '/tools/buildbot/bin/python'} 21:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:25 INFO - Downloading/unpacking jsonschema==2.5.1 21:55:25 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 21:55:25 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 21:55:25 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 21:55:25 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 21:55:25 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 21:55:25 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 21:55:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:55:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:55:27 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 21:55:27 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 21:55:27 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 21:55:27 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 21:55:27 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 21:55:27 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 21:55:27 INFO - Downloading functools32-3.2.3-2.tar.gz 21:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:55:27 INFO - warning: no files found matching '*.txt' 21:55:27 INFO - no previously-included directories found matching 'build' 21:55:27 INFO - no previously-included directories found matching 'dist' 21:55:27 INFO - no previously-included directories found matching '.git*' 21:55:27 INFO - Installing collected packages: jsonschema, functools32 21:55:27 INFO - Running setup.py install for functools32 21:55:27 INFO - warning: no files found matching '*.txt' 21:55:27 INFO - no previously-included directories found matching 'build' 21:55:27 INFO - no previously-included directories found matching 'dist' 21:55:27 INFO - no previously-included directories found matching '.git*' 21:55:27 INFO - Successfully installed jsonschema functools32 21:55:27 INFO - Cleaning up... 21:55:28 INFO - Return code: 0 21:55:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:55: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')]} 21:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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 0x7f6cef9f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf25ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', '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 21:55: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 21:55: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 21:55:28 INFO - Using env: {'DISPLAY': ':0', 21:55:28 INFO - 'HOME': '/home/cltbld', 21:55:28 INFO - 'LANG': 'en_US.UTF-8', 21:55:28 INFO - 'LANGUAGE': 'en_US:en', 21:55:28 INFO - 'LOGNAME': 'cltbld', 21:55:28 INFO - 'MAIL': '/var/mail/cltbld', 21:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:28 INFO - 'MOZ_NO_REMOTE': '1', 21:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:28 INFO - 'NO_EM_RESTART': '1', 21:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:28 INFO - 'PWD': '/builds/slave/test', 21:55:28 INFO - 'SHELL': '/bin/bash', 21:55:28 INFO - 'SHLVL': '1', 21:55:28 INFO - 'TERM': 'linux', 21:55:28 INFO - 'TMOUT': '86400', 21:55:28 INFO - 'USER': 'cltbld', 21:55:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:28 INFO - '_': '/tools/buildbot/bin/python'} 21:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:55:28 INFO - Cleaning up... 21:55:28 INFO - Return code: 0 21:55:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:55: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')]} 21:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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 0x7f6cef9f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf25ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', '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 21:55: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 21:55: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 21:55:28 INFO - Using env: {'DISPLAY': ':0', 21:55:28 INFO - 'HOME': '/home/cltbld', 21:55:28 INFO - 'LANG': 'en_US.UTF-8', 21:55:28 INFO - 'LANGUAGE': 'en_US:en', 21:55:28 INFO - 'LOGNAME': 'cltbld', 21:55:28 INFO - 'MAIL': '/var/mail/cltbld', 21:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:28 INFO - 'MOZ_NO_REMOTE': '1', 21:55:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:28 INFO - 'NO_EM_RESTART': '1', 21:55:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:28 INFO - 'PWD': '/builds/slave/test', 21:55:28 INFO - 'SHELL': '/bin/bash', 21:55:28 INFO - 'SHLVL': '1', 21:55:28 INFO - 'TERM': 'linux', 21:55:28 INFO - 'TMOUT': '86400', 21:55:28 INFO - 'USER': 'cltbld', 21:55:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:28 INFO - '_': '/tools/buildbot/bin/python'} 21:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:28 INFO - Downloading/unpacking blobuploader==1.2.4 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55: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 21:55:30 INFO - Downloading blobuploader-1.2.4.tar.gz 21:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:55:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:55:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 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 21:55:30 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 21:55:31 INFO - Downloading docopt-0.6.1.tar.gz 21:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:55:31 INFO - Installing collected packages: blobuploader, requests, docopt 21:55:31 INFO - Running setup.py install for blobuploader 21:55:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:55:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:55:31 INFO - Running setup.py install for requests 21:55:31 INFO - Running setup.py install for docopt 21:55:31 INFO - Successfully installed blobuploader requests docopt 21:55:31 INFO - Cleaning up... 21:55:31 INFO - Return code: 0 21:55:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:31 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 0x7f6cef9f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf25ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', '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 21:55:31 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 21:55:31 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 21:55:31 INFO - Using env: {'DISPLAY': ':0', 21:55:31 INFO - 'HOME': '/home/cltbld', 21:55:31 INFO - 'LANG': 'en_US.UTF-8', 21:55:31 INFO - 'LANGUAGE': 'en_US:en', 21:55:31 INFO - 'LOGNAME': 'cltbld', 21:55:31 INFO - 'MAIL': '/var/mail/cltbld', 21:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:31 INFO - 'MOZ_NO_REMOTE': '1', 21:55:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:31 INFO - 'NO_EM_RESTART': '1', 21:55:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:31 INFO - 'PWD': '/builds/slave/test', 21:55:31 INFO - 'SHELL': '/bin/bash', 21:55:31 INFO - 'SHLVL': '1', 21:55:31 INFO - 'TERM': 'linux', 21:55:31 INFO - 'TMOUT': '86400', 21:55:31 INFO - 'USER': 'cltbld', 21:55:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:31 INFO - '_': '/tools/buildbot/bin/python'} 21:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:55:32 INFO - Running setup.py (path:/tmp/pip-O2XlKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:55:32 INFO - Running setup.py (path:/tmp/pip-fBlOUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:55:32 INFO - Running setup.py (path:/tmp/pip-AH4Cvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:55:32 INFO - Running setup.py (path:/tmp/pip-vYsyyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:55:32 INFO - Running setup.py (path:/tmp/pip-mIh8MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:55:32 INFO - Running setup.py (path:/tmp/pip-ajMlSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:55:32 INFO - Running setup.py (path:/tmp/pip-sa6ChK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:55:32 INFO - Running setup.py (path:/tmp/pip-c032Eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:55:32 INFO - Running setup.py (path:/tmp/pip-VO6RBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:55:32 INFO - Running setup.py (path:/tmp/pip-dTCCTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:55:32 INFO - Running setup.py (path:/tmp/pip-a5pNYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:55:32 INFO - Running setup.py (path:/tmp/pip-hUwHyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:55:32 INFO - Running setup.py (path:/tmp/pip-Do2swy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:55:33 INFO - Running setup.py (path:/tmp/pip-epe_11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:55:33 INFO - Running setup.py (path:/tmp/pip-KdNSYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:55:33 INFO - Running setup.py (path:/tmp/pip-m_2VO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:55:33 INFO - Running setup.py (path:/tmp/pip-RTQ1AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:55:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:55:33 INFO - Running setup.py install for manifestparser 21:55:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:55:33 INFO - Running setup.py install for mozcrash 21:55:33 INFO - Running setup.py install for mozdebug 21:55:33 INFO - Running setup.py install for mozdevice 21:55:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:55:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:55:33 INFO - Running setup.py install for mozfile 21:55:33 INFO - Running setup.py install for mozhttpd 21:55:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:55:33 INFO - Running setup.py install for mozinfo 21:55:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Running setup.py install for mozInstall 21:55:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Running setup.py install for mozleak 21:55:34 INFO - Running setup.py install for mozlog 21:55:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Running setup.py install for moznetwork 21:55:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Running setup.py install for mozprocess 21:55:34 INFO - Running setup.py install for mozprofile 21:55:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Running setup.py install for mozrunner 21:55:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:55:34 INFO - Running setup.py install for mozscreenshot 21:55:34 INFO - Running setup.py install for moztest 21:55:35 INFO - Running setup.py install for mozversion 21:55:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:55:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:55:35 INFO - Cleaning up... 21:55:35 INFO - Return code: 0 21:55:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:55: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')]} 21:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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')]} 21:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55: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 0x7f6cef9f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf25ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', '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 21:55: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 21:55: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 21:55:35 INFO - Using env: {'DISPLAY': ':0', 21:55:35 INFO - 'HOME': '/home/cltbld', 21:55:35 INFO - 'LANG': 'en_US.UTF-8', 21:55:35 INFO - 'LANGUAGE': 'en_US:en', 21:55:35 INFO - 'LOGNAME': 'cltbld', 21:55:35 INFO - 'MAIL': '/var/mail/cltbld', 21:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:35 INFO - 'MOZ_NO_REMOTE': '1', 21:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:35 INFO - 'NO_EM_RESTART': '1', 21:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:35 INFO - 'PWD': '/builds/slave/test', 21:55:35 INFO - 'SHELL': '/bin/bash', 21:55:35 INFO - 'SHLVL': '1', 21:55:35 INFO - 'TERM': 'linux', 21:55:35 INFO - 'TMOUT': '86400', 21:55:35 INFO - 'USER': 'cltbld', 21:55:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:35 INFO - '_': '/tools/buildbot/bin/python'} 21:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:55:35 INFO - Running setup.py (path:/tmp/pip-APokpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:55: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)) 21:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:55:35 INFO - Running setup.py (path:/tmp/pip-9i_dGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:55:35 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)) 21:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:55:35 INFO - Running setup.py (path:/tmp/pip-IUULJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:55:35 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)) 21:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:55:35 INFO - Running setup.py (path:/tmp/pip-WcCVQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:55:35 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)) 21:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:55:35 INFO - Running setup.py (path:/tmp/pip-rTN2Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:55:35 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)) 21:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:55:35 INFO - Running setup.py (path:/tmp/pip-6twgbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:55:35 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)) 21:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:55:35 INFO - Running setup.py (path:/tmp/pip-v74E7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:55:35 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)) 21:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:55:35 INFO - Running setup.py (path:/tmp/pip-5C5fLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:55:35 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)) 21:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:55:35 INFO - Running setup.py (path:/tmp/pip-O3rUMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:55: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)) 21:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:55:36 INFO - Running setup.py (path:/tmp/pip-jtJ7ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:55: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)) 21:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:55:36 INFO - Running setup.py (path:/tmp/pip-gBMGRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:55: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)) 21:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:55:36 INFO - Running setup.py (path:/tmp/pip-ScoeEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:55: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)) 21:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:55:36 INFO - Running setup.py (path:/tmp/pip-2kC9dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:55: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)) 21:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:55:36 INFO - Running setup.py (path:/tmp/pip-KvXHiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:55: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)) 21:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:55:36 INFO - Running setup.py (path:/tmp/pip-ZVSz7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:55:36 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)) 21:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:55:36 INFO - Running setup.py (path:/tmp/pip-DKTN3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:55:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:55:36 INFO - Running setup.py (path:/tmp/pip-TL_o2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:55:36 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)) 21:55:36 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)) 21:55:36 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)) 21:55:36 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)) 21:55:36 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)) 21:55:36 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)) 21:55:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:55:39 INFO - Downloading blessings-1.6.tar.gz 21:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:55:39 INFO - Installing collected packages: blessings 21:55:39 INFO - Running setup.py install for blessings 21:55:39 INFO - Successfully installed blessings 21:55:39 INFO - Cleaning up... 21:55:39 INFO - Return code: 0 21:55:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:55:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:55:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:55:40 INFO - Reading from file tmpfile_stdout 21:55:40 INFO - Current package versions: 21:55:40 INFO - argparse == 1.2.1 21:55:40 INFO - blessings == 1.6 21:55:40 INFO - blobuploader == 1.2.4 21:55:40 INFO - docopt == 0.6.1 21:55:40 INFO - functools32 == 3.2.3-2 21:55:40 INFO - jsonschema == 2.5.1 21:55:40 INFO - manifestparser == 1.1 21:55:40 INFO - mozInstall == 1.12 21:55:40 INFO - mozcrash == 1.0 21:55:40 INFO - mozdebug == 0.1 21:55:40 INFO - mozdevice == 0.48 21:55:40 INFO - mozfile == 1.2 21:55:40 INFO - mozhttpd == 0.7 21:55:40 INFO - mozinfo == 0.9 21:55:40 INFO - mozleak == 0.1 21:55:40 INFO - mozlog == 3.4 21:55:40 INFO - moznetwork == 0.27 21:55:40 INFO - mozprocess == 0.23 21:55:40 INFO - mozprofile == 0.28 21:55:40 INFO - mozrunner == 6.13 21:55:40 INFO - mozscreenshot == 0.1 21:55:40 INFO - mozsystemmonitor == 0.3 21:55:40 INFO - moztest == 0.8 21:55:40 INFO - mozversion == 1.4 21:55:40 INFO - psutil == 3.1.1 21:55:40 INFO - requests == 1.2.3 21:55:40 INFO - wsgiref == 0.1.2 21:55:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:55:40 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')]} 21:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:40 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')]} 21:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:40 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 0x7f6cef9f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf25ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', '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 21:55:40 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 21:55:40 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 21:55:40 INFO - Using env: {'DISPLAY': ':0', 21:55:40 INFO - 'HOME': '/home/cltbld', 21:55:40 INFO - 'LANG': 'en_US.UTF-8', 21:55:40 INFO - 'LANGUAGE': 'en_US:en', 21:55:40 INFO - 'LOGNAME': 'cltbld', 21:55:40 INFO - 'MAIL': '/var/mail/cltbld', 21:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:40 INFO - 'MOZ_NO_REMOTE': '1', 21:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:40 INFO - 'NO_EM_RESTART': '1', 21:55:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:40 INFO - 'PWD': '/builds/slave/test', 21:55:40 INFO - 'SHELL': '/bin/bash', 21:55:40 INFO - 'SHLVL': '1', 21:55:40 INFO - 'TERM': 'linux', 21:55:40 INFO - 'TMOUT': '86400', 21:55:40 INFO - 'USER': 'cltbld', 21:55:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:40 INFO - '_': '/tools/buildbot/bin/python'} 21:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:40 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)) 21:55:40 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)) 21:55:40 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)) 21:55:40 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)) 21:55:40 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)) 21:55:40 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)) 21:55:40 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)) 21:55:40 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)) 21:55:40 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)) 21:55:40 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)) 21:55:40 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)) 21:55:40 INFO - Cleaning up... 21:55:40 INFO - Return code: 0 21:55:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:55:40 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')]} 21:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:40 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')]} 21:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:55:40 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 0x7f6cef9f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf25ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', '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 21:55:40 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 21:55:40 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 21:55:40 INFO - Using env: {'DISPLAY': ':0', 21:55:40 INFO - 'HOME': '/home/cltbld', 21:55:40 INFO - 'LANG': 'en_US.UTF-8', 21:55:40 INFO - 'LANGUAGE': 'en_US:en', 21:55:40 INFO - 'LOGNAME': 'cltbld', 21:55:40 INFO - 'MAIL': '/var/mail/cltbld', 21:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:40 INFO - 'MOZ_NO_REMOTE': '1', 21:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:40 INFO - 'NO_EM_RESTART': '1', 21:55:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:40 INFO - 'PWD': '/builds/slave/test', 21:55:40 INFO - 'SHELL': '/bin/bash', 21:55:40 INFO - 'SHLVL': '1', 21:55:40 INFO - 'TERM': 'linux', 21:55:40 INFO - 'TMOUT': '86400', 21:55:40 INFO - 'USER': 'cltbld', 21:55:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:40 INFO - '_': '/tools/buildbot/bin/python'} 21:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:55:40 INFO - Cleaning up... 21:55:40 INFO - Return code: 0 21:55:40 INFO - Running post-action listener: _resource_record_post_action 21:55:40 INFO - Running post-action listener: _start_resource_monitoring 21:55:40 INFO - Starting resource monitoring. 21:55:40 INFO - [mozharness: 2017-01-10 05:55:40.599570Z] Finished create-virtualenv step (success) 21:55:40 INFO - [mozharness: 2017-01-10 05:55:40.600068Z] Running install step. 21:55:40 INFO - Running pre-action listener: _resource_record_pre_action 21:55:40 INFO - Running main action method: install 21:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:55:40 INFO - Reading from file tmpfile_stdout 21:55:40 INFO - Detecting whether we're running mozinstall >=1.0... 21:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:55:40 INFO - Reading from file tmpfile_stdout 21:55:40 INFO - Output received: 21:55:40 INFO - Usage: mozinstall [options] installer 21:55:40 INFO - Options: 21:55:40 INFO - -h, --help show this help message and exit 21:55:40 INFO - -d DEST, --destination=DEST 21:55:40 INFO - Directory to install application into. [default: 21:55:40 INFO - "/builds/slave/test"] 21:55:40 INFO - --app=APP Application being installed. [default: firefox] 21:55:40 INFO - mkdir: /builds/slave/test/build/application 21:55: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'] 21:55: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 21:55:56 INFO - Reading from file tmpfile_stdout 21:55:56 INFO - Output received: 21:55:56 INFO - /builds/slave/test/build/application/firefox/firefox 21:55:56 INFO - Running post-action listener: _resource_record_post_action 21:55:56 INFO - [mozharness: 2017-01-10 05:55:56.836318Z] Finished install step (success) 21:55:56 INFO - [mozharness: 2017-01-10 05:55:56.836562Z] Running run-tests step. 21:55:56 INFO - Running pre-action listener: _resource_record_pre_action 21:55:56 INFO - Running main action method: run_tests 21:55:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:55:56 INFO - Python 2.7.3 21:55:56 INFO - Return code: 0 21:55:56 INFO - grabbing minidump binary from tooltool 21:55: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')]} 21:55: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 0xf22f60>, '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 0xf23d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf241d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:55: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 21:55: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 21:55: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 21:55:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:55:56 INFO - Return code: 0 21:55:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:55:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:55:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:55:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:55:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:55: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/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 21:55: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/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 21:55:56 INFO - Using env: {'DISPLAY': ':0', 21:55:56 INFO - 'HOME': '/home/cltbld', 21:55:56 INFO - 'LANG': 'en_US.UTF-8', 21:55:56 INFO - 'LANGUAGE': 'en_US:en', 21:55:56 INFO - 'LOGNAME': 'cltbld', 21:55:56 INFO - 'MAIL': '/var/mail/cltbld', 21:55:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:55:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:55:56 INFO - 'MOZ_NO_REMOTE': '1', 21:55:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:55:56 INFO - 'NO_EM_RESTART': '1', 21:55:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:55:56 INFO - 'PWD': '/builds/slave/test', 21:55:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:55:56 INFO - 'SHELL': '/bin/bash', 21:55:56 INFO - 'SHLVL': '1', 21:55:56 INFO - 'TERM': 'linux', 21:55:56 INFO - 'TMOUT': '86400', 21:55:56 INFO - 'USER': 'cltbld', 21:55:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900', 21:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:55:56 INFO - '_': '/tools/buildbot/bin/python'} 21:55: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/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 21:55:57 INFO - mozversion application_buildid: 20170109201208 21:55:57 INFO - mozversion application_changeset: 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 21:55:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:55:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:55:57 INFO - mozversion application_name: Firefox 21:55:57 INFO - mozversion application_remotingname: firefox-dev 21:55:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:55:57 INFO - mozversion application_vendor: Mozilla 21:55:57 INFO - mozversion application_version: 52.0a2 21:55:57 INFO - mozversion platform_buildid: 20170109201208 21:55:57 INFO - mozversion platform_changeset: 9e93163b43f8dd2b7a2a7191dac910ae1259c0e8 21:55:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:55:57 INFO - mozversion platform_version: 52.0a2 21:55:57 INFO - using testdate: 1484027757 21:55:57 INFO - actual date: 1484027757 21:55:57 INFO - starting webserver on 'localhost:43145' 21:55:57 INFO - SUITE-START | Running 2 tests 21:55:57 INFO - TEST-START | dromaeo_css 21:55:57 INFO - operating with platform_type : linux_ 21:55:57 INFO - Initialising browser for dromaeo_css test... 21:55:57 INFO - TEST-INFO | started process 18221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytjkPB/profile http://localhost:43145/getInfo.html) 21:56:01 INFO - PROCESS | 18221 | __metrics Screen width/height:1600/1200 21:56:01 INFO - PROCESS | 18221 | colorDepth:24 21:56:01 INFO - PROCESS | 18221 | Browser inner width/height: 1024/697 21:56:01 INFO - PROCESS | 18221 | __metrics 21:56:01 INFO - PROCESS | 18221 | 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" 21:56:01 INFO - PROCESS | 18221 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:56:02 INFO - PROCESS | 18221 | console.error: PushService: 21:56:02 INFO - PROCESS | 18221 | stateChangeProcessEnqueue: Error transitioning state 21:56:02 INFO - PROCESS | 18221 | UnknownError 21:56:03 INFO - TEST-INFO | 18221: exit 0 21:56:03 INFO - Browser initialized. 21:56:03 INFO - Running cycle 1/1 for dromaeo_css test... 21:56:03 INFO - TEST-INFO | started process 18316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytjkPB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:56:15 INFO - PROCESS | 18316 | RSS: Main: 144093184 21:56:15 INFO - PROCESS | 18316 | 21:59:16 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:43145/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43145/tests/dromaeo/cssquery-ext.html) 21:59:17 INFO - PROCESS | 18316 | RSS: Main: 236478464 21:59:17 INFO - PROCESS | 18316 | 22:02:20 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:43145/tests/dromaeo/cssquery-ext.html (next: http://localhost:43145/tests/dromaeo/cssquery-jquery.html) 22:02:20 INFO - PROCESS | 18316 | RSS: Main: 233414656 22:02:20 INFO - PROCESS | 18316 | 22:05:22 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:43145/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43145/tests/dromaeo/cssquery-mootools.html) 22:05:23 INFO - PROCESS | 18316 | RSS: Main: 176033792 22:05:23 INFO - PROCESS | 18316 | 22:08:25 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:43145/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43145/tests/dromaeo/cssquery-prototype.html) 22:08:25 INFO - PROCESS | 18316 | RSS: Main: 217276416 22:08:25 INFO - PROCESS | 18316 | 22:11:28 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:43145/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43145/tests/dromaeo/cssquery-yui.html) 22:11:29 INFO - PROCESS | 18316 | RSS: Main: 174813184 22:11:29 INFO - PROCESS | 18316 | 22:14:31 INFO - PROCESS | 18316 | Cycle 1(1): loaded http://localhost:43145/tests/dromaeo/cssquery-yui.html (next: http://localhost:43145/tests/dromaeo/cssquery-dojo.html) 22:14:32 INFO - PROCESS | 18316 | RSS: Main: 255438848 22:14:32 INFO - PROCESS | 18316 | 22:14:32 INFO - PROCESS | 18316 | __start_tp_report 22:14:32 INFO - PROCESS | 18316 | _x_x_mozilla_page_load 22:14:32 INFO - PROCESS | 18316 | _x_x_mozilla_page_load_details 22:14:32 INFO - PROCESS | 18316 | |i|pagename|runs| 22:14:32 INFO - PROCESS | 18316 | |0;dojo.html;3166.176794033551;3193.5369371441143;3205.990113114369;3223.72598329142;3247.9512807307897;5328.493793089655;5407.756650950707;5423.701696406696;5423.945760542393;5446;5551.583631227654;5553.694546799924;5568.777248910039;5594.832155035356;5599.076152434844;5002.349694539714;5025.648204625678;5039.47085556015;5070.492950704918;5115.232715092748;4890.095332363507;4890.535399137077;5050.570701490377;5082.593392528607;5104.800371912597;4955.132851750929;4987.052460032601;5001.299818025461;5004.349434573501;5010.824621138261;5038.067957427887;5053.545180933734;5098.413682426494;5099.209622508517;5126.71803050832;4777.116233496779;4986.227134794112;5005.624578156653;5037.647364684473;5067.290579318898;5356.758945847446;5362.865928351784;5379.623426360156;5406.864828379283;5433.864153396157;5765.509931655773;5782.624129431573;5847.970760146172;5864.794732184353;5877.382874798127;5715.3141623005085;5887.528997680175;5896;5913.615614985055;5926.348101708809;5392.676439413609;5451.236826844245;5502.284702988626;5523.364813046471;5571.13647384656;5982.820515384458;6009.669468179205;6022.909656355158;6024.909626355608;6027.035674292092;5570.359408667974;5790.276215473066;5797.246357973437;5806.44838740319;5808.767649293981;5691.857703557362;5795.739191736382;5849.88300233993;5863.912041319383;5930.881382372415;5893.11603259506;5896.027155519291;5897.911531327033;5908.940910590839;5924.052151655715;5836.854078648068;5894.204282421818;5896.616719913192;5916.674582897982;5930.110483427434;4426.911461770811;4456.732596044248;4466.754328511963;4525.343825145335;4594.6783725139585;4083.1221287423346;4093.488313960755;4107.137501124797;4107.404426358161;4119.588041195856;5651;5662.915056274159;5662.943370566324;5663.801766938137;5685.971570142123;5632.718364081779;5679;5941.673207973517;5953.851153721192;5957.553183511167;5517.44825517445;5517.668939863621;5534.142207957773;5602.523785478198;5627.324721033502;5082.771275292621;5096.133657278272;5097.490250974947;5105.974470127626;5119.948800512022;5852.736626851717;5927.585069045298;6033.42682445167;6090.23872015998;6106.633601983806;5730.914036289542;5771.105478650816;5810.186573879576;5904.734286957183;5924.377940316204;6060.878782424415;6067.484263837447;6067.575269731253;6067.605605635619;6074.574779765374;5743.8564035899435;5744.770209191585;5746.798862039808;5746.994276001599;5749.338826035059;5702.914456283076;5758.193852860687;5827.475527202572;5868.559858010752;5871.588988770916;5791.420857914175;5794.62334948227;5795.971020144872;5797.159411885169;5816.76732930678;5733.254676891977;5750.511206547323;5804.622699524517;5806;5813.24427824397;5536.474034966672;5567.5545956322585;5574.888502230014;5591.993441180626;5752.798652047159;5736.942630573641;5750.022496175744;5750.453706897838;5763.250777398911;5777.017906955912;5435.673859568438;5575.665460072409;5578.665280083208;5584.804531841366;5586.888262234814 22:14:32 INFO - PROCESS | 18316 | |1;ext.html;568.2584227583003;580.3558050563875;626.1328060636017;642.3608509533012;650.609634219468;33386.83306583467;45103.54896451039;46281.30578041323;46379.768101159534;46436.535634643646;46522.30216546755;46568.53431465684;46573;46627;47112;8285.792855178608;8533.957330213372;8651.394402391836;8788.8681669775;8791.472511649321;10526.263161578692;10759.085477734363;10761.08530774885;11044.502997365138;11053.336799791998;10788.622398216065;10851.728706782354;10860.239783215178;10865.51105200264;10866.836997445045;10508.842367364496;10558.260921735482;10558.31370960885;10577.31247468912;10638.308509946868;10673.679789606324;10715.410652414113;10721;10726.678199654023;10742.946285268601;42756.57243427557;42890.571094289284;43073.35389969153;43345;43379.783101084606;3663.5970043295215;3743.775373477573;3989.341758609826;4260.595243451867;4387.956120438818;32224.838875805704;32316.676833231602;32378.19054523632;33038.6696133038;35006.649933500594;4280.9143817123795;4367.148406060819;4408.559144085598;4411.757353345564;4441.289393697025;350859;350983;351408;351415;351707;62558;63002.369976300564;63028.684856575426;63046.36953630497;63063.369366306666;39721.60278397179;40804;40852.38721419181;42598.148037039085;42675;19320.4203873884;19502.804971950383;19511.707324390147;19513.121909514106;19513.219471220993;11934.3436111013;11939.582114625946;14422;14468.927655361656;14628.488002919847;20056.398308050782;20495.795042049685;20510.38468845937;20515.281965131147;20550.897245513675;7063.223045464994;7143.285671432815;7315.890261646079;7407.518511296748;7497.250274972459;1004.542932965499;1083.160550573312;1097.6487523992405;1193.8925496705338;1209.770143672717;34861;34873;34966;35008.824955875054;35249.64750352463;1139.1171841822654;1142.8685701144475;1160.118310084325;1177.4054102678092;1195.2231049817515;17213.913930430266;18238;18276;18364.540886477946;18429.90785046093;512242;517701;521795;522670;524221;42191.36712949247;42248.78875605603;42249;42258.943526412084;55513.722431387585;1313.1070871807262;1321.7620828250815;1388;1399.181478834893;1411.336671764269;34212.48681269733;35932.820335898155;36087.27825443529;36124.27751445009;36132.4580131293;54531.727341364625;54986.72506637441;54993.72503137459;55130.72434637801;55166.72416637891;369687;370880;372074;520915;533749;45991.080178396915;46343.07313853637;46477.53522464732;46847.29729054135;47179.29231061605;51369;51718.48281517137;51819.740901295256;51827;52239.47760522498;42096.36855447232;43394.13211735684;43805.56194438015;44703.55296446994;44742;44358;44638.55361446344;45072;45892;46048;36032.27935441329;36061.639383606875;36465.81767091148;43843.78078109589;43952.12095758131;36037.63962360343;38192.61807382002;39673.801630991664;39983.40024899687;42153.78923105365;29990.70009299879;30090.247743805703;30104.24739381533;30176.698233018265;30430 22:14:32 INFO - PROCESS | 18316 | |2;jquery.html;384.80567313506674;390.29356864076044;410.26971989858055;416.98957526061855;424.34438792066254;13963.790543141848;16069.919650401745;19276.421707348785;19850.602987940234;19910.303139390126;19301.710474342897;19453.31913383032;19674.803251967474;19960.30138945137;20046.398608041745;4713.269443236304;5621.072523033695;5828.388019257981;5831.358550559435;5896.970515147418;5724.055530837407;5793.536517078624;5829.242198514187;5838.153467747175;5840.941590584103;5533.861653458655;5621.353544342412;5658.858528536799;5813.215215945836;5814.069748840187;5651.689157096358;5700.116481945305;5750.396208398141;5753.252077229933;5759.164921086461;5108.361454818148;5163.122269214243;5339.065663508871;5361.08861493547;5436.945630543683;14358.282085895768;14472.429068716261;14495.42018319266;14601.12393256408;14667.77998330026;2200.933971980843;2278.236790675126;2321.593721098801;2396.388920825196;2629.1192450529097;10415.739606509822;10543.209259305582;10872.130229581615;11063.170262230284;12960.379952505937;1922.846172306212;1942.8445724342018;1947.20164732459;1965.2532037825679;2000.5998800239865;59249.7037514814;66151.33848661548;75031;84572.57713711393;87626;10732.463376831283;10806.94596527028;10952.780944381067;10995.835062474069;11043.116550675926;15007;15029.323680434407;15034;15047.247637618295;15067.171305578078;7593.734219302298;7640.656170472342;7711.884321735179;7912.248336408032;8130.796730081677;7507.962460187773;7648.043994500687;7675.117361503387;7746.457747957702;7880.487768295157;4535.433070866142;4724.527547245317;4724.905501890012;4758.904821903612;4825.831095911626;1956.4521933858543;2008.1465377214624;2042.652749032668;2087.2485905074163;2098;828.647824674523;881.4711173295971;883.960221790021;902.1010772324294;906.0260220263111;17207.925798503944;17520.824791752173;18150.364737234133;18222.180001899946;18592.44222673322;934.8831396075491;936.2556767369957;957.1911734584265;974.6393834281362;975.0298453039129;9727.416355018722;10821.29661572011;10823.353666127225;11965.700857478632;12083.758324833454;372677;375662;376540;488614;491687;88774.55612722025;97806;99356.50321748489;100399;102967.85160741933;479.1088575250032;499.17137551664064;504.4148787406664;504.68961588622733;505.46673259711355;11091.50088246047;11216.541849559831;11264.155188360743;11575.942120289345;11730.354830484406;33116.668833312324;39269.6073039266;39951;41655.58344416517;43659.4465281901;61002.38997609967;61153;61651;62440;63000.684996574724;8758.824823503366;9170.862437063583;9190.54047297619;9279.582418791035;9373.343865929319;13477.450093239402;14090.647733806327;14145.292735363397;14211.360488777824;14643.12141271527;11928.463219154984;12139.514419423123;12265.202761820454;12360.44378002974;12420.254784712946;11277.548898044315;12074;12176.939115304367;12368.938155309166;12775.169613975062;11666.475008624462;11747.706307342043;11894.464749086139;11979.460924258256;12222.694432639255;8417.200365965224;8619.1811777881;8656.956715216636;8674.566271686264;8714.38999270045;9980.850287245552;11042.558297668003;11121.666350009513;11138.721531961766;11355.205135640756 22:14:32 INFO - PROCESS | 18316 | |3;mootools.html;1340.5844188301633;1440.2510694438893;1470.1252754611005;1551.6663917257788;1749.9737503937436;7353.227911069341;7988.001499812523;8220.219079187475;8234.752957411272;8445.704400345989;8242.093369729326;8315.625796839142;8316.958415207931;8320.126386729396;8323.500589964606;2311.075569772092;2323.337848713117;2340.5201933603657;2341.110378056345;2341.800946919514;2327.5810354136247;2362.9527409451803;2388.235764555343;2389.8088152947807;2390.0439824070336;2414.782669559739;2419.0686585664557;2437.6709144265565;2456.4350199454047;2457.8771061446946;2346.425125844162;2367.0413482539598;2381.833271670984;2389.9044038238535;2392;2369.8815059246967;2383.4041489627593;2398.4123889646976;2399.2682231919257;2402.939926501834;8213.753587392388;8274.958625206835;8309.916900830975;8329.750107496724;8331.708390206313;5156.8968620627375;5330.067238233332;5342.759575819097;5401.054815407328;5407.297051383295;3334.06646139079;3424.5890493140732;3437.8655043835724;3499.4400895856797;3501.1072176594807;1098.4288170151556;1131.9886801132047;1132.5243397772956;1164.2548768787983;1165.959191428296;11253.662390128227;11319.490622921989;11416.71458213543;11424.200305978586;11441;4112.157007813391;4432.490263619725;4477.664175186874;4507.616852567503;4515.729056256635;9217.815643687089;9222.354435189472;9232.307576931757;9232.399894006869;9235.12266334697;5191.325127733446;5222.973885130626;5228.111221092423;5231.136862417735;5234.659747116425;4338.934915976263;4469.932951005738;4773.1408346497965;4870.318155458239;4872.171730805771;3816.5038544988975;3871.3418718817306;3925.1953349563273;3966.2464131814863;3969.7221194516105;1124.5839039555417;1144.8339990701302;1169.8654654714817;1172.9648110556698;1180.3685028509706;893.4103491695449;1005.6379703306803;1027.7379268286538;1028.1158203944601;1034.0693375961544;5626.043572592669;5719.28508936383;5734.885302293931;5758.712064396764;5827.125931110282;937.9437233765996;962.5043102802063;987.0721521769514;992.4888682328607;1020.7754294055296;3907.628775266345;3915.9216815663526;4084.4077608746566;4130;4161.83352665896;10010.199184065257;10316.948415257875;10343.844842327371;10380.013898679614;10384.32501887375;10223.846642300372;10247.38515689061;10255.07704306601;10330.845037324447;10332.328398654063;7487.7004919803685;7802.063752349641;7854.136045035041;8024.959875200587;8027;5588.385277619377;5725.885482290414;5754.136879468113;5763.971180144073;5782.421757824184;9058.048904864894;9059.909400905906;9077.818443631222;9150.954245228731;9265.53672316368;9307;9310.208632266062;9344;9436.245100392089;9439.244860411289;6822.590644561342;7040.401565866959;7044.366007059184;7474.289942455458;7666.233376662289;7204.855902882018;7419.1467981180695;7877.487963282369;7975.92024079775;8203.384746143944;7142.071530700976;7327.230640782641;7369.594672293076;7371.963140184264;7708.653110610148;7183.856322873408;7356.668949897375;7493.962530187532;7514.887276690744;7561;6497.837554061186;6608.372204640744;6617.536772426077;6720.193576770819;6722.899156512558;4806.351142595845;5044.873878152929;5138.07514647367;5158.664686795496;5270.4202537721585;4981.551660350586;5013.323201367769;5093.134167191661;5187.429382767817;5281.471852814841 22:14:32 INFO - PROCESS | 18316 | |4;prototype.html;342.5598106433234;344.2581237433331;349.2072994302934;351.57986206483247;354.43290734824274;5404.675719456835;5419.376771671259;5422.457754224585;5476.698781567012;5517.2551705519745;5068.84793456196;5143.27994080829;5231.686098834063;5260.526552610264;5361.5978801589845;4231.4710661167355;4245.490541135068;4249.383839343293;4254.8510802121855;4266.168097221043;4225.8520951766695;4233.386159006942;4244.045089854773;4264.763218666583;4268.338407546819;3930.4693866327966;3969.900752481197;4180.205760905434;4185.539590645027;4200.390943313218;4179.644730197937;4196.265653510654;4198.979005104955;4204.369344598304;4206.810693518783;3753.399456087013;3770.1517158639363;3770.322206618056;3773.3585290500682;3777.3578491656485;5046.2178362353525;5168.612354073422;5225.529702326809;5237.764300606482;5241.606879484054;4802.375691160127;4823.686460380064;4831.492693267227;4847.466778654345;4848.418189817209;5515.889682206373;5539.19681646159;5571.8607034824045;5574.770091963207;5609.177017469298;3975.980120099381;4141.109661422778;4191.811368488426;4197.349410841324;4206.284931561611;5740.942590574125;5746.109353050284;5775.913361299584;5778.966042827507;5792.478676919055;4280.978595107004;4285.935710964338;4290.4636920384955;4298.376735373354;4299.333603291495;4188.643965262926;4291.184674911757;4315.834724624334;4349.6294519486955;4352.260115780325;4810.6632535722865;4821.879453013703;4836.975815120973;4844;4857.4171099467585;5577.944220557823;5579.246801681721;5588.133839254922;5592.2730045094695;5608.915866262009;1392.6518370407398;1426.2298358886292;1442.8268607766925;1446.3130013243624;1452.1504919621927;957.9760505987267;981.4896253947907;1008.0272537001829;1016.8474728790741;1031.3141760729181;5203.583713303003;5229.555487783581;5231.189165679326;5239.7296203594715;5254.502466796945;5434.820629931455;5446.836594902159;5448;5475.494239084204;5512.586556008316;5095.547612894423;5129.384473863161;5236.633435659467;5270;5276.815311464157;2941.9705802942126;2944.528875379929;2944.7349738523635;2954.5863579098946;2961.837098959578;5564.618723340535;5699.259096317535;5716.227969329438;5744.195812586241;5780.508656764222;5566.638168519034;5599.356074051455;5601.271834661549;5602.831915042555;5626.437356264422;5660.915086273709;5665.98857405615;5669.348024977098;5675;5685.289338832646;5444.210589464585;5488.9725551371985;5507.256520369699;5807.186993820784;5835.2122463466885;5759.625624334405;5765.596408251382;5779.508741756998;5779.682117483579;5785.942140578541;5816.062888241411;6047.879042419215;6052.909206361996;6064.818055458343;6065.636061836304;4163.8334466621;4205.243056249905;4205.453291072141;4211.326187809936;4213.599708027732;5748.597598168088;5768;5801.113254119666;5813.680247586423;5831.854203644943;5466.726663666721;5632.7183640816975;5674.687892165971;5676.7511147547475;5685.403032681509;5621.437856214346;5630.5214056805635;5639.520640745583;5641.887162256649;5647.131714775392;5335.73321333924;5454.181872718965;5596.272484576979;5602.579806514609;5606.271184745957;5563.13771365439;5613.522850557585;5630.254621067482;5655.943440565707;5655.943440565707;5526.806561770319;5545.390007099135;5558.861028474321;5565.805196818092;5573 22:14:32 INFO - PROCESS | 18316 | |5;yui.html;631.902055181447;645.941865232129;702.192478649553;712.2877122877123;713.639611995942;14680.265986700662;15899.046057236574;15988.76016859748;15998.600034999115;16002.199890005497;14390.208538530376;14513.927430362859;14514.419423223086;14525.201113938729;14547.854521454783;700.5481464455423;723.3453724379445;825.5830805443243;829.4235506323108;846.8729690546437;844.8648216285395;846.6951897316961;847.1655419411875;847.478800537668;847.7541512961234;898.8471959766855;899.5457294066488;899.7300809757079;899.8875140607424;899.9820003599924;728.7012324946746;750.7334896111856;846.2003406780594;890.1454603580538;890.3322508118911;653.627432363553;657.5627207906737;657.6711644177911;657.917760279965;658.2068607328158;14178.574642760734;14212.147271163763;14223;14230.786538201935;14241;13728.725425491533;13941.721165576733;14024.579262622035;14134.575962721136;14198.716025679532;12598.81101783474;12690.175138615961;12707.872921270762;12848;12900.483980640764;4441.467023957113;4497.550244975509;4550.317452382136;4564.5435456454425;4568.611668008223;56064.43935560633;56397;59250.70374648142;60176.69911650414;60688;11426.771464570827;11516.94241528787;11557.190996630323;11691.356975366436;11791.410429478492;19099.61800764005;19262.4221273362;19290.61418771645;19351;19633.60732785365;7386.815329616803;7993.360531157494;8200.302974247137;8253.257206851413;8391.076981532027;4702.224133018082;4704.9059018819435;4802.231642937113;4825.758712064383;4853;3490.5811302643847;3556.8440256916606;3604.675579197885;3610.6930910872343;3611.0972256935765;637.1430426076919;648.6594537867563;657.3032585459429;658.5127006015609;672.9024291477806;553.9778408863681;598.2212622369071;607.5230943709167;635.4408120853619;657.8914479110894;8678;8723.60743766532;8922.910770892207;8963.549098456366;9019.77450563728;575.3211210771331;597.6892016151663;623.9500839932795;636.0237036149581;641.4836056974087;3963.841446342172;4245.80893859777;4288.7855607220135;4340.761258130833;4385.495667998157;86930.56534717286;90486;90806.54596727106;91117;93988;46866.29700554494;53874.461255386945;64160.67919660372;64609.67695161588;74075;64104;64285.67857160778;64460.35539644637;65319.346806532274;67136;9365;9716.174125199155;9820.361676491006;9852.704418867446;9875.20998320147;43357.78321108374;43572.56427435812;43871;43997.34003989879;44152.77923610361;54286.18570721363;61458.69270653618;61659;61911.38088619236;63399.36600633935;11752.529898803952;12360.44378002974;12438.626841194779;12591.685207869876;13458.461661533429;12954.417051232906;13258.867411325764;13373;14328.641783955485;14664.266786660837;12688;12696.301703406401;12818.423170957516;12894.419751111034;13052;12375.504979800708;12569;12583.370831458573;12674.809877852023;12751.936240318739;12318.75362492763;12641.367931603567;12675.985921126472;12776.233425994471;12808.551700690432;10678.14574834027;10798.474550146317;11329.943350283196;11334.376609286568;11548.884511154782;10887.782244355227;10960.671179864617;11294.548218071184;11329.943350283196;11382 22:14:32 INFO - PROCESS | 18316 | __end_tp_report 22:14:32 INFO - PROCESS | 18316 | __start_cc_report 22:14:32 INFO - PROCESS | 18316 | _x_x_mozilla_cycle_collect,993 22:14:32 INFO - PROCESS | 18316 | __end_cc_report 22:14:32 INFO - PROCESS | 18316 | __startTimestamp1484028872040__endTimestamp 22:14:32 INFO - PROCESS | 18316 | 22:14:32 INFO - PROCESS | 18316 | ------- Summary: start ------- 22:14:32 INFO - PROCESS | 18316 | Number of tests: 6 22:14:32 INFO - PROCESS | 18316 | 22:14:32 INFO - PROCESS | 18316 | [#0] dojo.html Cycles:165 Average:5453.16 Median:5662.92 stddev:600.46 (10.6%) stddev-sans-first:574.87 22:14:32 INFO - PROCESS | 18316 | Values: 3166.2 3193.5 3206.0 3223.7 3248.0 5328.5 5407.8 5423.7 5423.9 5446.0 5551.6 5553.7 5568.8 5594.8 5599.1 5002.3 5025.6 5039.5 5070.5 5115.2 4890.1 4890.5 5050.6 5082.6 5104.8 4955.1 4987.1 5001.3 5004.3 5010.8 5038.1 5053.5 5098.4 5099.2 5126.7 4777.1 4986.2 5005.6 5037.6 5067.3 5356.8 5362.9 5379.6 5406.9 5433.9 5765.5 5782.6 5848.0 5864.8 5877.4 5715.3 5887.5 5896.0 5913.6 5926.3 5392.7 5451.2 5502.3 5523.4 5571.1 5982.8 6009.7 6022.9 6024.9 6027.0 5570.4 5790.3 5797.2 5806.4 5808.8 5691.9 5795.7 5849.9 5863.9 5930.9 5893.1 5896.0 5897.9 5908.9 5924.1 5836.9 5894.2 5896.6 5916.7 5930.1 4426.9 4456.7 4466.8 4525.3 4594.7 4083.1 4093.5 4107.1 4107.4 4119.6 5651.0 5662.9 5662.9 5663.8 5686.0 5632.7 5679.0 5941.7 5953.9 5957.6 5517.4 5517.7 5534.1 5602.5 5627.3 5082.8 5096.1 5097.5 5106.0 5119.9 5852.7 5927.6 6033.4 6090.2 6106.6 5730.9 5771.1 5810.2 5904.7 5924.4 6060.9 6067.5 6067.6 6067.6 6074.6 5743.9 5744.8 5746.8 5747.0 5749.3 5702.9 5758.2 5827.5 5868.6 5871.6 5791.4 5794.6 5796.0 5797.2 5816.8 5733.3 5750.5 5804.6 5806.0 5813.2 5536.5 5567.6 5574.9 5592.0 5752.8 5736.9 5750.0 5750.5 5763.3 5777.0 5435.7 5575.7 5578.7 5584.8 5586.9 22:14:32 INFO - PROCESS | 18316 | 22:14:32 INFO - PROCESS | 18316 | [#1] ext.html Cycles:180 Average:60680.39 Median:38933.21 stddev:116966.47 (300.4%) stddev-sans-first:117207.51 22:14:32 INFO - PROCESS | 18316 | Values: 568.3 580.4 626.1 642.4 650.6 33386.8 45103.5 46281.3 46379.8 46436.5 46522.3 46568.5 46573.0 46627.0 47112.0 8285.8 8534.0 8651.4 8788.9 8791.5 10526.3 10759.1 10761.1 11044.5 11053.3 10788.6 10851.7 10860.2 10865.5 10866.8 10508.8 10558.3 10558.3 10577.3 10638.3 10673.7 10715.4 10721.0 10726.7 10742.9 42756.6 42890.6 43073.4 43345.0 43379.8 3663.6 3743.8 3989.3 4260.6 4388.0 32224.8 32316.7 32378.2 33038.7 35006.6 4280.9 4367.1 4408.6 4411.8 4441.3 350859.0 350983.0 351408.0 351415.0 351707.0 62558.0 63002.4 63028.7 63046.4 63063.4 39721.6 40804.0 40852.4 42598.1 42675.0 19320.4 19502.8 19511.7 19513.1 19513.2 11934.3 11939.6 14422.0 14468.9 14628.5 20056.4 20495.8 20510.4 20515.3 20550.9 7063.2 7143.3 7315.9 7407.5 7497.3 1004.5 1083.2 1097.6 1193.9 1209.8 34861.0 34873.0 34966.0 35008.8 35249.6 1139.1 1142.9 1160.1 1177.4 1195.2 17213.9 18238.0 18276.0 18364.5 18429.9 512242.0 517701.0 521795.0 522670.0 524221.0 42191.4 42248.8 42249.0 42258.9 55513.7 1313.1 1321.8 1388.0 1399.2 1411.3 34212.5 35932.8 36087.3 36124.3 36132.5 54531.7 54986.7 54993.7 55130.7 55166.7 369687.0 370880.0 372074.0 520915.0 533749.0 45991.1 46343.1 46477.5 46847.3 47179.3 51369.0 51718.5 51819.7 51827.0 52239.5 42096.4 43394.1 43805.6 44703.6 44742.0 44358.0 44638.6 45072.0 45892.0 46048.0 36032.3 36061.6 36465.8 43843.8 43952.1 36037.6 38192.6 39673.8 39983.4 42153.8 29990.7 30090.2 30104.2 30176.7 30430.0 22:14:32 INFO - PROCESS | 18316 | 22:14:32 INFO - PROCESS | 18316 | [#2] jquery.html Cycles:180 Average:26688.53 Median:19829.95 stddev:70648.69 (356.3%) stddev-sans-first:70819.27 22:14:32 INFO - PROCESS | 18316 | Values: 384.8 390.3 410.3 417.0 424.3 13963.8 16069.9 19276.4 19850.6 19910.3 19301.7 19453.3 19674.8 19960.3 20046.4 4713.3 5621.1 5828.4 5831.4 5897.0 5724.1 5793.5 5829.2 5838.2 5840.9 5533.9 5621.4 5658.9 5813.2 5814.1 5651.7 5700.1 5750.4 5753.3 5759.2 5108.4 5163.1 5339.1 5361.1 5436.9 14358.3 14472.4 14495.4 14601.1 14667.8 2200.9 2278.2 2321.6 2396.4 2629.1 10415.7 10543.2 10872.1 11063.2 12960.4 1922.8 1942.8 1947.2 1965.3 2000.6 59249.7 66151.3 75031.0 84572.6 87626.0 10732.5 10806.9 10952.8 10995.8 11043.1 15007.0 15029.3 15034.0 15047.2 15067.2 7593.7 7640.7 7711.9 7912.2 8130.8 7508.0 7648.0 7675.1 7746.5 7880.5 4535.4 4724.5 4724.9 4758.9 4825.8 1956.5 2008.1 2042.7 2087.2 2098.0 828.6 881.5 884.0 902.1 906.0 17207.9 17520.8 18150.4 18222.2 18592.4 934.9 936.3 957.2 974.6 975.0 9727.4 10821.3 10823.4 11965.7 12083.8 372677.0 375662.0 376540.0 488614.0 491687.0 88774.6 97806.0 99356.5 100399.0 102967.9 479.1 499.2 504.4 504.7 505.5 11091.5 11216.5 11264.2 11575.9 11730.4 33116.7 39269.6 39951.0 41655.6 43659.4 61002.4 61153.0 61651.0 62440.0 63000.7 8758.8 9170.9 9190.5 9279.6 9373.3 13477.5 14090.6 14145.3 14211.4 14643.1 11928.5 12139.5 12265.2 12360.4 12420.3 11277.5 12074.0 12176.9 12368.9 12775.2 11666.5 11747.7 11894.5 11979.5 12222.7 8417.2 8619.2 8657.0 8674.6 8714.4 9980.9 11042.6 11121.7 11138.7 11355.2 22:14:32 INFO - PROCESS | 18316 | 22:14:32 INFO - PROCESS | 18316 | [#3] mootools.html Cycles:180 Average:5524.39 Median:5147.49 stddev:2996.15 (58.2%) stddev-sans-first:2988.05 22:14:32 INFO - PROCESS | 18316 | Values: 1340.6 1440.3 1470.1 1551.7 1750.0 7353.2 7988.0 8220.2 8234.8 8445.7 8242.1 8315.6 8317.0 8320.1 8323.5 2311.1 2323.3 2340.5 2341.1 2341.8 2327.6 2363.0 2388.2 2389.8 2390.0 2414.8 2419.1 2437.7 2456.4 2457.9 2346.4 2367.0 2381.8 2389.9 2392.0 2369.9 2383.4 2398.4 2399.3 2402.9 8213.8 8275.0 8309.9 8329.8 8331.7 5156.9 5330.1 5342.8 5401.1 5407.3 3334.1 3424.6 3437.9 3499.4 3501.1 1098.4 1132.0 1132.5 1164.3 1166.0 11253.7 11319.5 11416.7 11424.2 11441.0 4112.2 4432.5 4477.7 4507.6 4515.7 9217.8 9222.4 9232.3 9232.4 9235.1 5191.3 5223.0 5228.1 5231.1 5234.7 4338.9 4469.9 4773.1 4870.3 4872.2 3816.5 3871.3 3925.2 3966.2 3969.7 1124.6 1144.8 1169.9 1173.0 1180.4 893.4 1005.6 1027.7 1028.1 1034.1 5626.0 5719.3 5734.9 5758.7 5827.1 937.9 962.5 987.1 992.5 1020.8 3907.6 3915.9 4084.4 4130.0 4161.8 10010.2 10316.9 10343.8 10380.0 10384.3 10223.8 10247.4 10255.1 10330.8 10332.3 7487.7 7802.1 7854.1 8025.0 8027.0 5588.4 5725.9 5754.1 5764.0 5782.4 9058.0 9059.9 9077.8 9151.0 9265.5 9307.0 9310.2 9344.0 9436.2 9439.2 6822.6 7040.4 7044.4 7474.3 7666.2 7204.9 7419.1 7877.5 7975.9 8203.4 7142.1 7327.2 7369.6 7372.0 7708.7 7183.9 7356.7 7494.0 7514.9 7561.0 6497.8 6608.4 6617.5 6720.2 6722.9 4806.4 5044.9 5138.1 5158.7 5270.4 4981.6 5013.3 5093.1 5187.4 5281.5 22:14:32 INFO - PROCESS | 18316 | 22:14:32 INFO - PROCESS | 18316 | [#4] prototype.html Cycles:180 Average:4713.00 Median:5273.41 stddev:1355.73 (25.7%) stddev-sans-first:1319.25 22:14:32 INFO - PROCESS | 18316 | Values: 342.6 344.3 349.2 351.6 354.4 5404.7 5419.4 5422.5 5476.7 5517.3 5068.8 5143.3 5231.7 5260.5 5361.6 4231.5 4245.5 4249.4 4254.9 4266.2 4225.9 4233.4 4244.0 4264.8 4268.3 3930.5 3969.9 4180.2 4185.5 4200.4 4179.6 4196.3 4199.0 4204.4 4206.8 3753.4 3770.2 3770.3 3773.4 3777.4 5046.2 5168.6 5225.5 5237.8 5241.6 4802.4 4823.7 4831.5 4847.5 4848.4 5515.9 5539.2 5571.9 5574.8 5609.2 3976.0 4141.1 4191.8 4197.3 4206.3 5740.9 5746.1 5775.9 5779.0 5792.5 4281.0 4285.9 4290.5 4298.4 4299.3 4188.6 4291.2 4315.8 4349.6 4352.3 4810.7 4821.9 4837.0 4844.0 4857.4 5577.9 5579.2 5588.1 5592.3 5608.9 1392.7 1426.2 1442.8 1446.3 1452.2 958.0 981.5 1008.0 1016.8 1031.3 5203.6 5229.6 5231.2 5239.7 5254.5 5434.8 5446.8 5448.0 5475.5 5512.6 5095.5 5129.4 5236.6 5270.0 5276.8 2942.0 2944.5 2944.7 2954.6 2961.8 5564.6 5699.3 5716.2 5744.2 5780.5 5566.6 5599.4 5601.3 5602.8 5626.4 5660.9 5666.0 5669.3 5675.0 5685.3 5444.2 5489.0 5507.3 5807.2 5835.2 5759.6 5765.6 5779.5 5779.7 5785.9 5816.1 6047.9 6052.9 6064.8 6065.6 4163.8 4205.2 4205.5 4211.3 4213.6 5748.6 5768.0 5801.1 5813.7 5831.9 5466.7 5632.7 5674.7 5676.8 5685.4 5621.4 5630.5 5639.5 5641.9 5647.1 5335.7 5454.2 5596.3 5602.6 5606.3 5563.1 5613.5 5630.3 5655.9 5655.9 5526.8 5545.4 5558.9 5565.8 5573.0 22:14:32 INFO - PROCESS | 18316 | 22:14:32 INFO - PROCESS | 18316 | [#5] yui.html Cycles:180 Average:17176.01 Median:25784.26 stddev:22145.13 (85.9%) stddev-sans-first:22172.41 22:14:32 INFO - PROCESS | 18316 | Values: 631.9 645.9 702.2 712.3 713.6 14680.3 15899.0 15988.8 15998.6 16002.2 14390.2 14513.9 14514.4 14525.2 14547.9 700.5 723.3 825.6 829.4 846.9 844.9 846.7 847.2 847.5 847.8 898.8 899.5 899.7 899.9 900.0 728.7 750.7 846.2 890.1 890.3 653.6 657.6 657.7 657.9 658.2 14178.6 14212.1 14223.0 14230.8 14241.0 13728.7 13941.7 14024.6 14134.6 14198.7 12598.8 12690.2 12707.9 12848.0 12900.5 4441.5 4497.6 4550.3 4564.5 4568.6 56064.4 56397.0 59250.7 60176.7 60688.0 11426.8 11516.9 11557.2 11691.4 11791.4 19099.6 19262.4 19290.6 19351.0 19633.6 7386.8 7993.4 8200.3 8253.3 8391.1 4702.2 4704.9 4802.2 4825.8 4853.0 3490.6 3556.8 3604.7 3610.7 3611.1 637.1 648.7 657.3 658.5 672.9 554.0 598.2 607.5 635.4 657.9 8678.0 8723.6 8922.9 8963.5 9019.8 575.3 597.7 624.0 636.0 641.5 3963.8 4245.8 4288.8 4340.8 4385.5 86930.6 90486.0 90806.5 91117.0 93988.0 46866.3 53874.5 64160.7 64609.7 74075.0 64104.0 64285.7 64460.4 65319.3 67136.0 9365.0 9716.2 9820.4 9852.7 9875.2 43357.8 43572.6 43871.0 43997.3 44152.8 54286.2 61458.7 61659.0 61911.4 63399.4 11752.5 12360.4 12438.6 12591.7 13458.5 12954.4 13258.9 13373.0 14328.6 14664.3 12688.0 12696.3 12818.4 12894.4 13052.0 12375.5 12569.0 12583.4 12674.8 12751.9 12318.8 12641.4 12676.0 12776.2 12808.6 10678.1 10798.5 11329.9 11334.4 11548.9 10887.8 10960.7 11294.5 11329.9 11382.0 22:14:32 INFO - PROCESS | 18316 | -------- Summary: end -------- 22:14:32 INFO - PROCESS | 18316 | 22:14:32 INFO - TEST-INFO | 18316: exit 0 22:14:32 INFO - TEST-OK | dromaeo_css | took 1115741ms 22:14:32 INFO - TEST-START | kraken 22:14:32 INFO - operating with platform_type : linux_ 22:14:32 INFO - Initialising browser for kraken test... 22:14:32 INFO - TEST-INFO | started process 18633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3NZsPI/profile http://localhost:43145/getInfo.html) 22:14:36 INFO - PROCESS | 18633 | __metrics Screen width/height:1600/1200 22:14:36 INFO - PROCESS | 18633 | colorDepth:24 22:14:36 INFO - PROCESS | 18633 | Browser inner width/height: 1024/697 22:14:36 INFO - PROCESS | 18633 | __metrics 22:14:37 INFO - PROCESS | 18633 | 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" 22:14:37 INFO - PROCESS | 18633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:14:38 INFO - PROCESS | 18633 | console.error: PushService: 22:14:38 INFO - PROCESS | 18633 | stateChangeProcessEnqueue: Error transitioning state 22:14:38 INFO - PROCESS | 18633 | UnknownError 22:14:38 INFO - TEST-INFO | 18633: exit 0 22:14:38 INFO - Browser initialized. 22:14:38 INFO - Running cycle 1/1 for kraken test... 22:14:38 INFO - TEST-INFO | started process 18729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3NZsPI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:50 INFO - PROCESS | 18729 | RSS: Main: 143962112 22:14:50 INFO - PROCESS | 18729 | 22:14:53 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43145/tests/kraken/driver.html?testName=audio-beat-detection) 22:14:53 INFO - PROCESS | 18729 | RSS: Main: 185516032 22:14:53 INFO - PROCESS | 18729 | 22:14:56 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43145/tests/kraken/driver.html?testName=audio-dft) 22:14:57 INFO - PROCESS | 18729 | RSS: Main: 174882816 22:14:57 INFO - PROCESS | 18729 | 22:14:59 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43145/tests/kraken/driver.html?testName=audio-fft) 22:15:00 INFO - PROCESS | 18729 | RSS: Main: 266768384 22:15:00 INFO - PROCESS | 18729 | 22:15:02 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43145/tests/kraken/driver.html?testName=audio-oscillator) 22:15:03 INFO - PROCESS | 18729 | RSS: Main: 173039616 22:15:03 INFO - PROCESS | 18729 | 22:15:05 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43145/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:15:05 INFO - PROCESS | 18729 | RSS: Main: 175611904 22:15:05 INFO - PROCESS | 18729 | 22:15:08 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43145/tests/kraken/driver.html?testName=imaging-darkroom) 22:15:09 INFO - PROCESS | 18729 | RSS: Main: 212865024 22:15:09 INFO - PROCESS | 18729 | 22:15:12 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43145/tests/kraken/driver.html?testName=imaging-desaturate) 22:15:13 INFO - PROCESS | 18729 | RSS: Main: 211431424 22:15:13 INFO - PROCESS | 18729 | 22:15:15 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43145/tests/kraken/driver.html?testName=json-parse-financial) 22:15:16 INFO - PROCESS | 18729 | RSS: Main: 211156992 22:15:16 INFO - PROCESS | 18729 | 22:15:18 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43145/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:15:18 INFO - PROCESS | 18729 | RSS: Main: 173031424 22:15:18 INFO - PROCESS | 18729 | 22:15:20 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43145/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:15:20 INFO - PROCESS | 18729 | RSS: Main: 179757056 22:15:20 INFO - PROCESS | 18729 | 22:15:22 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43145/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:15:23 INFO - PROCESS | 18729 | RSS: Main: 189349888 22:15:23 INFO - PROCESS | 18729 | 22:15:26 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:15:26 INFO - PROCESS | 18729 | RSS: Main: 198041600 22:15:26 INFO - PROCESS | 18729 | 22:15:29 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:15:30 INFO - PROCESS | 18729 | RSS: Main: 194240512 22:15:30 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | Cycle 1(1): loaded http://localhost:43145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43145/tests/kraken/driver.html?testName=ai-astar) 22:15:31 INFO - PROCESS | 18729 | RSS: Main: 245821440 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | __start_tp_report 22:15:31 INFO - PROCESS | 18729 | _x_x_mozilla_page_load 22:15:31 INFO - PROCESS | 18729 | _x_x_mozilla_page_load_details 22:15:31 INFO - PROCESS | 18729 | |i|pagename|runs| 22:15:31 INFO - PROCESS | 18729 | |0;ai-astar;101;111;111;111;111;115;112;111;113;111 22:15:31 INFO - PROCESS | 18729 | |1;audio-beat-detection;148;122;121;164;128;122;119;123;144;126 22:15:31 INFO - PROCESS | 18729 | |2;audio-dft;161;160;162;160;161;162;160;160;160;161 22:15:31 INFO - PROCESS | 18729 | |3;audio-fft;74;75;76;114;76;74;75;76;101;76 22:15:31 INFO - PROCESS | 18729 | |4;audio-oscillator;80;82;115;82;81;82;98;82;82;116 22:15:31 INFO - PROCESS | 18729 | |5;imaging-gaussian-blur;117;116;117;117;118;117;117;116;116;117 22:15:31 INFO - PROCESS | 18729 | |6;imaging-darkroom;146;146;146;145;146;146;146;147;145;146 22:15:31 INFO - PROCESS | 18729 | |7;imaging-desaturate;85;85;86;85;84;85;85;84;85;85 22:15:31 INFO - PROCESS | 18729 | |8;json-parse-financial;52;52;51;51;52;61;53;50;50;51 22:15:31 INFO - PROCESS | 18729 | |9;json-stringify-tinderbox;59;58;59;60;60;59;58;58;59;60 22:15:31 INFO - PROCESS | 18729 | |10;stanford-crypto-aes;74;74;75;75;74;74;74;75;82;74 22:15:31 INFO - PROCESS | 18729 | |11;stanford-crypto-ccm;125;124;140;120;130;121;117;119;163;121 22:15:31 INFO - PROCESS | 18729 | |12;stanford-crypto-pbkdf2;158;155;153;155;154;157;156;154;152;154 22:15:31 INFO - PROCESS | 18729 | |13;stanford-crypto-sha256-iterative;63;63;62;62;63;63;63;62;61;65 22:15:31 INFO - PROCESS | 18729 | __end_tp_report 22:15:31 INFO - PROCESS | 18729 | __start_cc_report 22:15:31 INFO - PROCESS | 18729 | _x_x_mozilla_cycle_collect,1610 22:15:31 INFO - PROCESS | 18729 | __end_cc_report 22:15:31 INFO - PROCESS | 18729 | __startTimestamp1484028931920__endTimestamp 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | ------- Summary: start ------- 22:15:31 INFO - PROCESS | 18729 | Number of tests: 14 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:3.65 (3.3%) stddev-sans-first:1.39 22:15:31 INFO - PROCESS | 18729 | Values: 101.0 111.0 111.0 111.0 111.0 115.0 112.0 111.0 113.0 111.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:127.00 stddev:15.08 (11.9%) stddev-sans-first:14.79 22:15:31 INFO - PROCESS | 18729 | Values: 148.0 122.0 121.0 164.0 128.0 122.0 119.0 123.0 144.0 126.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 22:15:31 INFO - PROCESS | 18729 | Values: 161.0 160.0 162.0 160.0 161.0 162.0 160.0 160.0 160.0 161.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:13.96 (18.5%) stddev-sans-first:14.53 22:15:31 INFO - PROCESS | 18729 | Values: 74.0 75.0 76.0 114.0 76.0 74.0 75.0 76.0 101.0 76.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.00 stddev:14.40 (17.6%) stddev-sans-first:14.81 22:15:31 INFO - PROCESS | 18729 | Values: 80.0 82.0 115.0 82.0 81.0 82.0 98.0 82.0 82.0 116.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 22:15:31 INFO - PROCESS | 18729 | Values: 117.0 116.0 117.0 117.0 118.0 117.0 117.0 116.0 116.0 117.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 22:15:31 INFO - PROCESS | 18729 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 147.0 145.0 146.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 22:15:31 INFO - PROCESS | 18729 | Values: 85.0 85.0 86.0 85.0 84.0 85.0 85.0 84.0 85.0 85.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:3.20 (6.2%) stddev-sans-first:3.39 22:15:31 INFO - PROCESS | 18729 | Values: 52.0 52.0 51.0 51.0 52.0 61.0 53.0 50.0 50.0 51.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 22:15:31 INFO - PROCESS | 18729 | Values: 59.0 58.0 59.0 60.0 60.0 59.0 58.0 58.0 59.0 60.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.50 stddev:2.47 (3.3%) stddev-sans-first:2.59 22:15:31 INFO - PROCESS | 18729 | Values: 74.0 74.0 75.0 75.0 74.0 74.0 74.0 75.0 82.0 74.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:124.50 stddev:13.99 (11.2%) stddev-sans-first:14.80 22:15:31 INFO - PROCESS | 18729 | Values: 125.0 124.0 140.0 120.0 130.0 121.0 117.0 119.0 163.0 121.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:1.81 (1.2%) stddev-sans-first:1.51 22:15:31 INFO - PROCESS | 18729 | Values: 158.0 155.0 153.0 155.0 154.0 157.0 156.0 154.0 152.0 154.0 22:15:31 INFO - PROCESS | 18729 | 22:15:31 INFO - PROCESS | 18729 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 22:15:31 INFO - PROCESS | 18729 | Values: 63.0 63.0 62.0 62.0 63.0 63.0 63.0 62.0 61.0 65.0 22:15:31 INFO - PROCESS | 18729 | -------- Summary: end -------- 22:15:31 INFO - PROCESS | 18729 | 22:15:32 INFO - TEST-INFO | 18729: exit 0 22:15:32 INFO - TEST-OK | kraken | took 60129ms 22:15:32 INFO - SUITE-END | took 1175s 22:15:33 INFO - Completed test suite (00:19:35) 22:15:33 INFO - javascript benchmark 22:15:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.176794033551, 3193.5369371441143, 3205.990113114369, 3223.72598329142, 3247.9512807307897, 5328.493793089655, 5407.756650950707, 5423.701696406696, 5423.945760542393, 5446.0, 5551.583631227654, 5553.694546799924, 5568.777248910039, 5594.832155035356, 5599.076152434844, 5002.349694539714, 5025.648204625678, 5039.47085556015, 5070.492950704918, 5115.232715092748, 4890.095332363507, 4890.535399137077, 5050.570701490377, 5082.593392528607, 5104.800371912597, 4955.132851750929, 4987.052460032601, 5001.299818025461, 5004.349434573501, 5010.824621138261, 5038.067957427887, 5053.545180933734, 5098.413682426494, 5099.209622508517, 5126.71803050832, 4777.116233496779, 4986.227134794112, 5005.624578156653, 5037.647364684473, 5067.290579318898, 5356.758945847446, 5362.865928351784, 5379.623426360156, 5406.864828379283, 5433.864153396157, 5765.509931655773, 5782.624129431573, 5847.970760146172, 5864.794732184353, 5877.382874798127, 5715.3141623005085, 5887.528997680175, 5896.0, 5913.615614985055, 5926.348101708809, 5392.676439413609, 5451.236826844245, 5502.284702988626, 5523.364813046471, 5571.13647384656, 5982.820515384458, 6009.669468179205, 6022.909656355158, 6024.909626355608, 6027.035674292092, 5570.359408667974, 5790.276215473066, 5797.246357973437, 5806.44838740319, 5808.767649293981, 5691.857703557362, 5795.739191736382, 5849.88300233993, 5863.912041319383, 5930.881382372415, 5893.11603259506, 5896.027155519291, 5897.911531327033, 5908.940910590839, 5924.052151655715, 5836.854078648068, 5894.204282421818, 5896.616719913192, 5916.674582897982, 5930.110483427434, 4426.911461770811, 4456.732596044248, 4466.754328511963, 4525.343825145335, 4594.6783725139585, 4083.1221287423346, 4093.488313960755, 4107.137501124797, 4107.404426358161, 4119.588041195856, 5651.0, 5662.915056274159, 5662.943370566324, 5663.801766938137, 5685.971570142123, 5632.718364081779, 5679.0, 5941.673207973517, 5953.851153721192, 5957.553183511167, 5517.44825517445, 5517.668939863621, 5534.142207957773, 5602.523785478198, 5627.324721033502, 5082.771275292621, 5096.133657278272, 5097.490250974947, 5105.974470127626, 5119.948800512022, 5852.736626851717, 5927.585069045298, 6033.42682445167, 6090.23872015998, 6106.633601983806, 5730.914036289542, 5771.105478650816, 5810.186573879576, 5904.734286957183, 5924.377940316204, 6060.878782424415, 6067.484263837447, 6067.575269731253, 6067.605605635619, 6074.574779765374, 5743.8564035899435, 5744.770209191585, 5746.798862039808, 5746.994276001599, 5749.338826035059, 5702.914456283076, 5758.193852860687, 5827.475527202572, 5868.559858010752, 5871.588988770916, 5791.420857914175, 5794.62334948227, 5795.971020144872, 5797.159411885169, 5816.76732930678, 5733.254676891977, 5750.511206547323, 5804.622699524517, 5806.0, 5813.24427824397, 5536.474034966672, 5567.5545956322585, 5574.888502230014, 5591.993441180626, 5752.798652047159, 5736.942630573641, 5750.022496175744, 5750.453706897838, 5763.250777398911, 5777.017906955912, 5435.673859568438, 5575.665460072409, 5578.665280083208, 5584.804531841366, 5586.888262234814], "value": 5413.984999039235, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2584227583003, 580.3558050563875, 626.1328060636017, 642.3608509533012, 650.609634219468, 33386.83306583467, 45103.54896451039, 46281.30578041323, 46379.768101159534, 46436.535634643646, 46522.30216546755, 46568.53431465684, 46573.0, 46627.0, 47112.0, 8285.792855178608, 8533.957330213372, 8651.394402391836, 8788.8681669775, 8791.472511649321, 10526.263161578692, 10759.085477734363, 10761.08530774885, 11044.502997365138, 11053.336799791998, 10788.622398216065, 10851.728706782354, 10860.239783215178, 10865.51105200264, 10866.836997445045, 10508.842367364496, 10558.260921735482, 10558.31370960885, 10577.31247468912, 10638.308509946868, 10673.679789606324, 10715.410652414113, 10721.0, 10726.678199654023, 10742.946285268601, 42756.57243427557, 42890.571094289284, 43073.35389969153, 43345.0, 43379.783101084606, 3663.5970043295215, 3743.775373477573, 3989.341758609826, 4260.595243451867, 4387.956120438818, 32224.838875805704, 32316.676833231602, 32378.19054523632, 33038.6696133038, 35006.649933500594, 4280.9143817123795, 4367.148406060819, 4408.559144085598, 4411.757353345564, 4441.289393697025, 350859.0, 350983.0, 351408.0, 351415.0, 351707.0, 62558.0, 63002.369976300564, 63028.684856575426, 63046.36953630497, 63063.369366306666, 39721.60278397179, 40804.0, 40852.38721419181, 42598.148037039085, 42675.0, 19320.4203873884, 19502.804971950383, 19511.707324390147, 19513.121909514106, 19513.219471220993, 11934.3436111013, 11939.582114625946, 14422.0, 14468.927655361656, 14628.488002919847, 20056.398308050782, 20495.795042049685, 20510.38468845937, 20515.281965131147, 20550.897245513675, 7063.223045464994, 7143.285671432815, 7315.890261646079, 7407.518511296748, 7497.250274972459, 1004.542932965499, 1083.160550573312, 1097.6487523992405, 1193.8925496705338, 1209.770143672717, 34861.0, 34873.0, 34966.0, 35008.824955875054, 35249.64750352463, 1139.1171841822654, 1142.8685701144475, 1160.118310084325, 1177.4054102678092, 1195.2231049817515, 17213.913930430266, 18238.0, 18276.0, 18364.540886477946, 18429.90785046093, 512242.0, 517701.0, 521795.0, 522670.0, 524221.0, 42191.36712949247, 42248.78875605603, 42249.0, 42258.943526412084, 55513.722431387585, 1313.1070871807262, 1321.7620828250815, 1388.0, 1399.181478834893, 1411.336671764269, 34212.48681269733, 35932.820335898155, 36087.27825443529, 36124.27751445009, 36132.4580131293, 54531.727341364625, 54986.72506637441, 54993.72503137459, 55130.72434637801, 55166.72416637891, 369687.0, 370880.0, 372074.0, 520915.0, 533749.0, 45991.080178396915, 46343.07313853637, 46477.53522464732, 46847.29729054135, 47179.29231061605, 51369.0, 51718.48281517137, 51819.740901295256, 51827.0, 52239.47760522498, 42096.36855447232, 43394.13211735684, 43805.56194438015, 44703.55296446994, 44742.0, 44358.0, 44638.55361446344, 45072.0, 45892.0, 46048.0, 36032.27935441329, 36061.639383606875, 36465.81767091148, 43843.78078109589, 43952.12095758131, 36037.63962360343, 38192.61807382002, 39673.801630991664, 39983.40024899687, 42153.78923105365, 29990.70009299879, 30090.247743805703, 30104.24739381533, 30176.698233018265, 30430.0], "value": 21271.458850930656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.80567313506674, 390.29356864076044, 410.26971989858055, 416.98957526061855, 424.34438792066254, 13963.790543141848, 16069.919650401745, 19276.421707348785, 19850.602987940234, 19910.303139390126, 19301.710474342897, 19453.31913383032, 19674.803251967474, 19960.30138945137, 20046.398608041745, 4713.269443236304, 5621.072523033695, 5828.388019257981, 5831.358550559435, 5896.970515147418, 5724.055530837407, 5793.536517078624, 5829.242198514187, 5838.153467747175, 5840.941590584103, 5533.861653458655, 5621.353544342412, 5658.858528536799, 5813.215215945836, 5814.069748840187, 5651.689157096358, 5700.116481945305, 5750.396208398141, 5753.252077229933, 5759.164921086461, 5108.361454818148, 5163.122269214243, 5339.065663508871, 5361.08861493547, 5436.945630543683, 14358.282085895768, 14472.429068716261, 14495.42018319266, 14601.12393256408, 14667.77998330026, 2200.933971980843, 2278.236790675126, 2321.593721098801, 2396.388920825196, 2629.1192450529097, 10415.739606509822, 10543.209259305582, 10872.130229581615, 11063.170262230284, 12960.379952505937, 1922.846172306212, 1942.8445724342018, 1947.20164732459, 1965.2532037825679, 2000.5998800239865, 59249.7037514814, 66151.33848661548, 75031.0, 84572.57713711393, 87626.0, 10732.463376831283, 10806.94596527028, 10952.780944381067, 10995.835062474069, 11043.116550675926, 15007.0, 15029.323680434407, 15034.0, 15047.247637618295, 15067.171305578078, 7593.734219302298, 7640.656170472342, 7711.884321735179, 7912.248336408032, 8130.796730081677, 7507.962460187773, 7648.043994500687, 7675.117361503387, 7746.457747957702, 7880.487768295157, 4535.433070866142, 4724.527547245317, 4724.905501890012, 4758.904821903612, 4825.831095911626, 1956.4521933858543, 2008.1465377214624, 2042.652749032668, 2087.2485905074163, 2098.0, 828.647824674523, 881.4711173295971, 883.960221790021, 902.1010772324294, 906.0260220263111, 17207.925798503944, 17520.824791752173, 18150.364737234133, 18222.180001899946, 18592.44222673322, 934.8831396075491, 936.2556767369957, 957.1911734584265, 974.6393834281362, 975.0298453039129, 9727.416355018722, 10821.29661572011, 10823.353666127225, 11965.700857478632, 12083.758324833454, 372677.0, 375662.0, 376540.0, 488614.0, 491687.0, 88774.55612722025, 97806.0, 99356.50321748489, 100399.0, 102967.85160741933, 479.1088575250032, 499.17137551664064, 504.4148787406664, 504.68961588622733, 505.46673259711355, 11091.50088246047, 11216.541849559831, 11264.155188360743, 11575.942120289345, 11730.354830484406, 33116.668833312324, 39269.6073039266, 39951.0, 41655.58344416517, 43659.4465281901, 61002.38997609967, 61153.0, 61651.0, 62440.0, 63000.684996574724, 8758.824823503366, 9170.862437063583, 9190.54047297619, 9279.582418791035, 9373.343865929319, 13477.450093239402, 14090.647733806327, 14145.292735363397, 14211.360488777824, 14643.12141271527, 11928.463219154984, 12139.514419423123, 12265.202761820454, 12360.44378002974, 12420.254784712946, 11277.548898044315, 12074.0, 12176.939115304367, 12368.938155309166, 12775.169613975062, 11666.475008624462, 11747.706307342043, 11894.464749086139, 11979.460924258256, 12222.694432639255, 8417.200365965224, 8619.1811777881, 8656.956715216636, 8674.566271686264, 8714.38999270045, 9980.850287245552, 11042.558297668003, 11121.666350009513, 11138.721531961766, 11355.205135640756], "value": 8763.69577125365, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.5844188301633, 1440.2510694438893, 1470.1252754611005, 1551.6663917257788, 1749.9737503937436, 7353.227911069341, 7988.001499812523, 8220.219079187475, 8234.752957411272, 8445.704400345989, 8242.093369729326, 8315.625796839142, 8316.958415207931, 8320.126386729396, 8323.500589964606, 2311.075569772092, 2323.337848713117, 2340.5201933603657, 2341.110378056345, 2341.800946919514, 2327.5810354136247, 2362.9527409451803, 2388.235764555343, 2389.8088152947807, 2390.0439824070336, 2414.782669559739, 2419.0686585664557, 2437.6709144265565, 2456.4350199454047, 2457.8771061446946, 2346.425125844162, 2367.0413482539598, 2381.833271670984, 2389.9044038238535, 2392.0, 2369.8815059246967, 2383.4041489627593, 2398.4123889646976, 2399.2682231919257, 2402.939926501834, 8213.753587392388, 8274.958625206835, 8309.916900830975, 8329.750107496724, 8331.708390206313, 5156.8968620627375, 5330.067238233332, 5342.759575819097, 5401.054815407328, 5407.297051383295, 3334.06646139079, 3424.5890493140732, 3437.8655043835724, 3499.4400895856797, 3501.1072176594807, 1098.4288170151556, 1131.9886801132047, 1132.5243397772956, 1164.2548768787983, 1165.959191428296, 11253.662390128227, 11319.490622921989, 11416.71458213543, 11424.200305978586, 11441.0, 4112.157007813391, 4432.490263619725, 4477.664175186874, 4507.616852567503, 4515.729056256635, 9217.815643687089, 9222.354435189472, 9232.307576931757, 9232.399894006869, 9235.12266334697, 5191.325127733446, 5222.973885130626, 5228.111221092423, 5231.136862417735, 5234.659747116425, 4338.934915976263, 4469.932951005738, 4773.1408346497965, 4870.318155458239, 4872.171730805771, 3816.5038544988975, 3871.3418718817306, 3925.1953349563273, 3966.2464131814863, 3969.7221194516105, 1124.5839039555417, 1144.8339990701302, 1169.8654654714817, 1172.9648110556698, 1180.3685028509706, 893.4103491695449, 1005.6379703306803, 1027.7379268286538, 1028.1158203944601, 1034.0693375961544, 5626.043572592669, 5719.28508936383, 5734.885302293931, 5758.712064396764, 5827.125931110282, 937.9437233765996, 962.5043102802063, 987.0721521769514, 992.4888682328607, 1020.7754294055296, 3907.628775266345, 3915.9216815663526, 4084.4077608746566, 4130.0, 4161.83352665896, 10010.199184065257, 10316.948415257875, 10343.844842327371, 10380.013898679614, 10384.32501887375, 10223.846642300372, 10247.38515689061, 10255.07704306601, 10330.845037324447, 10332.328398654063, 7487.7004919803685, 7802.063752349641, 7854.136045035041, 8024.959875200587, 8027.0, 5588.385277619377, 5725.885482290414, 5754.136879468113, 5763.971180144073, 5782.421757824184, 9058.048904864894, 9059.909400905906, 9077.818443631222, 9150.954245228731, 9265.53672316368, 9307.0, 9310.208632266062, 9344.0, 9436.245100392089, 9439.244860411289, 6822.590644561342, 7040.401565866959, 7044.366007059184, 7474.289942455458, 7666.233376662289, 7204.855902882018, 7419.1467981180695, 7877.487963282369, 7975.92024079775, 8203.384746143944, 7142.071530700976, 7327.230640782641, 7369.594672293076, 7371.963140184264, 7708.653110610148, 7183.856322873408, 7356.668949897375, 7493.962530187532, 7514.887276690744, 7561.0, 6497.837554061186, 6608.372204640744, 6617.536772426077, 6720.193576770819, 6722.899156512558, 4806.351142595845, 5044.873878152929, 5138.07514647367, 5158.664686795496, 5270.4202537721585, 4981.551660350586, 5013.323201367769, 5093.134167191661, 5187.429382767817, 5281.471852814841], "value": 4501.194071047752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.5598106433234, 344.2581237433331, 349.2072994302934, 351.57986206483247, 354.43290734824274, 5404.675719456835, 5419.376771671259, 5422.457754224585, 5476.698781567012, 5517.2551705519745, 5068.84793456196, 5143.27994080829, 5231.686098834063, 5260.526552610264, 5361.5978801589845, 4231.4710661167355, 4245.490541135068, 4249.383839343293, 4254.8510802121855, 4266.168097221043, 4225.8520951766695, 4233.386159006942, 4244.045089854773, 4264.763218666583, 4268.338407546819, 3930.4693866327966, 3969.900752481197, 4180.205760905434, 4185.539590645027, 4200.390943313218, 4179.644730197937, 4196.265653510654, 4198.979005104955, 4204.369344598304, 4206.810693518783, 3753.399456087013, 3770.1517158639363, 3770.322206618056, 3773.3585290500682, 3777.3578491656485, 5046.2178362353525, 5168.612354073422, 5225.529702326809, 5237.764300606482, 5241.606879484054, 4802.375691160127, 4823.686460380064, 4831.492693267227, 4847.466778654345, 4848.418189817209, 5515.889682206373, 5539.19681646159, 5571.8607034824045, 5574.770091963207, 5609.177017469298, 3975.980120099381, 4141.109661422778, 4191.811368488426, 4197.349410841324, 4206.284931561611, 5740.942590574125, 5746.109353050284, 5775.913361299584, 5778.966042827507, 5792.478676919055, 4280.978595107004, 4285.935710964338, 4290.4636920384955, 4298.376735373354, 4299.333603291495, 4188.643965262926, 4291.184674911757, 4315.834724624334, 4349.6294519486955, 4352.260115780325, 4810.6632535722865, 4821.879453013703, 4836.975815120973, 4844.0, 4857.4171099467585, 5577.944220557823, 5579.246801681721, 5588.133839254922, 5592.2730045094695, 5608.915866262009, 1392.6518370407398, 1426.2298358886292, 1442.8268607766925, 1446.3130013243624, 1452.1504919621927, 957.9760505987267, 981.4896253947907, 1008.0272537001829, 1016.8474728790741, 1031.3141760729181, 5203.583713303003, 5229.555487783581, 5231.189165679326, 5239.7296203594715, 5254.502466796945, 5434.820629931455, 5446.836594902159, 5448.0, 5475.494239084204, 5512.586556008316, 5095.547612894423, 5129.384473863161, 5236.633435659467, 5270.0, 5276.815311464157, 2941.9705802942126, 2944.528875379929, 2944.7349738523635, 2954.5863579098946, 2961.837098959578, 5564.618723340535, 5699.259096317535, 5716.227969329438, 5744.195812586241, 5780.508656764222, 5566.638168519034, 5599.356074051455, 5601.271834661549, 5602.831915042555, 5626.437356264422, 5660.915086273709, 5665.98857405615, 5669.348024977098, 5675.0, 5685.289338832646, 5444.210589464585, 5488.9725551371985, 5507.256520369699, 5807.186993820784, 5835.2122463466885, 5759.625624334405, 5765.596408251382, 5779.508741756998, 5779.682117483579, 5785.942140578541, 5816.062888241411, 6047.879042419215, 6052.909206361996, 6064.818055458343, 6065.636061836304, 4163.8334466621, 4205.243056249905, 4205.453291072141, 4211.326187809936, 4213.599708027732, 5748.597598168088, 5768.0, 5801.113254119666, 5813.680247586423, 5831.854203644943, 5466.726663666721, 5632.7183640816975, 5674.687892165971, 5676.7511147547475, 5685.403032681509, 5621.437856214346, 5630.5214056805635, 5639.520640745583, 5641.887162256649, 5647.131714775392, 5335.73321333924, 5454.181872718965, 5596.272484576979, 5602.579806514609, 5606.271184745957, 5563.13771365439, 5613.522850557585, 5630.254621067482, 5655.943440565707, 5655.943440565707, 5526.806561770319, 5545.390007099135, 5558.861028474321, 5565.805196818092, 5573.0], "value": 4285.809384703812, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.902055181447, 645.941865232129, 702.192478649553, 712.2877122877123, 713.639611995942, 14680.265986700662, 15899.046057236574, 15988.76016859748, 15998.600034999115, 16002.199890005497, 14390.208538530376, 14513.927430362859, 14514.419423223086, 14525.201113938729, 14547.854521454783, 700.5481464455423, 723.3453724379445, 825.5830805443243, 829.4235506323108, 846.8729690546437, 844.8648216285395, 846.6951897316961, 847.1655419411875, 847.478800537668, 847.7541512961234, 898.8471959766855, 899.5457294066488, 899.7300809757079, 899.8875140607424, 899.9820003599924, 728.7012324946746, 750.7334896111856, 846.2003406780594, 890.1454603580538, 890.3322508118911, 653.627432363553, 657.5627207906737, 657.6711644177911, 657.917760279965, 658.2068607328158, 14178.574642760734, 14212.147271163763, 14223.0, 14230.786538201935, 14241.0, 13728.725425491533, 13941.721165576733, 14024.579262622035, 14134.575962721136, 14198.716025679532, 12598.81101783474, 12690.175138615961, 12707.872921270762, 12848.0, 12900.483980640764, 4441.467023957113, 4497.550244975509, 4550.317452382136, 4564.5435456454425, 4568.611668008223, 56064.43935560633, 56397.0, 59250.70374648142, 60176.69911650414, 60688.0, 11426.771464570827, 11516.94241528787, 11557.190996630323, 11691.356975366436, 11791.410429478492, 19099.61800764005, 19262.4221273362, 19290.61418771645, 19351.0, 19633.60732785365, 7386.815329616803, 7993.360531157494, 8200.302974247137, 8253.257206851413, 8391.076981532027, 4702.224133018082, 4704.9059018819435, 4802.231642937113, 4825.758712064383, 4853.0, 3490.5811302643847, 3556.8440256916606, 3604.675579197885, 3610.6930910872343, 3611.0972256935765, 637.1430426076919, 648.6594537867563, 657.3032585459429, 658.5127006015609, 672.9024291477806, 553.9778408863681, 598.2212622369071, 607.5230943709167, 635.4408120853619, 657.8914479110894, 8678.0, 8723.60743766532, 8922.910770892207, 8963.549098456366, 9019.77450563728, 575.3211210771331, 597.6892016151663, 623.9500839932795, 636.0237036149581, 641.4836056974087, 3963.841446342172, 4245.80893859777, 4288.7855607220135, 4340.761258130833, 4385.495667998157, 86930.56534717286, 90486.0, 90806.54596727106, 91117.0, 93988.0, 46866.29700554494, 53874.461255386945, 64160.67919660372, 64609.67695161588, 74075.0, 64104.0, 64285.67857160778, 64460.35539644637, 65319.346806532274, 67136.0, 9365.0, 9716.174125199155, 9820.361676491006, 9852.704418867446, 9875.20998320147, 43357.78321108374, 43572.56427435812, 43871.0, 43997.34003989879, 44152.77923610361, 54286.18570721363, 61458.69270653618, 61659.0, 61911.38088619236, 63399.36600633935, 11752.529898803952, 12360.44378002974, 12438.626841194779, 12591.685207869876, 13458.461661533429, 12954.417051232906, 13258.867411325764, 13373.0, 14328.641783955485, 14664.266786660837, 12688.0, 12696.301703406401, 12818.423170957516, 12894.419751111034, 13052.0, 12375.504979800708, 12569.0, 12583.370831458573, 12674.809877852023, 12751.936240318739, 12318.75362492763, 12641.367931603567, 12675.985921126472, 12776.233425994471, 12808.551700690432, 10678.14574834027, 10798.474550146317, 11329.943350283196, 11334.376609286568, 11548.884511154782, 10887.782244355227, 10960.671179864617, 11294.548218071184, 11329.943350283196, 11382.0], "value": 7075.557125290251, "unit": "score"}], "name": "dromaeo_css", "value": 7186.679433547963, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 111.0, 111.0, 115.0, 112.0, 111.0, 113.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 121.0, 164.0, 128.0, 122.0, 119.0, 123.0, 144.0, 126.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 161.0, 162.0, 160.0, 160.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 114.0, 76.0, 74.0, 75.0, 76.0, 101.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 115.0, 82.0, 81.0, 82.0, 98.0, 82.0, 82.0, 116.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 51.0, 52.0, 61.0, 53.0, 50.0, 50.0, 51.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 59.0, 60.0, 60.0, 59.0, 58.0, 58.0, 59.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 75.0, 74.0, 74.0, 74.0, 75.0, 82.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 140.0, 120.0, 130.0, 121.0, 117.0, 119.0, 163.0, 121.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 153.0, 155.0, 154.0, 157.0, 156.0, 154.0, 152.0, 154.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 61.0, 65.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1454.2999999999997, "alertThreshold": 2.0}]} 22:15:33 INFO - Return code: 0 22:15:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:15:33 INFO - # TBPL SUCCESS # 22:15:33 INFO - Running post-action listener: _resource_record_post_action 22:15:33 INFO - [mozharness: 2017-01-10 06:15:33.230916Z] Finished run-tests step (success) 22:15:33 INFO - Running post-run listener: _resource_record_post_run 22:15:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366039040; Read time: 16; Write time: 258992 22:15:33 INFO - TinderboxPrint: CPU usage
13.0% 22:15:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 22:15:33 INFO - TinderboxPrint: I/O write bytes / time
366,039,040 / 258,992 22:15:33 INFO - TinderboxPrint: CPU idle
8,277.4 (87.0%) 22:15:33 INFO - TinderboxPrint: CPU user
1,190.2 (12.5%) 22:15:33 INFO - TinderboxPrint: Swap in / out
0 / 0 22:15:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108306432; Read time: 0; Write time: 82944 22:15:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 246476800; Read time: 0; Write time: 172592 22:15:33 INFO - Running post-run listener: _upload_blobber_files 22:15:33 INFO - Blob upload gear active. 22:15:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:15: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 22:15: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'] 22:15: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 22:15:34 INFO - (blobuploader) - INFO - Open directory for files ... 22:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:15:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:15:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:37 INFO - (blobuploader) - INFO - Done attempting. 22:15:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:15:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:15:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:38 INFO - (blobuploader) - INFO - Done attempting. 22:15:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:15:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:15:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:15:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:15:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:15:39 INFO - (blobuploader) - INFO - Done attempting. 22:15:39 INFO - (blobuploader) - INFO - Iteration through files over. 22:15:39 INFO - Return code: 0 22:15:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:15:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:15:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10fb4f6bcc5c3b85d3f65b0cfe115b52756f6ec285d92e2b5d943819051d2fb36f7219be83b9eafe112e3c19ec19bd91627ddcb2c6a955681b1d8ff6d269e391", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b05b83c7f1a9f3827b63e76771811646b368a17be2d12df09d926cef1a66bd728e5d335b9af90c724052dc2ac6405cac726e9cabfd1cf5db513b47d22f78d8e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf97712acaefc318409152bc0a15391555719d3eb75d75cfc81691c2ad6003b6ef5b64ab85c231611a452a78c422ac49bb882bbf3c2038fd3853ee6aea4dfc21"} 22:15:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:15:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:15:39 INFO - Contents: 22:15:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10fb4f6bcc5c3b85d3f65b0cfe115b52756f6ec285d92e2b5d943819051d2fb36f7219be83b9eafe112e3c19ec19bd91627ddcb2c6a955681b1d8ff6d269e391", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b05b83c7f1a9f3827b63e76771811646b368a17be2d12df09d926cef1a66bd728e5d335b9af90c724052dc2ac6405cac726e9cabfd1cf5db513b47d22f78d8e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf97712acaefc318409152bc0a15391555719d3eb75d75cfc81691c2ad6003b6ef5b64ab85c231611a452a78c422ac49bb882bbf3c2038fd3853ee6aea4dfc21"} 22:15:39 INFO - Running post-run listener: copy_logs_to_upload_dir 22:15:39 INFO - Copying logs to upload dir... 22:15:39 INFO - mkdir: /builds/slave/test/build/upload/logs 22:15:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.402148 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-01-09 22:15:38.840459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 22:15:38.843584) ========= 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=af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900 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/10fb4f6bcc5c3b85d3f65b0cfe115b52756f6ec285d92e2b5d943819051d2fb36f7219be83b9eafe112e3c19ec19bd91627ddcb2c6a955681b1d8ff6d269e391", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b05b83c7f1a9f3827b63e76771811646b368a17be2d12df09d926cef1a66bd728e5d335b9af90c724052dc2ac6405cac726e9cabfd1cf5db513b47d22f78d8e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf97712acaefc318409152bc0a15391555719d3eb75d75cfc81691c2ad6003b6ef5b64ab85c231611a452a78c422ac49bb882bbf3c2038fd3853ee6aea4dfc21"} build_url:https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011830 build_url: 'https://queue.taskcluster.net/v1/task/N-T151xgSkSm9C34Vo9tCQ/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/10fb4f6bcc5c3b85d3f65b0cfe115b52756f6ec285d92e2b5d943819051d2fb36f7219be83b9eafe112e3c19ec19bd91627ddcb2c6a955681b1d8ff6d269e391", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b05b83c7f1a9f3827b63e76771811646b368a17be2d12df09d926cef1a66bd728e5d335b9af90c724052dc2ac6405cac726e9cabfd1cf5db513b47d22f78d8e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf97712acaefc318409152bc0a15391555719d3eb75d75cfc81691c2ad6003b6ef5b64ab85c231611a452a78c422ac49bb882bbf3c2038fd3853ee6aea4dfc21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 22:15:38.872061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 22:15:38.872425) ========= 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=af724c981e2a0f424dbabf99000001e7-1484026424.445256-1416358900 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 22:15:38.951880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 22:15:38.955201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 22:15:38.955482) ========= ========= Total master_lag: 0.17 =========