builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1482595380.74 results: success (0) buildid: 20161224062636 builduid: bf03869168b14236a3bae5a42b8ebce0 revision: 1deac793ef1dc655f2095e1f8d15deb32e2f666f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:00.737567) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:00.738029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:00.738311) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:00.754447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:00.754749) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-24 08:03:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-12-24 08:03:01 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:00.882657) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:00.883019) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017170 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:00.932027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:00.932352) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1deac793ef1dc655f2095e1f8d15deb32e2f666f --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 1deac793ef1dc655f2095e1f8d15deb32e2f666f --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=9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-24 08:03:01,324 truncating revision to first 12 chars 2016-12-24 08:03:01,324 Setting DEBUG logging. 2016-12-24 08:03:01,324 attempt 1/10 2016-12-24 08:03:01,324 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1deac793ef1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-24 08:03:01,665 unpacking tar archive at: mozilla-aurora-1deac793ef1d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699719 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:01.644663) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:01.644977) ========= script_repo_revision: 1deac793ef1dc655f2095e1f8d15deb32e2f666f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:01.645377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:01.645659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-24 08:03:01.653359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-24 08:03:01.653664) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:03:02 INFO - MultiFileLogger online at 20161224 08:03:02 in /builds/slave/test 08:03: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 08:03:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:03:02 INFO - {'append_to_log': False, 08:03:02 INFO - 'base_work_dir': '/builds/slave/test', 08:03:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:03:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:03:02 INFO - 'branch': 'Mozilla-Aurora', 08:03:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:02 INFO - 'config_files': ('talos/linux_config.py',), 08:03:02 INFO - 'default_actions': ('clobber', 08:03:02 INFO - 'read-buildbot-config', 08:03:02 INFO - 'download-and-extract', 08:03:02 INFO - 'populate-webroot', 08:03:02 INFO - 'create-virtualenv', 08:03:02 INFO - 'install', 08:03:02 INFO - 'run-tests'), 08:03:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:02 INFO - 'download_minidump_stackwalk': True, 08:03:02 INFO - 'download_symbols': 'ondemand', 08:03:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:02 INFO - 'installer_path': 'installer.exe', 08:03:02 INFO - 'log_level': 'info', 08:03:02 INFO - 'log_name': 'talos', 08:03:02 INFO - 'log_to_console': True, 08:03:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:03:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:03:02 INFO - 'opt_config_files': (), 08:03:02 INFO - 'pip_index': False, 08:03:02 INFO - 'sps_profile': False, 08:03:02 INFO - 'sps_profile_interval': 0, 08:03:02 INFO - 'suite': 'dromaeojs', 08:03:02 INFO - 'system_bits': '32', 08:03:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:02 INFO - 'title': 'talos-linux64-ix-013', 08:03:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:02 INFO - 'use_talos_json': True, 08:03:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:03:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:02 INFO - 'work_dir': 'build'} 08:03:02 INFO - [mozharness: 2016-12-24 16:03:02.149186Z] Running clobber step. 08:03:02 INFO - Running pre-action listener: _resource_record_pre_action 08:03:02 INFO - Running main action method: clobber 08:03:02 INFO - rmtree: /builds/slave/test/build 08:03:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:03:02 INFO - Running post-action listener: _resource_record_post_action 08:03:02 INFO - [mozharness: 2016-12-24 16:03:02.613171Z] Finished clobber step (success) 08:03:02 INFO - [mozharness: 2016-12-24 16:03:02.613269Z] Running read-buildbot-config step. 08:03:02 INFO - Running pre-action listener: _resource_record_pre_action 08:03:02 INFO - Running main action method: read_buildbot_config 08:03:02 INFO - Using buildbot properties: 08:03:02 INFO - { 08:03:02 INFO - "project": "", 08:03:02 INFO - "product": "firefox", 08:03:02 INFO - "script_repo_revision": "production", 08:03:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:03:02 INFO - "repository": "", 08:03:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:03:02 INFO - "buildid": "20161224062636", 08:03:02 INFO - "pgo_build": "True", 08:03:02 INFO - "basedir": "/builds/slave/test", 08:03:02 INFO - "buildnumber": 655, 08:03:02 INFO - "slavename": "talos-linux64-ix-013", 08:03:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:03:02 INFO - "platform": "ubuntu64_hw", 08:03:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:03:02 INFO - "branch": "mozilla-aurora", 08:03:02 INFO - "repo_path": "releases/mozilla-aurora", 08:03:02 INFO - "revision": "1deac793ef1dc655f2095e1f8d15deb32e2f666f", 08:03:02 INFO - "stage_platform": "linux64-pgo", 08:03:02 INFO - "builduid": "bf03869168b14236a3bae5a42b8ebce0", 08:03:02 INFO - "slavebuilddir": "test" 08:03:02 INFO - } 08:03:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:03:02 INFO - Running post-action listener: _resource_record_post_action 08:03:02 INFO - [mozharness: 2016-12-24 16:03:02.615675Z] Finished read-buildbot-config step (success) 08:03:02 INFO - [mozharness: 2016-12-24 16:03:02.615762Z] Running download-and-extract step. 08:03:02 INFO - Running pre-action listener: _resource_record_pre_action 08:03:02 INFO - Running main action method: download_and_extract 08:03:02 INFO - mkdir: /builds/slave/test/build/tests 08:03: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')]} 08:03:02 INFO - trying https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:03:02 INFO - Downloading https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/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 08:03:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/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 08:03:03 INFO - Downloaded 1361 bytes. 08:03:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:03:03 INFO - Using the following test package requirements: 08:03:03 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:03:03 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:03:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:03:03 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:03:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:03:03 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:03:03 INFO - u'jsshell-linux-x86_64.zip'], 08:03:03 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:03:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:03:03 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:03:03 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:03:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:03:03 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:03:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:03:03 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:03:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:03:03 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:03:03 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:03:03 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:03:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:03:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:03:03 INFO - Fetch https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:03:03 INFO - Http code: 200 08:03:03 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 08:03:03 INFO - x-amz-cf-id: soPCXIRKSmoUx7iu3pxKxyHOlTm_Za5lkGwNRwvyRIE7sY1I8btqGQ== 08:03:03 INFO - x-amz-version-id: UeADmEsfL2pGQey6szlcHxpXLWKOScjB 08:03:04 INFO - Expected file size: 21943165 08:03:04 INFO - Obtained file size: 21943165 08:03: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 08:03:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:03:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:03:08 INFO - Fetch https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:03:08 INFO - Http code: 200 08:03:08 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 08:03:08 INFO - x-amz-cf-id: ONzQrR0UuJNO1dgf3QzYCV2LiuVJ07raZtXkGVoqwLDdVjIigkdd0Q== 08:03:08 INFO - x-amz-version-id: UeADmEsfL2pGQey6szlcHxpXLWKOScjB 08:03:08 INFO - Expected file size: 21943165 08:03:08 INFO - Obtained file size: 21943165 08:03:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:03:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:03:13 INFO - Fetch https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:03:13 INFO - Http code: 200 08:03:13 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 08:03:13 INFO - x-amz-cf-id: vCqCPm5DyAfNH8HGmJ9MBFMYXnfIOmhqFtIbvDJIAI6TzpDUoAa4ig== 08:03:13 INFO - x-amz-version-id: Nri0Pqa59nTAmxsXfM1p0jFoQocghd3x 08:03:14 INFO - Expected file size: 14409038 08:03:14 INFO - Obtained file size: 14409038 08:03: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')]} 08:03:14 INFO - trying https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:03:14 INFO - Downloading https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/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 08:03:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/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 08:03:15 INFO - Downloaded 63973504 bytes. 08:03:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:03:15 INFO - mkdir: /builds/slave/test/properties 08:03:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:03:15 INFO - Writing to file /builds/slave/test/properties/build_url 08:03:15 INFO - Contents: 08:03:15 INFO - build_url:https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:03:16 INFO - Running post-action listener: _resource_record_post_action 08:03:16 INFO - Running post-action listener: set_extra_try_arguments 08:03:16 INFO - [mozharness: 2016-12-24 16:03:16.148650Z] Finished download-and-extract step (success) 08:03:16 INFO - [mozharness: 2016-12-24 16:03:16.148949Z] Running populate-webroot step. 08:03:16 INFO - Running pre-action listener: _resource_record_pre_action 08:03:16 INFO - Running main action method: populate_webroot 08:03:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:03:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:03:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:03:16 INFO - '--tppagecycles', 08:03:16 INFO - '7'], 08:03:16 INFO - 'tests': ['tsvgm']}}, 08:03:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:03:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:03:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:03:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:03:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:16 INFO - 'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:16 INFO - 'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['damp', 'tps']}, 08:03:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:16 INFO - 'tests': ['damp', 'tps']}, 08:03:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['dromaeo_dom']}, 08:03:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:03:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['basic_compositor_video']}, 08:03:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:03:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['a11yr', 08:03:16 INFO - 'ts_paint', 08:03:16 INFO - 'tpaint', 08:03:16 INFO - 'sessionrestore', 08:03:16 INFO - 'sessionrestore_no_auto_restore', 08:03:16 INFO - 'tabpaint']}, 08:03:16 INFO - 'other-e10s': {'tests': ['a11yr', 08:03:16 INFO - 'ts_paint', 08:03:16 INFO - 'tpaint', 08:03:16 INFO - 'sessionrestore', 08:03:16 INFO - 'sessionrestore_no_auto_restore', 08:03:16 INFO - 'tabpaint']}, 08:03:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:03:16 INFO - 'ts_paint', 08:03:16 INFO - 'tpaint', 08:03:16 INFO - 'sessionrestore', 08:03:16 INFO - 'sessionrestore_no_auto_restore', 08:03:16 INFO - 'tabpaint']}, 08:03:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:03:16 INFO - 'ts_paint', 08:03:16 INFO - 'tpaint', 08:03:16 INFO - 'sessionrestore', 08:03:16 INFO - 'sessionrestore_no_auto_restore', 08:03:16 INFO - 'tabpaint']}, 08:03:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['a11yr', 08:03:16 INFO - 'ts_paint', 08:03:16 INFO - 'tpaint', 08:03:16 INFO - 'sessionrestore', 08:03:16 INFO - 'sessionrestore_no_auto_restore', 08:03:16 INFO - 'tabpaint']}, 08:03:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['a11yr', 08:03:16 INFO - 'ts_paint', 08:03:16 INFO - 'tpaint', 08:03:16 INFO - 'sessionrestore', 08:03:16 INFO - 'sessionrestore_no_auto_restore', 08:03:16 INFO - 'tabpaint']}, 08:03:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['tsvgx', 08:03:16 INFO - 'tsvgr_opacity', 08:03:16 INFO - 'tart', 08:03:16 INFO - 'tscrollx', 08:03:16 INFO - 'cart']}, 08:03:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:03:16 INFO - 'tsvgr_opacity', 08:03:16 INFO - 'tart', 08:03:16 INFO - 'tscrollx', 08:03:16 INFO - 'cart']}, 08:03:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:16 INFO - 'talos_options': ['--disable-e10s'], 08:03:16 INFO - 'tests': ['tp5o']}, 08:03:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:16 INFO - 'tests': ['tp5o']}, 08:03:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:16 INFO - 'talos_options': ['--disable-e10s', 08:03:16 INFO - '--xperf_path', 08:03:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:16 INFO - 'tests': ['tp5n']}, 08:03:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:16 INFO - 'talos_options': ['--xperf_path', 08:03:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:16 INFO - 'tests': ['tp5n']}}, 08:03:16 INFO - 'talos.zip': {'path': '', 08:03:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:03:16 INFO - Running post-action listener: _resource_record_post_action 08:03:16 INFO - [mozharness: 2016-12-24 16:03:16.167918Z] Finished populate-webroot step (success) 08:03:16 INFO - [mozharness: 2016-12-24 16:03:16.168010Z] Running create-virtualenv step. 08:03:16 INFO - Running pre-action listener: _resource_record_pre_action 08:03:16 INFO - Running main action method: create_virtualenv 08:03:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:03: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 08:03:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:03:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:03:16 INFO - Using real prefix '/usr' 08:03:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:03:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:03:18 INFO - Installing pip.................done. 08:03:18 INFO - Return code: 0 08:03:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:03:18 INFO - Reading from file tmpfile_stdout 08:03:18 INFO - Output received: 08:03:18 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) 08:03:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:03:18 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')]} 08:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:18 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')]} 08:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:18 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 0x7fe80817df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', '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 08:03:18 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 08:03:18 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 08:03:18 INFO - Using env: {'DISPLAY': ':0', 08:03:18 INFO - 'HOME': '/home/cltbld', 08:03:18 INFO - 'LANG': 'en_US.UTF-8', 08:03:18 INFO - 'LANGUAGE': 'en_US:en', 08:03:18 INFO - 'LOGNAME': 'cltbld', 08:03:18 INFO - 'MAIL': '/var/mail/cltbld', 08:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:18 INFO - 'MOZ_NO_REMOTE': '1', 08:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:18 INFO - 'NO_EM_RESTART': '1', 08:03:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:18 INFO - 'PWD': '/builds/slave/test', 08:03:18 INFO - 'SHELL': '/bin/bash', 08:03:18 INFO - 'SHLVL': '1', 08:03:18 INFO - 'TERM': 'linux', 08:03:18 INFO - 'TMOUT': '86400', 08:03:18 INFO - 'USER': 'cltbld', 08:03:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:18 INFO - '_': '/tools/buildbot/bin/python'} 08:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03: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 08:03:19 INFO - Cleaning up... 08:03:19 INFO - Return code: 0 08:03:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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 0x7fe80817df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', '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 08:03: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 08:03: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 08:03:19 INFO - Using env: {'DISPLAY': ':0', 08:03:19 INFO - 'HOME': '/home/cltbld', 08:03:19 INFO - 'LANG': 'en_US.UTF-8', 08:03:19 INFO - 'LANGUAGE': 'en_US:en', 08:03:19 INFO - 'LOGNAME': 'cltbld', 08:03:19 INFO - 'MAIL': '/var/mail/cltbld', 08:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:19 INFO - 'MOZ_NO_REMOTE': '1', 08:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:19 INFO - 'NO_EM_RESTART': '1', 08:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:19 INFO - 'PWD': '/builds/slave/test', 08:03:19 INFO - 'SHELL': '/bin/bash', 08:03:19 INFO - 'SHLVL': '1', 08:03:19 INFO - 'TERM': 'linux', 08:03:19 INFO - 'TMOUT': '86400', 08:03:19 INFO - 'USER': 'cltbld', 08:03:19 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:19 INFO - '_': '/tools/buildbot/bin/python'} 08:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:19 INFO - Downloading/unpacking psutil>=3.1.1 08:03:19 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 08:03:19 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 08:03:19 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 08:03:19 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 08:03:19 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 08:03:19 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 08:03:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:03:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:21 INFO - Installing collected packages: psutil 08:03:21 INFO - Running setup.py install for psutil 08:03:21 INFO - building 'psutil._psutil_linux' extension 08:03:21 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 08:03:21 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 08:03:21 INFO - building 'psutil._psutil_posix' extension 08:03:21 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 08:03:21 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 08:03:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:21 INFO - Successfully installed psutil 08:03:21 INFO - Cleaning up... 08:03:22 INFO - Return code: 0 08:03:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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 0x7fe80817df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', '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 08:03: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 08:03: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 08:03:22 INFO - Using env: {'DISPLAY': ':0', 08:03:22 INFO - 'HOME': '/home/cltbld', 08:03:22 INFO - 'LANG': 'en_US.UTF-8', 08:03:22 INFO - 'LANGUAGE': 'en_US:en', 08:03:22 INFO - 'LOGNAME': 'cltbld', 08:03:22 INFO - 'MAIL': '/var/mail/cltbld', 08:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:22 INFO - 'MOZ_NO_REMOTE': '1', 08:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:22 INFO - 'NO_EM_RESTART': '1', 08:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:22 INFO - 'PWD': '/builds/slave/test', 08:03:22 INFO - 'SHELL': '/bin/bash', 08:03:22 INFO - 'SHLVL': '1', 08:03:22 INFO - 'TERM': 'linux', 08:03:22 INFO - 'TMOUT': '86400', 08:03:22 INFO - 'USER': 'cltbld', 08:03:22 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:22 INFO - '_': '/tools/buildbot/bin/python'} 08:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:03:22 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 08:03:22 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 08:03:22 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 08:03:22 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 08:03:22 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 08:03:22 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 08:03:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:03:24 INFO - Installing collected packages: mozsystemmonitor 08:03:24 INFO - Running setup.py install for mozsystemmonitor 08:03:24 INFO - Successfully installed mozsystemmonitor 08:03:24 INFO - Cleaning up... 08:03:24 INFO - Return code: 0 08:03:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:03:24 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')]} 08:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:24 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')]} 08:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:24 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 0x7fe80817df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', '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 08:03:24 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 08:03:24 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 08:03:24 INFO - Using env: {'DISPLAY': ':0', 08:03:24 INFO - 'HOME': '/home/cltbld', 08:03:24 INFO - 'LANG': 'en_US.UTF-8', 08:03:24 INFO - 'LANGUAGE': 'en_US:en', 08:03:24 INFO - 'LOGNAME': 'cltbld', 08:03:24 INFO - 'MAIL': '/var/mail/cltbld', 08:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:24 INFO - 'MOZ_NO_REMOTE': '1', 08:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:24 INFO - 'NO_EM_RESTART': '1', 08:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:24 INFO - 'PWD': '/builds/slave/test', 08:03:24 INFO - 'SHELL': '/bin/bash', 08:03:24 INFO - 'SHLVL': '1', 08:03:24 INFO - 'TERM': 'linux', 08:03:24 INFO - 'TMOUT': '86400', 08:03:24 INFO - 'USER': 'cltbld', 08:03:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:24 INFO - '_': '/tools/buildbot/bin/python'} 08:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:24 INFO - Downloading/unpacking jsonschema==2.5.1 08:03:24 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 08:03:24 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 08:03:24 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 08:03:24 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 08:03:24 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 08:03:24 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 08:03:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:03:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:03:27 INFO - warning: no files found matching '*.txt' 08:03:27 INFO - no previously-included directories found matching 'build' 08:03:27 INFO - no previously-included directories found matching 'dist' 08:03:27 INFO - no previously-included directories found matching '.git*' 08:03:27 INFO - Installing collected packages: jsonschema, functools32 08:03:27 INFO - Running setup.py install for functools32 08:03:27 INFO - warning: no files found matching '*.txt' 08:03:27 INFO - no previously-included directories found matching 'build' 08:03:27 INFO - no previously-included directories found matching 'dist' 08:03:27 INFO - no previously-included directories found matching '.git*' 08:03:27 INFO - Successfully installed jsonschema functools32 08:03:27 INFO - Cleaning up... 08:03:27 INFO - Return code: 0 08:03:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:03:27 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')]} 08:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:27 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')]} 08:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:27 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 0x7fe80817df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', '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 08:03:27 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 08:03:27 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 08:03:27 INFO - Using env: {'DISPLAY': ':0', 08:03:27 INFO - 'HOME': '/home/cltbld', 08:03:27 INFO - 'LANG': 'en_US.UTF-8', 08:03:27 INFO - 'LANGUAGE': 'en_US:en', 08:03:27 INFO - 'LOGNAME': 'cltbld', 08:03:27 INFO - 'MAIL': '/var/mail/cltbld', 08:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:27 INFO - 'MOZ_NO_REMOTE': '1', 08:03:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:27 INFO - 'NO_EM_RESTART': '1', 08:03:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:27 INFO - 'PWD': '/builds/slave/test', 08:03:27 INFO - 'SHELL': '/bin/bash', 08:03:27 INFO - 'SHLVL': '1', 08:03:27 INFO - 'TERM': 'linux', 08:03:27 INFO - 'TMOUT': '86400', 08:03:27 INFO - 'USER': 'cltbld', 08:03:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:27 INFO - '_': '/tools/buildbot/bin/python'} 08:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:03:27 INFO - Cleaning up... 08:03:27 INFO - Return code: 0 08:03:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:03:27 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')]} 08:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:27 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')]} 08:03:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:27 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 0x7fe80817df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', '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 08:03:27 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 08:03:27 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 08:03:27 INFO - Using env: {'DISPLAY': ':0', 08:03:27 INFO - 'HOME': '/home/cltbld', 08:03:27 INFO - 'LANG': 'en_US.UTF-8', 08:03:27 INFO - 'LANGUAGE': 'en_US:en', 08:03:27 INFO - 'LOGNAME': 'cltbld', 08:03:27 INFO - 'MAIL': '/var/mail/cltbld', 08:03:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:27 INFO - 'MOZ_NO_REMOTE': '1', 08:03:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:27 INFO - 'NO_EM_RESTART': '1', 08:03:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:27 INFO - 'PWD': '/builds/slave/test', 08:03:27 INFO - 'SHELL': '/bin/bash', 08:03:27 INFO - 'SHLVL': '1', 08:03:27 INFO - 'TERM': 'linux', 08:03:27 INFO - 'TMOUT': '86400', 08:03:27 INFO - 'USER': 'cltbld', 08:03:27 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:27 INFO - '_': '/tools/buildbot/bin/python'} 08:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:03:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:03:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03:30 INFO - Downloading docopt-0.6.1.tar.gz 08:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:03:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:03:30 INFO - Running setup.py install for blobuploader 08:03:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:03:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:03:30 INFO - Running setup.py install for requests 08:03:30 INFO - Running setup.py install for docopt 08:03:31 INFO - Successfully installed blobuploader requests docopt 08:03:31 INFO - Cleaning up... 08:03:31 INFO - Return code: 0 08:03:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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 0x7fe80817df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', '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 08:03: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 08:03: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 08:03:31 INFO - Using env: {'DISPLAY': ':0', 08:03:31 INFO - 'HOME': '/home/cltbld', 08:03:31 INFO - 'LANG': 'en_US.UTF-8', 08:03:31 INFO - 'LANGUAGE': 'en_US:en', 08:03:31 INFO - 'LOGNAME': 'cltbld', 08:03:31 INFO - 'MAIL': '/var/mail/cltbld', 08:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:31 INFO - 'MOZ_NO_REMOTE': '1', 08:03:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:31 INFO - 'NO_EM_RESTART': '1', 08:03:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:31 INFO - 'PWD': '/builds/slave/test', 08:03:31 INFO - 'SHELL': '/bin/bash', 08:03:31 INFO - 'SHLVL': '1', 08:03:31 INFO - 'TERM': 'linux', 08:03:31 INFO - 'TMOUT': '86400', 08:03:31 INFO - 'USER': 'cltbld', 08:03:31 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:31 INFO - '_': '/tools/buildbot/bin/python'} 08:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:31 INFO - Running setup.py (path:/tmp/pip-TWE40m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:31 INFO - Running setup.py (path:/tmp/pip-ONwlKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:31 INFO - Running setup.py (path:/tmp/pip-b6Viwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:31 INFO - Running setup.py (path:/tmp/pip-MtWcNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:31 INFO - Running setup.py (path:/tmp/pip-N8l3QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:31 INFO - Running setup.py (path:/tmp/pip-ElUI6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:31 INFO - Running setup.py (path:/tmp/pip-kTEEwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:31 INFO - Running setup.py (path:/tmp/pip-dlUQPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:31 INFO - Running setup.py (path:/tmp/pip-YHN1tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:31 INFO - Running setup.py (path:/tmp/pip-QZUePj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:32 INFO - Running setup.py (path:/tmp/pip-ma6T9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:32 INFO - Running setup.py (path:/tmp/pip-vurVAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:32 INFO - Running setup.py (path:/tmp/pip-KpMOoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:32 INFO - Running setup.py (path:/tmp/pip-gJbdlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:32 INFO - Running setup.py (path:/tmp/pip-Z2a9Dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:32 INFO - Running setup.py (path:/tmp/pip-RU3vbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:32 INFO - Running setup.py (path:/tmp/pip-WkNRC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:03:32 INFO - Running setup.py install for manifestparser 08:03:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:03:32 INFO - Running setup.py install for mozcrash 08:03:32 INFO - Running setup.py install for mozdebug 08:03:32 INFO - Running setup.py install for mozdevice 08:03:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:03:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:03:32 INFO - Running setup.py install for mozfile 08:03:33 INFO - Running setup.py install for mozhttpd 08:03:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for mozinfo 08:03:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for mozInstall 08:03:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for mozleak 08:03:33 INFO - Running setup.py install for mozlog 08:03:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for moznetwork 08:03:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for mozprocess 08:03:33 INFO - Running setup.py install for mozprofile 08:03:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for mozrunner 08:03:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for mozscreenshot 08:03:34 INFO - Running setup.py install for moztest 08:03:34 INFO - Running setup.py install for mozversion 08:03:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:03:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:03:34 INFO - Cleaning up... 08:03:34 INFO - Return code: 0 08:03:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:34 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 0x7fe80817df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', '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 08:03:34 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 08:03:34 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 08:03:34 INFO - Using env: {'DISPLAY': ':0', 08:03:34 INFO - 'HOME': '/home/cltbld', 08:03:34 INFO - 'LANG': 'en_US.UTF-8', 08:03:34 INFO - 'LANGUAGE': 'en_US:en', 08:03:34 INFO - 'LOGNAME': 'cltbld', 08:03:34 INFO - 'MAIL': '/var/mail/cltbld', 08:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:34 INFO - 'MOZ_NO_REMOTE': '1', 08:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:34 INFO - 'NO_EM_RESTART': '1', 08:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:34 INFO - 'PWD': '/builds/slave/test', 08:03:34 INFO - 'SHELL': '/bin/bash', 08:03:34 INFO - 'SHLVL': '1', 08:03:34 INFO - 'TERM': 'linux', 08:03:34 INFO - 'TMOUT': '86400', 08:03:34 INFO - 'USER': 'cltbld', 08:03:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:34 INFO - '_': '/tools/buildbot/bin/python'} 08:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:34 INFO - Running setup.py (path:/tmp/pip-0HmG7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:34 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)) 08:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:34 INFO - Running setup.py (path:/tmp/pip-l4zTZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:34 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)) 08:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:34 INFO - Running setup.py (path:/tmp/pip-5jiIAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:34 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)) 08:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:34 INFO - Running setup.py (path:/tmp/pip-lhi0Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:34 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)) 08:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:34 INFO - Running setup.py (path:/tmp/pip-pCtMdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:34 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)) 08:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:34 INFO - Running setup.py (path:/tmp/pip-Qn31Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:34 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)) 08:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:34 INFO - Running setup.py (path:/tmp/pip-WNjU71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03: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)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:35 INFO - Running setup.py (path:/tmp/pip-PI3kQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03: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)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:35 INFO - Running setup.py (path:/tmp/pip-al7FFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:35 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)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:35 INFO - Running setup.py (path:/tmp/pip-NDx0F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:35 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)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:35 INFO - Running setup.py (path:/tmp/pip-JEDRKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:35 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)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:35 INFO - Running setup.py (path:/tmp/pip-pVLAse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:35 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)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:35 INFO - Running setup.py (path:/tmp/pip-HzT9Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:35 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)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:35 INFO - Running setup.py (path:/tmp/pip-3ies3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:35 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)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:35 INFO - Running setup.py (path:/tmp/pip-PBRoDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:35 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)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:35 INFO - Running setup.py (path:/tmp/pip-B3SlC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:35 INFO - Running setup.py (path:/tmp/pip-4M8EMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:35 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)) 08:03:35 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)) 08:03:35 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)) 08:03:35 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)) 08:03:35 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)) 08:03:35 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)) 08:03:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:03:35 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 08:03:35 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 08:03:35 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 08:03:35 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 08:03:35 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 08:03:35 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 08:03:37 INFO - Downloading blessings-1.6.tar.gz 08:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:03:37 INFO - Installing collected packages: blessings 08:03:37 INFO - Running setup.py install for blessings 08:03:37 INFO - Successfully installed blessings 08:03:37 INFO - Cleaning up... 08:03:38 INFO - Return code: 0 08:03:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:03:38 INFO - Reading from file tmpfile_stdout 08:03:38 INFO - Current package versions: 08:03:38 INFO - argparse == 1.2.1 08:03:38 INFO - blessings == 1.6 08:03:38 INFO - blobuploader == 1.2.4 08:03:38 INFO - docopt == 0.6.1 08:03:38 INFO - functools32 == 3.2.3-2 08:03:38 INFO - jsonschema == 2.5.1 08:03:38 INFO - manifestparser == 1.1 08:03:38 INFO - mozInstall == 1.12 08:03:38 INFO - mozcrash == 1.0 08:03:38 INFO - mozdebug == 0.1 08:03:38 INFO - mozdevice == 0.48 08:03:38 INFO - mozfile == 1.2 08:03:38 INFO - mozhttpd == 0.7 08:03:38 INFO - mozinfo == 0.9 08:03:38 INFO - mozleak == 0.1 08:03:38 INFO - mozlog == 3.4 08:03:38 INFO - moznetwork == 0.27 08:03:38 INFO - mozprocess == 0.23 08:03:38 INFO - mozprofile == 0.28 08:03:38 INFO - mozrunner == 6.13 08:03:38 INFO - mozscreenshot == 0.1 08:03:38 INFO - mozsystemmonitor == 0.3 08:03:38 INFO - moztest == 0.7 08:03:38 INFO - mozversion == 1.4 08:03:38 INFO - psutil == 3.1.1 08:03:38 INFO - requests == 1.2.3 08:03:38 INFO - wsgiref == 0.1.2 08:03:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:38 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 0x7fe80817df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', '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 08:03:38 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 08:03:38 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 08:03:38 INFO - Using env: {'DISPLAY': ':0', 08:03:38 INFO - 'HOME': '/home/cltbld', 08:03:38 INFO - 'LANG': 'en_US.UTF-8', 08:03:38 INFO - 'LANGUAGE': 'en_US:en', 08:03:38 INFO - 'LOGNAME': 'cltbld', 08:03:38 INFO - 'MAIL': '/var/mail/cltbld', 08:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:38 INFO - 'MOZ_NO_REMOTE': '1', 08:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:38 INFO - 'NO_EM_RESTART': '1', 08:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:38 INFO - 'PWD': '/builds/slave/test', 08:03:38 INFO - 'SHELL': '/bin/bash', 08:03:38 INFO - 'SHLVL': '1', 08:03:38 INFO - 'TERM': 'linux', 08:03:38 INFO - 'TMOUT': '86400', 08:03:38 INFO - 'USER': 'cltbld', 08:03:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:38 INFO - '_': '/tools/buildbot/bin/python'} 08:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:38 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)) 08:03:38 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)) 08:03:38 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)) 08:03:38 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)) 08:03:38 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)) 08:03:38 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)) 08:03:38 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)) 08:03:38 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)) 08:03:38 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)) 08:03:38 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)) 08:03:38 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)) 08:03:38 INFO - Cleaning up... 08:03:38 INFO - Return code: 0 08:03:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe80817df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', '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 08:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:03:38 INFO - Using env: {'DISPLAY': ':0', 08:03:38 INFO - 'HOME': '/home/cltbld', 08:03:38 INFO - 'LANG': 'en_US.UTF-8', 08:03:38 INFO - 'LANGUAGE': 'en_US:en', 08:03:38 INFO - 'LOGNAME': 'cltbld', 08:03:38 INFO - 'MAIL': '/var/mail/cltbld', 08:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:38 INFO - 'MOZ_NO_REMOTE': '1', 08:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:38 INFO - 'NO_EM_RESTART': '1', 08:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:38 INFO - 'PWD': '/builds/slave/test', 08:03:38 INFO - 'SHELL': '/bin/bash', 08:03:38 INFO - 'SHLVL': '1', 08:03:38 INFO - 'TERM': 'linux', 08:03:38 INFO - 'TMOUT': '86400', 08:03:38 INFO - 'USER': 'cltbld', 08:03:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:38 INFO - '_': '/tools/buildbot/bin/python'} 08:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:03:38 INFO - Cleaning up... 08:03:38 INFO - Return code: 0 08:03:38 INFO - Running post-action listener: _resource_record_post_action 08:03:38 INFO - Running post-action listener: _start_resource_monitoring 08:03:38 INFO - Starting resource monitoring. 08:03:38 INFO - [mozharness: 2016-12-24 16:03:38.732409Z] Finished create-virtualenv step (success) 08:03:38 INFO - [mozharness: 2016-12-24 16:03:38.732873Z] Running install step. 08:03:38 INFO - Running pre-action listener: _resource_record_pre_action 08:03:38 INFO - Running main action method: install 08:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:03:38 INFO - Reading from file tmpfile_stdout 08:03:38 INFO - Detecting whether we're running mozinstall >=1.0... 08:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:03:39 INFO - Reading from file tmpfile_stdout 08:03:39 INFO - Output received: 08:03:39 INFO - Usage: mozinstall [options] installer 08:03:39 INFO - Options: 08:03:39 INFO - -h, --help show this help message and exit 08:03:39 INFO - -d DEST, --destination=DEST 08:03:39 INFO - Directory to install application into. [default: 08:03:39 INFO - "/builds/slave/test"] 08:03:39 INFO - --app=APP Application being installed. [default: firefox] 08:03:39 INFO - mkdir: /builds/slave/test/build/application 08:03:39 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'] 08:03:39 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 08:03:54 INFO - Reading from file tmpfile_stdout 08:03:54 INFO - Output received: 08:03:54 INFO - /builds/slave/test/build/application/firefox/firefox 08:03:54 INFO - Running post-action listener: _resource_record_post_action 08:03:54 INFO - [mozharness: 2016-12-24 16:03:54.942084Z] Finished install step (success) 08:03:54 INFO - [mozharness: 2016-12-24 16:03:54.942328Z] Running run-tests step. 08:03:54 INFO - Running pre-action listener: _resource_record_pre_action 08:03:54 INFO - Running main action method: run_tests 08:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:03:54 INFO - Python 2.7.3 08:03:54 INFO - Return code: 0 08:03:54 INFO - grabbing minidump binary from tooltool 08:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:54 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 0x2b2af60>, '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 0x2b2bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:03:54 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 08:03:54 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 08:03:54 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 08:03:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:03:55 INFO - Return code: 0 08:03:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:03:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:03:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:03:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:03:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:03:55 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/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:03:55 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/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 08:03:55 INFO - Using env: {'DISPLAY': ':0', 08:03:55 INFO - 'HOME': '/home/cltbld', 08:03:55 INFO - 'LANG': 'en_US.UTF-8', 08:03:55 INFO - 'LANGUAGE': 'en_US:en', 08:03:55 INFO - 'LOGNAME': 'cltbld', 08:03:55 INFO - 'MAIL': '/var/mail/cltbld', 08:03:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:03:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:55 INFO - 'MOZ_NO_REMOTE': '1', 08:03:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:55 INFO - 'NO_EM_RESTART': '1', 08:03:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:55 INFO - 'PWD': '/builds/slave/test', 08:03:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:03:55 INFO - 'SHELL': '/bin/bash', 08:03:55 INFO - 'SHLVL': '1', 08:03:55 INFO - 'TERM': 'linux', 08:03:55 INFO - 'TMOUT': '86400', 08:03:55 INFO - 'USER': 'cltbld', 08:03:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039', 08:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:55 INFO - '_': '/tools/buildbot/bin/python'} 08:03:55 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/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:03:55 INFO - mozversion application_buildid: 20161224062636 08:03:55 INFO - mozversion application_changeset: 1deac793ef1dc655f2095e1f8d15deb32e2f666f 08:03:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:03:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:03:55 INFO - mozversion application_name: Firefox 08:03:55 INFO - mozversion application_remotingname: firefox-dev 08:03:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:03:55 INFO - mozversion application_vendor: Mozilla 08:03:55 INFO - mozversion application_version: 52.0a2 08:03:55 INFO - mozversion platform_buildid: 20161224062636 08:03:55 INFO - mozversion platform_changeset: 1deac793ef1dc655f2095e1f8d15deb32e2f666f 08:03:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:03:55 INFO - mozversion platform_version: 52.0a2 08:03:55 INFO - using testdate: 1482595435 08:03:55 INFO - actual date: 1482595435 08:03:55 INFO - starting webserver on 'localhost:41563' 08:03:55 INFO - SUITE-START | Running 2 tests 08:03:55 INFO - TEST-START | dromaeo_css 08:03:55 INFO - operating with platform_type : linux_ 08:03:55 INFO - Initialising browser for dromaeo_css test... 08:03:55 INFO - TEST-INFO | started process 12881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbxOHuY/profile http://localhost:41563/getInfo.html) 08:03:59 INFO - PROCESS | 12881 | __metrics Screen width/height:1600/1200 08:03:59 INFO - PROCESS | 12881 | colorDepth:24 08:03:59 INFO - PROCESS | 12881 | Browser inner width/height: 1024/697 08:03:59 INFO - PROCESS | 12881 | __metrics 08:03:59 INFO - PROCESS | 12881 | 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" 08:03:59 INFO - PROCESS | 12881 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:00 INFO - PROCESS | 12881 | console.error: PushService: 08:04:00 INFO - PROCESS | 12881 | stateChangeProcessEnqueue: Error transitioning state 08:04:00 INFO - PROCESS | 12881 | UnknownError 08:04:01 INFO - TEST-INFO | 12881: exit 0 08:04:01 INFO - Browser initialized. 08:04:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:01 INFO - TEST-INFO | started process 12972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbxOHuY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:12 INFO - PROCESS | 12972 | RSS: Main: 144936960 08:04:12 INFO - PROCESS | 12972 | 08:05:04 INFO - PROCESS | 12972 | 1482595504583 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:07:14 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41563/tests/dromaeo/cssquery-ext.html) 08:07:16 INFO - PROCESS | 12972 | RSS: Main: 242606080 08:07:16 INFO - PROCESS | 12972 | 08:10:18 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-ext.html (next: http://localhost:41563/tests/dromaeo/cssquery-jquery.html) 08:10:19 INFO - PROCESS | 12972 | RSS: Main: 231723008 08:10:19 INFO - PROCESS | 12972 | 08:13:21 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41563/tests/dromaeo/cssquery-mootools.html) 08:13:21 INFO - PROCESS | 12972 | RSS: Main: 176594944 08:13:21 INFO - PROCESS | 12972 | 08:16:23 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41563/tests/dromaeo/cssquery-prototype.html) 08:16:24 INFO - PROCESS | 12972 | RSS: Main: 215691264 08:16:24 INFO - PROCESS | 12972 | 08:19:26 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41563/tests/dromaeo/cssquery-yui.html) 08:19:27 INFO - PROCESS | 12972 | RSS: Main: 176209920 08:19:27 INFO - PROCESS | 12972 | 08:22:29 INFO - PROCESS | 12972 | Cycle 1(1): loaded http://localhost:41563/tests/dromaeo/cssquery-yui.html (next: http://localhost:41563/tests/dromaeo/cssquery-dojo.html) 08:22:30 INFO - PROCESS | 12972 | RSS: Main: 261001216 08:22:30 INFO - PROCESS | 12972 | 08:22:30 INFO - PROCESS | 12972 | __start_tp_report 08:22:30 INFO - PROCESS | 12972 | _x_x_mozilla_page_load 08:22:30 INFO - PROCESS | 12972 | _x_x_mozilla_page_load_details 08:22:30 INFO - PROCESS | 12972 | |i|pagename|runs| 08:22:30 INFO - PROCESS | 12972 | |0;dojo.html;3203.9038828835132;3257.5602293690354;3268.1176082457737;3282.8522716477755;3296.1430028192663;5498.1752737089455;5534;5551.944480555203;5556.805511807088;5576.553875689945;5559.277293951781;5566.805161819337;5579.525740312079;5587.720613969305;5636.210930469738;5040.1935690289465;5051.797928082872;5068.037072956126;5076.36545431821;5126.948730512703;4960.156773348539;4980.576650984671;5073.213651883964;5112.565431938289;5123.2315152727015;4961.875953101183;5011.9976004799;5025.648204625678;5039.269305950635;5045.117104506715;5099.59203263738;5126.333576635014;5128.53843154116;5134.897302053938;5136.178211486163;4842.297866809328;5038.697678139323;5057;5078.720670363128;5114.2584325273;5425.050616142199;5425.945740542584;5458.317710286215;5487.478689524489;5524.66851988882;5861.120831875211;5865.97345464542;5945.910811337833;5951.196588460546;5956.523478121783;5873.618214816066;5973.283206015262;5992.0712289595185;5997.940020599825;6000.309964354112;5496.367917689437;5580.776768929238;5610.1584762285165;5617.747201375948;5643.125315576092;6175.2898416681755;6175.84560385985;6179.196704428486;6184.103305020747;6186.907196392058;5702.144678298288;5928.762849485972;5930.584859059824;5934.525237980951;5942.227510423617;5826.621269617462;5921;5938.020226662638;5942.61373010753;6036.758529658852;5976.641401515923;5989.760409583568;5990.5507086968655;5990.610610310403;6008.939910600925;5939.524838012949;5987.670678112659;5998.610090344114;6008.489278411296;6009.729562169713;4473.127740090651;4506.662000349921;4511.390962220058;4519.728816271035;4546.499885012646;4118.176364727066;4124.690648201336;4148.585141485827;4161.771102589326;4174.248635245685;5752.511036561939;5765.4811067004175;5766.394528574523;5767.307923049177;5776.3068431787615;5836.795712150054;5889.734961926723;5902.8819423611285;5939.46544810969;6036.63780173191;5726.427357264323;5730.627509211888;5731.971340143273;5752.165935939349;5760.193572899798;5015.398152221684;5018.774155163026;5025.974870125626;5026.170681837456;5048.343715316985;6034.487068599218;6115.909724157069;6189.133521306931;6270.090836828635;6287.088372186007;5929.792457263975;5931.228940237914;5965.2245208124405;6054.455099041107;6058.27300723916;6296.874062518816;6318.715657795318;6329.208848893888;6329.968350158219;6330.683465826598;5743.798967036134;5752.827415177551;5917.408259174048;5927.051671732675;5962.37395073511;5893.499052580407;5935.436133567304;5969.880602388015;6050.818475445743;6065;5841.065429531254;5879.647221166743;5883.382244864228;5887.646741195542;5888.263967004124;5813.593048486735;5872.706364681663;5876.706164691663;5883;5883.676397798162;5680.545556355564;5739.7417116229035;5743.195952566561;5766.971165144148;5798.362180160263;5889.0283103287475;5897.203877476486;5902.321233058254;5924.851878702894;5927.377625349276;5605.32736071674;5634.464725851201;5660.490555849993;5708;5755.107958266475 08:22:30 INFO - PROCESS | 12972 | |1;ext.html;582.9009068458362;605.8545948972246;621.7668374359612;622.7228883147;638.8083574927521;34818.651813481854;45214.321785173204;45966;46009.53990460094;46013.309800353025;48078;48558;48618.51381486184;48656.02687946239;48677.26984095242;8318.958405207966;8435;8813.515256660898;8950.731478055668;8957;10318.845217321747;10602.098821600173;10611.469426528643;10622.840657390145;10634.468276586178;10761.354318740861;10815.67552973412;10826.72933176669;10837.349759014445;10841;10705;10756.73108172294;10772.299800512941;10777.353358798497;10780.892191078106;10703.571857125706;10753.139748820076;10755.139588832875;10758.246922715412;10765.246432749711;38070.809645951595;38365.23269534622;38373.232535349416;38416.80791596024;38445.807770960964;3282.6224984126893;3316.336732653455;3343.5987681478136;3367.1413789483768;3725.1245957200035;28377.71622283792;29819.552706709415;30016.69983300183;30024.849875750482;30063;3936.9212615747524;4009.8797036088963;4023.1350259694304;4048.392741088831;4124.711270211086;363437;364059;364116;365476;369383;39445;40237.1952560953;66336.33663663302;66451;66761;42153.57846421558;42489.36265956013;42493.787531062764;42550;42582.14835703269;16426.260818263207;16686.415975441043;16699;16699.332026718796;16704.665906682043;12633.873661263453;12850.228986260854;13361.599152025456;13479.663008424868;13785;9653.9034609653;9654.179394751385;9669.081437263449;9711.951440242754;9722.513874306256;3583.5341405617623;3612.855485780592;3616.4032934565503;3650.9634903651154;3720.906977325534;1036.8185567525804;1041.807265655856;1051.8790339110947;1114.8662160540625;1122.45560902962;34060.65939340625;34169.65830341714;34357.65642343595;34491;34694.65305346965;1102.8566286382718;1153.0026527054038;1174.2602160638744;1192.2369683402628;1210.6065528703207;16748.832511674726;17835.790559097415;17871.910640446975;17879.642407152045;17888;537260;541713;542587;542784;544273;62225.37774622286;62932;62983.37016629775;63073.36926630675;63117;1294.8899343555715;1309.2079292028186;1347.3263368315843;1373.7939309103915;1386.1682990205795;34678.65321346754;37066.293370662715;37169.44245836369;39623;39866.80066599648;59384.703076484344;66039;66044.33955660382;66135.66932165308;66208;444610;451185;451320;451541;452260;43515.78242108769;43565.346519802864;43621;43845.561544385426;47217.527824721314;49872.75063624659;53759.73120134374;54009.72995134999;54019.72990135181;54460.72769636127;45067;45770;46457.30314045224;46852;47872.76063619799;46522.20184769662;46677.53322466732;47037.529624704686;47467.52532474631;47476.7626161867;46333.073338533715;46848.531514684415;47465.76267118642;47514;48774;38957.80521097376;41904.1619167621;41942.58057419387;42314.400095128476;42589.5741042598;30875;31055.378892421573;31102.68897310998;31499.212519686276;31798.205044874063 08:22:30 INFO - PROCESS | 12972 | |2;jquery.html;405.547814187181;405.70789031897044;407.62091255132725;409.8196793410899;423.9003834098986;14098.436062557512;16918.830811691878;18433.53916152097;18440.99999999998;19397.515062123453;16052.357905683788;16604.58488537787;18194.81805181948;19150.329738459157;19152.712709309373;5671.376148623648;5921.792737254197;5928.644281343111;5928.644281343111;5929.673867937262;5632.464915833009;5784.2480477537865;5808.361080281165;5812.709364531777;5833.3874943130995;5809.244798176232;5809.564282678795;5815.360310365856;5816.302043754734;5820.039693450597;5623.240862483553;5806.419358064202;5812.534997200235;5817;5860.589758716891;5254.028004819121;5254.448282930313;5258.6318957672975;5260.447652996457;5261.158214685632;20844.687329690067;23017.19439819598;23087;23435;23445.88277058621;2431.5744744669787;2606.713261541229;2747.6015977683323;2804.817686850369;3036.1347016100303;14663.63340916475;14915.925420372829;15105.018173818667;15126.243687815675;15344.539663810103;1954.3941378172813;1962.2347284559035;1981.5343394302326;2023.7267968824315;2024.9392518224477;85695.5715221426;85744.57127714384;87005.99999999936;88214;89083.55458222733;10654.62708805188;10715.624578257824;10753.623623173151;11074.446277686244;11166.888331116746;15710.68578628421;15711.292991815395;15746.76379854303;15755.212239387985;15761.369545218293;7517.548947063194;7876.212378762078;8228.21831925966;8237.46456480327;8792.34057445694;8449.155084491502;8475.194856488624;8488.915110848937;8689.13108689126;8738.300935925237;6656.800295991128;6828.7268509259075;6899.517033807686;6920.688569014406;6957.199922008933;1915.6839121545067;1944.6110777844488;1984.7618285805795;2017.5157962088992;2028.391482555257;474.3146153807715;499.0667451864963;960.8078384323163;1038.4963292802984;1116.7822274656364;12089.818652720216;12095.455704493143;12392;12538;12569.245845249314;485.92468167434106;500.52200148857753;504.39220739009403;504.86621045422993;511.33015749368445;6562.67186640666;6605.801825945229;6627.3372662733345;6663.500237482208;6670.699818508178;462383;463010;466378;478295;498964;61331.693341533006;82934;93688.81711426127;94656.52671736597;104255.4787226059;930.418488444722;952.552300418802;958.2956526952685;972.5672075926145;973.3381300715581;17600.64798703993;17880.374186903395;17886.821131788514;18061.458156255332;18189.425030880102;30431.39137217199;32859.50710739293;42959.71120866379;43220.56779432291;43422.34866477069;60823.69588152031;61852.38147618466;62525.37474625377;62750.37249627445;62946.685266573375;8661.13388661154;8832.116788321116;8958.417702849294;9008.369414140947;9102.908970910472;10335.689929302132;12420.503179872703;13705.588832335046;13848.861511384757;14084.830913044483;11845.5854045108;11893.940530297294;12146.271223726604;12181.147319687538;12450.439730211981;5515.448455154453;9513.571889264862;10404;10894.237403381687;11789.41052947332;11774.293542387484;11847.289162650268;11893.76212475763;11955.880441195477;12016.879831201926;8431.114732952952;8607.48355098671;8637.524936128322;8759.080296568769;8905.465672059698;10039.598416063276;11395.943020285176;11490.310581365145;11572.305661660328;11604.95555400018 08:22:30 INFO - PROCESS | 12972 | |3;mootools.html;1397.7903314502826;1431.8782903453207;1469.933852976616;1495.4765831958823;1501.0768377447873;7974.362051035911;8439.451435656678;8668.133186681329;8685.609147588359;8892;8989.235914947238;9066.09339066093;9069.183773460387;9071.682491112811;9083.636654533811;2440.4630981184155;2467.148833652387;2469.1358024691394;2469.9012039518398;2470.555300045991;2380.5476959377747;2474.492728990562;2484.056058697692;2486.502699460106;2487.8880450379684;2254.0870947266385;2257.8306627002958;2260.9660855087186;2369.3296226160514;2378.512404956988;2367.9408014799596;2387.868667223302;2398.3524448399007;2407.265783935899;2411.360989337818;2454.2023842251338;2469.8641574713383;2487.9004839806385;2493.912713055034;2494.725580186178;8717;8790.296776257885;9002.954985225031;9014.86477702835;9014.909850901473;5439.102548079562;5632.943670563324;5637.23897273871;5641.576881733887;5641.971790141064;3375.763696541243;3396.456566949301;3463.1169051891857;3470.9652903471147;3479.7216222702123;1044.6918159143072;1068.5084860963966;1074.511097450658;1086.8858769829133;1095.594629986902;12466.314352710597;12506.312152831591;12533.060020498408;12625.368731563385;12643.683907902285;4580.312953057068;4765.547273009128;4792.95207047932;4802.807887684454;4838.709677419366;9952.900470995197;9957.203423726085;9964.302498825013;9967.850482242773;9974.950125249326;5381.408045115034;5396.596884809977;5397.8110766123;5398.406175320712;5399.946000540023;4361.454818147731;4536.138133754576;4656.092062047868;5010.248462730547;5064.316317297118;3954.130091379892;3988.12261302513;4096.836126554905;4098.979505102515;4099.7745124017865;1228.2078059651653;1251.0679543739973;1265.7468506298776;1276.2661469654986;1281.6603600045996;884.6992022712309;885.5262434597588;896.1755185229605;909.3997961345481;916.8258030974227;5920.348761636216;6088.2694076710195;6102.450779429784;6122.387761223842;6265.8746825063245;467.2687244462405;500.92301551663485;502.29929248697863;513.3044724398386;518.3546484626588;4104.42538044674;4257.106007738348;4324.654027677778;4328.350747387917;4418.16054949565;11125.332480051224;11131.554737810558;11244.718882028015;11248.493817778219;11271.38007409584;10812.837807432894;10931.125509959184;11149.498272577592;11157;11210.21528493014;8238.876416853753;8398.370122240856;8447.535385553854;8463.026751923484;8465.068842427328;6173.938260617516;6232.345603711545;6273.498120150286;6316.494680425463;6340.619562826245;9538.761530961781;9859.654912078044;10002.599896004078;10072.848907266543;10182.541785619516;9188.816223675356;9494.430334179971;10008.599656013677;10218.693439196835;10295.691129266133;8094.635741391534;8321.417500774887;8497.2777313929;8498.32013438911;8662.956685216786;8601.956990215009;8739.388242823195;8781.429207101519;8799.296056315352;8800.735977920673;7341.4860959732305;7434.182239953709;7467.92532074694;7619.69521219145;7744.186860379579;6879.965600172167;7221.53060051095;7322.780316590511;7434.925650743423;7440.590767507839;7274.6726397313305;7304.890426643498;7353.963230183815;7360.30077142692;7422.146453157956;5322.308099947137;5339.919901201408;5393.894251678318;5426.186072089218;5622.297212848394;5104.591632669451;5232.816851410183;5267.420583735862;5280.260763493037;5364.865878353073 08:22:30 INFO - PROCESS | 12972 | |4;prototype.html;349.9930001399972;352.3393636930754;353.7293970112863;363.37680877295435;366.1541838353404;5087.6693014954;5222.294990176325;5300.522952934235;5327.866803329919;5347.545458636016;5063.303793229273;5166.210246466912;5214.921776173351;5217.34783152106;5223.425423203445;4179.937300940488;4192.832286708528;4192.993681516429;4196.076863090116;4208.600182982612;4051.8654776662584;4156.542780294165;4170.270202714528;4191.476065491814;4192.24539582875;4085.897852553695;4087.5299340575916;4089.5092588889224;4091.6931230157707;4097.569755175708;4092.3426012464997;4092.897677558055;4099.754014759109;4102.3026085565525;4123.237201117803;3654.1911753682098;3674.7243956703355;3678.393065144248;3689.2990331836863;3696.1129328961124;5018.924716129261;5115.44227886057;5119.206522988943;5121.641485096045;5135.486451354872;4672.509386514401;4694.272387779865;4705.858824235244;4707.788149533245;4712.363830882856;5430.5384042356445;5445.782168713246;5461.69960652164;5482.053870875821;5509.944900550983;3824.2542704172697;3957.8416863325433;4008.83964641414;4012.137390461065;4014.959850401517;5690.5447564194765;5703.315602127771;5704.345739735513;5718.285214348207;5722.771089156428;4132.855350062733;4137;4141.64795992344;4143.254214241405;4158.625723684822;3916.941245881314;4149.605787450188;4194.517630472474;4195.265828480004;4202;4717.88619511121;4734.147853386424;4735.857924262277;4747.952520474751;4754.120487709784;5549.694766787866;5554.444555544414;5561.721913904288;5567.331920169606;5584.877746456321;1304.39345704248;1304.7520971015476;1397.3502321420588;1401.824771903512;1404.8059149722653;959.4483172176027;966.6954909203579;969.2149359019216;974.2060220919927;974.770928831724;5119.6160287978555;5128.333316668809;5142.588592912558;5143.434222235551;5157.252198431206;5433.809816656398;5448.346198456132;5463.972680136653;5465.316835395575;5475.616706830484;4933.235348520985;5187.584993200535;5220.895582088337;5245.659032162897;5249.685018898878;2846.9430611387656;2849.6437945256844;2851.8574071296766;2862.4418238443304;2871;5682.857928551819;5688.971555142198;5690.886182276414;5703.347943206429;5710.828675139753;5261.316028916216;5419.044097808622;5526.535468100957;5538.889222215533;5563.499285064283;5647.604667673223;5655.943440565542;5658.236138121301;5661.830145095653;5694.715264236855;5242.816501422432;5357.357117145812;5392.460753924576;5415.945840541702;5444.564434845282;5350;5377.462253774591;5392.487713667196;5429.348478182644;5440.292761940922;5723.508659717486;5725.541956643542;5726.5418766499415;5733.8566535836935;5736.196932429547;3911.1591007932293;3942.2115576885312;4029.71791974559;4045.3931910213705;4052.675785937177;5364.222187782828;5375.543078838343;5401.6488928221115;5414.214938833768;5417.702026388586;5366.624336296578;5397.78408863641;5535.861603459945;5538.833834984957;5547.583931205257;5522.889542209053;5532.197831314517;5542.8337149885565;5544.7227638618715;5558.833235002957;5203.609729270244;5416.539594134542;5473.2063850742215;5487.560995120461;5497.752601132878;5529.640573362719;5537.473939975695;5539.556835453234;5541.972290138524;5580.35825880029;5412.161115027177;5434.429384914685;5450.291462109901;5464.398916119303;5476.931998260301 08:22:30 INFO - PROCESS | 12972 | |5;yui.html;676.28989560961;699.4404476418864;718.3247747117712;719.5287086958041;734.3390948146667;14276.643083922894;14391.856081439182;14538.563843084698;14567.198804065785;14597;13549.322533873315;13808;13818.723625527484;13840.446382144728;13848.376823042961;723.9457040721967;742.6027075514601;827.5241736001793;845.0577605969346;846.9830603387928;859.9398042137053;862.0861886400436;862.6764963138822;862.6764963138822;862.8576284912982;902.0753727429404;902.8645703144515;903.56628818167;903.7198468474761;903.9096090390974;752.4018405367718;773.3928865840317;865.3553102938288;897.7935074932736;902.9503377314245;669.712023829753;669.9229588597276;669.9564528305693;670.031804043153;670.2191946382508;13137.802932956014;13152.342382880914;13171.143875648148;13179.868201318055;13192;12977.545785897448;13136.211827290297;13174.538891138764;13265.3367331634;13382.732345353039;12037.277763334228;12058.336791476466;12241.571544995972;12391.75216495665;12597.496100155982;4219.831206751757;4235.237657221699;4289.764062976535;4299.59153880384;4330.090680957002;64277.35722642761;66582.66708666425;66931.66534167346;67768.3223167772;68292.31707682909;10338.224633152544;10711.83932241017;10843.78312433747;10993;11073;15791.526254212393;16200.837991620168;18870.622587548172;18883.433496995112;18898.716519252222;7650.3004266207445;7864.72473463426;8037.236462536167;8113.8377232456205;8330.125336839666;4557.453105627346;4770.117528257283;4807.687500312469;4815.3017812417;4923.581495572845;3248.2529018325918;3364.6971772540587;3379.0369744622662;3379.729621630264;3381.019504343713;616.9537284703665;623.7847942459844;629.1914889367233;630.196499463188;630.4011189370117;595.6455908734296;613.294711082259;633.556510442692;645.6997496164306;660.8116686744255;8745.212930836255;8829.470231786114;8928.464292142493;8970.506622135714;9288.442693438416;586.3725813379729;598.9251343582052;630.9905351419733;641.3714559731396;642.7043559962469;4109.486314210723;4241.897106752267;4327.37253098299;4341.804618792162;4371.335310983928;90172.5491372552;92237;92418;93353;94630.52684736533;77966;81526.59236703897;81936.18063819404;84499.5775021121;85978;72371.27628723645;73591.63204183945;73778.26221737821;74554;75080;8281;8408.411411201401;8552.401331906707;8563.443376180529;8628.697995570124;50192.24711629256;50982.23526647178;51171.232431514305;51287.487125129766;52541;67764.66117669578;68556;68843.65578172277;69569.30430695628;69974.65012674904;10889.237753357505;11044.834327485254;11511.30932144074;11676.94161529221;11812.114091443347;12717;13034.47862085506;13464.528741494001;13509.797353039909;13737.656558585715;12234.87765122373;12665.556705515632;12688.111832171659;12915.677108072374;13171.026538859407;12179.573714919936;12202;12343;12620.36898155107;12868.356582170667;12110.636680899586;12142.635720928387;12142.75714485723;12328.81506777417;12924.806127907901;10660.572249777848;10751.247412681038;10807.35155890649;10899.891001089887;11182.105431565618;11028.724281892695;11177.441127943734;11200.271982321123;11239.943800280946;11299.887001129884 08:22:30 INFO - PROCESS | 12972 | __end_tp_report 08:22:30 INFO - PROCESS | 12972 | __start_cc_report 08:22:30 INFO - PROCESS | 12972 | _x_x_mozilla_cycle_collect,1051 08:22:30 INFO - PROCESS | 12972 | __end_cc_report 08:22:30 INFO - PROCESS | 12972 | __startTimestamp1482596550145__endTimestamp 08:22:30 INFO - PROCESS | 12972 | 08:22:30 INFO - PROCESS | 12972 | ------- Summary: start ------- 08:22:30 INFO - PROCESS | 12972 | Number of tests: 6 08:22:30 INFO - PROCESS | 12972 | 08:22:30 INFO - PROCESS | 12972 | [#0] dojo.html Cycles:165 Average:5548.84 Median:5765.48 stddev:636.62 (11.0%) stddev-sans-first:611.41 08:22:30 INFO - PROCESS | 12972 | Values: 3203.9 3257.6 3268.1 3282.9 3296.1 5498.2 5534.0 5551.9 5556.8 5576.6 5559.3 5566.8 5579.5 5587.7 5636.2 5040.2 5051.8 5068.0 5076.4 5126.9 4960.2 4980.6 5073.2 5112.6 5123.2 4961.9 5012.0 5025.6 5039.3 5045.1 5099.6 5126.3 5128.5 5134.9 5136.2 4842.3 5038.7 5057.0 5078.7 5114.3 5425.1 5425.9 5458.3 5487.5 5524.7 5861.1 5866.0 5945.9 5951.2 5956.5 5873.6 5973.3 5992.1 5997.9 6000.3 5496.4 5580.8 5610.2 5617.7 5643.1 6175.3 6175.8 6179.2 6184.1 6186.9 5702.1 5928.8 5930.6 5934.5 5942.2 5826.6 5921.0 5938.0 5942.6 6036.8 5976.6 5989.8 5990.6 5990.6 6008.9 5939.5 5987.7 5998.6 6008.5 6009.7 4473.1 4506.7 4511.4 4519.7 4546.5 4118.2 4124.7 4148.6 4161.8 4174.2 5752.5 5765.5 5766.4 5767.3 5776.3 5836.8 5889.7 5902.9 5939.5 6036.6 5726.4 5730.6 5732.0 5752.2 5760.2 5015.4 5018.8 5026.0 5026.2 5048.3 6034.5 6115.9 6189.1 6270.1 6287.1 5929.8 5931.2 5965.2 6054.5 6058.3 6296.9 6318.7 6329.2 6330.0 6330.7 5743.8 5752.8 5917.4 5927.1 5962.4 5893.5 5935.4 5969.9 6050.8 6065.0 5841.1 5879.6 5883.4 5887.6 5888.3 5813.6 5872.7 5876.7 5883.0 5883.7 5680.5 5739.7 5743.2 5767.0 5798.4 5889.0 5897.2 5902.3 5924.9 5927.4 5605.3 5634.5 5660.5 5708.0 5755.1 08:22:30 INFO - PROCESS | 12972 | 08:22:30 INFO - PROCESS | 12972 | [#1] ext.html Cycles:180 Average:62514.74 Median:21690.96 stddev:121320.86 (559.3%) stddev-sans-first:121572.09 08:22:30 INFO - PROCESS | 12972 | Values: 582.9 605.9 621.8 622.7 638.8 34818.7 45214.3 45966.0 46009.5 46013.3 48078.0 48558.0 48618.5 48656.0 48677.3 8319.0 8435.0 8813.5 8950.7 8957.0 10318.8 10602.1 10611.5 10622.8 10634.5 10761.4 10815.7 10826.7 10837.3 10841.0 10705.0 10756.7 10772.3 10777.4 10780.9 10703.6 10753.1 10755.1 10758.2 10765.2 38070.8 38365.2 38373.2 38416.8 38445.8 3282.6 3316.3 3343.6 3367.1 3725.1 28377.7 29819.6 30016.7 30024.8 30063.0 3936.9 4009.9 4023.1 4048.4 4124.7 363437.0 364059.0 364116.0 365476.0 369383.0 39445.0 40237.2 66336.3 66451.0 66761.0 42153.6 42489.4 42493.8 42550.0 42582.1 16426.3 16686.4 16699.0 16699.3 16704.7 12633.9 12850.2 13361.6 13479.7 13785.0 9653.9 9654.2 9669.1 9712.0 9722.5 3583.5 3612.9 3616.4 3651.0 3720.9 1036.8 1041.8 1051.9 1114.9 1122.5 34060.7 34169.7 34357.7 34491.0 34694.7 1102.9 1153.0 1174.3 1192.2 1210.6 16748.8 17835.8 17871.9 17879.6 17888.0 537260.0 541713.0 542587.0 542784.0 544273.0 62225.4 62932.0 62983.4 63073.4 63117.0 1294.9 1309.2 1347.3 1373.8 1386.2 34678.7 37066.3 37169.4 39623.0 39866.8 59384.7 66039.0 66044.3 66135.7 66208.0 444610.0 451185.0 451320.0 451541.0 452260.0 43515.8 43565.3 43621.0 43845.6 47217.5 49872.8 53759.7 54009.7 54019.7 54460.7 45067.0 45770.0 46457.3 46852.0 47872.8 46522.2 46677.5 47037.5 47467.5 47476.8 46333.1 46848.5 47465.8 47514.0 48774.0 38957.8 41904.2 41942.6 42314.4 42589.6 30875.0 31055.4 31102.7 31499.2 31798.2 08:22:30 INFO - PROCESS | 12972 | 08:22:30 INFO - PROCESS | 12972 | [#2] jquery.html Cycles:180 Average:28400.31 Median:252902.67 stddev:78380.56 (31.0%) stddev-sans-first:78572.25 08:22:30 INFO - PROCESS | 12972 | Values: 405.5 405.7 407.6 409.8 423.9 14098.4 16918.8 18433.5 18441.0 19397.5 16052.4 16604.6 18194.8 19150.3 19152.7 5671.4 5921.8 5928.6 5928.6 5929.7 5632.5 5784.2 5808.4 5812.7 5833.4 5809.2 5809.6 5815.4 5816.3 5820.0 5623.2 5806.4 5812.5 5817.0 5860.6 5254.0 5254.4 5258.6 5260.4 5261.2 20844.7 23017.2 23087.0 23435.0 23445.9 2431.6 2606.7 2747.6 2804.8 3036.1 14663.6 14915.9 15105.0 15126.2 15344.5 1954.4 1962.2 1981.5 2023.7 2024.9 85695.6 85744.6 87006.0 88214.0 89083.6 10654.6 10715.6 10753.6 11074.4 11166.9 15710.7 15711.3 15746.8 15755.2 15761.4 7517.5 7876.2 8228.2 8237.5 8792.3 8449.2 8475.2 8488.9 8689.1 8738.3 6656.8 6828.7 6899.5 6920.7 6957.2 1915.7 1944.6 1984.8 2017.5 2028.4 474.3 499.1 960.8 1038.5 1116.8 12089.8 12095.5 12392.0 12538.0 12569.2 485.9 500.5 504.4 504.9 511.3 6562.7 6605.8 6627.3 6663.5 6670.7 462383.0 463010.0 466378.0 478295.0 498964.0 61331.7 82934.0 93688.8 94656.5 104255.5 930.4 952.6 958.3 972.6 973.3 17600.6 17880.4 17886.8 18061.5 18189.4 30431.4 32859.5 42959.7 43220.6 43422.3 60823.7 61852.4 62525.4 62750.4 62946.7 8661.1 8832.1 8958.4 9008.4 9102.9 10335.7 12420.5 13705.6 13848.9 14084.8 11845.6 11893.9 12146.3 12181.1 12450.4 5515.4 9513.6 10404.0 10894.2 11789.4 11774.3 11847.3 11893.8 11955.9 12016.9 8431.1 8607.5 8637.5 8759.1 8905.5 10039.6 11395.9 11490.3 11572.3 11605.0 08:22:30 INFO - PROCESS | 12972 | 08:22:30 INFO - PROCESS | 12972 | [#3] mootools.html Cycles:180 Average:5869.79 Median:515.83 stddev:3326.96 (645.0%) stddev-sans-first:3319.31 08:22:30 INFO - PROCESS | 12972 | Values: 1397.8 1431.9 1469.9 1495.5 1501.1 7974.4 8439.5 8668.1 8685.6 8892.0 8989.2 9066.1 9069.2 9071.7 9083.6 2440.5 2467.1 2469.1 2469.9 2470.6 2380.5 2474.5 2484.1 2486.5 2487.9 2254.1 2257.8 2261.0 2369.3 2378.5 2367.9 2387.9 2398.4 2407.3 2411.4 2454.2 2469.9 2487.9 2493.9 2494.7 8717.0 8790.3 9003.0 9014.9 9014.9 5439.1 5632.9 5637.2 5641.6 5642.0 3375.8 3396.5 3463.1 3471.0 3479.7 1044.7 1068.5 1074.5 1086.9 1095.6 12466.3 12506.3 12533.1 12625.4 12643.7 4580.3 4765.5 4793.0 4802.8 4838.7 9952.9 9957.2 9964.3 9967.9 9975.0 5381.4 5396.6 5397.8 5398.4 5399.9 4361.5 4536.1 4656.1 5010.2 5064.3 3954.1 3988.1 4096.8 4099.0 4099.8 1228.2 1251.1 1265.7 1276.3 1281.7 884.7 885.5 896.2 909.4 916.8 5920.3 6088.3 6102.5 6122.4 6265.9 467.3 500.9 502.3 513.3 518.4 4104.4 4257.1 4324.7 4328.4 4418.2 11125.3 11131.6 11244.7 11248.5 11271.4 10812.8 10931.1 11149.5 11157.0 11210.2 8238.9 8398.4 8447.5 8463.0 8465.1 6173.9 6232.3 6273.5 6316.5 6340.6 9538.8 9859.7 10002.6 10072.8 10182.5 9188.8 9494.4 10008.6 10218.7 10295.7 8094.6 8321.4 8497.3 8498.3 8663.0 8602.0 8739.4 8781.4 8799.3 8800.7 7341.5 7434.2 7467.9 7619.7 7744.2 6880.0 7221.5 7322.8 7434.9 7440.6 7274.7 7304.9 7354.0 7360.3 7422.1 5322.3 5339.9 5393.9 5426.2 5622.3 5104.6 5232.8 5267.4 5280.3 5364.9 08:22:30 INFO - PROCESS | 12972 | 08:22:30 INFO - PROCESS | 12972 | [#4] prototype.html Cycles:180 Average:4600.29 Median:5233.12 stddev:1328.30 (25.4%) stddev-sans-first:1293.15 08:22:30 INFO - PROCESS | 12972 | Values: 350.0 352.3 353.7 363.4 366.2 5087.7 5222.3 5300.5 5327.9 5347.5 5063.3 5166.2 5214.9 5217.3 5223.4 4179.9 4192.8 4193.0 4196.1 4208.6 4051.9 4156.5 4170.3 4191.5 4192.2 4085.9 4087.5 4089.5 4091.7 4097.6 4092.3 4092.9 4099.8 4102.3 4123.2 3654.2 3674.7 3678.4 3689.3 3696.1 5018.9 5115.4 5119.2 5121.6 5135.5 4672.5 4694.3 4705.9 4707.8 4712.4 5430.5 5445.8 5461.7 5482.1 5509.9 3824.3 3957.8 4008.8 4012.1 4015.0 5690.5 5703.3 5704.3 5718.3 5722.8 4132.9 4137.0 4141.6 4143.3 4158.6 3916.9 4149.6 4194.5 4195.3 4202.0 4717.9 4734.1 4735.9 4748.0 4754.1 5549.7 5554.4 5561.7 5567.3 5584.9 1304.4 1304.8 1397.4 1401.8 1404.8 959.4 966.7 969.2 974.2 974.8 5119.6 5128.3 5142.6 5143.4 5157.3 5433.8 5448.3 5464.0 5465.3 5475.6 4933.2 5187.6 5220.9 5245.7 5249.7 2846.9 2849.6 2851.9 2862.4 2871.0 5682.9 5689.0 5690.9 5703.3 5710.8 5261.3 5419.0 5526.5 5538.9 5563.5 5647.6 5655.9 5658.2 5661.8 5694.7 5242.8 5357.4 5392.5 5415.9 5444.6 5350.0 5377.5 5392.5 5429.3 5440.3 5723.5 5725.5 5726.5 5733.9 5736.2 3911.2 3942.2 4029.7 4045.4 4052.7 5364.2 5375.5 5401.6 5414.2 5417.7 5366.6 5397.8 5535.9 5538.8 5547.6 5522.9 5532.2 5542.8 5544.7 5558.8 5203.6 5416.5 5473.2 5487.6 5497.8 5529.6 5537.5 5539.6 5542.0 5580.4 5412.2 5434.4 5450.3 5464.4 5476.9 08:22:30 INFO - PROCESS | 12972 | 08:22:30 INFO - PROCESS | 12972 | [#5] yui.html Cycles:180 Average:18448.98 Median:50587.24 stddev:25374.09 (50.2%) stddev-sans-first:25410.17 08:22:30 INFO - PROCESS | 12972 | Values: 676.3 699.4 718.3 719.5 734.3 14276.6 14391.9 14538.6 14567.2 14597.0 13549.3 13808.0 13818.7 13840.4 13848.4 723.9 742.6 827.5 845.1 847.0 859.9 862.1 862.7 862.7 862.9 902.1 902.9 903.6 903.7 903.9 752.4 773.4 865.4 897.8 903.0 669.7 669.9 670.0 670.0 670.2 13137.8 13152.3 13171.1 13179.9 13192.0 12977.5 13136.2 13174.5 13265.3 13382.7 12037.3 12058.3 12241.6 12391.8 12597.5 4219.8 4235.2 4289.8 4299.6 4330.1 64277.4 66582.7 66931.7 67768.3 68292.3 10338.2 10711.8 10843.8 10993.0 11073.0 15791.5 16200.8 18870.6 18883.4 18898.7 7650.3 7864.7 8037.2 8113.8 8330.1 4557.5 4770.1 4807.7 4815.3 4923.6 3248.3 3364.7 3379.0 3379.7 3381.0 617.0 623.8 629.2 630.2 630.4 595.6 613.3 633.6 645.7 660.8 8745.2 8829.5 8928.5 8970.5 9288.4 586.4 598.9 631.0 641.4 642.7 4109.5 4241.9 4327.4 4341.8 4371.3 90172.5 92237.0 92418.0 93353.0 94630.5 77966.0 81526.6 81936.2 84499.6 85978.0 72371.3 73591.6 73778.3 74554.0 75080.0 8281.0 8408.4 8552.4 8563.4 8628.7 50192.2 50982.2 51171.2 51287.5 52541.0 67764.7 68556.0 68843.7 69569.3 69974.7 10889.2 11044.8 11511.3 11676.9 11812.1 12717.0 13034.5 13464.5 13509.8 13737.7 12234.9 12665.6 12688.1 12915.7 13171.0 12179.6 12202.0 12343.0 12620.4 12868.4 12110.6 12142.6 12142.8 12328.8 12924.8 10660.6 10751.2 10807.4 10899.9 11182.1 11028.7 11177.4 11200.3 11239.9 11299.9 08:22:30 INFO - PROCESS | 12972 | -------- Summary: end -------- 08:22:30 INFO - PROCESS | 12972 | 08:22:30 INFO - TEST-INFO | 12972: exit 0 08:22:30 INFO - TEST-OK | dromaeo_css | took 1115718ms 08:22:30 INFO - TEST-START | kraken 08:22:30 INFO - operating with platform_type : linux_ 08:22:30 INFO - Initialising browser for kraken test... 08:22:30 INFO - TEST-INFO | started process 13293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplrIQe6/profile http://localhost:41563/getInfo.html) 08:22:35 INFO - PROCESS | 13293 | __metrics Screen width/height:1600/1200 08:22:35 INFO - PROCESS | 13293 | colorDepth:24 08:22:35 INFO - PROCESS | 13293 | Browser inner width/height: 1024/697 08:22:35 INFO - PROCESS | 13293 | __metrics 08:22:35 INFO - PROCESS | 13293 | 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" 08:22:35 INFO - PROCESS | 13293 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:22:36 INFO - PROCESS | 13293 | console.error: PushService: 08:22:36 INFO - PROCESS | 13293 | stateChangeProcessEnqueue: Error transitioning state 08:22:36 INFO - PROCESS | 13293 | UnknownError 08:22:36 INFO - TEST-INFO | 13293: exit 0 08:22:36 INFO - Browser initialized. 08:22:36 INFO - Running cycle 1/1 for kraken test... 08:22:36 INFO - TEST-INFO | started process 13390 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplrIQe6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:48 INFO - PROCESS | 13390 | RSS: Main: 144556032 08:22:48 INFO - PROCESS | 13390 | 08:22:51 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41563/tests/kraken/driver.html?testName=audio-beat-detection) 08:22:51 INFO - PROCESS | 13390 | RSS: Main: 185442304 08:22:51 INFO - PROCESS | 13390 | 08:22:54 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41563/tests/kraken/driver.html?testName=audio-dft) 08:22:55 INFO - PROCESS | 13390 | RSS: Main: 174845952 08:22:55 INFO - PROCESS | 13390 | 08:22:57 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41563/tests/kraken/driver.html?testName=audio-fft) 08:22:58 INFO - PROCESS | 13390 | RSS: Main: 266510336 08:22:58 INFO - PROCESS | 13390 | 08:23:00 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41563/tests/kraken/driver.html?testName=audio-oscillator) 08:23:01 INFO - PROCESS | 13390 | RSS: Main: 172318720 08:23:01 INFO - PROCESS | 13390 | 08:23:03 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41563/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:03 INFO - PROCESS | 13390 | RSS: Main: 175874048 08:23:03 INFO - PROCESS | 13390 | 08:23:06 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41563/tests/kraken/driver.html?testName=imaging-darkroom) 08:23:07 INFO - PROCESS | 13390 | RSS: Main: 214331392 08:23:07 INFO - PROCESS | 13390 | 08:23:10 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41563/tests/kraken/driver.html?testName=imaging-desaturate) 08:23:11 INFO - PROCESS | 13390 | RSS: Main: 214761472 08:23:11 INFO - PROCESS | 13390 | 08:23:13 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41563/tests/kraken/driver.html?testName=json-parse-financial) 08:23:14 INFO - PROCESS | 13390 | RSS: Main: 215502848 08:23:14 INFO - PROCESS | 13390 | 08:23:15 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41563/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:23:16 INFO - PROCESS | 13390 | RSS: Main: 173559808 08:23:16 INFO - PROCESS | 13390 | 08:23:18 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:23:18 INFO - PROCESS | 13390 | RSS: Main: 180207616 08:23:18 INFO - PROCESS | 13390 | 08:23:20 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:23:21 INFO - PROCESS | 13390 | RSS: Main: 189145088 08:23:21 INFO - PROCESS | 13390 | 08:23:24 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:23:24 INFO - PROCESS | 13390 | RSS: Main: 197906432 08:23:24 INFO - PROCESS | 13390 | 08:23:27 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:23:27 INFO - PROCESS | 13390 | RSS: Main: 194449408 08:23:27 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | Cycle 1(1): loaded http://localhost:41563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41563/tests/kraken/driver.html?testName=ai-astar) 08:23:29 INFO - PROCESS | 13390 | RSS: Main: 245923840 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | __start_tp_report 08:23:29 INFO - PROCESS | 13390 | _x_x_mozilla_page_load 08:23:29 INFO - PROCESS | 13390 | _x_x_mozilla_page_load_details 08:23:29 INFO - PROCESS | 13390 | |i|pagename|runs| 08:23:29 INFO - PROCESS | 13390 | |0;ai-astar;100;111;111;110;111;109;110;111;112;110 08:23:29 INFO - PROCESS | 13390 | |1;audio-beat-detection;146;118;117;151;121;119;118;118;147;118 08:23:29 INFO - PROCESS | 13390 | |2;audio-dft;159;163;160;161;161;160;160;160;161;160 08:23:29 INFO - PROCESS | 13390 | |3;audio-fft;72;75;76;118;77;76;75;75;108;74 08:23:29 INFO - PROCESS | 13390 | |4;audio-oscillator;82;82;110;82;82;82;99;82;82;116 08:23:29 INFO - PROCESS | 13390 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;116;116;116 08:23:29 INFO - PROCESS | 13390 | |6;imaging-darkroom;147;146;147;147;147;146;147;147;146;147 08:23:29 INFO - PROCESS | 13390 | |7;imaging-desaturate;85;85;84;85;84;85;84;84;84;84 08:23:29 INFO - PROCESS | 13390 | |8;json-parse-financial;51;50;51;50;51;51;50;51;51;51 08:23:29 INFO - PROCESS | 13390 | |9;json-stringify-tinderbox;59;59;58;59;60;60;59;59;59;59 08:23:29 INFO - PROCESS | 13390 | |10;stanford-crypto-aes;83;77;81;75;74;75;75;83;74;75 08:23:29 INFO - PROCESS | 13390 | |11;stanford-crypto-ccm;123;130;122;122;131;123;118;119;172;128 08:23:29 INFO - PROCESS | 13390 | |12;stanford-crypto-pbkdf2;152;154;153;153;153;151;157;157;154;154 08:23:29 INFO - PROCESS | 13390 | |13;stanford-crypto-sha256-iterative;62;63;62;65;61;62;63;68;61;64 08:23:29 INFO - PROCESS | 13390 | __end_tp_report 08:23:29 INFO - PROCESS | 13390 | __start_cc_report 08:23:29 INFO - PROCESS | 13390 | _x_x_mozilla_cycle_collect,1656 08:23:29 INFO - PROCESS | 13390 | __end_cc_report 08:23:29 INFO - PROCESS | 13390 | __startTimestamp1482596609890__endTimestamp 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | ------- Summary: start ------- 08:23:29 INFO - PROCESS | 13390 | Number of tests: 14 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.44 (3.1%) stddev-sans-first:0.88 08:23:29 INFO - PROCESS | 13390 | Values: 100.0 111.0 111.0 110.0 111.0 109.0 110.0 111.0 112.0 110.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:120.00 stddev:14.38 (12.0%) stddev-sans-first:13.56 08:23:29 INFO - PROCESS | 13390 | Values: 146.0 118.0 117.0 151.0 121.0 119.0 118.0 118.0 147.0 118.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.08 (0.7%) stddev-sans-first:1.00 08:23:29 INFO - PROCESS | 13390 | Values: 159.0 163.0 160.0 161.0 161.0 160.0 160.0 160.0 161.0 160.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:16.25 (21.7%) stddev-sans-first:16.78 08:23:29 INFO - PROCESS | 13390 | Values: 72.0 75.0 76.0 118.0 77.0 76.0 75.0 75.0 108.0 74.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:13.35 (16.3%) stddev-sans-first:13.85 08:23:29 INFO - PROCESS | 13390 | Values: 82.0 82.0 110.0 82.0 82.0 82.0 99.0 82.0 82.0 116.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:23:29 INFO - PROCESS | 13390 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 116.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:23:29 INFO - PROCESS | 13390 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 147.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 08:23:29 INFO - PROCESS | 13390 | Values: 85.0 85.0 84.0 85.0 84.0 85.0 84.0 84.0 84.0 84.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 08:23:29 INFO - PROCESS | 13390 | Values: 51.0 50.0 51.0 50.0 51.0 51.0 50.0 51.0 51.0 51.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 08:23:29 INFO - PROCESS | 13390 | Values: 59.0 59.0 58.0 59.0 60.0 60.0 59.0 59.0 59.0 59.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.00 stddev:3.68 (4.8%) stddev-sans-first:3.24 08:23:29 INFO - PROCESS | 13390 | Values: 83.0 77.0 81.0 75.0 74.0 75.0 75.0 83.0 74.0 75.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:125.50 stddev:15.80 (12.6%) stddev-sans-first:16.61 08:23:29 INFO - PROCESS | 13390 | Values: 123.0 130.0 122.0 122.0 131.0 123.0 118.0 119.0 172.0 128.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:154.00 stddev:1.93 (1.3%) stddev-sans-first:1.94 08:23:29 INFO - PROCESS | 13390 | Values: 152.0 154.0 153.0 153.0 153.0 151.0 157.0 157.0 154.0 154.0 08:23:29 INFO - PROCESS | 13390 | 08:23:29 INFO - PROCESS | 13390 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:2.13 (3.4%) stddev-sans-first:2.22 08:23:29 INFO - PROCESS | 13390 | Values: 62.0 63.0 62.0 65.0 61.0 62.0 63.0 68.0 61.0 64.0 08:23:29 INFO - PROCESS | 13390 | -------- Summary: end -------- 08:23:29 INFO - PROCESS | 13390 | 08:23:30 INFO - TEST-INFO | 13390: exit 0 08:23:30 INFO - TEST-OK | kraken | took 60024ms 08:23:30 INFO - SUITE-END | took 1175s 08:23:31 INFO - Completed test suite (00:19:35) 08:23:31 INFO - javascript benchmark 08:23:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3203.9038828835132, 3257.5602293690354, 3268.1176082457737, 3282.8522716477755, 3296.1430028192663, 5498.1752737089455, 5534.0, 5551.944480555203, 5556.805511807088, 5576.553875689945, 5559.277293951781, 5566.805161819337, 5579.525740312079, 5587.720613969305, 5636.210930469738, 5040.1935690289465, 5051.797928082872, 5068.037072956126, 5076.36545431821, 5126.948730512703, 4960.156773348539, 4980.576650984671, 5073.213651883964, 5112.565431938289, 5123.2315152727015, 4961.875953101183, 5011.9976004799, 5025.648204625678, 5039.269305950635, 5045.117104506715, 5099.59203263738, 5126.333576635014, 5128.53843154116, 5134.897302053938, 5136.178211486163, 4842.297866809328, 5038.697678139323, 5057.0, 5078.720670363128, 5114.2584325273, 5425.050616142199, 5425.945740542584, 5458.317710286215, 5487.478689524489, 5524.66851988882, 5861.120831875211, 5865.97345464542, 5945.910811337833, 5951.196588460546, 5956.523478121783, 5873.618214816066, 5973.283206015262, 5992.0712289595185, 5997.940020599825, 6000.309964354112, 5496.367917689437, 5580.776768929238, 5610.1584762285165, 5617.747201375948, 5643.125315576092, 6175.2898416681755, 6175.84560385985, 6179.196704428486, 6184.103305020747, 6186.907196392058, 5702.144678298288, 5928.762849485972, 5930.584859059824, 5934.525237980951, 5942.227510423617, 5826.621269617462, 5921.0, 5938.020226662638, 5942.61373010753, 6036.758529658852, 5976.641401515923, 5989.760409583568, 5990.5507086968655, 5990.610610310403, 6008.939910600925, 5939.524838012949, 5987.670678112659, 5998.610090344114, 6008.489278411296, 6009.729562169713, 4473.127740090651, 4506.662000349921, 4511.390962220058, 4519.728816271035, 4546.499885012646, 4118.176364727066, 4124.690648201336, 4148.585141485827, 4161.771102589326, 4174.248635245685, 5752.511036561939, 5765.4811067004175, 5766.394528574523, 5767.307923049177, 5776.3068431787615, 5836.795712150054, 5889.734961926723, 5902.8819423611285, 5939.46544810969, 6036.63780173191, 5726.427357264323, 5730.627509211888, 5731.971340143273, 5752.165935939349, 5760.193572899798, 5015.398152221684, 5018.774155163026, 5025.974870125626, 5026.170681837456, 5048.343715316985, 6034.487068599218, 6115.909724157069, 6189.133521306931, 6270.090836828635, 6287.088372186007, 5929.792457263975, 5931.228940237914, 5965.2245208124405, 6054.455099041107, 6058.27300723916, 6296.874062518816, 6318.715657795318, 6329.208848893888, 6329.968350158219, 6330.683465826598, 5743.798967036134, 5752.827415177551, 5917.408259174048, 5927.051671732675, 5962.37395073511, 5893.499052580407, 5935.436133567304, 5969.880602388015, 6050.818475445743, 6065.0, 5841.065429531254, 5879.647221166743, 5883.382244864228, 5887.646741195542, 5888.263967004124, 5813.593048486735, 5872.706364681663, 5876.706164691663, 5883.0, 5883.676397798162, 5680.545556355564, 5739.7417116229035, 5743.195952566561, 5766.971165144148, 5798.362180160263, 5889.0283103287475, 5897.203877476486, 5902.321233058254, 5924.851878702894, 5927.377625349276, 5605.32736071674, 5634.464725851201, 5660.490555849993, 5708.0, 5755.107958266475], "value": 5505.893790079047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.9009068458362, 605.8545948972246, 621.7668374359612, 622.7228883147, 638.8083574927521, 34818.651813481854, 45214.321785173204, 45966.0, 46009.53990460094, 46013.309800353025, 48078.0, 48558.0, 48618.51381486184, 48656.02687946239, 48677.26984095242, 8318.958405207966, 8435.0, 8813.515256660898, 8950.731478055668, 8957.0, 10318.845217321747, 10602.098821600173, 10611.469426528643, 10622.840657390145, 10634.468276586178, 10761.354318740861, 10815.67552973412, 10826.72933176669, 10837.349759014445, 10841.0, 10705.0, 10756.73108172294, 10772.299800512941, 10777.353358798497, 10780.892191078106, 10703.571857125706, 10753.139748820076, 10755.139588832875, 10758.246922715412, 10765.246432749711, 38070.809645951595, 38365.23269534622, 38373.232535349416, 38416.80791596024, 38445.807770960964, 3282.6224984126893, 3316.336732653455, 3343.5987681478136, 3367.1413789483768, 3725.1245957200035, 28377.71622283792, 29819.552706709415, 30016.69983300183, 30024.849875750482, 30063.0, 3936.9212615747524, 4009.8797036088963, 4023.1350259694304, 4048.392741088831, 4124.711270211086, 363437.0, 364059.0, 364116.0, 365476.0, 369383.0, 39445.0, 40237.1952560953, 66336.33663663302, 66451.0, 66761.0, 42153.57846421558, 42489.36265956013, 42493.787531062764, 42550.0, 42582.14835703269, 16426.260818263207, 16686.415975441043, 16699.0, 16699.332026718796, 16704.665906682043, 12633.873661263453, 12850.228986260854, 13361.599152025456, 13479.663008424868, 13785.0, 9653.9034609653, 9654.179394751385, 9669.081437263449, 9711.951440242754, 9722.513874306256, 3583.5341405617623, 3612.855485780592, 3616.4032934565503, 3650.9634903651154, 3720.906977325534, 1036.8185567525804, 1041.807265655856, 1051.8790339110947, 1114.8662160540625, 1122.45560902962, 34060.65939340625, 34169.65830341714, 34357.65642343595, 34491.0, 34694.65305346965, 1102.8566286382718, 1153.0026527054038, 1174.2602160638744, 1192.2369683402628, 1210.6065528703207, 16748.832511674726, 17835.790559097415, 17871.910640446975, 17879.642407152045, 17888.0, 537260.0, 541713.0, 542587.0, 542784.0, 544273.0, 62225.37774622286, 62932.0, 62983.37016629775, 63073.36926630675, 63117.0, 1294.8899343555715, 1309.2079292028186, 1347.3263368315843, 1373.7939309103915, 1386.1682990205795, 34678.65321346754, 37066.293370662715, 37169.44245836369, 39623.0, 39866.80066599648, 59384.703076484344, 66039.0, 66044.33955660382, 66135.66932165308, 66208.0, 444610.0, 451185.0, 451320.0, 451541.0, 452260.0, 43515.78242108769, 43565.346519802864, 43621.0, 43845.561544385426, 47217.527824721314, 49872.75063624659, 53759.73120134374, 54009.72995134999, 54019.72990135181, 54460.72769636127, 45067.0, 45770.0, 46457.30314045224, 46852.0, 47872.76063619799, 46522.20184769662, 46677.53322466732, 47037.529624704686, 47467.52532474631, 47476.7626161867, 46333.073338533715, 46848.531514684415, 47465.76267118642, 47514.0, 48774.0, 38957.80521097376, 41904.1619167621, 41942.58057419387, 42314.400095128476, 42589.5741042598, 30875.0, 31055.378892421573, 31102.68897310998, 31499.212519686276, 31798.205044874063], "value": 20572.49120344917, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.547814187181, 405.70789031897044, 407.62091255132725, 409.8196793410899, 423.9003834098986, 14098.436062557512, 16918.830811691878, 18433.53916152097, 18440.99999999998, 19397.515062123453, 16052.357905683788, 16604.58488537787, 18194.81805181948, 19150.329738459157, 19152.712709309373, 5671.376148623648, 5921.792737254197, 5928.644281343111, 5928.644281343111, 5929.673867937262, 5632.464915833009, 5784.2480477537865, 5808.361080281165, 5812.709364531777, 5833.3874943130995, 5809.244798176232, 5809.564282678795, 5815.360310365856, 5816.302043754734, 5820.039693450597, 5623.240862483553, 5806.419358064202, 5812.534997200235, 5817.0, 5860.589758716891, 5254.028004819121, 5254.448282930313, 5258.6318957672975, 5260.447652996457, 5261.158214685632, 20844.687329690067, 23017.19439819598, 23087.0, 23435.0, 23445.88277058621, 2431.5744744669787, 2606.713261541229, 2747.6015977683323, 2804.817686850369, 3036.1347016100303, 14663.63340916475, 14915.925420372829, 15105.018173818667, 15126.243687815675, 15344.539663810103, 1954.3941378172813, 1962.2347284559035, 1981.5343394302326, 2023.7267968824315, 2024.9392518224477, 85695.5715221426, 85744.57127714384, 87005.99999999936, 88214.0, 89083.55458222733, 10654.62708805188, 10715.624578257824, 10753.623623173151, 11074.446277686244, 11166.888331116746, 15710.68578628421, 15711.292991815395, 15746.76379854303, 15755.212239387985, 15761.369545218293, 7517.548947063194, 7876.212378762078, 8228.21831925966, 8237.46456480327, 8792.34057445694, 8449.155084491502, 8475.194856488624, 8488.915110848937, 8689.13108689126, 8738.300935925237, 6656.800295991128, 6828.7268509259075, 6899.517033807686, 6920.688569014406, 6957.199922008933, 1915.6839121545067, 1944.6110777844488, 1984.7618285805795, 2017.5157962088992, 2028.391482555257, 474.3146153807715, 499.0667451864963, 960.8078384323163, 1038.4963292802984, 1116.7822274656364, 12089.818652720216, 12095.455704493143, 12392.0, 12538.0, 12569.245845249314, 485.92468167434106, 500.52200148857753, 504.39220739009403, 504.86621045422993, 511.33015749368445, 6562.67186640666, 6605.801825945229, 6627.3372662733345, 6663.500237482208, 6670.699818508178, 462383.0, 463010.0, 466378.0, 478295.0, 498964.0, 61331.693341533006, 82934.0, 93688.81711426127, 94656.52671736597, 104255.4787226059, 930.418488444722, 952.552300418802, 958.2956526952685, 972.5672075926145, 973.3381300715581, 17600.64798703993, 17880.374186903395, 17886.821131788514, 18061.458156255332, 18189.425030880102, 30431.39137217199, 32859.50710739293, 42959.71120866379, 43220.56779432291, 43422.34866477069, 60823.69588152031, 61852.38147618466, 62525.37474625377, 62750.37249627445, 62946.685266573375, 8661.13388661154, 8832.116788321116, 8958.417702849294, 9008.369414140947, 9102.908970910472, 10335.689929302132, 12420.503179872703, 13705.588832335046, 13848.861511384757, 14084.830913044483, 11845.5854045108, 11893.940530297294, 12146.271223726604, 12181.147319687538, 12450.439730211981, 5515.448455154453, 9513.571889264862, 10404.0, 10894.237403381687, 11789.41052947332, 11774.293542387484, 11847.289162650268, 11893.76212475763, 11955.880441195477, 12016.879831201926, 8431.114732952952, 8607.48355098671, 8637.524936128322, 8759.080296568769, 8905.465672059698, 10039.598416063276, 11395.943020285176, 11490.310581365145, 11572.305661660328, 11604.95555400018], "value": 8941.602294962802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.7903314502826, 1431.8782903453207, 1469.933852976616, 1495.4765831958823, 1501.0768377447873, 7974.362051035911, 8439.451435656678, 8668.133186681329, 8685.609147588359, 8892.0, 8989.235914947238, 9066.09339066093, 9069.183773460387, 9071.682491112811, 9083.636654533811, 2440.4630981184155, 2467.148833652387, 2469.1358024691394, 2469.9012039518398, 2470.555300045991, 2380.5476959377747, 2474.492728990562, 2484.056058697692, 2486.502699460106, 2487.8880450379684, 2254.0870947266385, 2257.8306627002958, 2260.9660855087186, 2369.3296226160514, 2378.512404956988, 2367.9408014799596, 2387.868667223302, 2398.3524448399007, 2407.265783935899, 2411.360989337818, 2454.2023842251338, 2469.8641574713383, 2487.9004839806385, 2493.912713055034, 2494.725580186178, 8717.0, 8790.296776257885, 9002.954985225031, 9014.86477702835, 9014.909850901473, 5439.102548079562, 5632.943670563324, 5637.23897273871, 5641.576881733887, 5641.971790141064, 3375.763696541243, 3396.456566949301, 3463.1169051891857, 3470.9652903471147, 3479.7216222702123, 1044.6918159143072, 1068.5084860963966, 1074.511097450658, 1086.8858769829133, 1095.594629986902, 12466.314352710597, 12506.312152831591, 12533.060020498408, 12625.368731563385, 12643.683907902285, 4580.312953057068, 4765.547273009128, 4792.95207047932, 4802.807887684454, 4838.709677419366, 9952.900470995197, 9957.203423726085, 9964.302498825013, 9967.850482242773, 9974.950125249326, 5381.408045115034, 5396.596884809977, 5397.8110766123, 5398.406175320712, 5399.946000540023, 4361.454818147731, 4536.138133754576, 4656.092062047868, 5010.248462730547, 5064.316317297118, 3954.130091379892, 3988.12261302513, 4096.836126554905, 4098.979505102515, 4099.7745124017865, 1228.2078059651653, 1251.0679543739973, 1265.7468506298776, 1276.2661469654986, 1281.6603600045996, 884.6992022712309, 885.5262434597588, 896.1755185229605, 909.3997961345481, 916.8258030974227, 5920.348761636216, 6088.2694076710195, 6102.450779429784, 6122.387761223842, 6265.8746825063245, 467.2687244462405, 500.92301551663485, 502.29929248697863, 513.3044724398386, 518.3546484626588, 4104.42538044674, 4257.106007738348, 4324.654027677778, 4328.350747387917, 4418.16054949565, 11125.332480051224, 11131.554737810558, 11244.718882028015, 11248.493817778219, 11271.38007409584, 10812.837807432894, 10931.125509959184, 11149.498272577592, 11157.0, 11210.21528493014, 8238.876416853753, 8398.370122240856, 8447.535385553854, 8463.026751923484, 8465.068842427328, 6173.938260617516, 6232.345603711545, 6273.498120150286, 6316.494680425463, 6340.619562826245, 9538.761530961781, 9859.654912078044, 10002.599896004078, 10072.848907266543, 10182.541785619516, 9188.816223675356, 9494.430334179971, 10008.599656013677, 10218.693439196835, 10295.691129266133, 8094.635741391534, 8321.417500774887, 8497.2777313929, 8498.32013438911, 8662.956685216786, 8601.956990215009, 8739.388242823195, 8781.429207101519, 8799.296056315352, 8800.735977920673, 7341.4860959732305, 7434.182239953709, 7467.92532074694, 7619.69521219145, 7744.186860379579, 6879.965600172167, 7221.53060051095, 7322.780316590511, 7434.925650743423, 7440.590767507839, 7274.6726397313305, 7304.890426643498, 7353.963230183815, 7360.30077142692, 7422.146453157956, 5322.308099947137, 5339.919901201408, 5393.894251678318, 5426.186072089218, 5622.297212848394, 5104.591632669451, 5232.816851410183, 5267.420583735862, 5280.260763493037, 5364.865878353073], "value": 4619.514338474482, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.9930001399972, 352.3393636930754, 353.7293970112863, 363.37680877295435, 366.1541838353404, 5087.6693014954, 5222.294990176325, 5300.522952934235, 5327.866803329919, 5347.545458636016, 5063.303793229273, 5166.210246466912, 5214.921776173351, 5217.34783152106, 5223.425423203445, 4179.937300940488, 4192.832286708528, 4192.993681516429, 4196.076863090116, 4208.600182982612, 4051.8654776662584, 4156.542780294165, 4170.270202714528, 4191.476065491814, 4192.24539582875, 4085.897852553695, 4087.5299340575916, 4089.5092588889224, 4091.6931230157707, 4097.569755175708, 4092.3426012464997, 4092.897677558055, 4099.754014759109, 4102.3026085565525, 4123.237201117803, 3654.1911753682098, 3674.7243956703355, 3678.393065144248, 3689.2990331836863, 3696.1129328961124, 5018.924716129261, 5115.44227886057, 5119.206522988943, 5121.641485096045, 5135.486451354872, 4672.509386514401, 4694.272387779865, 4705.858824235244, 4707.788149533245, 4712.363830882856, 5430.5384042356445, 5445.782168713246, 5461.69960652164, 5482.053870875821, 5509.944900550983, 3824.2542704172697, 3957.8416863325433, 4008.83964641414, 4012.137390461065, 4014.959850401517, 5690.5447564194765, 5703.315602127771, 5704.345739735513, 5718.285214348207, 5722.771089156428, 4132.855350062733, 4137.0, 4141.64795992344, 4143.254214241405, 4158.625723684822, 3916.941245881314, 4149.605787450188, 4194.517630472474, 4195.265828480004, 4202.0, 4717.88619511121, 4734.147853386424, 4735.857924262277, 4747.952520474751, 4754.120487709784, 5549.694766787866, 5554.444555544414, 5561.721913904288, 5567.331920169606, 5584.877746456321, 1304.39345704248, 1304.7520971015476, 1397.3502321420588, 1401.824771903512, 1404.8059149722653, 959.4483172176027, 966.6954909203579, 969.2149359019216, 974.2060220919927, 974.770928831724, 5119.6160287978555, 5128.333316668809, 5142.588592912558, 5143.434222235551, 5157.252198431206, 5433.809816656398, 5448.346198456132, 5463.972680136653, 5465.316835395575, 5475.616706830484, 4933.235348520985, 5187.584993200535, 5220.895582088337, 5245.659032162897, 5249.685018898878, 2846.9430611387656, 2849.6437945256844, 2851.8574071296766, 2862.4418238443304, 2871.0, 5682.857928551819, 5688.971555142198, 5690.886182276414, 5703.347943206429, 5710.828675139753, 5261.316028916216, 5419.044097808622, 5526.535468100957, 5538.889222215533, 5563.499285064283, 5647.604667673223, 5655.943440565542, 5658.236138121301, 5661.830145095653, 5694.715264236855, 5242.816501422432, 5357.357117145812, 5392.460753924576, 5415.945840541702, 5444.564434845282, 5350.0, 5377.462253774591, 5392.487713667196, 5429.348478182644, 5440.292761940922, 5723.508659717486, 5725.541956643542, 5726.5418766499415, 5733.8566535836935, 5736.196932429547, 3911.1591007932293, 3942.2115576885312, 4029.71791974559, 4045.3931910213705, 4052.675785937177, 5364.222187782828, 5375.543078838343, 5401.6488928221115, 5414.214938833768, 5417.702026388586, 5366.624336296578, 5397.78408863641, 5535.861603459945, 5538.833834984957, 5547.583931205257, 5522.889542209053, 5532.197831314517, 5542.8337149885565, 5544.7227638618715, 5558.833235002957, 5203.609729270244, 5416.539594134542, 5473.2063850742215, 5487.560995120461, 5497.752601132878, 5529.640573362719, 5537.473939975695, 5539.556835453234, 5541.972290138524, 5580.35825880029, 5412.161115027177, 5434.429384914685, 5450.291462109901, 5464.398916119303, 5476.931998260301], "value": 4184.7115865313, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.28989560961, 699.4404476418864, 718.3247747117712, 719.5287086958041, 734.3390948146667, 14276.643083922894, 14391.856081439182, 14538.563843084698, 14567.198804065785, 14597.0, 13549.322533873315, 13808.0, 13818.723625527484, 13840.446382144728, 13848.376823042961, 723.9457040721967, 742.6027075514601, 827.5241736001793, 845.0577605969346, 846.9830603387928, 859.9398042137053, 862.0861886400436, 862.6764963138822, 862.6764963138822, 862.8576284912982, 902.0753727429404, 902.8645703144515, 903.56628818167, 903.7198468474761, 903.9096090390974, 752.4018405367718, 773.3928865840317, 865.3553102938288, 897.7935074932736, 902.9503377314245, 669.712023829753, 669.9229588597276, 669.9564528305693, 670.031804043153, 670.2191946382508, 13137.802932956014, 13152.342382880914, 13171.143875648148, 13179.868201318055, 13192.0, 12977.545785897448, 13136.211827290297, 13174.538891138764, 13265.3367331634, 13382.732345353039, 12037.277763334228, 12058.336791476466, 12241.571544995972, 12391.75216495665, 12597.496100155982, 4219.831206751757, 4235.237657221699, 4289.764062976535, 4299.59153880384, 4330.090680957002, 64277.35722642761, 66582.66708666425, 66931.66534167346, 67768.3223167772, 68292.31707682909, 10338.224633152544, 10711.83932241017, 10843.78312433747, 10993.0, 11073.0, 15791.526254212393, 16200.837991620168, 18870.622587548172, 18883.433496995112, 18898.716519252222, 7650.3004266207445, 7864.72473463426, 8037.236462536167, 8113.8377232456205, 8330.125336839666, 4557.453105627346, 4770.117528257283, 4807.687500312469, 4815.3017812417, 4923.581495572845, 3248.2529018325918, 3364.6971772540587, 3379.0369744622662, 3379.729621630264, 3381.019504343713, 616.9537284703665, 623.7847942459844, 629.1914889367233, 630.196499463188, 630.4011189370117, 595.6455908734296, 613.294711082259, 633.556510442692, 645.6997496164306, 660.8116686744255, 8745.212930836255, 8829.470231786114, 8928.464292142493, 8970.506622135714, 9288.442693438416, 586.3725813379729, 598.9251343582052, 630.9905351419733, 641.3714559731396, 642.7043559962469, 4109.486314210723, 4241.897106752267, 4327.37253098299, 4341.804618792162, 4371.335310983928, 90172.5491372552, 92237.0, 92418.0, 93353.0, 94630.52684736533, 77966.0, 81526.59236703897, 81936.18063819404, 84499.5775021121, 85978.0, 72371.27628723645, 73591.63204183945, 73778.26221737821, 74554.0, 75080.0, 8281.0, 8408.411411201401, 8552.401331906707, 8563.443376180529, 8628.697995570124, 50192.24711629256, 50982.23526647178, 51171.232431514305, 51287.487125129766, 52541.0, 67764.66117669578, 68556.0, 68843.65578172277, 69569.30430695628, 69974.65012674904, 10889.237753357505, 11044.834327485254, 11511.30932144074, 11676.94161529221, 11812.114091443347, 12717.0, 13034.47862085506, 13464.528741494001, 13509.797353039909, 13737.656558585715, 12234.87765122373, 12665.556705515632, 12688.111832171659, 12915.677108072374, 13171.026538859407, 12179.573714919936, 12202.0, 12343.0, 12620.36898155107, 12868.356582170667, 12110.636680899586, 12142.635720928387, 12142.75714485723, 12328.81506777417, 12924.806127907901, 10660.572249777848, 10751.247412681038, 10807.35155890649, 10899.891001089887, 11182.105431565618, 11028.724281892695, 11177.441127943734, 11200.271982321123, 11239.943800280946, 11299.887001129884], "value": 7090.62035072812, "unit": "score"}], "name": "dromaeo_css", "value": 7195.93011340587, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 111.0, 110.0, 111.0, 109.0, 110.0, 111.0, 112.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 117.0, 151.0, 121.0, 119.0, 118.0, 118.0, 147.0, 118.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 160.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 76.0, 118.0, 77.0, 76.0, 75.0, 75.0, 108.0, 74.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 110.0, 82.0, 82.0, 82.0, 99.0, 82.0, 82.0, 116.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 50.0, 51.0, 51.0, 50.0, 51.0, 51.0, 51.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 81.0, 75.0, 74.0, 75.0, 75.0, 83.0, 74.0, 75.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 130.0, 122.0, 122.0, 131.0, 123.0, 118.0, 119.0, 172.0, 128.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 154.0, 153.0, 153.0, 153.0, 151.0, 157.0, 157.0, 154.0, 154.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 65.0, 61.0, 62.0, 63.0, 68.0, 61.0, 64.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1450.1, "alertThreshold": 2.0}]} 08:23:31 INFO - Return code: 0 08:23:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:23:31 INFO - # TBPL SUCCESS # 08:23:31 INFO - Running post-action listener: _resource_record_post_action 08:23:31 INFO - [mozharness: 2016-12-24 16:23:31.222094Z] Finished run-tests step (success) 08:23:31 INFO - Running post-run listener: _resource_record_post_run 08:23:31 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 366399488; Read time: 28; Write time: 292588 08:23:31 INFO - TinderboxPrint: CPU usage
13.0% 08:23:31 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 08:23:31 INFO - TinderboxPrint: I/O write bytes / time
366,399,488 / 292,588 08:23:31 INFO - TinderboxPrint: CPU idle
8,277.3 (87.0%) 08:23:31 INFO - TinderboxPrint: CPU user
1,192.2 (12.5%) 08:23:31 INFO - TinderboxPrint: Swap in / out
0 / 0 08:23:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118665216; Read time: 0; Write time: 110704 08:23:31 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247234560; Read time: 16; Write time: 181840 08:23:31 INFO - Running post-run listener: _upload_blobber_files 08:23:31 INFO - Blob upload gear active. 08:23:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:23:31 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 08:23:31 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'] 08:23:31 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 08:23:32 INFO - (blobuploader) - INFO - Open directory for files ... 08:23:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:23:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:23:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:33 INFO - (blobuploader) - INFO - Done attempting. 08:23:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:23:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:23:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:36 INFO - (blobuploader) - INFO - Done attempting. 08:23:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:23:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:23:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:37 INFO - (blobuploader) - INFO - Done attempting. 08:23:37 INFO - (blobuploader) - INFO - Iteration through files over. 08:23:37 INFO - Return code: 0 08:23:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:23:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:23:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3273e852076f0546fc7f4809cf530284c7e7675f6e22a4cedb859b225c4203e5ac3b6fc067afc4abcf4be4ceca212ecfea2dfc0ff883f4e14c8ef121c96b7f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8eeee042b93a38b4681bc164984a34d94a3e0830d5736d602b86caeeb5b48370042c602c6ac92495ed17bb3608222b2d22f7e652677df425878e4d0ecb3ed5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a111c8a97d0190afaa9373e6c55d2b30a3e4201fa0b7c6b88ae14139f2ee1d456af12bc27af76c76112067c3412a9b2ea6097506ce9e564d9c6756c6fa75c29"} 08:23:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:23:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:23:37 INFO - Contents: 08:23:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3273e852076f0546fc7f4809cf530284c7e7675f6e22a4cedb859b225c4203e5ac3b6fc067afc4abcf4be4ceca212ecfea2dfc0ff883f4e14c8ef121c96b7f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8eeee042b93a38b4681bc164984a34d94a3e0830d5736d602b86caeeb5b48370042c602c6ac92495ed17bb3608222b2d22f7e652677df425878e4d0ecb3ed5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a111c8a97d0190afaa9373e6c55d2b30a3e4201fa0b7c6b88ae14139f2ee1d456af12bc27af76c76112067c3412a9b2ea6097506ce9e564d9c6756c6fa75c29"} 08:23:37 INFO - Running post-run listener: copy_logs_to_upload_dir 08:23:37 INFO - Copying logs to upload dir... 08:23:37 INFO - mkdir: /builds/slave/test/build/upload/logs 08:23:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.405121 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-24 08:23:37.079771) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-24 08:23:37.083293) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039 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/3273e852076f0546fc7f4809cf530284c7e7675f6e22a4cedb859b225c4203e5ac3b6fc067afc4abcf4be4ceca212ecfea2dfc0ff883f4e14c8ef121c96b7f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8eeee042b93a38b4681bc164984a34d94a3e0830d5736d602b86caeeb5b48370042c602c6ac92495ed17bb3608222b2d22f7e652677df425878e4d0ecb3ed5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a111c8a97d0190afaa9373e6c55d2b30a3e4201fa0b7c6b88ae14139f2ee1d456af12bc27af76c76112067c3412a9b2ea6097506ce9e564d9c6756c6fa75c29"} build_url:https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/G4R4EUIpR6yapOraXcbLFw/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/3273e852076f0546fc7f4809cf530284c7e7675f6e22a4cedb859b225c4203e5ac3b6fc067afc4abcf4be4ceca212ecfea2dfc0ff883f4e14c8ef121c96b7f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d8eeee042b93a38b4681bc164984a34d94a3e0830d5736d602b86caeeb5b48370042c602c6ac92495ed17bb3608222b2d22f7e652677df425878e4d0ecb3ed5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a111c8a97d0190afaa9373e6c55d2b30a3e4201fa0b7c6b88ae14139f2ee1d456af12bc27af76c76112067c3412a9b2ea6097506ce9e564d9c6756c6fa75c29"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-24 08:23:37.109873) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 08:23:37.110378) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1482588966.737572-2027666039 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-24 08:23:37.194704) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-24 08:23:37.195015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-24 08:23:37.195323) ========= ========= Total master_lag: 0.17 =========