builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1483999193.62 results: success (0) buildid: 20170109122608 builduid: 6925b58af8494641bdec7a7be8d2cbc3 revision: 1c8a9f489bb4bf063b1502222a4cda953d80d7f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:53.622515) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:53.622894) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:53.623168) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:53.647092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:53.647353) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 13:59:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2017-01-09 13:59:53 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:53.747981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:53.748270) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017812 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:53.800176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:53.800471) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1c8a9f489bb4bf063b1502222a4cda953d80d7f6 --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 1c8a9f489bb4bf063b1502222a4cda953d80d7f6 --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=d6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 13:59:53,987 truncating revision to first 12 chars 2017-01-09 13:59:53,987 Setting DEBUG logging. 2017-01-09 13:59:53,987 attempt 1/10 2017-01-09 13:59:53,987 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1c8a9f489bb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 13:59:54,531 unpacking tar archive at: mozilla-aurora-1c8a9f489bb4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.839276 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:54.652931) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:54.653243) ========= script_repo_revision: 1c8a9f489bb4bf063b1502222a4cda953d80d7f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:54.653610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:54.653867) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 13:59:54.663241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-01-09 13:59:54.663500) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:59:54 INFO - MultiFileLogger online at 20170109 13:59:54 in /builds/slave/test 13:59:54 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 13:59:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:59:54 INFO - {'append_to_log': False, 13:59:54 INFO - 'base_work_dir': '/builds/slave/test', 13:59:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:59:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:59:54 INFO - 'branch': 'Mozilla-Aurora', 13:59:54 INFO - 'buildbot_json_path': 'buildprops.json', 13:59:54 INFO - 'config_files': ('talos/linux_config.py',), 13:59:54 INFO - 'default_actions': ('clobber', 13:59:54 INFO - 'read-buildbot-config', 13:59:54 INFO - 'download-and-extract', 13:59:54 INFO - 'populate-webroot', 13:59:54 INFO - 'create-virtualenv', 13:59:54 INFO - 'install', 13:59:54 INFO - 'run-tests'), 13:59:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:59:54 INFO - 'download_minidump_stackwalk': True, 13:59:54 INFO - 'download_symbols': 'ondemand', 13:59:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:59:54 INFO - 'tooltool.py': '/tools/tooltool.py', 13:59:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:59:54 INFO - '/tools/misc-python/virtualenv.py')}, 13:59:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:59:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:59:54 INFO - 'installer_path': 'installer.exe', 13:59:54 INFO - 'log_level': 'info', 13:59:54 INFO - 'log_name': 'talos', 13:59:54 INFO - 'log_to_console': True, 13:59:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:59:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:59:54 INFO - 'opt_config_files': (), 13:59:54 INFO - 'pip_index': False, 13:59:54 INFO - 'sps_profile': False, 13:59:54 INFO - 'sps_profile_interval': 0, 13:59:54 INFO - 'suite': 'dromaeojs', 13:59:54 INFO - 'system_bits': '32', 13:59:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:59:54 INFO - 'title': 'talos-linux64-ix-034', 13:59:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:59:54 INFO - 'use_talos_json': True, 13:59:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:59:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:59:54 INFO - 'work_dir': 'build'} 13:59:54 INFO - [mozharness: 2017-01-09 21:59:54.950229Z] Running clobber step. 13:59:54 INFO - Running pre-action listener: _resource_record_pre_action 13:59:54 INFO - Running main action method: clobber 13:59:54 INFO - rmtree: /builds/slave/test/build 13:59:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:59:55 INFO - Running post-action listener: _resource_record_post_action 13:59:55 INFO - [mozharness: 2017-01-09 21:59:55.410134Z] Finished clobber step (success) 13:59:55 INFO - [mozharness: 2017-01-09 21:59:55.410239Z] Running read-buildbot-config step. 13:59:55 INFO - Running pre-action listener: _resource_record_pre_action 13:59:55 INFO - Running main action method: read_buildbot_config 13:59:55 INFO - Using buildbot properties: 13:59:55 INFO - { 13:59:55 INFO - "project": "", 13:59:55 INFO - "product": "firefox", 13:59:55 INFO - "script_repo_revision": "production", 13:59:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:59:55 INFO - "repository": "", 13:59:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:59:55 INFO - "buildid": "20170109122608", 13:59:55 INFO - "pgo_build": "True", 13:59:55 INFO - "basedir": "/builds/slave/test", 13:59:55 INFO - "buildnumber": 688, 13:59:55 INFO - "slavename": "talos-linux64-ix-034", 13:59:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:59:55 INFO - "platform": "ubuntu64_hw", 13:59:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:59:55 INFO - "branch": "mozilla-aurora", 13:59:55 INFO - "repo_path": "releases/mozilla-aurora", 13:59:55 INFO - "revision": "1c8a9f489bb4bf063b1502222a4cda953d80d7f6", 13:59:55 INFO - "stage_platform": "linux64-pgo", 13:59:55 INFO - "builduid": "6925b58af8494641bdec7a7be8d2cbc3", 13:59:55 INFO - "slavebuilddir": "test" 13:59:55 INFO - } 13:59:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 13:59:55 INFO - Running post-action listener: _resource_record_post_action 13:59:55 INFO - [mozharness: 2017-01-09 21:59:55.412653Z] Finished read-buildbot-config step (success) 13:59:55 INFO - [mozharness: 2017-01-09 21:59:55.412740Z] Running download-and-extract step. 13:59:55 INFO - Running pre-action listener: _resource_record_pre_action 13:59:55 INFO - Running main action method: download_and_extract 13:59:55 INFO - mkdir: /builds/slave/test/build/tests 13:59:55 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')]} 13:59:55 INFO - trying https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 13:59:55 INFO - Downloading https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/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 13:59:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/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 13:59:56 INFO - Downloaded 1361 bytes. 13:59:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 13:59:56 INFO - Using the following test package requirements: 13:59:56 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 13:59:56 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:59:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:59:56 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:59:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:59:56 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:59:56 INFO - u'jsshell-linux-x86_64.zip'], 13:59:56 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:59:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:59:56 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 13:59:56 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:59:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:59:56 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:59:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:59:56 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:59:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:59:56 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:59:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:59:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:59:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 13:59:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:59:56 INFO - Fetch https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 13:59:56 INFO - Http code: 200 13:59:56 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 13:59:56 INFO - x-amz-cf-id: lu6fE0oIjQMf1pzU8ODdB--nyboHqnckhWOXGi_vbd2Ny9Kj9itNqQ== 13:59:56 INFO - x-amz-version-id: G_c.gQdy8sVC0p28G1LGClJySHOp6JLE 13:59:57 INFO - Expected file size: 21944212 13:59:57 INFO - Obtained file size: 21944212 14:00:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:00:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 14:00:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:00:01 INFO - Fetch https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:00:02 INFO - Http code: 200 14:00:02 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 14:00:02 INFO - x-amz-cf-id: sbqYB7mwuhpTVWS9BYaXmjaG6sLR2miFr5nzZmUqVE3Q1mqcDphHEA== 14:00:02 INFO - x-amz-version-id: G_c.gQdy8sVC0p28G1LGClJySHOp6JLE 14:00:02 INFO - Expected file size: 21944212 14:00:02 INFO - Obtained file size: 21944212 14:00:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 14:00:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:00:07 INFO - Fetch https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:00:07 INFO - Http code: 200 14:00:07 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 14:00:07 INFO - x-amz-cf-id: yGT42zdSqtVDekr_0XiqGr6DsgjnPae-pdSSQzs2PhM1oZ0kds49MQ== 14:00:07 INFO - x-amz-version-id: S40v8peKKokP2CSDdhKUfjlI_1unJVx9 14:00:08 INFO - Expected file size: 14409038 14:00:08 INFO - Obtained file size: 14409038 14:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:09 INFO - trying https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:00:09 INFO - Downloading https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:00:12 INFO - Downloaded 64099443 bytes. 14:00:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:00:12 INFO - mkdir: /builds/slave/test/properties 14:00:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:00:12 INFO - Writing to file /builds/slave/test/properties/build_url 14:00:12 INFO - Contents: 14:00:12 INFO - build_url:https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 14:00:13 INFO - Running post-action listener: _resource_record_post_action 14:00:13 INFO - Running post-action listener: set_extra_try_arguments 14:00:13 INFO - [mozharness: 2017-01-09 22:00:13.538979Z] Finished download-and-extract step (success) 14:00:13 INFO - [mozharness: 2017-01-09 22:00:13.539205Z] Running populate-webroot step. 14:00:13 INFO - Running pre-action listener: _resource_record_pre_action 14:00:13 INFO - Running main action method: populate_webroot 14:00:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:00:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:00:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:00:13 INFO - '--tppagecycles', 14:00:13 INFO - '7'], 14:00:13 INFO - 'tests': ['tsvgm']}}, 14:00:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:00:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:00:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:00:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:00:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:13 INFO - 'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:13 INFO - 'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['damp', 'tps']}, 14:00:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:13 INFO - 'tests': ['damp', 'tps']}, 14:00:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['dromaeo_dom']}, 14:00:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:00:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['basic_compositor_video']}, 14:00:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:00:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['a11yr', 14:00:13 INFO - 'ts_paint', 14:00:13 INFO - 'tpaint', 14:00:13 INFO - 'sessionrestore', 14:00:13 INFO - 'sessionrestore_no_auto_restore', 14:00:13 INFO - 'tabpaint']}, 14:00:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:00:13 INFO - 'ts_paint', 14:00:13 INFO - 'tpaint', 14:00:13 INFO - 'sessionrestore', 14:00:13 INFO - 'sessionrestore_no_auto_restore', 14:00:13 INFO - 'tabpaint']}, 14:00:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:00:13 INFO - 'ts_paint', 14:00:13 INFO - 'tpaint', 14:00:13 INFO - 'sessionrestore', 14:00:13 INFO - 'sessionrestore_no_auto_restore', 14:00:13 INFO - 'tabpaint']}, 14:00:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:00:13 INFO - 'ts_paint', 14:00:13 INFO - 'tpaint', 14:00:13 INFO - 'sessionrestore', 14:00:13 INFO - 'sessionrestore_no_auto_restore', 14:00:13 INFO - 'tabpaint']}, 14:00:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['a11yr', 14:00:13 INFO - 'ts_paint', 14:00:13 INFO - 'tpaint', 14:00:13 INFO - 'sessionrestore', 14:00:13 INFO - 'sessionrestore_no_auto_restore', 14:00:13 INFO - 'tabpaint']}, 14:00:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['a11yr', 14:00:13 INFO - 'ts_paint', 14:00:13 INFO - 'tpaint', 14:00:13 INFO - 'sessionrestore', 14:00:13 INFO - 'sessionrestore_no_auto_restore', 14:00:13 INFO - 'tabpaint']}, 14:00:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['tsvgx', 14:00:13 INFO - 'tsvgr_opacity', 14:00:13 INFO - 'tart', 14:00:13 INFO - 'tscrollx', 14:00:13 INFO - 'cart']}, 14:00:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:00:13 INFO - 'tsvgr_opacity', 14:00:13 INFO - 'tart', 14:00:13 INFO - 'tscrollx', 14:00:13 INFO - 'cart']}, 14:00:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:13 INFO - 'talos_options': ['--disable-e10s'], 14:00:13 INFO - 'tests': ['tp5o']}, 14:00:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:13 INFO - 'tests': ['tp5o']}, 14:00:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:13 INFO - 'talos_options': ['--disable-e10s', 14:00:13 INFO - '--xperf_path', 14:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:13 INFO - 'tests': ['tp5n']}, 14:00:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:13 INFO - 'talos_options': ['--xperf_path', 14:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:13 INFO - 'tests': ['tp5n']}}, 14:00:13 INFO - 'talos.zip': {'path': '', 14:00:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:00:13 INFO - Running post-action listener: _resource_record_post_action 14:00:13 INFO - [mozharness: 2017-01-09 22:00:13.556841Z] Finished populate-webroot step (success) 14:00:13 INFO - [mozharness: 2017-01-09 22:00:13.556929Z] Running create-virtualenv step. 14:00:13 INFO - Running pre-action listener: _resource_record_pre_action 14:00:13 INFO - Running main action method: create_virtualenv 14:00:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:00:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:00:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:00:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:00:13 INFO - Using real prefix '/usr' 14:00:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:00:14 INFO - Installing distribute.............................................................................................................................................................................................done. 14:00:16 INFO - Installing pip.................done. 14:00:16 INFO - Return code: 0 14:00:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:00:16 INFO - Reading from file tmpfile_stdout 14:00:16 INFO - Output received: 14:00:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:00:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:16 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 0x7f33250fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:00:16 INFO - Using env: {'DISPLAY': ':0', 14:00:16 INFO - 'HOME': '/home/cltbld', 14:00:16 INFO - 'LANG': 'en_US.UTF-8', 14:00:16 INFO - 'LANGUAGE': 'en_US:en', 14:00:16 INFO - 'LOGNAME': 'cltbld', 14:00:16 INFO - 'MAIL': '/var/mail/cltbld', 14:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:16 INFO - 'MOZ_NO_REMOTE': '1', 14:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:16 INFO - 'NO_EM_RESTART': '1', 14:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:16 INFO - 'PWD': '/builds/slave/test', 14:00:16 INFO - 'SHELL': '/bin/bash', 14:00:16 INFO - 'SHLVL': '1', 14:00:16 INFO - 'TERM': 'linux', 14:00:16 INFO - 'TMOUT': '86400', 14:00:16 INFO - 'USER': 'cltbld', 14:00:16 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:16 INFO - '_': '/tools/buildbot/bin/python'} 14:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:00:16 INFO - Cleaning up... 14:00:16 INFO - Return code: 0 14:00:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:16 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 0x7f33250fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:00:16 INFO - Using env: {'DISPLAY': ':0', 14:00:16 INFO - 'HOME': '/home/cltbld', 14:00:16 INFO - 'LANG': 'en_US.UTF-8', 14:00:16 INFO - 'LANGUAGE': 'en_US:en', 14:00:16 INFO - 'LOGNAME': 'cltbld', 14:00:16 INFO - 'MAIL': '/var/mail/cltbld', 14:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:16 INFO - 'MOZ_NO_REMOTE': '1', 14:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:16 INFO - 'NO_EM_RESTART': '1', 14:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:16 INFO - 'PWD': '/builds/slave/test', 14:00:16 INFO - 'SHELL': '/bin/bash', 14:00:16 INFO - 'SHLVL': '1', 14:00:16 INFO - 'TERM': 'linux', 14:00:16 INFO - 'TMOUT': '86400', 14:00:16 INFO - 'USER': 'cltbld', 14:00:16 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:16 INFO - '_': '/tools/buildbot/bin/python'} 14:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:16 INFO - Downloading/unpacking psutil>=3.1.1 14:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:00:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:18 INFO - Installing collected packages: psutil 14:00:18 INFO - Running setup.py install for psutil 14:00:18 INFO - building 'psutil._psutil_linux' extension 14:00:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:00:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:00:19 INFO - building 'psutil._psutil_posix' extension 14:00:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:00:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:00:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:19 INFO - Successfully installed psutil 14:00:19 INFO - Cleaning up... 14:00:19 INFO - Return code: 0 14:00:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33250fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:00: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:00: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 mozsystemmonitor==0.3 14:00:19 INFO - Using env: {'DISPLAY': ':0', 14:00:19 INFO - 'HOME': '/home/cltbld', 14:00:19 INFO - 'LANG': 'en_US.UTF-8', 14:00:19 INFO - 'LANGUAGE': 'en_US:en', 14:00:19 INFO - 'LOGNAME': 'cltbld', 14:00:19 INFO - 'MAIL': '/var/mail/cltbld', 14:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:19 INFO - 'MOZ_NO_REMOTE': '1', 14:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:19 INFO - 'NO_EM_RESTART': '1', 14:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:19 INFO - 'PWD': '/builds/slave/test', 14:00:19 INFO - 'SHELL': '/bin/bash', 14:00:19 INFO - 'SHLVL': '1', 14:00:19 INFO - 'TERM': 'linux', 14:00:19 INFO - 'TMOUT': '86400', 14:00:19 INFO - 'USER': 'cltbld', 14:00:19 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:19 INFO - '_': '/tools/buildbot/bin/python'} 14:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:00:21 INFO - Installing collected packages: mozsystemmonitor 14:00:21 INFO - Running setup.py install for mozsystemmonitor 14:00:21 INFO - Successfully installed mozsystemmonitor 14:00:21 INFO - Cleaning up... 14:00:21 INFO - Return code: 0 14:00:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:21 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 0x7f33250fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:00:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:00:21 INFO - Using env: {'DISPLAY': ':0', 14:00:21 INFO - 'HOME': '/home/cltbld', 14:00:21 INFO - 'LANG': 'en_US.UTF-8', 14:00:21 INFO - 'LANGUAGE': 'en_US:en', 14:00:21 INFO - 'LOGNAME': 'cltbld', 14:00:21 INFO - 'MAIL': '/var/mail/cltbld', 14:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:21 INFO - 'MOZ_NO_REMOTE': '1', 14:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:21 INFO - 'NO_EM_RESTART': '1', 14:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:21 INFO - 'PWD': '/builds/slave/test', 14:00:21 INFO - 'SHELL': '/bin/bash', 14:00:21 INFO - 'SHLVL': '1', 14:00:21 INFO - 'TERM': 'linux', 14:00:21 INFO - 'TMOUT': '86400', 14:00:21 INFO - 'USER': 'cltbld', 14:00:21 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:21 INFO - '_': '/tools/buildbot/bin/python'} 14:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:22 INFO - Downloading/unpacking jsonschema==2.5.1 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:00:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:24 INFO - Downloading functools32-3.2.3-2.tar.gz 14:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:00:24 INFO - warning: no files found matching '*.txt' 14:00:24 INFO - no previously-included directories found matching 'build' 14:00:24 INFO - no previously-included directories found matching 'dist' 14:00:24 INFO - no previously-included directories found matching '.git*' 14:00:24 INFO - Installing collected packages: jsonschema, functools32 14:00:24 INFO - Running setup.py install for functools32 14:00:24 INFO - warning: no files found matching '*.txt' 14:00:24 INFO - no previously-included directories found matching 'build' 14:00:24 INFO - no previously-included directories found matching 'dist' 14:00:24 INFO - no previously-included directories found matching '.git*' 14:00:24 INFO - Successfully installed jsonschema functools32 14:00:24 INFO - Cleaning up... 14:00:24 INFO - Return code: 0 14:00:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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', '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 0x7f33250fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:00: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 functools32==3.2.3-2 14:00:24 INFO - Using env: {'DISPLAY': ':0', 14:00:24 INFO - 'HOME': '/home/cltbld', 14:00:24 INFO - 'LANG': 'en_US.UTF-8', 14:00:24 INFO - 'LANGUAGE': 'en_US:en', 14:00:24 INFO - 'LOGNAME': 'cltbld', 14:00:24 INFO - 'MAIL': '/var/mail/cltbld', 14:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:24 INFO - 'MOZ_NO_REMOTE': '1', 14:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:24 INFO - 'NO_EM_RESTART': '1', 14:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:24 INFO - 'PWD': '/builds/slave/test', 14:00:24 INFO - 'SHELL': '/bin/bash', 14:00:24 INFO - 'SHLVL': '1', 14:00:24 INFO - 'TERM': 'linux', 14:00:24 INFO - 'TMOUT': '86400', 14:00:24 INFO - 'USER': 'cltbld', 14:00:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:24 INFO - '_': '/tools/buildbot/bin/python'} 14:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:00:24 INFO - Cleaning up... 14:00:24 INFO - Return code: 0 14:00:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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', '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 0x7f33250fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:00: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 blobuploader==1.2.4 14:00:24 INFO - Using env: {'DISPLAY': ':0', 14:00:24 INFO - 'HOME': '/home/cltbld', 14:00:24 INFO - 'LANG': 'en_US.UTF-8', 14:00:24 INFO - 'LANGUAGE': 'en_US:en', 14:00:24 INFO - 'LOGNAME': 'cltbld', 14:00:24 INFO - 'MAIL': '/var/mail/cltbld', 14:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:24 INFO - 'MOZ_NO_REMOTE': '1', 14:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:24 INFO - 'NO_EM_RESTART': '1', 14:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:24 INFO - 'PWD': '/builds/slave/test', 14:00:24 INFO - 'SHELL': '/bin/bash', 14:00:24 INFO - 'SHLVL': '1', 14:00:24 INFO - 'TERM': 'linux', 14:00:24 INFO - 'TMOUT': '86400', 14:00:24 INFO - 'USER': 'cltbld', 14:00:24 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:24 INFO - '_': '/tools/buildbot/bin/python'} 14:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:25 INFO - Downloading/unpacking blobuploader==1.2.4 14:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:27 INFO - Downloading blobuploader-1.2.4.tar.gz 14:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:00:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:00:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:27 INFO - Downloading docopt-0.6.1.tar.gz 14:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:00:27 INFO - Installing collected packages: blobuploader, requests, docopt 14:00:27 INFO - Running setup.py install for blobuploader 14:00:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:00:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:00:27 INFO - Running setup.py install for requests 14:00:28 INFO - Running setup.py install for docopt 14:00:28 INFO - Successfully installed blobuploader requests docopt 14:00:28 INFO - Cleaning up... 14:00:28 INFO - Return code: 0 14:00:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:28 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 0x7f33250fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:00:28 INFO - Using env: {'DISPLAY': ':0', 14:00:28 INFO - 'HOME': '/home/cltbld', 14:00:28 INFO - 'LANG': 'en_US.UTF-8', 14:00:28 INFO - 'LANGUAGE': 'en_US:en', 14:00:28 INFO - 'LOGNAME': 'cltbld', 14:00:28 INFO - 'MAIL': '/var/mail/cltbld', 14:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:28 INFO - 'MOZ_NO_REMOTE': '1', 14:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:28 INFO - 'NO_EM_RESTART': '1', 14:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:28 INFO - 'PWD': '/builds/slave/test', 14:00:28 INFO - 'SHELL': '/bin/bash', 14:00:28 INFO - 'SHLVL': '1', 14:00:28 INFO - 'TERM': 'linux', 14:00:28 INFO - 'TMOUT': '86400', 14:00:28 INFO - 'USER': 'cltbld', 14:00:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:28 INFO - '_': '/tools/buildbot/bin/python'} 14:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:28 INFO - Running setup.py (path:/tmp/pip-SN3oO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:28 INFO - Running setup.py (path:/tmp/pip-05xqsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:28 INFO - Running setup.py (path:/tmp/pip-bug3_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:28 INFO - Running setup.py (path:/tmp/pip-l0TS3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:28 INFO - Running setup.py (path:/tmp/pip-jDt9DX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:29 INFO - Running setup.py (path:/tmp/pip-bcd5Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:29 INFO - Running setup.py (path:/tmp/pip-HIjfNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:29 INFO - Running setup.py (path:/tmp/pip-Gn1bfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:29 INFO - Running setup.py (path:/tmp/pip-q3JRgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:29 INFO - Running setup.py (path:/tmp/pip-1SHyte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:29 INFO - Running setup.py (path:/tmp/pip-Qpp8e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:29 INFO - Running setup.py (path:/tmp/pip-7mDOnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:29 INFO - Running setup.py (path:/tmp/pip-zHivQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:29 INFO - Running setup.py (path:/tmp/pip-aYjy79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:29 INFO - Running setup.py (path:/tmp/pip-qhxtmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:29 INFO - Running setup.py (path:/tmp/pip-uQGSrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:29 INFO - Running setup.py (path:/tmp/pip-cvwnqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:00:29 INFO - Running setup.py install for manifestparser 14:00:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:00:30 INFO - Running setup.py install for mozcrash 14:00:30 INFO - Running setup.py install for mozdebug 14:00:30 INFO - Running setup.py install for mozdevice 14:00:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:00:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:00:30 INFO - Running setup.py install for mozfile 14:00:30 INFO - Running setup.py install for mozhttpd 14:00:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:00:30 INFO - Running setup.py install for mozinfo 14:00:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:00:30 INFO - Running setup.py install for mozInstall 14:00:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:00:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:00:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:00:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:00:30 INFO - Running setup.py install for mozleak 14:00:30 INFO - Running setup.py install for mozlog 14:00:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:00:30 INFO - Running setup.py install for moznetwork 14:00:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:00:31 INFO - Running setup.py install for mozprocess 14:00:31 INFO - Running setup.py install for mozprofile 14:00:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:00:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:00:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:00:31 INFO - Running setup.py install for mozrunner 14:00:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:00:31 INFO - Running setup.py install for mozscreenshot 14:00:31 INFO - Running setup.py install for moztest 14:00:31 INFO - Running setup.py install for mozversion 14:00:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:00:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:00:31 INFO - Cleaning up... 14:00:31 INFO - Return code: 0 14:00:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:31 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 0x7f33250fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:00:31 INFO - Using env: {'DISPLAY': ':0', 14:00:31 INFO - 'HOME': '/home/cltbld', 14:00:31 INFO - 'LANG': 'en_US.UTF-8', 14:00:31 INFO - 'LANGUAGE': 'en_US:en', 14:00:31 INFO - 'LOGNAME': 'cltbld', 14:00:31 INFO - 'MAIL': '/var/mail/cltbld', 14:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:31 INFO - 'MOZ_NO_REMOTE': '1', 14:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:31 INFO - 'NO_EM_RESTART': '1', 14:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:31 INFO - 'PWD': '/builds/slave/test', 14:00:31 INFO - 'SHELL': '/bin/bash', 14:00:31 INFO - 'SHLVL': '1', 14:00:31 INFO - 'TERM': 'linux', 14:00:31 INFO - 'TMOUT': '86400', 14:00:31 INFO - 'USER': 'cltbld', 14:00:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:31 INFO - '_': '/tools/buildbot/bin/python'} 14:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:31 INFO - Running setup.py (path:/tmp/pip-xbS31_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:32 INFO - Running setup.py (path:/tmp/pip-kBKYR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:32 INFO - Running setup.py (path:/tmp/pip-UFfhXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:32 INFO - Running setup.py (path:/tmp/pip-zAPcmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:32 INFO - Running setup.py (path:/tmp/pip-6jc1na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:32 INFO - Running setup.py (path:/tmp/pip-kH6AvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:32 INFO - Running setup.py (path:/tmp/pip-XQbLGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:32 INFO - Running setup.py (path:/tmp/pip-lGTsPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:32 INFO - Running setup.py (path:/tmp/pip-39woak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:32 INFO - Running setup.py (path:/tmp/pip-xGrzjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:32 INFO - Running setup.py (path:/tmp/pip-kMf1mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:32 INFO - Running setup.py (path:/tmp/pip-kohd5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:32 INFO - Running setup.py (path:/tmp/pip-fh96W9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:32 INFO - Running setup.py (path:/tmp/pip-0wdQrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:32 INFO - Running setup.py (path:/tmp/pip-56x7jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:33 INFO - Running setup.py (path:/tmp/pip-o_PuPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:33 INFO - Running setup.py (path:/tmp/pip-d7a54i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:00:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:35 INFO - Downloading blessings-1.6.tar.gz 14:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:00:35 INFO - Installing collected packages: blessings 14:00:35 INFO - Running setup.py install for blessings 14:00:35 INFO - Successfully installed blessings 14:00:35 INFO - Cleaning up... 14:00:35 INFO - Return code: 0 14:00:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:36 INFO - Reading from file tmpfile_stdout 14:00:36 INFO - Current package versions: 14:00:36 INFO - argparse == 1.2.1 14:00:36 INFO - blessings == 1.6 14:00:36 INFO - blobuploader == 1.2.4 14:00:36 INFO - docopt == 0.6.1 14:00:36 INFO - functools32 == 3.2.3-2 14:00:36 INFO - jsonschema == 2.5.1 14:00:36 INFO - manifestparser == 1.1 14:00:36 INFO - mozInstall == 1.12 14:00:36 INFO - mozcrash == 1.0 14:00:36 INFO - mozdebug == 0.1 14:00:36 INFO - mozdevice == 0.48 14:00:36 INFO - mozfile == 1.2 14:00:36 INFO - mozhttpd == 0.7 14:00:36 INFO - mozinfo == 0.9 14:00:36 INFO - mozleak == 0.1 14:00:36 INFO - mozlog == 3.4 14:00:36 INFO - moznetwork == 0.27 14:00:36 INFO - mozprocess == 0.23 14:00:36 INFO - mozprofile == 0.28 14:00:36 INFO - mozrunner == 6.13 14:00:36 INFO - mozscreenshot == 0.1 14:00:36 INFO - mozsystemmonitor == 0.3 14:00:36 INFO - moztest == 0.8 14:00:36 INFO - mozversion == 1.4 14:00:36 INFO - psutil == 3.1.1 14:00:36 INFO - requests == 1.2.3 14:00:36 INFO - wsgiref == 0.1.2 14:00:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:36 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 0x7f33250fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:00:36 INFO - Using env: {'DISPLAY': ':0', 14:00:36 INFO - 'HOME': '/home/cltbld', 14:00:36 INFO - 'LANG': 'en_US.UTF-8', 14:00:36 INFO - 'LANGUAGE': 'en_US:en', 14:00:36 INFO - 'LOGNAME': 'cltbld', 14:00:36 INFO - 'MAIL': '/var/mail/cltbld', 14:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:36 INFO - 'MOZ_NO_REMOTE': '1', 14:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:36 INFO - 'NO_EM_RESTART': '1', 14:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:36 INFO - 'PWD': '/builds/slave/test', 14:00:36 INFO - 'SHELL': '/bin/bash', 14:00:36 INFO - 'SHLVL': '1', 14:00:36 INFO - 'TERM': 'linux', 14:00:36 INFO - 'TMOUT': '86400', 14:00:36 INFO - 'USER': 'cltbld', 14:00:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:36 INFO - '_': '/tools/buildbot/bin/python'} 14:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:00:36 INFO - Cleaning up... 14:00:36 INFO - Return code: 0 14:00:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f33250fbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:00:36 INFO - Using env: {'DISPLAY': ':0', 14:00:36 INFO - 'HOME': '/home/cltbld', 14:00:36 INFO - 'LANG': 'en_US.UTF-8', 14:00:36 INFO - 'LANGUAGE': 'en_US:en', 14:00:36 INFO - 'LOGNAME': 'cltbld', 14:00:36 INFO - 'MAIL': '/var/mail/cltbld', 14:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:36 INFO - 'MOZ_NO_REMOTE': '1', 14:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:36 INFO - 'NO_EM_RESTART': '1', 14:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:36 INFO - 'PWD': '/builds/slave/test', 14:00:36 INFO - 'SHELL': '/bin/bash', 14:00:36 INFO - 'SHLVL': '1', 14:00:36 INFO - 'TERM': 'linux', 14:00:36 INFO - 'TMOUT': '86400', 14:00:36 INFO - 'USER': 'cltbld', 14:00:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:36 INFO - '_': '/tools/buildbot/bin/python'} 14:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:00:36 INFO - Cleaning up... 14:00:36 INFO - Return code: 0 14:00:36 INFO - Running post-action listener: _resource_record_post_action 14:00:36 INFO - Running post-action listener: _start_resource_monitoring 14:00:36 INFO - Starting resource monitoring. 14:00:36 INFO - [mozharness: 2017-01-09 22:00:36.673951Z] Finished create-virtualenv step (success) 14:00:36 INFO - [mozharness: 2017-01-09 22:00:36.674530Z] Running install step. 14:00:36 INFO - Running pre-action listener: _resource_record_pre_action 14:00:36 INFO - Running main action method: install 14:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:36 INFO - Reading from file tmpfile_stdout 14:00:36 INFO - Detecting whether we're running mozinstall >=1.0... 14:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:00:36 INFO - Reading from file tmpfile_stdout 14:00:36 INFO - Output received: 14:00:36 INFO - Usage: mozinstall [options] installer 14:00:36 INFO - Options: 14:00:36 INFO - -h, --help show this help message and exit 14:00:36 INFO - -d DEST, --destination=DEST 14:00:36 INFO - Directory to install application into. [default: 14:00:36 INFO - "/builds/slave/test"] 14:00:36 INFO - --app=APP Application being installed. [default: firefox] 14:00:36 INFO - mkdir: /builds/slave/test/build/application 14:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:00:52 INFO - Reading from file tmpfile_stdout 14:00:52 INFO - Output received: 14:00:52 INFO - /builds/slave/test/build/application/firefox/firefox 14:00:52 INFO - Running post-action listener: _resource_record_post_action 14:00:52 INFO - [mozharness: 2017-01-09 22:00:52.919700Z] Finished install step (success) 14:00:52 INFO - [mozharness: 2017-01-09 22:00:52.919943Z] Running run-tests step. 14:00:52 INFO - Running pre-action listener: _resource_record_pre_action 14:00:52 INFO - Running main action method: run_tests 14:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:00:52 INFO - Python 2.7.3 14:00:52 INFO - Return code: 0 14:00:52 INFO - grabbing minidump binary from tooltool 14:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:00:52 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 0x1b50f60>, '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 0x1b51d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b521d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:00:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:00:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:00:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:00:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:00:52 INFO - Return code: 0 14:00:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:00:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:00:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:00:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:00:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:00:53 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/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:00:53 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/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:00:53 INFO - Using env: {'DISPLAY': ':0', 14:00:53 INFO - 'HOME': '/home/cltbld', 14:00:53 INFO - 'LANG': 'en_US.UTF-8', 14:00:53 INFO - 'LANGUAGE': 'en_US:en', 14:00:53 INFO - 'LOGNAME': 'cltbld', 14:00:53 INFO - 'MAIL': '/var/mail/cltbld', 14:00:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:00:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:53 INFO - 'MOZ_NO_REMOTE': '1', 14:00:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:53 INFO - 'NO_EM_RESTART': '1', 14:00:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:53 INFO - 'PWD': '/builds/slave/test', 14:00:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:00:53 INFO - 'SHELL': '/bin/bash', 14:00:53 INFO - 'SHLVL': '1', 14:00:53 INFO - 'TERM': 'linux', 14:00:53 INFO - 'TMOUT': '86400', 14:00:53 INFO - 'USER': 'cltbld', 14:00:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342', 14:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:53 INFO - '_': '/tools/buildbot/bin/python'} 14:00:53 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/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:00:53 INFO - mozversion application_buildid: 20170109122608 14:00:53 INFO - mozversion application_changeset: 1c8a9f489bb4bf063b1502222a4cda953d80d7f6 14:00:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:00:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:00:53 INFO - mozversion application_name: Firefox 14:00:53 INFO - mozversion application_remotingname: firefox-dev 14:00:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:00:53 INFO - mozversion application_vendor: Mozilla 14:00:53 INFO - mozversion application_version: 52.0a2 14:00:53 INFO - mozversion platform_buildid: 20170109122608 14:00:53 INFO - mozversion platform_changeset: 1c8a9f489bb4bf063b1502222a4cda953d80d7f6 14:00:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:00:53 INFO - mozversion platform_version: 52.0a2 14:00:53 INFO - using testdate: 1483999253 14:00:53 INFO - actual date: 1483999253 14:00:53 INFO - starting webserver on 'localhost:56377' 14:00:53 INFO - SUITE-START | Running 2 tests 14:00:53 INFO - TEST-START | dromaeo_css 14:00:53 INFO - operating with platform_type : linux_ 14:00:53 INFO - Initialising browser for dromaeo_css test... 14:00:53 INFO - TEST-INFO | started process 21980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOFe6X5/profile http://localhost:56377/getInfo.html) 14:00:57 INFO - PROCESS | 21980 | __metrics Screen width/height:1600/1200 14:00:57 INFO - PROCESS | 21980 | colorDepth:24 14:00:57 INFO - PROCESS | 21980 | Browser inner width/height: 1024/697 14:00:57 INFO - PROCESS | 21980 | __metrics 14:00:57 INFO - PROCESS | 21980 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:00:57 INFO - PROCESS | 21980 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:00:58 INFO - PROCESS | 21980 | console.error: PushService: 14:00:58 INFO - PROCESS | 21980 | stateChangeProcessEnqueue: Error transitioning state 14:00:58 INFO - PROCESS | 21980 | UnknownError 14:00:58 INFO - TEST-INFO | 21980: exit 0 14:00:58 INFO - Browser initialized. 14:00:58 INFO - Running cycle 1/1 for dromaeo_css test... 14:00:58 INFO - TEST-INFO | started process 22072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOFe6X5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:10 INFO - PROCESS | 22072 | RSS: Main: 144863232 14:01:10 INFO - PROCESS | 22072 | 14:04:12 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:56377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56377/tests/dromaeo/cssquery-ext.html) 14:04:13 INFO - PROCESS | 22072 | RSS: Main: 244183040 14:04:13 INFO - PROCESS | 22072 | 14:07:16 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:56377/tests/dromaeo/cssquery-ext.html (next: http://localhost:56377/tests/dromaeo/cssquery-jquery.html) 14:07:16 INFO - PROCESS | 22072 | RSS: Main: 226504704 14:07:16 INFO - PROCESS | 22072 | 14:10:18 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:56377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56377/tests/dromaeo/cssquery-mootools.html) 14:10:19 INFO - PROCESS | 22072 | RSS: Main: 236224512 14:10:19 INFO - PROCESS | 22072 | 14:13:21 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:56377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56377/tests/dromaeo/cssquery-prototype.html) 14:13:22 INFO - PROCESS | 22072 | RSS: Main: 174002176 14:13:22 INFO - PROCESS | 22072 | 14:16:24 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:56377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56377/tests/dromaeo/cssquery-yui.html) 14:16:25 INFO - PROCESS | 22072 | RSS: Main: 174632960 14:16:25 INFO - PROCESS | 22072 | 14:19:27 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:56377/tests/dromaeo/cssquery-yui.html (next: http://localhost:56377/tests/dromaeo/cssquery-dojo.html) 14:19:27 INFO - PROCESS | 22072 | RSS: Main: 266887168 14:19:27 INFO - PROCESS | 22072 | 14:19:27 INFO - PROCESS | 22072 | __start_tp_report 14:19:27 INFO - PROCESS | 22072 | _x_x_mozilla_page_load 14:19:27 INFO - PROCESS | 22072 | _x_x_mozilla_page_load_details 14:19:27 INFO - PROCESS | 22072 | |i|pagename|runs| 14:19:27 INFO - PROCESS | 22072 | |0;dojo.html;3260.4457242268813;3303.4879593662977;3309.768316217863;3331.133905184651;3348.6483919188486;5595.7481913313895;5647.689377084259;5659.717014149292;5687.431256874321;5718.942810571898;5611.691356975375;5690.63010904291;5693.658380497173;5696.829095127143;5749.511291540213;5099.235114732783;5128.358955130609;5131.846044618667;5144.8713782155555;5198.038362902875;4940.802367905279;5236;5236.895262094756;5245.213218017289;5248.6063545234065;4927.6797008194535;5013.298138260647;5020.7489625518765;5031.3207716958295;5049.293098966147;5052.924206136892;5077.974610126926;5079.974600126994;5150.098732721796;5180.456052114511;4996.825111121129;5073.543381095719;5107.387113546398;5128.615353848476;5130.71781052042;5419.783208671648;5467.589930755209;5474.479924407215;5531.3362396512275;5577.637453565546;5881.14723365114;5895.852603684899;5903.734331955073;6014.368491308437;6021.307549631761;6001.219841420631;6026.427489388501;6035.8792824143275;6039.245094363205;6039.486643635296;5467.726613669301;5515.586331025149;5635.126555383922;5683.516901063374;5707.34365547959;6221.129041934133;6228.283747369111;6254.593451425642;6265.248170219603;6272.529560282997;6012.759489620366;6020.879582408327;6021.42796434338;6021.909671354933;6054;5849.912251316234;5864.736086876101;5866.2373891393845;5878.735456904449;5903.881922361528;5904.793332233351;5911.9704401478575;5912.201852749909;5932.970335148297;5954.672493012926;5871.4715675589405;5911.527077833763;5927.585069045125;5928.051511758098;5931.051031834886;4444.555544445529;4500.369948207253;4579.061292435043;4603.447586289667;4642.698224615389;4161.188568229227;4191.308434108338;4198.685098617616;4209.642180414699;4231.048014196843;5839.591228613956;5843.912341314884;5846.181534585162;5852.209951656557;5853.209816674779;5844.678542680108;5916.940830591725;5954.49386802118;6151.538634602333;6152.953997820381;5671.773129074873;5755.740991655385;5781.8554536136935;5794.101914203221;5795.159701843209;5273.3935597406025;5276.5251127398715;5287.57699384056;5288.682679039193;5289.894202115936;6127.754889804358;6169.259688837368;6237.688115594202;6286.559940804192;6296.275928268308;5989.64062156272;6043.2748070231855;6060.606060606223;6111.287884814297;6142.78500252489;6307.432331090224;6349.396807303298;6351.047342898602;6352.936470635234;6361.045843123568;5621.831345059655;5656.943430565641;5990.161377407079;5991.88016239664;5994.820155395345;5892.941070589411;5915.85210369727;5975.37258587842;6052.788152414644;6058.4850287724275;5816.9127463088935;5847.38602446754;5884.499817515388;5884.9705751470965;5887.941120588911;5808.30300363959;5818.389069147678;5821;5830.4461076197695;5836.649801011783;5701.885962280814;5768.509676677361;5826.883462330815;5874.530037596896;5890.970545147246;5952.285725712942;5978.790742323998;5982.1325907744;5990.221271234712;5991.820245392645;5534.335879694301;5573.470520300565;5835.387284335084;5836.241288632451;5848.298204215522 14:19:27 INFO - PROCESS | 22072 | |1;ext.html;584.1471451680546;597.8057131432284;625.9499240060794;643.8004218692206;654.7086546486815;36423.81788091059;45702.54297457024;46219.76890115545;46298.305525417105;50483;46743.29885051727;47209;47372.76313618427;47410.52589474104;47426.525734742725;8385.454945428528;8871.068537803534;9012.684556040507;9014.36899417041;9017.36878418511;8281.751547453587;10566.788664226711;10793.784124317508;10794.73013174673;11142.331460112418;10978.286411383235;10983.176261780358;11001.889981100167;11073;11078.335299881992;10721.195910306718;10788.190885683527;10793.29843560166;10797.5680972761;10805.729856753565;10663.466826658714;10701.78596428067;10733.516991735312;10734.946325268402;10739.463026848705;43829.12341753147;44303;44337;44433;44466.555334446886;3681.6134305897763;3782.470454136423;3798.4682144499793;3953.2093581283857;4210.221109094828;31150.84424577885;31332.686673133205;31728.841355793073;31964.360712785616;32155.19612009695;4230.576942305775;4242.533321334681;4336.21948049351;4368.410264614268;4389.574759945144;232272;232928;234060;234288.99999999828;235386;64612.67693661596;64923;65139.34860651428;65337.67331163314;65388;39991.60008399937;40574.79712601418;40882.38676419856;68942;69043.96434053493;17730.468085957444;17772.46682599524;17788.02165880863;17788.02165880889;17819.643607127786;13303.933480332536;13598.864011359958;13669.794953075712;13750.381232844546;13784.931075344559;20238.69641955372;21441.67837482439;21490.892545537172;21533.138674452846;21565.67651485229;7378.225286344964;7413.332800048021;7458.925410745823;7663.808404789814;7790;1007.8034783217203;1013.4831236069657;1109.517359948425;1190.4166958190597;1221.3770976801718;33477.16307092342;33701;33767;34073.48889766655;34254.14364640904;996.4668902137322;1145.8770405003143;1173.859136903577;1235.116891422637;1285.2095960983927;15815.762763558556;17387.565310867078;17451.825481745273;18976;19045.61908761817;526889;527441;528416;530552;532128;60147.69926150429;60477.39522604806;60587.69706151529;60652.69673651604;60714;1309.109805332364;1355.6407551998727;1418.1136789506352;1429.7640889253364;1449.9202543859979;29308.120756377342;34672;35211.47182792209;35248.29503409969;35326.82336588403;54262.45737542574;54756;54814.17778733402;54872.725636371564;54891.17663234975;387806;389925;390717;390777;391638;29621.555676664437;30139;30407.847960760053;31270;32095.518567221043;49310.26034609556;50014;50282;53788.462115378345;54871;42351;42637.5736242646;42948.35577466278;44133.77933110314;44747;42687.35968960406;43122.353164703185;43252.13495730131;43583.56416435795;44988.55011449844;42830.78584607057;43911.34132988071;43991.78004109959;44026.559734402246;44195.337069943336;37164.44253336148;38618;39666.40500392439;40071.39892901667;40251.1949761009;28919.56620650734;29354.266143346587;29643.85178074096;29835.403291934475;29877.253068672588 14:19:27 INFO - PROCESS | 22072 | |2;jquery.html;396.755995063036;424.7748693192607;430.97845107744615;435.4643788140589;449.43146919147284;15877;19204.711929321053;19631.705524417146;20472.873991930475;20582.279620213296;18444.815551844476;19995.500112497193;20438.489037774063;20689.586208275825;20699.896500517512;5818.1854540364275;6051.667158306292;6054.48536874364;6055.333913269536;6057.485113765313;5647;5912.43831835977;5940.138679891413;5948.37542058082;5949.4348036936635;5719.59962802604;5920.111983202511;5920.378360272174;5922.141289513018;5925.4963328117165;5886.175935369051;5917.289925208981;5936.970315148396;5938.16865638813;5945.31628862682;5151.742412879378;5377.623566350357;5384;5384.138537833967;5384.6769193848495;14538.127712337187;14552.636184095376;14799;14800.259987000607;15027.549173524812;2079.3034333498294;2203.4821816873023;2258.5482903419215;2479.367761220877;2554.6678931738943;10601.73495662607;10673.092787113104;10739.03348698613;10995;11090.334579925231;1792.1397729089979;1876.47458711561;1877.3898482993081;1891.1678861300984;1928.6817675083594;84021.57989210016;84928.15071849264;84965;85114.57442712809;88930.6660400101;10597.894021059845;11808.94095529534;12248.44881980313;12263.386830658432;12292.323922184365;13710.862891371158;15459.690806183813;16197.757033644504;16200.270987805578;16817.831821681626;8655.13448655142;8679.739607811776;8686.174813392718;8835.160659737314;8956.641734330553;8306.8338633227;8406.957965210257;8432.831343373098;8584.484930904166;8588.65645374178;5083.61872859537;5111.233315002705;5145.202493613496;5153.510416510426;5255.106631872591;2082.5106100066473;2091.822195113402;2114.059243636598;2123.723915890924;2176.651735722277;1006.5923301063082;1033.440092303403;1034.5706531789374;1081.9621313254;1097.8737445193744;20014.49963750889;20310.390688279374;20360;20571;20791.68812467814;1081.313366012572;1083.0739717541546;1088.4884104470887;1122.7586068995042;1138.5957984915235;10586.947065264778;11659.708507287385;11708.531658733555;11900.64298071042;12087.456064477119;483276;494554;503643;510661;511138;96768;97208.51395742976;98058.50970745101;100452;101378;1064.9094826939643;1107.0534692837507;1158.073541167063;1162.8837116288303;1173.1611897493333;17578;17763.111844407988;17942.55143621368;18304.542386440444;18424.98662573518;43604.34593481037;44567.77716111398;44913;44931.55068449405;45398.31902521531;54130;58760.4123958772;61249;62583;67772.98340524797;11966.940165299118;12079.75840483203;12167.81748273759;12283.692907677023;12468.189567678071;13299.46802127904;13377.464901403835;13436.731265374834;13505.459781608626;13592.93203533976;11787.882121179022;11895.821562676394;12059.939700301442;12125.454354553889;12138.33239171854;11815.940920295343;11917.22538035025;12047.457864396298;12167.2699638022;12452.626421207378;12058.758824823279;12278.754424911273;12340.629781106582;12579.74840503203;12968.157069790434;12043.638690839289;12109.576164834189;12121;12270.32513211782;12421.689457763629;11814.763704726029;12018.04349557851;12168;12397.504099835905;12505.93747031259 14:19:27 INFO - PROCESS | 22072 | |3;mootools.html;1354.4920654754467;1463.69994151199;1505.9849401505983;1655.445425782363;1776.1474492243715;7462.141853686828;8048.356131509479;8372.204640559152;8384.24541791238;8663.220310172082;8470.322374210064;8554.144585541442;8562.871556926651;8573.785655358604;8578.399512034144;2409.698787651539;2413.6620873077695;2435.926922192328;2441.377448750566;2445.74319696432;2387.844790088647;2429.1983645396976;2463.864487453189;2464.3099932019063;2467.617519284514;2395.5089206712582;2406.03758496601;2427.3446169534213;2428.6964129483813;2433.4646377796857;2339.836211465198;2350.529894021194;2360.7875291223786;2364.3852598324474;2378.5361854438393;2292.8280378971644;2310.6996090508296;2332.7433982261937;2333.5099629077913;2333.7432882382923;8208.83582328356;8372;8494.362922780816;8514.106018867991;8561.44350617208;5273.789048438058;5449.618526703132;5456.072467680504;5458.727063646802;5459.099248623972;3305.586801649794;3385.4414021686393;3434.4333185024443;3462.394081035834;3472.2013936794424;1049.8425236214553;1075.7095584192225;1080.8378743188507;1111.1721767283345;1123.646051493777;11034.503447344889;11049.668509944635;11116.44417779116;11130.165237607212;11135.554577816878;4277.572242775697;4409.691321607456;4496.0108776069865;4496.145732310851;4601.838935637304;9352.298577606707;9353.579088941015;9358.409070458038;9364.063593640718;9369.859452108223;5281.366236051698;5287.365516138011;5291.735413229323;5293.100172970604;5296.1261391870685;4387.4954380246045;4391.736495810262;4805.927911081337;4858.902821943541;4931.408231012301;3826.234753049401;3865.4588357629955;3933.547642021147;3965.6827453803626;3966.147278335114;1108.2076315434504;1213.1568559850996;1221.5724496426358;1224.516316055171;1232.8520577530753;850.9021462531764;950.5864948747317;959.2230293462318;966.9516524173763;982.1160955140288;5536.584756143306;5606.887862242732;5615.129654903497;5913.201717768046;5941.792037278675;925.796324808541;975.2149519636761;992.553350992042;1006.5420233793607;1023.8310678738073;3958.4062390641634;4092.6112019358116;4159.7920103994675;4183.748975061506;4300.16146851361;10225.386476811414;10435.426051567236;10506.527206275583;10527.210459215436;10576.206784491194;10402.635907743193;10403.58385664565;10405.791884162274;10425.530851111718;10428.426436545911;7802.492837965514;7996.9200307997335;8091.878621820678;8107.594620268963;8115.797105072303;5579.04557725907;5585.469380408855;5869.706514674334;5922.289325280994;6053.4551890330085;9661.661841835503;9662.613495460102;9712.902870971482;9772.12050915421;9786.951065244913;9409;9725.319227653996;9766.46284454362;9891.55488003056;9892;7012.509124361246;7059.788206353817;7244.094488188976;7282.6722797473185;7447;8208.753737387888;8227.71203007892;8271;8296.336293096658;8306.916930830856;7386.815329616587;7397.926020739724;7430.368418684472;7544.396448284015;7565.130010048915;7235.710571577078;7283;7319.121705395387;7328.230535793665;7342.926570734225;6690.096836926952;6791.3548212919695;6796.286389928986;6797.1163748714325;6801.5238933274195;4786.736729479772;4937.481564435682;4960.20636698141;4962.454130045764;5127.923136141452;5047.772850221675;5075.543201111917;5132.897342053213;5201.973990130025;5385.569154467555 14:19:27 INFO - PROCESS | 22072 | |4;prototype.html;350.73694728953285;352.10038352010605;352.948822420749;357.89978805934345;359.7661520011992;5403.91894121588;5431.348238211415;5439.700816455093;5446.2375267462585;5475.397706252309;5277.86805329866;5289.471052894709;5347.839564813052;5365.463453654633;5367.865803354918;3703.7037037036957;3992.7803970781524;4136.917261654765;4145.834166633346;4162.458880345551;4155.210510003089;4159.875203743893;4171.103212809246;4177.206330797138;4194.790260486979;4122.752634841919;4179.561146079664;4179.665626749868;4189.245935731567;4199.685023623225;3996.740211886233;4058.512978442606;4122.484689413824;4173.017816537121;4217.915641687165;3720.9813950930343;3725.256117601793;3737.8504859805576;3739.139997800521;3739.5325584301963;5157.896842063138;5167.457416971201;5185.392528316196;5227.771473703677;5241;4754.857354279377;4763.245090341672;4785.138675038492;4817;4842.515748425165;5523.4200408956885;5555.388907220203;5561.388247292794;5563.193336966117;5584;4157.168566286755;4185.602367775056;4186.488107135725;4193.496780386343;4199.286121359376;5572.637778544382;5672.40439753824;5710.200571919934;5774.942250577483;5839.474447299721;4208.642265407413;4216.620504154641;4217.620414162679;4222.9577704223175;4247.51153617338;4260.339647354665;4270.765107919032;4291.184674911757;4293.699441039097;4317.935230971538;4696.248600224016;4705.6470764692785;4714.622830173578;4811.4707382187935;4841.975790121027;5478.58910581708;5490.6431081979545;5515.172724091338;5530.6128571000445;5551.805686800943;1432.3339647064165;1443.7473442147582;1446.5443385333585;1449.9270539800682;1463.6853076588584;953.6566835939057;990.3117333453325;998.4259051045677;1000.3547711725896;1023.5036007536339;5222.843314700565;5238.5023422774775;5247.2653828464045;5255.947440525622;5279.44565820591;5505.366882808448;5512.39363669996;5518.834434966958;5520.723963801794;5521.420250873681;4954.083494553519;5179.352580927384;5194.97402512985;5245.580353571705;5283.894322113536;2878.8128771629777;2879.9424011520073;2889.19102651258;2902.7097290270804;2905.5205891028168;5618.43815618443;5710.915515836773;5716.456936591017;5736.340320863154;5764.394738552475;5316.415194328698;5510.366307874566;5523.315388806453;5536.363318218376;5577.6932268724795;5767.971160144172;5769.278840144982;5898.882022359443;5912.46787789101;5916.7337469813965;5671.376148623565;5713.314402271754;5718.685472299064;5722.542196624343;5750.137479378127;5515.22786809855;5625.662460252398;5631.408702086222;5642.097264437671;5672.943270567406;5871.354151043296;5892.558058145742;5892.705364731832;5906.763729450774;5914.260717410324;4269.060806622538;4270.466191726035;4275.743455392686;4293.420388247547;4309.288967320483;5515.669059856261;5615.606907516435;5688.146777983336;5689.118186681071;5700.714964251688;5573.526250268773;5593.384727680033;5595.496405323541;5604.8038318658655;5634.32388113429;5262.710805746408;5499.3675727291875;5529.502344788827;5536.861578460571;5541;5565.719884426524;5584.776608935597;5588.608797384307;5590.524805391425;5595.496405323541;5608.326546112303;5643.322801263875;5652.547796176378;5652.576056795675;5653.547716182778;5304.946950530445;5506.256655351476;5542.3903370630005;5543.1408131739645;5561.610687251854 14:19:27 INFO - PROCESS | 22072 | |5;yui.html;743.1528058013865;749.9287567681071;763.3663959127465;772.3164998975907;783.1502819440906;14805.777913331309;15762;15801.130937798416;15812.762808557882;15817.446389376375;14315;14462.5661230163;14463.638409039779;14471.638209044779;14475.78286325706;727.0221552012548;749.8800191969286;848.9660413583449;870.7431307764193;884.1688812516214;878.4465786554462;880.9207171354577;881.4314766975297;881.497546398553;881.660560684138;926.0276709455079;926.6015613286285;927.3601215161517;928.1878356438117;928.6471140966423;762.8283636181842;785.2736218997404;874.3180319350885;897.878786363839;903.0698380667923;663.3300366629691;664.9102371179877;665.7237246542679;666.203886355805;666.8799616069106;14419;14776.778348324784;14783.408663653441;14825.481108161162;14829.480968166063;12944.741105177938;13274.933625331909;13355.065145439823;13406.463741450429;13481.123726957716;10313.793724125551;10335.379877207391;10401.167906567456;10412;10531.15750739939;4112.403701463271;4126.958730412687;4154.958450415487;4226.281532139544;4252.681048921312;60435.69782151105;62515;63939;63949.68025159891;64564.3543564563;10142.594296228068;10349.327293725884;10367.274290799722;10428.634997775192;10446.68659940203;20780.896095519427;20781.064852081694;20789.1684332625;20793.480162995744;20795.584088318148;8046.879296810553;8110.188981101843;8159.510429374256;8193.262606365337;8201.507909525448;4292.313229883203;4294.7852607369505;4350.412694286294;4444.28891377378;4501.459824820977;3323.850426730803;3393.0669066007044;3437.4671925851535;3440.518327434161;3441.896743097711;555.9527440167631;561.8651523634298;563.5745012515524;570.7545755325167;570.8886767080462;544.2081771023152;557.5595279728968;599.032562411702;607.2348840461051;626.4518546272012;8002.8799568006525;8424.536650484282;8570.314374849997;8835.734927952171;9228.354015219005;592.4371846745609;596.0433504225742;620.0203678188542;642.502060902804;655.446148004935;4283.571642835692;4330.415393921843;4339.414179085846;4409.933850992237;4582.839600614029;57070.7146464265;85359.57320213484;85804.57097714471;91506.54246728723;91656;72537;72829.6358518204;74914;75157.62421187859;75274;66754.32719709574;67644;68651.31348686549;69938;72858;7983.920160798318;8562.443441176303;8663.653453861774;8681.739547813575;8833.514156721441;46649;47999.5200048009;48279.75860120677;49304.753476233825;49800.25299620581;41968.79015604902;50275.49724502708;52558.73720631372;56040;57493.71253143708;11496.94251528737;11644.301341919512;11824.881751182378;11836.112291578338;11988.220765650205;12491.312977786309;12819.487220511075;12856.100072994801;12895.484180633044;14000.789988149982;11325.263857849213;12326.383680816103;12370.381480926098;12533.310667913353;13006.609801705965;11856.52573897069;12037.939810300892;12356.135070544975;12391.566295179626;12756.298403587893;12248.142630015813;12338.753224935272;12368.143590454349;12370.44333004999;12600.684982875135;9189.127032931861;9305.348625596143;9378.671746489114;9662.3719458235;10016.69949901475;8916.420432671855;10043.748906277402;10091.243156763125;10444.947775261075;10472.68581942543 14:19:27 INFO - PROCESS | 22072 | __end_tp_report 14:19:27 INFO - PROCESS | 22072 | __start_cc_report 14:19:27 INFO - PROCESS | 22072 | _x_x_mozilla_cycle_collect,1084 14:19:27 INFO - PROCESS | 22072 | __end_cc_report 14:19:27 INFO - PROCESS | 22072 | __startTimestamp1484000367941__endTimestamp 14:19:27 INFO - PROCESS | 22072 | 14:19:27 INFO - PROCESS | 22072 | ------- Summary: start ------- 14:19:27 INFO - PROCESS | 22072 | Number of tests: 6 14:19:27 INFO - PROCESS | 22072 | 14:19:27 INFO - PROCESS | 22072 | [#0] dojo.html Cycles:165 Average:5592.67 Median:5835.39 stddev:627.68 (10.8%) stddev-sans-first:602.35 14:19:27 INFO - PROCESS | 22072 | Values: 3260.4 3303.5 3309.8 3331.1 3348.6 5595.7 5647.7 5659.7 5687.4 5718.9 5611.7 5690.6 5693.7 5696.8 5749.5 5099.2 5128.4 5131.8 5144.9 5198.0 4940.8 5236.0 5236.9 5245.2 5248.6 4927.7 5013.3 5020.7 5031.3 5049.3 5052.9 5078.0 5080.0 5150.1 5180.5 4996.8 5073.5 5107.4 5128.6 5130.7 5419.8 5467.6 5474.5 5531.3 5577.6 5881.1 5895.9 5903.7 6014.4 6021.3 6001.2 6026.4 6035.9 6039.2 6039.5 5467.7 5515.6 5635.1 5683.5 5707.3 6221.1 6228.3 6254.6 6265.2 6272.5 6012.8 6020.9 6021.4 6021.9 6054.0 5849.9 5864.7 5866.2 5878.7 5903.9 5904.8 5912.0 5912.2 5933.0 5954.7 5871.5 5911.5 5927.6 5928.1 5931.1 4444.6 4500.4 4579.1 4603.4 4642.7 4161.2 4191.3 4198.7 4209.6 4231.0 5839.6 5843.9 5846.2 5852.2 5853.2 5844.7 5916.9 5954.5 6151.5 6153.0 5671.8 5755.7 5781.9 5794.1 5795.2 5273.4 5276.5 5287.6 5288.7 5289.9 6127.8 6169.3 6237.7 6286.6 6296.3 5989.6 6043.3 6060.6 6111.3 6142.8 6307.4 6349.4 6351.0 6352.9 6361.0 5621.8 5656.9 5990.2 5991.9 5994.8 5892.9 5915.9 5975.4 6052.8 6058.5 5816.9 5847.4 5884.5 5885.0 5887.9 5808.3 5818.4 5821.0 5830.4 5836.6 5701.9 5768.5 5826.9 5874.5 5891.0 5952.3 5978.8 5982.1 5990.2 5991.8 5534.3 5573.5 5835.4 5836.2 5848.3 14:19:27 INFO - PROCESS | 22072 | 14:19:27 INFO - PROCESS | 22072 | [#1] ext.html Cycles:180 Average:56808.04 Median:390321.00 stddev:106702.65 (27.3%) stddev-sans-first:106918.47 14:19:27 INFO - PROCESS | 22072 | Values: 584.1 597.8 625.9 643.8 654.7 36423.8 45702.5 46219.8 46298.3 50483.0 46743.3 47209.0 47372.8 47410.5 47426.5 8385.5 8871.1 9012.7 9014.4 9017.4 8281.8 10566.8 10793.8 10794.7 11142.3 10978.3 10983.2 11001.9 11073.0 11078.3 10721.2 10788.2 10793.3 10797.6 10805.7 10663.5 10701.8 10733.5 10734.9 10739.5 43829.1 44303.0 44337.0 44433.0 44466.6 3681.6 3782.5 3798.5 3953.2 4210.2 31150.8 31332.7 31728.8 31964.4 32155.2 4230.6 4242.5 4336.2 4368.4 4389.6 232272.0 232928.0 234060.0 234289.0 235386.0 64612.7 64923.0 65139.3 65337.7 65388.0 39991.6 40574.8 40882.4 68942.0 69044.0 17730.5 17772.5 17788.0 17788.0 17819.6 13303.9 13598.9 13669.8 13750.4 13784.9 20238.7 21441.7 21490.9 21533.1 21565.7 7378.2 7413.3 7458.9 7663.8 7790.0 1007.8 1013.5 1109.5 1190.4 1221.4 33477.2 33701.0 33767.0 34073.5 34254.1 996.5 1145.9 1173.9 1235.1 1285.2 15815.8 17387.6 17451.8 18976.0 19045.6 526889.0 527441.0 528416.0 530552.0 532128.0 60147.7 60477.4 60587.7 60652.7 60714.0 1309.1 1355.6 1418.1 1429.8 1449.9 29308.1 34672.0 35211.5 35248.3 35326.8 54262.5 54756.0 54814.2 54872.7 54891.2 387806.0 389925.0 390717.0 390777.0 391638.0 29621.6 30139.0 30407.8 31270.0 32095.5 49310.3 50014.0 50282.0 53788.5 54871.0 42351.0 42637.6 42948.4 44133.8 44747.0 42687.4 43122.4 43252.1 43583.6 44988.6 42830.8 43911.3 43991.8 44026.6 44195.3 37164.4 38618.0 39666.4 40071.4 40251.2 28919.6 29354.3 29643.9 29835.4 29877.3 14:19:27 INFO - PROCESS | 22072 | 14:19:27 INFO - PROCESS | 22072 | [#2] jquery.html Cycles:180 Average:30023.76 Median:19813.60 stddev:82714.41 (417.5%) stddev-sans-first:82916.54 14:19:27 INFO - PROCESS | 22072 | Values: 396.8 424.8 431.0 435.5 449.4 15877.0 19204.7 19631.7 20472.9 20582.3 18444.8 19995.5 20438.5 20689.6 20699.9 5818.2 6051.7 6054.5 6055.3 6057.5 5647.0 5912.4 5940.1 5948.4 5949.4 5719.6 5920.1 5920.4 5922.1 5925.5 5886.2 5917.3 5937.0 5938.2 5945.3 5151.7 5377.6 5384.0 5384.1 5384.7 14538.1 14552.6 14799.0 14800.3 15027.5 2079.3 2203.5 2258.5 2479.4 2554.7 10601.7 10673.1 10739.0 10995.0 11090.3 1792.1 1876.5 1877.4 1891.2 1928.7 84021.6 84928.2 84965.0 85114.6 88930.7 10597.9 11808.9 12248.4 12263.4 12292.3 13710.9 15459.7 16197.8 16200.3 16817.8 8655.1 8679.7 8686.2 8835.2 8956.6 8306.8 8407.0 8432.8 8584.5 8588.7 5083.6 5111.2 5145.2 5153.5 5255.1 2082.5 2091.8 2114.1 2123.7 2176.7 1006.6 1033.4 1034.6 1082.0 1097.9 20014.5 20310.4 20360.0 20571.0 20791.7 1081.3 1083.1 1088.5 1122.8 1138.6 10586.9 11659.7 11708.5 11900.6 12087.5 483276.0 494554.0 503643.0 510661.0 511138.0 96768.0 97208.5 98058.5 100452.0 101378.0 1064.9 1107.1 1158.1 1162.9 1173.2 17578.0 17763.1 17942.6 18304.5 18425.0 43604.3 44567.8 44913.0 44931.6 45398.3 54130.0 58760.4 61249.0 62583.0 67773.0 11966.9 12079.8 12167.8 12283.7 12468.2 13299.5 13377.5 13436.7 13505.5 13592.9 11787.9 11895.8 12059.9 12125.5 12138.3 11815.9 11917.2 12047.5 12167.3 12452.6 12058.8 12278.8 12340.6 12579.7 12968.2 12043.6 12109.6 12121.0 12270.3 12421.7 11814.8 12018.0 12168.0 12397.5 12505.9 14:19:27 INFO - PROCESS | 22072 | 14:19:27 INFO - PROCESS | 22072 | [#3] mootools.html Cycles:180 Average:5601.78 Median:5237.88 stddev:3061.51 (58.4%) stddev-sans-first:3053.46 14:19:27 INFO - PROCESS | 22072 | Values: 1354.5 1463.7 1506.0 1655.4 1776.1 7462.1 8048.4 8372.2 8384.2 8663.2 8470.3 8554.1 8562.9 8573.8 8578.4 2409.7 2413.7 2435.9 2441.4 2445.7 2387.8 2429.2 2463.9 2464.3 2467.6 2395.5 2406.0 2427.3 2428.7 2433.5 2339.8 2350.5 2360.8 2364.4 2378.5 2292.8 2310.7 2332.7 2333.5 2333.7 8208.8 8372.0 8494.4 8514.1 8561.4 5273.8 5449.6 5456.1 5458.7 5459.1 3305.6 3385.4 3434.4 3462.4 3472.2 1049.8 1075.7 1080.8 1111.2 1123.6 11034.5 11049.7 11116.4 11130.2 11135.6 4277.6 4409.7 4496.0 4496.1 4601.8 9352.3 9353.6 9358.4 9364.1 9369.9 5281.4 5287.4 5291.7 5293.1 5296.1 4387.5 4391.7 4805.9 4858.9 4931.4 3826.2 3865.5 3933.5 3965.7 3966.1 1108.2 1213.2 1221.6 1224.5 1232.9 850.9 950.6 959.2 967.0 982.1 5536.6 5606.9 5615.1 5913.2 5941.8 925.8 975.2 992.6 1006.5 1023.8 3958.4 4092.6 4159.8 4183.7 4300.2 10225.4 10435.4 10506.5 10527.2 10576.2 10402.6 10403.6 10405.8 10425.5 10428.4 7802.5 7996.9 8091.9 8107.6 8115.8 5579.0 5585.5 5869.7 5922.3 6053.5 9661.7 9662.6 9712.9 9772.1 9787.0 9409.0 9725.3 9766.5 9891.6 9892.0 7012.5 7059.8 7244.1 7282.7 7447.0 8208.8 8227.7 8271.0 8296.3 8306.9 7386.8 7397.9 7430.4 7544.4 7565.1 7235.7 7283.0 7319.1 7328.2 7342.9 6690.1 6791.4 6796.3 6797.1 6801.5 4786.7 4937.5 4960.2 4962.5 5127.9 5047.8 5075.5 5132.9 5202.0 5385.6 14:19:27 INFO - PROCESS | 22072 | 14:19:27 INFO - PROCESS | 22072 | [#4] prototype.html Cycles:180 Average:4689.86 Median:5310.68 stddev:1351.56 (25.4%) stddev-sans-first:1315.53 14:19:27 INFO - PROCESS | 22072 | Values: 350.7 352.1 352.9 357.9 359.8 5403.9 5431.3 5439.7 5446.2 5475.4 5277.9 5289.5 5347.8 5365.5 5367.9 3703.7 3992.8 4136.9 4145.8 4162.5 4155.2 4159.9 4171.1 4177.2 4194.8 4122.8 4179.6 4179.7 4189.2 4199.7 3996.7 4058.5 4122.5 4173.0 4217.9 3721.0 3725.3 3737.9 3739.1 3739.5 5157.9 5167.5 5185.4 5227.8 5241.0 4754.9 4763.2 4785.1 4817.0 4842.5 5523.4 5555.4 5561.4 5563.2 5584.0 4157.2 4185.6 4186.5 4193.5 4199.3 5572.6 5672.4 5710.2 5774.9 5839.5 4208.6 4216.6 4217.6 4223.0 4247.5 4260.3 4270.8 4291.2 4293.7 4317.9 4696.2 4705.6 4714.6 4811.5 4842.0 5478.6 5490.6 5515.2 5530.6 5551.8 1432.3 1443.7 1446.5 1449.9 1463.7 953.7 990.3 998.4 1000.4 1023.5 5222.8 5238.5 5247.3 5255.9 5279.4 5505.4 5512.4 5518.8 5520.7 5521.4 4954.1 5179.4 5195.0 5245.6 5283.9 2878.8 2879.9 2889.2 2902.7 2905.5 5618.4 5710.9 5716.5 5736.3 5764.4 5316.4 5510.4 5523.3 5536.4 5577.7 5768.0 5769.3 5898.9 5912.5 5916.7 5671.4 5713.3 5718.7 5722.5 5750.1 5515.2 5625.7 5631.4 5642.1 5672.9 5871.4 5892.6 5892.7 5906.8 5914.3 4269.1 4270.5 4275.7 4293.4 4309.3 5515.7 5615.6 5688.1 5689.1 5700.7 5573.5 5593.4 5595.5 5604.8 5634.3 5262.7 5499.4 5529.5 5536.9 5541.0 5565.7 5584.8 5588.6 5590.5 5595.5 5608.3 5643.3 5652.5 5652.6 5653.5 5304.9 5506.3 5542.4 5543.1 5561.6 14:19:27 INFO - PROCESS | 22072 | 14:19:27 INFO - PROCESS | 22072 | [#5] yui.html Cycles:180 Average:17164.05 Median:50037.88 stddev:22656.67 (45.3%) stddev-sans-first:22686.67 14:19:27 INFO - PROCESS | 22072 | Values: 743.2 749.9 763.4 772.3 783.2 14805.8 15762.0 15801.1 15812.8 15817.4 14315.0 14462.6 14463.6 14471.6 14475.8 727.0 749.9 849.0 870.7 884.2 878.4 880.9 881.4 881.5 881.7 926.0 926.6 927.4 928.2 928.6 762.8 785.3 874.3 897.9 903.1 663.3 664.9 665.7 666.2 666.9 14419.0 14776.8 14783.4 14825.5 14829.5 12944.7 13274.9 13355.1 13406.5 13481.1 10313.8 10335.4 10401.2 10412.0 10531.2 4112.4 4127.0 4155.0 4226.3 4252.7 60435.7 62515.0 63939.0 63949.7 64564.4 10142.6 10349.3 10367.3 10428.6 10446.7 20780.9 20781.1 20789.2 20793.5 20795.6 8046.9 8110.2 8159.5 8193.3 8201.5 4292.3 4294.8 4350.4 4444.3 4501.5 3323.9 3393.1 3437.5 3440.5 3441.9 556.0 561.9 563.6 570.8 570.9 544.2 557.6 599.0 607.2 626.5 8002.9 8424.5 8570.3 8835.7 9228.4 592.4 596.0 620.0 642.5 655.4 4283.6 4330.4 4339.4 4409.9 4582.8 57070.7 85359.6 85804.6 91506.5 91656.0 72537.0 72829.6 74914.0 75157.6 75274.0 66754.3 67644.0 68651.3 69938.0 72858.0 7983.9 8562.4 8663.7 8681.7 8833.5 46649.0 47999.5 48279.8 49304.8 49800.3 41968.8 50275.5 52558.7 56040.0 57493.7 11496.9 11644.3 11824.9 11836.1 11988.2 12491.3 12819.5 12856.1 12895.5 14000.8 11325.3 12326.4 12370.4 12533.3 13006.6 11856.5 12037.9 12356.1 12391.6 12756.3 12248.1 12338.8 12368.1 12370.4 12600.7 9189.1 9305.3 9378.7 9662.4 10016.7 8916.4 10043.7 10091.2 10444.9 10472.7 14:19:27 INFO - PROCESS | 22072 | -------- Summary: end -------- 14:19:27 INFO - PROCESS | 22072 | 14:19:28 INFO - TEST-INFO | 22072: exit 0 14:19:28 INFO - TEST-OK | dromaeo_css | took 1115537ms 14:19:28 INFO - TEST-START | kraken 14:19:28 INFO - operating with platform_type : linux_ 14:19:28 INFO - Initialising browser for kraken test... 14:19:28 INFO - TEST-INFO | started process 22388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6hbQlX/profile http://localhost:56377/getInfo.html) 14:19:32 INFO - PROCESS | 22388 | __metrics Screen width/height:1600/1200 14:19:32 INFO - PROCESS | 22388 | colorDepth:24 14:19:32 INFO - PROCESS | 22388 | Browser inner width/height: 1024/697 14:19:32 INFO - PROCESS | 22388 | __metrics 14:19:33 INFO - PROCESS | 22388 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:19:33 INFO - PROCESS | 22388 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:19:33 INFO - PROCESS | 22388 | console.error: PushService: 14:19:33 INFO - PROCESS | 22388 | stateChangeProcessEnqueue: Error transitioning state 14:19:33 INFO - PROCESS | 22388 | UnknownError 14:19:34 INFO - TEST-INFO | 22388: exit 0 14:19:34 INFO - Browser initialized. 14:19:34 INFO - Running cycle 1/1 for kraken test... 14:19:34 INFO - TEST-INFO | started process 22482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6hbQlX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:46 INFO - PROCESS | 22482 | RSS: Main: 144732160 14:19:46 INFO - PROCESS | 22482 | 14:19:48 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56377/tests/kraken/driver.html?testName=audio-beat-detection) 14:19:49 INFO - PROCESS | 22482 | RSS: Main: 185737216 14:19:49 INFO - PROCESS | 22482 | 14:19:51 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56377/tests/kraken/driver.html?testName=audio-dft) 14:19:52 INFO - PROCESS | 22482 | RSS: Main: 174792704 14:19:52 INFO - PROCESS | 22482 | 14:19:55 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56377/tests/kraken/driver.html?testName=audio-fft) 14:19:55 INFO - PROCESS | 22482 | RSS: Main: 266612736 14:19:55 INFO - PROCESS | 22482 | 14:19:58 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56377/tests/kraken/driver.html?testName=audio-oscillator) 14:19:58 INFO - PROCESS | 22482 | RSS: Main: 172916736 14:19:58 INFO - PROCESS | 22482 | 14:20:00 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:20:01 INFO - PROCESS | 22482 | RSS: Main: 175075328 14:20:01 INFO - PROCESS | 22482 | 14:20:04 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56377/tests/kraken/driver.html?testName=imaging-darkroom) 14:20:04 INFO - PROCESS | 22482 | RSS: Main: 213544960 14:20:04 INFO - PROCESS | 22482 | 14:20:08 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56377/tests/kraken/driver.html?testName=imaging-desaturate) 14:20:08 INFO - PROCESS | 22482 | RSS: Main: 212168704 14:20:08 INFO - PROCESS | 22482 | 14:20:11 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56377/tests/kraken/driver.html?testName=json-parse-financial) 14:20:11 INFO - PROCESS | 22482 | RSS: Main: 211427328 14:20:11 INFO - PROCESS | 22482 | 14:20:13 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:20:14 INFO - PROCESS | 22482 | RSS: Main: 173727744 14:20:14 INFO - PROCESS | 22482 | 14:20:15 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56377/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:20:16 INFO - PROCESS | 22482 | RSS: Main: 180457472 14:20:16 INFO - PROCESS | 22482 | 14:20:18 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:20:18 INFO - PROCESS | 22482 | RSS: Main: 190279680 14:20:18 INFO - PROCESS | 22482 | 14:20:21 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:20:22 INFO - PROCESS | 22482 | RSS: Main: 198078464 14:20:22 INFO - PROCESS | 22482 | 14:20:24 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:20:25 INFO - PROCESS | 22482 | RSS: Main: 194506752 14:20:25 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | Cycle 1(1): loaded http://localhost:56377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56377/tests/kraken/driver.html?testName=ai-astar) 14:20:27 INFO - PROCESS | 22482 | RSS: Main: 245678080 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | __start_tp_report 14:20:27 INFO - PROCESS | 22482 | _x_x_mozilla_page_load 14:20:27 INFO - PROCESS | 22482 | _x_x_mozilla_page_load_details 14:20:27 INFO - PROCESS | 22482 | |i|pagename|runs| 14:20:27 INFO - PROCESS | 22482 | |0;ai-astar;102;111;110;111;124;111;111;111;113;110 14:20:27 INFO - PROCESS | 22482 | |1;audio-beat-detection;155;118;118;165;120;118;118;121;154;125 14:20:27 INFO - PROCESS | 22482 | |2;audio-dft;161;163;162;162;163;162;161;161;160;163 14:20:27 INFO - PROCESS | 22482 | |3;audio-fft;75;78;76;106;75;75;75;86;98;76 14:20:27 INFO - PROCESS | 22482 | |4;audio-oscillator;83;82;119;83;83;83;103;82;82;116 14:20:27 INFO - PROCESS | 22482 | |5;imaging-gaussian-blur;117;117;117;119;117;117;117;117;117;117 14:20:27 INFO - PROCESS | 22482 | |6;imaging-darkroom;147;146;147;146;146;146;147;147;145;146 14:20:27 INFO - PROCESS | 22482 | |7;imaging-desaturate;85;84;85;85;85;85;84;85;84;85 14:20:27 INFO - PROCESS | 22482 | |8;json-parse-financial;50;51;52;50;51;52;51;50;51;50 14:20:27 INFO - PROCESS | 22482 | |9;json-stringify-tinderbox;59;59;58;59;63;58;58;60;59;59 14:20:27 INFO - PROCESS | 22482 | |10;stanford-crypto-aes;75;74;76;81;78;79;74;74;73;74 14:20:27 INFO - PROCESS | 22482 | |11;stanford-crypto-ccm;122;121;120;134;120;129;119;124;159;122 14:20:27 INFO - PROCESS | 22482 | |12;stanford-crypto-pbkdf2;149;157;153;148;156;153;150;150;154;154 14:20:27 INFO - PROCESS | 22482 | |13;stanford-crypto-sha256-iterative;61;63;62;63;61;63;62;63;64;62 14:20:27 INFO - PROCESS | 22482 | __end_tp_report 14:20:27 INFO - PROCESS | 22482 | __start_cc_report 14:20:27 INFO - PROCESS | 22482 | _x_x_mozilla_cycle_collect,1613 14:20:27 INFO - PROCESS | 22482 | __end_cc_report 14:20:27 INFO - PROCESS | 22482 | __startTimestamp1484000427262__endTimestamp 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | ------- Summary: start ------- 14:20:27 INFO - PROCESS | 22482 | Number of tests: 14 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:5.32 (4.8%) stddev-sans-first:4.42 14:20:27 INFO - PROCESS | 22482 | Values: 102.0 111.0 110.0 111.0 124.0 111.0 111.0 111.0 113.0 110.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:123.00 stddev:18.84 (15.3%) stddev-sans-first:17.90 14:20:27 INFO - PROCESS | 22482 | Values: 155.0 118.0 118.0 165.0 120.0 118.0 118.0 121.0 154.0 125.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 14:20:27 INFO - PROCESS | 22482 | Values: 161.0 163.0 162.0 162.0 163.0 162.0 161.0 161.0 160.0 163.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:11.22 (14.8%) stddev-sans-first:11.61 14:20:27 INFO - PROCESS | 22482 | Values: 75.0 78.0 76.0 106.0 75.0 75.0 75.0 86.0 98.0 76.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:82.50 stddev:15.09 (18.3%) stddev-sans-first:15.68 14:20:27 INFO - PROCESS | 22482 | Values: 83.0 82.0 119.0 83.0 83.0 83.0 103.0 82.0 82.0 116.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 14:20:27 INFO - PROCESS | 22482 | Values: 117.0 117.0 117.0 119.0 117.0 117.0 117.0 117.0 117.0 117.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 14:20:27 INFO - PROCESS | 22482 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 147.0 147.0 145.0 146.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 14:20:27 INFO - PROCESS | 22482 | Values: 85.0 84.0 85.0 85.0 85.0 85.0 84.0 85.0 84.0 85.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 14:20:27 INFO - PROCESS | 22482 | Values: 50.0 51.0 52.0 50.0 51.0 52.0 51.0 50.0 51.0 50.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:1.48 (2.5%) stddev-sans-first:1.56 14:20:27 INFO - PROCESS | 22482 | Values: 59.0 59.0 58.0 59.0 63.0 58.0 58.0 60.0 59.0 59.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:2.66 (3.5%) stddev-sans-first:2.80 14:20:27 INFO - PROCESS | 22482 | Values: 75.0 74.0 76.0 81.0 78.0 79.0 74.0 74.0 73.0 74.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:123.00 stddev:12.17 (9.9%) stddev-sans-first:12.78 14:20:27 INFO - PROCESS | 22482 | Values: 122.0 121.0 120.0 134.0 120.0 129.0 119.0 124.0 159.0 122.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:153.50 stddev:3.03 (2.0%) stddev-sans-first:2.95 14:20:27 INFO - PROCESS | 22482 | Values: 149.0 157.0 153.0 148.0 156.0 153.0 150.0 150.0 154.0 154.0 14:20:27 INFO - PROCESS | 22482 | 14:20:27 INFO - PROCESS | 22482 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 14:20:27 INFO - PROCESS | 22482 | Values: 61.0 63.0 62.0 63.0 61.0 63.0 62.0 63.0 64.0 62.0 14:20:27 INFO - PROCESS | 22482 | -------- Summary: end -------- 14:20:27 INFO - PROCESS | 22482 | 14:20:28 INFO - TEST-INFO | 22482: exit 0 14:20:28 INFO - TEST-OK | kraken | took 59770ms 14:20:28 INFO - SUITE-END | took 1175s 14:20:28 INFO - Completed test suite (00:19:35) 14:20:28 INFO - javascript benchmark 14:20:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3260.4457242268813, 3303.4879593662977, 3309.768316217863, 3331.133905184651, 3348.6483919188486, 5595.7481913313895, 5647.689377084259, 5659.717014149292, 5687.431256874321, 5718.942810571898, 5611.691356975375, 5690.63010904291, 5693.658380497173, 5696.829095127143, 5749.511291540213, 5099.235114732783, 5128.358955130609, 5131.846044618667, 5144.8713782155555, 5198.038362902875, 4940.802367905279, 5236.0, 5236.895262094756, 5245.213218017289, 5248.6063545234065, 4927.6797008194535, 5013.298138260647, 5020.7489625518765, 5031.3207716958295, 5049.293098966147, 5052.924206136892, 5077.974610126926, 5079.974600126994, 5150.098732721796, 5180.456052114511, 4996.825111121129, 5073.543381095719, 5107.387113546398, 5128.615353848476, 5130.71781052042, 5419.783208671648, 5467.589930755209, 5474.479924407215, 5531.3362396512275, 5577.637453565546, 5881.14723365114, 5895.852603684899, 5903.734331955073, 6014.368491308437, 6021.307549631761, 6001.219841420631, 6026.427489388501, 6035.8792824143275, 6039.245094363205, 6039.486643635296, 5467.726613669301, 5515.586331025149, 5635.126555383922, 5683.516901063374, 5707.34365547959, 6221.129041934133, 6228.283747369111, 6254.593451425642, 6265.248170219603, 6272.529560282997, 6012.759489620366, 6020.879582408327, 6021.42796434338, 6021.909671354933, 6054.0, 5849.912251316234, 5864.736086876101, 5866.2373891393845, 5878.735456904449, 5903.881922361528, 5904.793332233351, 5911.9704401478575, 5912.201852749909, 5932.970335148297, 5954.672493012926, 5871.4715675589405, 5911.527077833763, 5927.585069045125, 5928.051511758098, 5931.051031834886, 4444.555544445529, 4500.369948207253, 4579.061292435043, 4603.447586289667, 4642.698224615389, 4161.188568229227, 4191.308434108338, 4198.685098617616, 4209.642180414699, 4231.048014196843, 5839.591228613956, 5843.912341314884, 5846.181534585162, 5852.209951656557, 5853.209816674779, 5844.678542680108, 5916.940830591725, 5954.49386802118, 6151.538634602333, 6152.953997820381, 5671.773129074873, 5755.740991655385, 5781.8554536136935, 5794.101914203221, 5795.159701843209, 5273.3935597406025, 5276.5251127398715, 5287.57699384056, 5288.682679039193, 5289.894202115936, 6127.754889804358, 6169.259688837368, 6237.688115594202, 6286.559940804192, 6296.275928268308, 5989.64062156272, 6043.2748070231855, 6060.606060606223, 6111.287884814297, 6142.78500252489, 6307.432331090224, 6349.396807303298, 6351.047342898602, 6352.936470635234, 6361.045843123568, 5621.831345059655, 5656.943430565641, 5990.161377407079, 5991.88016239664, 5994.820155395345, 5892.941070589411, 5915.85210369727, 5975.37258587842, 6052.788152414644, 6058.4850287724275, 5816.9127463088935, 5847.38602446754, 5884.499817515388, 5884.9705751470965, 5887.941120588911, 5808.30300363959, 5818.389069147678, 5821.0, 5830.4461076197695, 5836.649801011783, 5701.885962280814, 5768.509676677361, 5826.883462330815, 5874.530037596896, 5890.970545147246, 5952.285725712942, 5978.790742323998, 5982.1325907744, 5990.221271234712, 5991.820245392645, 5534.335879694301, 5573.470520300565, 5835.387284335084, 5836.241288632451, 5848.298204215522], "value": 5551.361719577653, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.1471451680546, 597.8057131432284, 625.9499240060794, 643.8004218692206, 654.7086546486815, 36423.81788091059, 45702.54297457024, 46219.76890115545, 46298.305525417105, 50483.0, 46743.29885051727, 47209.0, 47372.76313618427, 47410.52589474104, 47426.525734742725, 8385.454945428528, 8871.068537803534, 9012.684556040507, 9014.36899417041, 9017.36878418511, 8281.751547453587, 10566.788664226711, 10793.784124317508, 10794.73013174673, 11142.331460112418, 10978.286411383235, 10983.176261780358, 11001.889981100167, 11073.0, 11078.335299881992, 10721.195910306718, 10788.190885683527, 10793.29843560166, 10797.5680972761, 10805.729856753565, 10663.466826658714, 10701.78596428067, 10733.516991735312, 10734.946325268402, 10739.463026848705, 43829.12341753147, 44303.0, 44337.0, 44433.0, 44466.555334446886, 3681.6134305897763, 3782.470454136423, 3798.4682144499793, 3953.2093581283857, 4210.221109094828, 31150.84424577885, 31332.686673133205, 31728.841355793073, 31964.360712785616, 32155.19612009695, 4230.576942305775, 4242.533321334681, 4336.21948049351, 4368.410264614268, 4389.574759945144, 232272.0, 232928.0, 234060.0, 234288.99999999828, 235386.0, 64612.67693661596, 64923.0, 65139.34860651428, 65337.67331163314, 65388.0, 39991.60008399937, 40574.79712601418, 40882.38676419856, 68942.0, 69043.96434053493, 17730.468085957444, 17772.46682599524, 17788.02165880863, 17788.02165880889, 17819.643607127786, 13303.933480332536, 13598.864011359958, 13669.794953075712, 13750.381232844546, 13784.931075344559, 20238.69641955372, 21441.67837482439, 21490.892545537172, 21533.138674452846, 21565.67651485229, 7378.225286344964, 7413.332800048021, 7458.925410745823, 7663.808404789814, 7790.0, 1007.8034783217203, 1013.4831236069657, 1109.517359948425, 1190.4166958190597, 1221.3770976801718, 33477.16307092342, 33701.0, 33767.0, 34073.48889766655, 34254.14364640904, 996.4668902137322, 1145.8770405003143, 1173.859136903577, 1235.116891422637, 1285.2095960983927, 15815.762763558556, 17387.565310867078, 17451.825481745273, 18976.0, 19045.61908761817, 526889.0, 527441.0, 528416.0, 530552.0, 532128.0, 60147.69926150429, 60477.39522604806, 60587.69706151529, 60652.69673651604, 60714.0, 1309.109805332364, 1355.6407551998727, 1418.1136789506352, 1429.7640889253364, 1449.9202543859979, 29308.120756377342, 34672.0, 35211.47182792209, 35248.29503409969, 35326.82336588403, 54262.45737542574, 54756.0, 54814.17778733402, 54872.725636371564, 54891.17663234975, 387806.0, 389925.0, 390717.0, 390777.0, 391638.0, 29621.555676664437, 30139.0, 30407.847960760053, 31270.0, 32095.518567221043, 49310.26034609556, 50014.0, 50282.0, 53788.462115378345, 54871.0, 42351.0, 42637.5736242646, 42948.35577466278, 44133.77933110314, 44747.0, 42687.35968960406, 43122.353164703185, 43252.13495730131, 43583.56416435795, 44988.55011449844, 42830.78584607057, 43911.34132988071, 43991.78004109959, 44026.559734402246, 44195.337069943336, 37164.44253336148, 38618.0, 39666.40500392439, 40071.39892901667, 40251.1949761009, 28919.56620650734, 29354.266143346587, 29643.85178074096, 29835.403291934475, 29877.253068672588], "value": 21035.684160364228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.755995063036, 424.7748693192607, 430.97845107744615, 435.4643788140589, 449.43146919147284, 15877.0, 19204.711929321053, 19631.705524417146, 20472.873991930475, 20582.279620213296, 18444.815551844476, 19995.500112497193, 20438.489037774063, 20689.586208275825, 20699.896500517512, 5818.1854540364275, 6051.667158306292, 6054.48536874364, 6055.333913269536, 6057.485113765313, 5647.0, 5912.43831835977, 5940.138679891413, 5948.37542058082, 5949.4348036936635, 5719.59962802604, 5920.111983202511, 5920.378360272174, 5922.141289513018, 5925.4963328117165, 5886.175935369051, 5917.289925208981, 5936.970315148396, 5938.16865638813, 5945.31628862682, 5151.742412879378, 5377.623566350357, 5384.0, 5384.138537833967, 5384.6769193848495, 14538.127712337187, 14552.636184095376, 14799.0, 14800.259987000607, 15027.549173524812, 2079.3034333498294, 2203.4821816873023, 2258.5482903419215, 2479.367761220877, 2554.6678931738943, 10601.73495662607, 10673.092787113104, 10739.03348698613, 10995.0, 11090.334579925231, 1792.1397729089979, 1876.47458711561, 1877.3898482993081, 1891.1678861300984, 1928.6817675083594, 84021.57989210016, 84928.15071849264, 84965.0, 85114.57442712809, 88930.6660400101, 10597.894021059845, 11808.94095529534, 12248.44881980313, 12263.386830658432, 12292.323922184365, 13710.862891371158, 15459.690806183813, 16197.757033644504, 16200.270987805578, 16817.831821681626, 8655.13448655142, 8679.739607811776, 8686.174813392718, 8835.160659737314, 8956.641734330553, 8306.8338633227, 8406.957965210257, 8432.831343373098, 8584.484930904166, 8588.65645374178, 5083.61872859537, 5111.233315002705, 5145.202493613496, 5153.510416510426, 5255.106631872591, 2082.5106100066473, 2091.822195113402, 2114.059243636598, 2123.723915890924, 2176.651735722277, 1006.5923301063082, 1033.440092303403, 1034.5706531789374, 1081.9621313254, 1097.8737445193744, 20014.49963750889, 20310.390688279374, 20360.0, 20571.0, 20791.68812467814, 1081.313366012572, 1083.0739717541546, 1088.4884104470887, 1122.7586068995042, 1138.5957984915235, 10586.947065264778, 11659.708507287385, 11708.531658733555, 11900.64298071042, 12087.456064477119, 483276.0, 494554.0, 503643.0, 510661.0, 511138.0, 96768.0, 97208.51395742976, 98058.50970745101, 100452.0, 101378.0, 1064.9094826939643, 1107.0534692837507, 1158.073541167063, 1162.8837116288303, 1173.1611897493333, 17578.0, 17763.111844407988, 17942.55143621368, 18304.542386440444, 18424.98662573518, 43604.34593481037, 44567.77716111398, 44913.0, 44931.55068449405, 45398.31902521531, 54130.0, 58760.4123958772, 61249.0, 62583.0, 67772.98340524797, 11966.940165299118, 12079.75840483203, 12167.81748273759, 12283.692907677023, 12468.189567678071, 13299.46802127904, 13377.464901403835, 13436.731265374834, 13505.459781608626, 13592.93203533976, 11787.882121179022, 11895.821562676394, 12059.939700301442, 12125.454354553889, 12138.33239171854, 11815.940920295343, 11917.22538035025, 12047.457864396298, 12167.2699638022, 12452.626421207378, 12058.758824823279, 12278.754424911273, 12340.629781106582, 12579.74840503203, 12968.157069790434, 12043.638690839289, 12109.576164834189, 12121.0, 12270.32513211782, 12421.689457763629, 11814.763704726029, 12018.04349557851, 12168.0, 12397.504099835905, 12505.93747031259], "value": 9687.30002903622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.4920654754467, 1463.69994151199, 1505.9849401505983, 1655.445425782363, 1776.1474492243715, 7462.141853686828, 8048.356131509479, 8372.204640559152, 8384.24541791238, 8663.220310172082, 8470.322374210064, 8554.144585541442, 8562.871556926651, 8573.785655358604, 8578.399512034144, 2409.698787651539, 2413.6620873077695, 2435.926922192328, 2441.377448750566, 2445.74319696432, 2387.844790088647, 2429.1983645396976, 2463.864487453189, 2464.3099932019063, 2467.617519284514, 2395.5089206712582, 2406.03758496601, 2427.3446169534213, 2428.6964129483813, 2433.4646377796857, 2339.836211465198, 2350.529894021194, 2360.7875291223786, 2364.3852598324474, 2378.5361854438393, 2292.8280378971644, 2310.6996090508296, 2332.7433982261937, 2333.5099629077913, 2333.7432882382923, 8208.83582328356, 8372.0, 8494.362922780816, 8514.106018867991, 8561.44350617208, 5273.789048438058, 5449.618526703132, 5456.072467680504, 5458.727063646802, 5459.099248623972, 3305.586801649794, 3385.4414021686393, 3434.4333185024443, 3462.394081035834, 3472.2013936794424, 1049.8425236214553, 1075.7095584192225, 1080.8378743188507, 1111.1721767283345, 1123.646051493777, 11034.503447344889, 11049.668509944635, 11116.44417779116, 11130.165237607212, 11135.554577816878, 4277.572242775697, 4409.691321607456, 4496.0108776069865, 4496.145732310851, 4601.838935637304, 9352.298577606707, 9353.579088941015, 9358.409070458038, 9364.063593640718, 9369.859452108223, 5281.366236051698, 5287.365516138011, 5291.735413229323, 5293.100172970604, 5296.1261391870685, 4387.4954380246045, 4391.736495810262, 4805.927911081337, 4858.902821943541, 4931.408231012301, 3826.234753049401, 3865.4588357629955, 3933.547642021147, 3965.6827453803626, 3966.147278335114, 1108.2076315434504, 1213.1568559850996, 1221.5724496426358, 1224.516316055171, 1232.8520577530753, 850.9021462531764, 950.5864948747317, 959.2230293462318, 966.9516524173763, 982.1160955140288, 5536.584756143306, 5606.887862242732, 5615.129654903497, 5913.201717768046, 5941.792037278675, 925.796324808541, 975.2149519636761, 992.553350992042, 1006.5420233793607, 1023.8310678738073, 3958.4062390641634, 4092.6112019358116, 4159.7920103994675, 4183.748975061506, 4300.16146851361, 10225.386476811414, 10435.426051567236, 10506.527206275583, 10527.210459215436, 10576.206784491194, 10402.635907743193, 10403.58385664565, 10405.791884162274, 10425.530851111718, 10428.426436545911, 7802.492837965514, 7996.9200307997335, 8091.878621820678, 8107.594620268963, 8115.797105072303, 5579.04557725907, 5585.469380408855, 5869.706514674334, 5922.289325280994, 6053.4551890330085, 9661.661841835503, 9662.613495460102, 9712.902870971482, 9772.12050915421, 9786.951065244913, 9409.0, 9725.319227653996, 9766.46284454362, 9891.55488003056, 9892.0, 7012.509124361246, 7059.788206353817, 7244.094488188976, 7282.6722797473185, 7447.0, 8208.753737387888, 8227.71203007892, 8271.0, 8296.336293096658, 8306.916930830856, 7386.815329616587, 7397.926020739724, 7430.368418684472, 7544.396448284015, 7565.130010048915, 7235.710571577078, 7283.0, 7319.121705395387, 7328.230535793665, 7342.926570734225, 6690.096836926952, 6791.3548212919695, 6796.286389928986, 6797.1163748714325, 6801.5238933274195, 4786.736729479772, 4937.481564435682, 4960.20636698141, 4962.454130045764, 5127.923136141452, 5047.772850221675, 5075.543201111917, 5132.897342053213, 5201.973990130025, 5385.569154467555], "value": 4543.189890492152, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.73694728953285, 352.10038352010605, 352.948822420749, 357.89978805934345, 359.7661520011992, 5403.91894121588, 5431.348238211415, 5439.700816455093, 5446.2375267462585, 5475.397706252309, 5277.86805329866, 5289.471052894709, 5347.839564813052, 5365.463453654633, 5367.865803354918, 3703.7037037036957, 3992.7803970781524, 4136.917261654765, 4145.834166633346, 4162.458880345551, 4155.210510003089, 4159.875203743893, 4171.103212809246, 4177.206330797138, 4194.790260486979, 4122.752634841919, 4179.561146079664, 4179.665626749868, 4189.245935731567, 4199.685023623225, 3996.740211886233, 4058.512978442606, 4122.484689413824, 4173.017816537121, 4217.915641687165, 3720.9813950930343, 3725.256117601793, 3737.8504859805576, 3739.139997800521, 3739.5325584301963, 5157.896842063138, 5167.457416971201, 5185.392528316196, 5227.771473703677, 5241.0, 4754.857354279377, 4763.245090341672, 4785.138675038492, 4817.0, 4842.515748425165, 5523.4200408956885, 5555.388907220203, 5561.388247292794, 5563.193336966117, 5584.0, 4157.168566286755, 4185.602367775056, 4186.488107135725, 4193.496780386343, 4199.286121359376, 5572.637778544382, 5672.40439753824, 5710.200571919934, 5774.942250577483, 5839.474447299721, 4208.642265407413, 4216.620504154641, 4217.620414162679, 4222.9577704223175, 4247.51153617338, 4260.339647354665, 4270.765107919032, 4291.184674911757, 4293.699441039097, 4317.935230971538, 4696.248600224016, 4705.6470764692785, 4714.622830173578, 4811.4707382187935, 4841.975790121027, 5478.58910581708, 5490.6431081979545, 5515.172724091338, 5530.6128571000445, 5551.805686800943, 1432.3339647064165, 1443.7473442147582, 1446.5443385333585, 1449.9270539800682, 1463.6853076588584, 953.6566835939057, 990.3117333453325, 998.4259051045677, 1000.3547711725896, 1023.5036007536339, 5222.843314700565, 5238.5023422774775, 5247.2653828464045, 5255.947440525622, 5279.44565820591, 5505.366882808448, 5512.39363669996, 5518.834434966958, 5520.723963801794, 5521.420250873681, 4954.083494553519, 5179.352580927384, 5194.97402512985, 5245.580353571705, 5283.894322113536, 2878.8128771629777, 2879.9424011520073, 2889.19102651258, 2902.7097290270804, 2905.5205891028168, 5618.43815618443, 5710.915515836773, 5716.456936591017, 5736.340320863154, 5764.394738552475, 5316.415194328698, 5510.366307874566, 5523.315388806453, 5536.363318218376, 5577.6932268724795, 5767.971160144172, 5769.278840144982, 5898.882022359443, 5912.46787789101, 5916.7337469813965, 5671.376148623565, 5713.314402271754, 5718.685472299064, 5722.542196624343, 5750.137479378127, 5515.22786809855, 5625.662460252398, 5631.408702086222, 5642.097264437671, 5672.943270567406, 5871.354151043296, 5892.558058145742, 5892.705364731832, 5906.763729450774, 5914.260717410324, 4269.060806622538, 4270.466191726035, 4275.743455392686, 4293.420388247547, 4309.288967320483, 5515.669059856261, 5615.606907516435, 5688.146777983336, 5689.118186681071, 5700.714964251688, 5573.526250268773, 5593.384727680033, 5595.496405323541, 5604.8038318658655, 5634.32388113429, 5262.710805746408, 5499.3675727291875, 5529.502344788827, 5536.861578460571, 5541.0, 5565.719884426524, 5584.776608935597, 5588.608797384307, 5590.524805391425, 5595.496405323541, 5608.326546112303, 5643.322801263875, 5652.547796176378, 5652.576056795675, 5653.547716182778, 5304.946950530445, 5506.256655351476, 5542.3903370630005, 5543.1408131739645, 5561.610687251854], "value": 4266.933416293157, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.1528058013865, 749.9287567681071, 763.3663959127465, 772.3164998975907, 783.1502819440906, 14805.777913331309, 15762.0, 15801.130937798416, 15812.762808557882, 15817.446389376375, 14315.0, 14462.5661230163, 14463.638409039779, 14471.638209044779, 14475.78286325706, 727.0221552012548, 749.8800191969286, 848.9660413583449, 870.7431307764193, 884.1688812516214, 878.4465786554462, 880.9207171354577, 881.4314766975297, 881.497546398553, 881.660560684138, 926.0276709455079, 926.6015613286285, 927.3601215161517, 928.1878356438117, 928.6471140966423, 762.8283636181842, 785.2736218997404, 874.3180319350885, 897.878786363839, 903.0698380667923, 663.3300366629691, 664.9102371179877, 665.7237246542679, 666.203886355805, 666.8799616069106, 14419.0, 14776.778348324784, 14783.408663653441, 14825.481108161162, 14829.480968166063, 12944.741105177938, 13274.933625331909, 13355.065145439823, 13406.463741450429, 13481.123726957716, 10313.793724125551, 10335.379877207391, 10401.167906567456, 10412.0, 10531.15750739939, 4112.403701463271, 4126.958730412687, 4154.958450415487, 4226.281532139544, 4252.681048921312, 60435.69782151105, 62515.0, 63939.0, 63949.68025159891, 64564.3543564563, 10142.594296228068, 10349.327293725884, 10367.274290799722, 10428.634997775192, 10446.68659940203, 20780.896095519427, 20781.064852081694, 20789.1684332625, 20793.480162995744, 20795.584088318148, 8046.879296810553, 8110.188981101843, 8159.510429374256, 8193.262606365337, 8201.507909525448, 4292.313229883203, 4294.7852607369505, 4350.412694286294, 4444.28891377378, 4501.459824820977, 3323.850426730803, 3393.0669066007044, 3437.4671925851535, 3440.518327434161, 3441.896743097711, 555.9527440167631, 561.8651523634298, 563.5745012515524, 570.7545755325167, 570.8886767080462, 544.2081771023152, 557.5595279728968, 599.032562411702, 607.2348840461051, 626.4518546272012, 8002.8799568006525, 8424.536650484282, 8570.314374849997, 8835.734927952171, 9228.354015219005, 592.4371846745609, 596.0433504225742, 620.0203678188542, 642.502060902804, 655.446148004935, 4283.571642835692, 4330.415393921843, 4339.414179085846, 4409.933850992237, 4582.839600614029, 57070.7146464265, 85359.57320213484, 85804.57097714471, 91506.54246728723, 91656.0, 72537.0, 72829.6358518204, 74914.0, 75157.62421187859, 75274.0, 66754.32719709574, 67644.0, 68651.31348686549, 69938.0, 72858.0, 7983.920160798318, 8562.443441176303, 8663.653453861774, 8681.739547813575, 8833.514156721441, 46649.0, 47999.5200048009, 48279.75860120677, 49304.753476233825, 49800.25299620581, 41968.79015604902, 50275.49724502708, 52558.73720631372, 56040.0, 57493.71253143708, 11496.94251528737, 11644.301341919512, 11824.881751182378, 11836.112291578338, 11988.220765650205, 12491.312977786309, 12819.487220511075, 12856.100072994801, 12895.484180633044, 14000.789988149982, 11325.263857849213, 12326.383680816103, 12370.381480926098, 12533.310667913353, 13006.609801705965, 11856.52573897069, 12037.939810300892, 12356.135070544975, 12391.566295179626, 12756.298403587893, 12248.142630015813, 12338.753224935272, 12368.143590454349, 12370.44333004999, 12600.684982875135, 9189.127032931861, 9305.348625596143, 9378.671746489114, 9662.3719458235, 10016.69949901475, 8916.420432671855, 10043.748906277402, 10091.243156763125, 10444.947775261075, 10472.68581942543], "value": 6918.392263058207, "unit": "score"}], "name": "dromaeo_css", "value": 7303.224493042358, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 111.0, 124.0, 111.0, 111.0, 111.0, 113.0, 110.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 118.0, 165.0, 120.0, 118.0, 118.0, 121.0, 154.0, 125.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 163.0, 162.0, 161.0, 161.0, 160.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 106.0, 75.0, 75.0, 75.0, 86.0, 98.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 119.0, 83.0, 83.0, 83.0, 103.0, 82.0, 82.0, 116.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 50.0, 51.0, 52.0, 51.0, 50.0, 51.0, 50.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 63.0, 58.0, 58.0, 60.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 81.0, 78.0, 79.0, 74.0, 74.0, 73.0, 74.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 120.0, 134.0, 120.0, 129.0, 119.0, 124.0, 159.0, 122.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 157.0, 153.0, 148.0, 156.0, 153.0, 150.0, 150.0, 154.0, 154.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 63.0, 61.0, 63.0, 62.0, 63.0, 64.0, 62.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1453.8000000000002, "alertThreshold": 2.0}]} 14:20:29 INFO - Return code: 0 14:20:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:20:29 INFO - # TBPL SUCCESS # 14:20:29 INFO - Running post-action listener: _resource_record_post_action 14:20:29 INFO - [mozharness: 2017-01-09 22:20:29.069477Z] Finished run-tests step (success) 14:20:29 INFO - Running post-run listener: _resource_record_post_run 14:20:29 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 356765696; Read time: 24; Write time: 231264 14:20:29 INFO - TinderboxPrint: CPU usage
13.0% 14:20:29 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 14:20:29 INFO - TinderboxPrint: I/O write bytes / time
356,765,696 / 231,264 14:20:29 INFO - TinderboxPrint: CPU idle
8,279.0 (87.0%) 14:20:29 INFO - TinderboxPrint: CPU user
1,190.2 (12.5%) 14:20:29 INFO - TinderboxPrint: Swap in / out
0 / 0 14:20:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107565056; Read time: 0; Write time: 90712 14:20:29 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249200640; Read time: 20; Write time: 140552 14:20:29 INFO - Running post-run listener: _upload_blobber_files 14:20:29 INFO - Blob upload gear active. 14:20:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:20:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:20:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:20:30 INFO - (blobuploader) - INFO - Open directory for files ... 14:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:30 INFO - (blobuploader) - INFO - Done attempting. 14:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:20:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:31 INFO - (blobuploader) - INFO - Done attempting. 14:20:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:20:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:20:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:35 INFO - (blobuploader) - INFO - Done attempting. 14:20:35 INFO - (blobuploader) - INFO - Iteration through files over. 14:20:35 INFO - Return code: 0 14:20:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:20:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:20:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af3de787064043c7224190b779fe34abdd25883311cdcd913fe3186da871fa96b31841e6fed71f3ae799d561b39f9fcaf1f0ecabf1c818752393786af4069f82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/614f00416ad4f034a4b617c081a4bc64ed4c56a093ecd3389b3e40857ddc5455d900a916f85515bacfe48532336e0cff87395d2d693dfbd2a4d0816df02abd1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3378fd510c0cb84a2a2cebe4043b92dfb5b3440542efddc3749d0fde1bb2f8f4aeb9a0d8f79dd36b8f210dc598dfc482b5a3302bed97b2a8e175c404486a71b5"} 14:20:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:20:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:20:35 INFO - Contents: 14:20:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af3de787064043c7224190b779fe34abdd25883311cdcd913fe3186da871fa96b31841e6fed71f3ae799d561b39f9fcaf1f0ecabf1c818752393786af4069f82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/614f00416ad4f034a4b617c081a4bc64ed4c56a093ecd3389b3e40857ddc5455d900a916f85515bacfe48532336e0cff87395d2d693dfbd2a4d0816df02abd1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3378fd510c0cb84a2a2cebe4043b92dfb5b3440542efddc3749d0fde1bb2f8f4aeb9a0d8f79dd36b8f210dc598dfc482b5a3302bed97b2a8e175c404486a71b5"} 14:20:35 INFO - Running post-run listener: copy_logs_to_upload_dir 14:20:35 INFO - Copying logs to upload dir... 14:20:35 INFO - mkdir: /builds/slave/test/build/upload/logs 14:20:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.946454 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-01-09 14:20:35.631235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 14:20:35.635564) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342 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/af3de787064043c7224190b779fe34abdd25883311cdcd913fe3186da871fa96b31841e6fed71f3ae799d561b39f9fcaf1f0ecabf1c818752393786af4069f82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/614f00416ad4f034a4b617c081a4bc64ed4c56a093ecd3389b3e40857ddc5455d900a916f85515bacfe48532336e0cff87395d2d693dfbd2a4d0816df02abd1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3378fd510c0cb84a2a2cebe4043b92dfb5b3440542efddc3749d0fde1bb2f8f4aeb9a0d8f79dd36b8f210dc598dfc482b5a3302bed97b2a8e175c404486a71b5"} build_url:https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011788 build_url: 'https://queue.taskcluster.net/v1/task/HFxX7OxvRneOkbCvRhJBcg/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/af3de787064043c7224190b779fe34abdd25883311cdcd913fe3186da871fa96b31841e6fed71f3ae799d561b39f9fcaf1f0ecabf1c818752393786af4069f82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/614f00416ad4f034a4b617c081a4bc64ed4c56a093ecd3389b3e40857ddc5455d900a916f85515bacfe48532336e0cff87395d2d693dfbd2a4d0816df02abd1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3378fd510c0cb84a2a2cebe4043b92dfb5b3440542efddc3749d0fde1bb2f8f4aeb9a0d8f79dd36b8f210dc598dfc482b5a3302bed97b2a8e175c404486a71b5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 14:20:35.663841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:20:35.664220) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1483998540.584740-508155342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:20:35.745724) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 14:20:35.746089) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 14:20:35.746452) ========= ========= Total master_lag: 0.18 =========